2020-06-01T17:52:14.059Z,1591033934.059 [Supervisor](DEBUG): Initializing supervisor. 2020-06-01T17:52:14.062Z,1591033934.062 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-06-01T17:52:14.062Z,1591033934.062 [SyncHandler](INFO): Protected caller Thread ID is 5518 2020-06-01T17:52:14.063Z,1591033934.063 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-06-01T17:52:14.064Z,1591033934.064 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-06-01T17:52:14.064Z,1591033934.064 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5519 2020-06-01T17:52:14.068Z,1591033934.068 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-06-01T17:52:14.084Z,1591033934.084 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-06-01T17:52:14.085Z,1591033934.085 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-06-01T17:52:14.086Z,1591033934.086 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5520 2020-06-01T17:52:14.086Z,1591033934.086 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-06-01T17:52:14.087Z,1591033934.087 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-06-01T17:52:14.088Z,1591033934.088 [logger ThreadHandler](INFO): Protected caller Thread ID is 5521 2020-06-01T17:52:14.090Z,1591033934.090 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-06-01T17:52:14.091Z,1591033934.091 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-06-01T17:52:14.092Z,1591033934.092 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-06-01T17:52:14.189Z,1591033934.189 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-06-01T17:52:14.190Z,1591033934.190 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-06-01T17:52:14.874Z,1591033934.874 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-06-01T17:52:14.874Z,1591033934.874 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-06-01T17:52:15.089Z,1591033935.089 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-06-01T17:52:15.090Z,1591033935.090 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-06-01T17:52:15.193Z,1591033935.193 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-06-01T17:52:15.193Z,1591033935.193 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-06-01T17:52:15.299Z,1591033935.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-06-01T17:52:15.299Z,1591033935.299 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-06-01T17:52:15.407Z,1591033935.407 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-06-01T17:52:15.615Z,1591033935.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-06-01T17:52:15.615Z,1591033935.615 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-06-01T17:52:15.951Z,1591033935.951 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-06-01T17:52:15.952Z,1591033935.952 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-06-01T17:52:16.525Z,1591033936.525 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-06-01T17:52:16.525Z,1591033936.525 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-06-01T17:52:16.684Z,1591033936.684 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-06-01T17:52:16.684Z,1591033936.684 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-06-01T17:52:16.882Z,1591033936.882 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-06-01T17:52:16.882Z,1591033936.882 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-06-01T17:52:17.465Z,1591033937.465 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-06-01T17:52:17.465Z,1591033937.465 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-06-01T17:52:17.719Z,1591033937.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-06-01T17:52:17.719Z,1591033937.719 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-06-01T17:52:17.957Z,1591033937.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-06-01T17:52:17.957Z,1591033937.957 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-06-01T17:52:18.476Z,1591033938.476 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-06-01T17:52:18.476Z,1591033938.476 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-06-01T17:52:18.866Z,1591033938.866 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-06-01T17:52:18.868Z,1591033938.868 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-06-01T17:52:18.869Z,1591033938.869 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-06-01T17:52:19.101Z,1591033939.101 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-06-01T17:52:19.469Z,1591033939.469 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-06-01T17:52:19.684Z,1591033939.684 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-06-01T17:52:19.768Z,1591033939.768 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-06-01T17:52:19.862Z,1591033939.862 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-06-01T17:52:20.086Z,1591033940.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-06-01T17:52:20.387Z,1591033940.387 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-06-01T17:52:20.388Z,1591033940.388 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-06-01T17:52:20.481Z,1591033940.481 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-06-01T17:52:20.580Z,1591033940.580 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-06-01T17:52:20.727Z,1591033940.727 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-06-01T17:52:20.827Z,1591033940.827 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2020-06-01T17:52:20.828Z,1591033940.828 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-06-01T17:52:20.840Z,1591033940.840 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-06-01T17:52:20.918Z,1591033940.918 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-06-01T17:52:20.919Z,1591033940.919 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-06-01T17:52:20.969Z,1591033940.969 [VerticalControl](DEBUG): Construct VerticalControl. 2020-06-01T17:52:21.105Z,1591033941.105 [VerticalControl] Loaded 2020-06-01T17:52:21.105Z,1591033941.105 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-06-01T17:52:21.106Z,1591033941.106 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-06-01T17:52:21.205Z,1591033941.205 [HorizontalControl] Loaded 2020-06-01T17:52:21.205Z,1591033941.205 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-06-01T17:52:21.206Z,1591033941.206 [SpeedControl](DEBUG): Construct SpeedControl. 2020-06-01T17:52:21.213Z,1591033941.213 [SpeedControl] Loaded 2020-06-01T17:52:21.213Z,1591033941.213 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-06-01T17:52:21.214Z,1591033941.214 [LoopControl](DEBUG): Construct LoopControl. 2020-06-01T17:52:21.215Z,1591033941.215 [LoopControl] Loaded 2020-06-01T17:52:21.215Z,1591033941.215 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-06-01T17:52:21.215Z,1591033941.215 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-06-01T17:52:21.216Z,1591033941.216 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-06-01T17:52:21.258Z,1591033941.258 [DepthRateCalculator] Loaded 2020-06-01T17:52:21.258Z,1591033941.258 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-06-01T17:52:21.265Z,1591033941.265 [PitchRateCalculator] Loaded 2020-06-01T17:52:21.265Z,1591033941.265 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-06-01T17:52:21.283Z,1591033941.283 [SpeedCalculator] Loaded 2020-06-01T17:52:21.284Z,1591033941.284 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-06-01T17:52:21.310Z,1591033941.310 [TempGradientCalculator] Loaded 2020-06-01T17:52:21.310Z,1591033941.310 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-06-01T17:52:21.316Z,1591033941.316 [YawRateCalculator] Loaded 2020-06-01T17:52:21.316Z,1591033941.316 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-06-01T17:52:21.353Z,1591033941.353 [ElevatorOffsetCalculator] Loaded 2020-06-01T17:52:21.353Z,1591033941.353 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-06-01T17:52:21.354Z,1591033941.354 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-06-01T17:52:21.354Z,1591033941.354 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-06-01T17:52:21.382Z,1591033941.382 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-06-01T17:52:21.382Z,1591033941.382 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-06-01T17:52:21.467Z,1591033941.467 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-06-01T17:52:21.467Z,1591033941.467 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-06-01T17:52:21.764Z,1591033941.764 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-06-01T17:52:21.764Z,1591033941.764 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-06-01T17:52:21.866Z,1591033941.866 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-06-01T17:52:21.866Z,1591033941.866 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-06-01T17:52:22.165Z,1591033942.165 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-06-01T17:52:22.172Z,1591033942.172 [AHRS_M2](INFO): created writer for : platform_orientation 2020-06-01T17:52:22.174Z,1591033942.174 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-06-01T17:52:22.181Z,1591033942.181 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-06-01T17:52:22.181Z,1591033942.181 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-06-01T17:52:22.188Z,1591033942.188 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-06-01T17:52:22.188Z,1591033942.188 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-06-01T17:52:22.196Z,1591033942.196 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-06-01T17:52:22.291Z,1591033942.291 [AHRS_M2] Loaded 2020-06-01T17:52:22.292Z,1591033942.292 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-06-01T17:52:22.372Z,1591033942.372 [DataOverHttps] Loaded 2020-06-01T17:52:22.373Z,1591033942.373 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-06-01T17:52:22.374Z,1591033942.374 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F34E0 2020-06-01T17:52:22.374Z,1591033942.374 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5604 2020-06-01T17:52:22.391Z,1591033942.391 [Depth_Keller] Loaded 2020-06-01T17:52:22.392Z,1591033942.392 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-06-01T17:52:22.512Z,1591033942.512 [NAL9602] Loaded 2020-06-01T17:52:22.513Z,1591033942.513 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-06-01T17:52:22.558Z,1591033942.558 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now 2020-06-01T17:52:22.559Z,1591033942.559 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now 2020-06-01T17:52:22.559Z,1591033942.559 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now 2020-06-01T17:52:22.560Z,1591033942.560 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full 2020-06-01T17:52:22.560Z,1591033942.560 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now 2020-06-01T17:52:22.561Z,1591033942.561 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now 2020-06-01T17:52:22.561Z,1591033942.561 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now 2020-06-01T17:52:22.562Z,1591033942.562 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full 2020-06-01T17:52:22.562Z,1591033942.562 [Onboard] Loaded 2020-06-01T17:52:22.562Z,1591033942.562 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2020-06-01T17:52:22.567Z,1591033942.567 [Radio_Surface] Loaded 2020-06-01T17:52:22.567Z,1591033942.567 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-06-01T17:52:22.568Z,1591033942.568 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A234E0 2020-06-01T17:52:22.568Z,1591033942.568 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5605 2020-06-01T17:52:22.622Z,1591033942.622 [RDI_Pathfinder] Loaded 2020-06-01T17:52:22.622Z,1591033942.622 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2020-06-01T17:52:22.795Z,1591033942.795 [DAT] Loaded 2020-06-01T17:52:22.796Z,1591033942.796 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-06-01T17:52:24.842Z,1591033944.842 [BPC1] Loaded 2020-06-01T17:52:24.842Z,1591033944.842 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-06-01T17:52:24.842Z,1591033944.842 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-06-01T17:52:24.843Z,1591033944.843 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-06-01T17:52:25.312Z,1591033945.312 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-06-01T17:52:25.312Z,1591033945.312 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-06-01T17:52:25.338Z,1591033945.338 [NavChart] Loaded 2020-06-01T17:52:25.338Z,1591033945.338 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-06-01T17:52:25.343Z,1591033945.343 [UniversalFixResidualReporter] Loaded 2020-06-01T17:52:25.343Z,1591033945.343 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-06-01T17:52:25.344Z,1591033945.344 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-06-01T17:52:25.344Z,1591033945.344 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-06-01T17:52:25.568Z,1591033945.568 [SBIT](DEBUG): Construct Startup Built In Test. 2020-06-01T17:52:25.583Z,1591033945.583 [SBIT] Loaded 2020-06-01T17:52:25.583Z,1591033945.583 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-06-01T17:52:25.584Z,1591033945.584 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-06-01T17:52:25.600Z,1591033945.600 [IBIT] Loaded 2020-06-01T17:52:25.600Z,1591033945.600 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-06-01T17:52:25.604Z,1591033945.604 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-06-01T17:52:25.786Z,1591033945.786 [CBIT] Loaded 2020-06-01T17:52:25.786Z,1591033945.786 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-06-01T17:52:25.787Z,1591033945.787 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-06-01T17:52:25.787Z,1591033945.787 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-06-01T17:52:25.897Z,1591033945.897 [BuoyancyServo] Loaded 2020-06-01T17:52:25.897Z,1591033945.897 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-06-01T17:52:25.912Z,1591033945.912 [ElevatorServo] Loaded 2020-06-01T17:52:25.912Z,1591033945.912 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-06-01T17:52:25.927Z,1591033945.927 [MassServo] Loaded 2020-06-01T17:52:25.927Z,1591033945.927 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-06-01T17:52:25.940Z,1591033945.940 [RudderServo] Loaded 2020-06-01T17:52:25.941Z,1591033945.941 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-06-01T17:52:25.954Z,1591033945.954 [ThrusterServo] Loaded 2020-06-01T17:52:25.955Z,1591033945.955 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-06-01T17:52:25.955Z,1591033945.955 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-06-01T17:52:25.956Z,1591033945.956 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-06-01T17:52:25.975Z,1591033945.975 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-06-01T17:52:25.976Z,1591033945.976 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-06-01T17:52:26.215Z,1591033946.215 [BackSeatDriver] Loaded 2020-06-01T17:52:26.215Z,1591033946.215 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread. 2020-06-01T17:52:26.216Z,1591033946.216 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40C2C4E0 2020-06-01T17:52:26.217Z,1591033946.217 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 5606 2020-06-01T17:52:26.229Z,1591033946.229 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-06-01T17:52:26.236Z,1591033946.236 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-06-01T17:52:26.237Z,1591033946.237 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-06-01T17:52:26.243Z,1591033946.243 [CTD_Seabird](INFO): created writer for : depth 2020-06-01T17:52:26.243Z,1591033946.243 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-06-01T17:52:26.250Z,1591033946.250 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-06-01T17:52:26.251Z,1591033946.251 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-06-01T17:52:26.258Z,1591033946.258 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-06-01T17:52:26.258Z,1591033946.258 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-06-01T17:52:26.265Z,1591033946.265 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-06-01T17:52:26.266Z,1591033946.266 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-06-01T17:52:26.273Z,1591033946.273 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-06-01T17:52:26.273Z,1591033946.273 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-06-01T17:52:26.280Z,1591033946.280 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-06-01T17:52:26.317Z,1591033946.317 [CTD_Seabird] Loaded 2020-06-01T17:52:26.317Z,1591033946.317 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-06-01T17:52:26.318Z,1591033946.318 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C5C4E0 2020-06-01T17:52:26.319Z,1591033946.319 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5607 2020-06-01T17:52:26.327Z,1591033946.327 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-06-01T17:52:26.327Z,1591033946.327 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-06-01T17:52:26.332Z,1591033946.332 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-06-01T17:52:26.332Z,1591033946.332 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-06-01T17:52:26.337Z,1591033946.337 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-06-01T17:52:26.337Z,1591033946.337 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-06-01T17:52:26.342Z,1591033946.342 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-06-01T17:52:26.343Z,1591033946.343 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-06-01T17:52:26.347Z,1591033946.347 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-06-01T17:52:26.348Z,1591033946.348 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-06-01T17:52:26.353Z,1591033946.353 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-06-01T17:52:26.353Z,1591033946.353 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-06-01T17:52:26.358Z,1591033946.358 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-06-01T17:52:26.358Z,1591033946.358 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-06-01T17:52:26.363Z,1591033946.363 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.368Z,1591033946.368 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.369Z,1591033946.369 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.369Z,1591033946.369 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.374Z,1591033946.374 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.375Z,1591033946.375 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.380Z,1591033946.380 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.380Z,1591033946.380 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-06-01T17:52:26.385Z,1591033946.385 [WetLabsBB2FL] Loaded 2020-06-01T17:52:26.385Z,1591033946.385 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-06-01T17:52:26.386Z,1591033946.386 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C8C4E0 2020-06-01T17:52:26.387Z,1591033946.387 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5608 2020-06-01T17:52:26.401Z,1591033946.401 [WetLabsUBAT..SerialDriver](INFO): Created logger 2020-06-01T17:52:26.402Z,1591033946.402 [WetLabsUBAT..SerialDriver](INFO): publishing on LCM channel WetLabsUBAT 2020-06-01T17:52:26.402Z,1591033946.402 [WetLabsUBAT..StreamSerialDriver](INFO): Created logger 2020-06-01T17:52:26.408Z,1591033946.408 [WetLabsUBAT](INFO): readConfig(): serialNo_: UBAT0051, uartName_: /dev/ttyC1, optionalArgs_: -ldir /mnt/mmc/LRAUV/Logs/latest 2020-06-01T17:52:26.408Z,1591033946.408 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsUBAT.biolum_potential 2020-06-01T17:52:26.408Z,1591033946.408 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(): dataName: biolum_potential 2020-06-01T17:52:26.413Z,1591033946.413 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsUBAT.flow_rate 2020-06-01T17:52:26.414Z,1591033946.414 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(): dataName: flow_rate 2020-06-01T17:52:26.420Z,1591033946.420 [WetLabsUBAT] Loaded 2020-06-01T17:52:26.420Z,1591033946.420 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2020-06-01T17:52:26.421Z,1591033946.421 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40CBC4E0 2020-06-01T17:52:26.422Z,1591033946.422 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 5609 2020-06-01T17:52:26.422Z,1591033946.422 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-06-01T17:52:26.428Z,1591033946.428 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-06-01T17:52:26.429Z,1591033946.429 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-06-01T17:52:26.439Z,1591033946.439 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-06-01T17:52:26.440Z,1591033946.440 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40CEC4E0 2020-06-01T17:52:26.440Z,1591033946.440 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5610 2020-06-01T17:52:26.447Z,1591033946.447 [Supervisor](INFO): Main Thread ID is 5517 2020-06-01T17:52:26.447Z,1591033946.447 [Supervisor](DEBUG): Running supervisor. 2020-06-01T17:52:26.447Z,1591033946.447 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5611 2020-06-01T17:52:26.451Z,1591033946.451 [controlThread ThreadHandler](INFO): Handler Thread ID is 5612 2020-06-01T17:52:26.451Z,1591033946.451 [controlThread](DEBUG): Initializing ControlThread 2020-06-01T17:52:26.452Z,1591033946.452 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-06-01T17:52:26.454Z,1591033946.454 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-06-01T17:52:26.455Z,1591033946.455 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-06-01T17:52:26.456Z,1591033946.456 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-06-01T17:52:26.456Z,1591033946.456 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-06-01T17:52:26.456Z,1591033946.456 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-06-01T17:52:26.457Z,1591033946.457 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-06-01T17:52:26.457Z,1591033946.457 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-06-01T17:52:26.458Z,1591033946.458 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-06-01T17:52:26.458Z,1591033946.458 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-06-01T17:52:26.463Z,1591033946.463 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-06-01T17:52:26.464Z,1591033946.464 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-06-01T17:52:26.464Z,1591033946.464 [SBIT](INFO): Initialize SBIT Component. 2020-06-01T17:52:26.465Z,1591033946.465 [SBIT](IMPORTANT): git: 2020-05-06_C-4-ge907442 2020-06-01T17:52:26.465Z,1591033946.465 [SBIT](INFO): git hash: e907442e8d324ef9e313fad2e4afa1f9562153e8 2020-06-01T17:52:26.465Z,1591033946.465 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-06-01T17:52:26.466Z,1591033946.466 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Thu Feb 21 11:17:40 PST 2019 2020-06-01T17:52:26.467Z,1591033946.467 [SBIT](INFO): Beginning SBIT in 76.000000 seconds. 2020-06-01T17:52:26.467Z,1591033946.467 [IBIT](INFO): Initialize IBIT Component. 2020-06-01T17:52:26.468Z,1591033946.468 [CBIT](DEBUG): Initialize CBIT Component. 2020-06-01T17:52:26.470Z,1591033946.470 [logger ThreadHandler](INFO): Handler Thread ID is 5613 2020-06-01T17:52:26.481Z,1591033946.481 [CBIT](DEBUG): Initialized mux pins. 2020-06-01T17:52:26.481Z,1591033946.481 [CBIT](DEBUG): Initializing the watchdog timer. 2020-06-01T17:52:26.489Z,1591033946.489 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5614 2020-06-01T17:52:26.490Z,1591033946.490 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-06-01T17:52:26.501Z,1591033946.501 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5615 2020-06-01T17:52:26.505Z,1591033946.505 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2020-06-01T17:52:26.505Z,1591033946.505 [CBIT](DEBUG): Initializing heartbeat. 2020-06-01T17:52:26.513Z,1591033946.513 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 5616 2020-06-01T17:52:26.533Z,1591033946.533 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5617 2020-06-01T17:52:26.534Z,1591033946.534 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-06-01T17:52:26.539Z,1591033946.539 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5619 2020-06-01T17:52:26.540Z,1591033946.540 [WetLabsBB2FL](INFO): Powering down 2020-06-01T17:52:26.569Z,1591033946.569 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 5620 2020-06-01T17:52:26.577Z,1591033946.577 [CBIT](DEBUG): Deactivating GF circuits. 2020-06-01T17:52:26.577Z,1591033946.577 [CBIT](DEBUG): Deactivating emergency mode. 2020-06-01T17:52:26.585Z,1591033946.585 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5621 2020-06-01T17:52:26.591Z,1591033946.591 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-06-01T17:52:26.592Z,1591033946.592 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-06-01T17:52:26.592Z,1591033946.592 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-06-01T17:52:26.592Z,1591033946.592 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-06-01T17:52:26.592Z,1591033946.592 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-06-01T17:52:26.592Z,1591033946.592 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-06-01T17:52:26.593Z,1591033946.593 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-06-01T17:52:26.593Z,1591033946.593 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-06-01T17:52:26.593Z,1591033946.593 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-06-01T17:52:26.593Z,1591033946.593 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-06-01T17:52:26.594Z,1591033946.594 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-06-01T17:52:26.594Z,1591033946.594 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-06-01T17:52:26.594Z,1591033946.594 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-06-01T17:52:26.594Z,1591033946.594 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-06-01T17:52:26.594Z,1591033946.594 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-06-01T17:52:26.594Z,1591033946.594 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-06-01T17:52:26.613Z,1591033946.613 [CBIT](DEBUG): Backplane powered. 2020-06-01T17:52:26.615Z,1591033946.615 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-06-01T17:52:26.626Z,1591033946.626 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-06-01T17:52:26.652Z,1591033946.652 [MissionManager](DEBUG): 2020-06-01T17:52:26.653Z,1591033946.653 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-06-01T17:52:26.732Z,1591033946.732 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-06-01T17:52:26.734Z,1591033946.734 [Default:A.Wait](DEBUG): Construct Wait. 2020-06-01T17:52:26.736Z,1591033946.736 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-06-01T17:52:26.782Z,1591033946.782 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-06-01T17:52:26.801Z,1591033946.801 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-06-01T17:52:26.808Z,1591033946.808 [Default:E.Execute](DEBUG): Construct Execute. 2020-06-01T17:52:26.833Z,1591033946.833 [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-06-01T17:52:26.853Z,1591033946.853 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,Onboard,RDI_Pathfinder,DAT,BPC1,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-06-01T17:52:26.860Z,1591033946.860 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-06-01T17:52:26.905Z,1591033946.905 [Radio_Surface](INFO): Powering up 2020-06-01T17:52:26.949Z,1591033946.949 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-06-01T17:52:26.974Z,1591033946.974 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-06-01T17:52:26.974Z,1591033946.974 [DAT](INFO): Powering up 2020-06-01T17:52:26.974Z,1591033946.974 [DAT](DEBUG): Initializing DAT. 2020-06-01T17:52:27.074Z,1591033947.074 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:27.081Z,1591033947.081 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-06-01T17:52:27.083Z,1591033947.083 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:27.097Z,1591033947.097 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-06-01T17:52:27.098Z,1591033947.098 [MassServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:27.109Z,1591033947.109 [MassServo](DEBUG): Initializing MassServo. 2020-06-01T17:52:27.110Z,1591033947.110 [RudderServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:27.117Z,1591033947.117 [RudderServo](DEBUG): Initializing RudderServo. 2020-06-01T17:52:27.118Z,1591033947.118 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:27.126Z,1591033947.126 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-06-01T17:52:27.131Z,1591033947.131 [CommandLine](FAULT): Scheduling is paused 2020-06-01T17:52:27.131Z,1591033947.131 [CBIT](INFO): Critical error at 20200601T175226 2020-06-01T17:52:27.132Z,1591033947.132 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-06-01T17:52:28.005Z,1591033948.005 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-06-01T17:52:28.005Z,1591033948.005 [RudderServo](FAULT): Rudder failed to initialize 2020-06-01T17:52:28.005Z,1591033948.005 [RudderServo] Communications Fault, FailCount= 1 2020-06-01T17:52:28.005Z,1591033948.005 [RudderServo](ERROR): Communications Fault 2020-06-01T17:52:28.117Z,1591033948.117 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-06-01T17:52:28.314Z,1591033948.314 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-06-01T17:52:28.315Z,1591033948.315 [RudderServo](INFO): Powering down 2020-06-01T17:52:28.971Z,1591033948.971 [RudderServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:29.090Z,1591033949.090 [RudderServo](DEBUG): Initializing RudderServo. 2020-06-01T17:52:29.094Z,1591033949.094 [CBIT](INFO): Clearing failed state for component RudderServo 2020-06-01T17:52:29.095Z,1591033949.095 [RudderServo] No Fault, FailCount= 1 2020-06-01T17:52:36.657Z,1591033956.657 [BuoyancyServo](ERROR): getPosition uart error serial timeout 2020-06-01T17:52:36.657Z,1591033956.657 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout 2020-06-01T17:52:36.657Z,1591033956.657 [BuoyancyServo] Communications Fault, FailCount= 1 2020-06-01T17:52:36.657Z,1591033956.657 [BuoyancyServo](ERROR): Communications Fault 2020-06-01T17:52:36.689Z,1591033956.689 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2020-06-01T17:52:37.598Z,1591033957.598 [DAT](DEBUG): 2020-06-01T17:52:37.599Z,1591033957.599 [DAT](DEBUG): Teledyne Benthos DAT-900 Series 2020-06-01T17:52:38.362Z,1591033958.362 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-06-01T17:52:38.363Z,1591033958.363 [BuoyancyServo](INFO): Powering down 2020-06-01T17:52:38.747Z,1591033958.747 [DAT](DEBUG): MF Frequency Band 2020-06-01T17:52:38.748Z,1591033958.748 [DAT](DEBUG): Directional Acoustic Transponder version 8.12.21 2020-06-01T17:52:38.749Z,1591033958.749 [DAT](DEBUG): Jun 1 2020 17:48:38 2020-06-01T17:52:38.800Z,1591033958.800 [BuoyancyServo](FAULT): LCB fault: Current Limiter Activated. 2020-06-01T17:52:38.800Z,1591033958.800 [BuoyancyServo] Hardware Fault, FailCount= 1 2020-06-01T17:52:38.800Z,1591033958.800 [BuoyancyServo](ERROR): Hardware Fault 2020-06-01T17:52:39.239Z,1591033959.239 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2020-06-01T17:52:39.240Z,1591033959.240 [BuoyancyServo] No Fault, FailCount= 1 2020-06-01T17:52:39.578Z,1591033959.578 [DAT](DEBUG): Features enabled [Bearing] 2020-06-01T17:52:39.579Z,1591033959.579 [DAT](DEBUG): CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2020-06-01T17:52:39.580Z,1591033959.580 [DAT](INFO): commRate: 800 2020-06-01T17:52:39.608Z,1591033959.608 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-06-01T17:52:39.613Z,1591033959.613 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-06-01T17:52:39.950Z,1591033959.950 [DAT](INFO): entering command mode 2020-06-01T17:52:40.373Z,1591033960.373 [DAT](DEBUG): checking for command mode acknowledgment 2020-06-01T17:52:40.780Z,1591033960.780 [DAT](DEBUG): checking for command mode acknowledgment 2020-06-01T17:52:40.789Z,1591033960.789 [DAT](INFO): command mode acknowledged 2020-06-01T17:52:40.789Z,1591033960.789 [DAT](INFO): setting verbose to 3 2020-06-01T17:52:40.891Z,1591033960.891 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.031678 2020-06-01T17:52:41.162Z,1591033961.162 [DAT](DEBUG): checking for verbose setting acknowledgment 2020-06-01T17:52:41.164Z,1591033961.164 [DAT](INFO): set verbose to 3 2020-06-01T17:52:41.578Z,1591033961.578 [DAT](INFO): setting transmit power to 8 2020-06-01T17:52:41.992Z,1591033961.992 [DAT](DEBUG): checking for transmit power setting acknowledgment 2020-06-01T17:52:42.373Z,1591033962.373 [DAT](DEBUG): checking for transmit power setting acknowledgment 2020-06-01T17:52:42.374Z,1591033962.374 [DAT](INFO): set transmit power to 8 2020-06-01T17:52:42.777Z,1591033962.777 [DAT](INFO): setting local address to 9 2020-06-01T17:52:43.204Z,1591033963.204 [DAT](DEBUG): checking for local address setting acknowledgment 2020-06-01T17:52:43.586Z,1591033963.586 [DAT](DEBUG): checking for local address setting acknowledgment 2020-06-01T17:52:43.587Z,1591033963.587 [DAT](INFO): set local address to 9 2020-06-01T17:52:52.863Z,1591033972.863 [NAL9602](INFO): Powering up NAL9602 2020-06-01T17:53:11.637Z,1591033991.637 [CommandLine](IMPORTANT): got command quit 2020-06-01T17:53:12.641Z,1591033992.641 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-01T17:53:12.641Z,1591033992.641 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-06-01T17:53:12.789Z,1591033992.789 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-06-01T17:53:12.789Z,1591033992.789 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-06-01T17:53:12.790Z,1591033992.790 [CommandLine](INFO): Join timeout helper Thread ID is 5633 2020-06-01T17:53:12.801Z,1591033992.801 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-06-01T17:53:12.801Z,1591033992.801 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-06-01T17:53:12.801Z,1591033992.801 [NavChartDb](INFO): Join timeout helper Thread ID is 5634 2020-06-01T17:53:13.490Z,1591033993.490 [NAL9602](ERROR): NAL9602 initialization error. 2020-06-01T17:53:13.490Z,1591033993.490 [NAL9602] Communications Fault, FailCount= 1 2020-06-01T17:53:13.490Z,1591033993.490 [NAL9602](ERROR): Communications Fault 2020-06-01T17:53:13.602Z,1591033993.602 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-06-01T17:53:13.870Z,1591033993.870 [NAL9602](INFO): Powering down 2020-06-01T17:53:14.375Z,1591033994.375 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-06-01T17:53:14.376Z,1591033994.376 [NavChartDb ThreadHandler](INFO): Thread cance