2020-01-08T17:55:42.945Z,1578506142.945 [Supervisor](DEBUG): Initializing supervisor. 2020-01-08T17:55:42.947Z,1578506142.947 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-01-08T17:55:42.948Z,1578506142.948 [SyncHandler](INFO): Protected caller Thread ID is 7510 2020-01-08T17:55:42.948Z,1578506142.948 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-01-08T17:55:42.949Z,1578506142.949 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-01-08T17:55:42.950Z,1578506142.950 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7511 2020-01-08T17:55:42.952Z,1578506142.952 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-01-08T17:55:42.964Z,1578506142.964 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-01-08T17:55:42.965Z,1578506142.965 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-01-08T17:55:42.965Z,1578506142.965 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7512 2020-01-08T17:55:42.966Z,1578506142.966 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-01-08T17:55:42.967Z,1578506142.967 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-01-08T17:55:42.967Z,1578506142.967 [logger ThreadHandler](INFO): Protected caller Thread ID is 7513 2020-01-08T17:55:42.969Z,1578506142.969 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-01-08T17:55:42.969Z,1578506142.969 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-01-08T17:55:42.971Z,1578506142.971 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-01-08T17:55:43.168Z,1578506143.168 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-01-08T17:55:43.169Z,1578506143.169 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-01-08T17:55:43.247Z,1578506143.247 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-01-08T17:55:43.678Z,1578506143.678 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-01-08T17:55:43.679Z,1578506143.679 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-01-08T17:55:44.005Z,1578506144.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-01-08T17:55:44.005Z,1578506144.005 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-01-08T17:55:44.099Z,1578506144.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-01-08T17:55:44.100Z,1578506144.100 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-01-08T17:55:44.394Z,1578506144.394 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-01-08T17:55:44.395Z,1578506144.395 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-01-08T17:55:44.587Z,1578506144.587 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-01-08T17:55:44.588Z,1578506144.588 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-01-08T17:55:45.053Z,1578506145.053 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-01-08T17:55:45.053Z,1578506145.053 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-01-08T17:55:45.154Z,1578506145.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-01-08T17:55:45.155Z,1578506145.155 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-01-08T17:55:45.252Z,1578506145.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-01-08T17:55:45.253Z,1578506145.253 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-01-08T17:55:45.896Z,1578506145.896 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-01-08T17:55:45.896Z,1578506145.896 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-01-08T17:55:46.380Z,1578506146.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-01-08T17:55:46.380Z,1578506146.380 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-01-08T17:55:46.575Z,1578506146.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-01-08T17:55:46.576Z,1578506146.576 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-01-08T17:55:46.719Z,1578506146.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-01-08T17:55:46.719Z,1578506146.719 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-01-08T17:55:46.866Z,1578506146.866 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-01-08T17:55:46.868Z,1578506146.868 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2020-01-08T17:55:46.868Z,1578506146.868 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2020-01-08T17:55:46.957Z,1578506146.957 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2020-01-08T17:55:47.040Z,1578506147.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2020-01-08T17:55:47.138Z,1578506147.138 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2020-01-08T17:55:47.219Z,1578506147.219 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2020-01-08T17:55:47.312Z,1578506147.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2020-01-08T17:55:47.410Z,1578506147.410 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2020-01-08T17:55:47.614Z,1578506147.614 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2020-01-08T17:55:47.689Z,1578506147.689 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2020-01-08T17:55:47.852Z,1578506147.852 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2020-01-08T17:55:48.011Z,1578506148.011 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2020-01-08T17:55:48.263Z,1578506148.263 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2020-01-08T17:55:48.985Z,1578506148.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-01-08T17:55:49.146Z,1578506149.146 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2020-01-08T17:55:49.147Z,1578506149.147 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-01-08T17:55:49.156Z,1578506149.156 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-01-08T17:55:49.205Z,1578506149.205 [VerticalControl](DEBUG): Construct VerticalControl. 2020-01-08T17:55:49.318Z,1578506149.318 [VerticalControl] Loaded 2020-01-08T17:55:49.318Z,1578506149.318 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-01-08T17:55:49.319Z,1578506149.319 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-01-08T17:55:49.388Z,1578506149.388 [HorizontalControl] Loaded 2020-01-08T17:55:49.388Z,1578506149.388 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-01-08T17:55:49.389Z,1578506149.389 [SpeedControl](DEBUG): Construct SpeedControl. 2020-01-08T17:55:49.395Z,1578506149.395 [SpeedControl] Loaded 2020-01-08T17:55:49.395Z,1578506149.395 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-01-08T17:55:49.396Z,1578506149.396 [LoopControl](DEBUG): Construct LoopControl. 2020-01-08T17:55:49.396Z,1578506149.396 [LoopControl] Loaded 2020-01-08T17:55:49.396Z,1578506149.396 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-01-08T17:55:49.397Z,1578506149.397 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-01-08T17:55:49.397Z,1578506149.397 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-01-08T17:55:49.410Z,1578506149.410 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-01-08T17:55:49.411Z,1578506149.411 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-01-08T17:55:49.510Z,1578506149.510 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-01-08T17:55:49.511Z,1578506149.511 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-01-08T17:55:49.615Z,1578506149.615 [BuoyancyServo] Loaded 2020-01-08T17:55:49.615Z,1578506149.615 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-01-08T17:55:49.626Z,1578506149.626 [ElevatorServo] Loaded 2020-01-08T17:55:49.626Z,1578506149.626 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-01-08T17:55:49.637Z,1578506149.637 [MassServo] Loaded 2020-01-08T17:55:49.638Z,1578506149.638 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-01-08T17:55:49.649Z,1578506149.649 [RudderServo] Loaded 2020-01-08T17:55:49.649Z,1578506149.649 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-01-08T17:55:49.660Z,1578506149.660 [ThrusterServo] Loaded 2020-01-08T17:55:49.660Z,1578506149.660 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-01-08T17:55:49.661Z,1578506149.661 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-01-08T17:55:49.661Z,1578506149.661 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-01-08T17:55:49.769Z,1578506149.769 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-01-08T17:55:49.769Z,1578506149.769 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-01-08T17:55:49.790Z,1578506149.790 [NavChart] Loaded 2020-01-08T17:55:49.790Z,1578506149.790 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-01-08T17:55:49.794Z,1578506149.794 [UniversalFixResidualReporter] Loaded 2020-01-08T17:55:49.794Z,1578506149.794 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-01-08T17:55:49.795Z,1578506149.795 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-01-08T17:55:49.795Z,1578506149.795 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-01-08T17:55:49.866Z,1578506149.866 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-01-08T17:55:49.866Z,1578506149.866 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-01-08T17:55:50.107Z,1578506150.107 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-01-08T17:55:50.112Z,1578506150.112 [AHRS_M2](INFO): created writer for : platform_orientation 2020-01-08T17:55:50.114Z,1578506150.114 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-01-08T17:55:50.119Z,1578506150.119 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-01-08T17:55:50.120Z,1578506150.120 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-01-08T17:55:50.124Z,1578506150.124 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-01-08T17:55:50.125Z,1578506150.125 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-01-08T17:55:50.130Z,1578506150.130 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-01-08T17:55:50.205Z,1578506150.205 [AHRS_M2] Loaded 2020-01-08T17:55:50.205Z,1578506150.205 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-01-08T17:55:50.286Z,1578506150.286 [DataOverHttps] Loaded 2020-01-08T17:55:50.286Z,1578506150.286 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-01-08T17:55:50.287Z,1578506150.287 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408644E0 2020-01-08T17:55:50.288Z,1578506150.288 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7596 2020-01-08T17:55:50.301Z,1578506150.301 [Depth_Keller] Loaded 2020-01-08T17:55:50.301Z,1578506150.301 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-01-08T17:55:50.402Z,1578506150.402 [NAL9602] Loaded 2020-01-08T17:55:50.403Z,1578506150.403 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-01-08T17:55:50.418Z,1578506150.418 [Onboard] Loaded 2020-01-08T17:55:50.419Z,1578506150.419 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2020-01-08T17:55:50.422Z,1578506150.422 [Radio_Surface] Loaded 2020-01-08T17:55:50.422Z,1578506150.422 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-01-08T17:55:50.423Z,1578506150.423 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408944E0 2020-01-08T17:55:50.424Z,1578506150.424 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7597 2020-01-08T17:55:51.918Z,1578506151.918 [BPC1] Loaded 2020-01-08T17:55:51.918Z,1578506151.918 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-01-08T17:55:51.919Z,1578506151.919 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-01-08T17:55:51.919Z,1578506151.919 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-01-08T17:55:51.960Z,1578506151.960 [DepthRateCalculator] Loaded 2020-01-08T17:55:51.960Z,1578506151.960 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-01-08T17:55:51.965Z,1578506151.965 [PitchRateCalculator] Loaded 2020-01-08T17:55:51.965Z,1578506151.965 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-01-08T17:55:51.977Z,1578506151.977 [SpeedCalculator] Loaded 2020-01-08T17:55:51.978Z,1578506151.978 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-01-08T17:55:51.000Z,1578506152.000 [TempGradientCalculator] Loaded 2020-01-08T17:55:51.000Z,1578506152.000 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-01-08T17:55:52.005Z,1578506152.005 [YawRateCalculator] Loaded 2020-01-08T17:55:52.005Z,1578506152.005 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-01-08T17:55:52.035Z,1578506152.035 [ElevatorOffsetCalculator] Loaded 2020-01-08T17:55:52.036Z,1578506152.036 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-01-08T17:55:52.036Z,1578506152.036 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-01-08T17:55:52.037Z,1578506152.037 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-01-08T17:55:52.222Z,1578506152.222 [CANONSampler] Loaded 2020-01-08T17:55:52.223Z,1578506152.223 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2020-01-08T17:55:52.232Z,1578506152.232 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-01-08T17:55:52.237Z,1578506152.237 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-01-08T17:55:52.237Z,1578506152.237 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-01-08T17:55:52.242Z,1578506152.242 [CTD_Seabird](INFO): created writer for : depth 2020-01-08T17:55:52.243Z,1578506152.243 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-01-08T17:55:52.248Z,1578506152.248 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-01-08T17:55:52.248Z,1578506152.248 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-01-08T17:55:52.253Z,1578506152.253 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-01-08T17:55:52.254Z,1578506152.254 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-01-08T17:55:52.259Z,1578506152.259 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-01-08T17:55:52.260Z,1578506152.260 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-01-08T17:55:52.265Z,1578506152.265 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-01-08T17:55:52.266Z,1578506152.266 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-01-08T17:55:52.271Z,1578506152.271 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-01-08T17:55:52.271Z,1578506152.271 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water 2020-01-08T17:55:52.276Z,1578506152.276 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water 2020-01-08T17:55:52.277Z,1578506152.277 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq 2020-01-08T17:55:52.277Z,1578506152.277 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq 2020-01-08T17:55:52.310Z,1578506152.310 [CTD_Seabird] Loaded 2020-01-08T17:55:52.310Z,1578506152.310 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-01-08T17:55:52.311Z,1578506152.311 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409964E0 2020-01-08T17:55:52.312Z,1578506152.312 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7598 2020-01-08T17:55:52.326Z,1578506152.326 [PAR_Licor] Loaded 2020-01-08T17:55:52.327Z,1578506152.327 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-01-08T17:55:52.333Z,1578506152.333 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-01-08T17:55:52.333Z,1578506152.333 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-01-08T17:55:52.337Z,1578506152.337 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-01-08T17:55:52.337Z,1578506152.337 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-01-08T17:55:52.342Z,1578506152.342 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-01-08T17:55:52.342Z,1578506152.342 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-01-08T17:55:52.346Z,1578506152.346 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-01-08T17:55:52.346Z,1578506152.346 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-01-08T17:55:52.351Z,1578506152.351 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-01-08T17:55:52.351Z,1578506152.351 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-01-08T17:55:52.355Z,1578506152.355 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-01-08T17:55:52.355Z,1578506152.355 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-01-08T17:55:52.360Z,1578506152.360 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-01-08T17:55:52.360Z,1578506152.360 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-01-08T17:55:52.364Z,1578506152.364 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.369Z,1578506152.369 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.369Z,1578506152.369 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.370Z,1578506152.370 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.374Z,1578506152.374 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.374Z,1578506152.374 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.378Z,1578506152.378 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.378Z,1578506152.378 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-01-08T17:55:52.383Z,1578506152.383 [WetLabsBB2FL] Loaded 2020-01-08T17:55:52.383Z,1578506152.383 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-01-08T17:55:52.384Z,1578506152.384 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409C64E0 2020-01-08T17:55:52.384Z,1578506152.384 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7599 2020-01-08T17:55:52.385Z,1578506152.385 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-01-08T17:55:52.386Z,1578506152.386 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-01-08T17:55:52.418Z,1578506152.418 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-01-08T17:55:52.418Z,1578506152.418 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-01-08T17:55:52.708Z,1578506152.708 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-01-08T17:55:52.709Z,1578506152.709 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-01-08T17:55:52.844Z,1578506152.844 [SBIT](DEBUG): Construct Startup Built In Test. 2020-01-08T17:55:52.856Z,1578506152.856 [SBIT] Loaded 2020-01-08T17:55:52.856Z,1578506152.856 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-01-08T17:55:52.857Z,1578506152.857 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-01-08T17:55:52.869Z,1578506152.869 [IBIT] Loaded 2020-01-08T17:55:52.869Z,1578506152.869 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-01-08T17:55:52.872Z,1578506152.872 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-01-08T17:55:53.011Z,1578506153.011 [CBIT] Loaded 2020-01-08T17:55:53.011Z,1578506153.011 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-01-08T17:55:53.011Z,1578506153.011 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-01-08T17:55:53.040Z,1578506153.040 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-01-08T17:55:53.040Z,1578506153.040 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-01-08T17:55:53.059Z,1578506153.059 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-01-08T17:55:53.060Z,1578506153.060 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC54E0 2020-01-08T17:55:53.060Z,1578506153.060 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7600 2020-01-08T17:55:53.070Z,1578506153.070 [Supervisor](INFO): Main Thread ID is 7509 2020-01-08T17:55:53.070Z,1578506153.070 [Supervisor](DEBUG): Running supervisor. 2020-01-08T17:55:53.071Z,1578506153.071 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7601 2020-01-08T17:55:53.074Z,1578506153.074 [controlThread ThreadHandler](INFO): Handler Thread ID is 7602 2020-01-08T17:55:53.074Z,1578506153.074 [controlThread](DEBUG): Initializing ControlThread 2020-01-08T17:55:53.075Z,1578506153.075 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-01-08T17:55:53.076Z,1578506153.076 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-01-08T17:55:53.077Z,1578506153.077 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-01-08T17:55:53.078Z,1578506153.078 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-01-08T17:55:53.079Z,1578506153.079 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-01-08T17:55:53.080Z,1578506153.080 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-01-08T17:55:53.082Z,1578506153.082 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-01-08T17:55:53.083Z,1578506153.083 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-01-08T17:55:53.083Z,1578506153.083 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-01-08T17:55:53.083Z,1578506153.083 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-01-08T17:55:53.084Z,1578506153.084 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-01-08T17:55:53.084Z,1578506153.084 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-01-08T17:55:53.086Z,1578506153.086 [SBIT](INFO): Initialize SBIT Component. 2020-01-08T17:55:53.086Z,1578506153.086 [SBIT](IMPORTANT): git: 2019-11-11-3-gd320370 2020-01-08T17:55:53.086Z,1578506153.086 [SBIT](INFO): git hash: d3203708d3f1ecd20247ca5ed6b734626dd89ff5 2020-01-08T17:55:53.087Z,1578506153.087 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-01-08T17:55:53.088Z,1578506153.088 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 2020-01-08T17:55:53.089Z,1578506153.089 [SBIT](INFO): Beginning SBIT in 160.000000 seconds. 2020-01-08T17:55:53.089Z,1578506153.089 [IBIT](INFO): Initialize IBIT Component. 2020-01-08T17:55:53.090Z,1578506153.090 [CBIT](DEBUG): Initialize CBIT Component. 2020-01-08T17:55:53.091Z,1578506153.091 [logger ThreadHandler](INFO): Handler Thread ID is 7603 2020-01-08T17:55:53.101Z,1578506153.101 [CBIT](DEBUG): Initialized mux pins. 2020-01-08T17:55:53.101Z,1578506153.101 [CBIT](DEBUG): Initializing the watchdog timer. 2020-01-08T17:55:53.110Z,1578506153.110 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7604 2020-01-08T17:55:53.111Z,1578506153.111 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-01-08T17:55:53.122Z,1578506153.122 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7605 2020-01-08T17:55:53.125Z,1578506153.125 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-01-08T17:55:53.125Z,1578506153.125 [CBIT](DEBUG): Initializing heartbeat. 2020-01-08T17:55:53.134Z,1578506153.134 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7606 2020-01-08T17:55:53.134Z,1578506153.134 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-01-08T17:55:53.138Z,1578506153.138 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2020-01-08T17:55:53.139Z,1578506153.139 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7608 2020-01-08T17:55:53.140Z,1578506153.140 [WetLabsBB2FL](INFO): Powering down 2020-01-08T17:55:53.174Z,1578506153.174 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7609 2020-01-08T17:55:53.177Z,1578506153.177 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-01-08T17:55:53.177Z,1578506153.177 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-01-08T17:55:53.178Z,1578506153.178 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-01-08T17:55:53.178Z,1578506153.178 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-01-08T17:55:53.178Z,1578506153.178 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-01-08T17:55:53.178Z,1578506153.178 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-01-08T17:55:53.178Z,1578506153.178 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-01-08T17:55:53.178Z,1578506153.178 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-01-08T17:55:53.179Z,1578506153.179 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-01-08T17:55:53.179Z,1578506153.179 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-01-08T17:55:53.179Z,1578506153.179 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-01-08T17:55:53.179Z,1578506153.179 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-01-08T17:55:53.179Z,1578506153.179 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-01-08T17:55:53.180Z,1578506153.180 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-01-08T17:55:53.180Z,1578506153.180 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-01-08T17:55:53.180Z,1578506153.180 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-01-08T17:55:53.198Z,1578506153.198 [CBIT](DEBUG): Deactivating GF circuits. 2020-01-08T17:55:53.198Z,1578506153.198 [CBIT](DEBUG): Deactivating emergency mode. 2020-01-08T17:55:53.233Z,1578506153.233 [CBIT](DEBUG): Backplane powered. 2020-01-08T17:55:53.234Z,1578506153.234 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-01-08T17:55:53.244Z,1578506153.244 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-01-08T17:55:53.254Z,1578506153.254 [MissionManager](DEBUG): 2020-01-08T17:55:53.255Z,1578506153.255 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-01-08T17:55:53.322Z,1578506153.322 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-01-08T17:55:53.323Z,1578506153.323 [Default:A.Wait](DEBUG): Construct Wait. 2020-01-08T17:55:53.324Z,1578506153.324 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-01-08T17:55:53.371Z,1578506153.371 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-01-08T17:55:53.373Z,1578506153.373 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-01-08T17:55:53.395Z,1578506153.395 [Default:E.Execute](DEBUG): Construct Execute. 2020-01-08T17:55:53.398Z,1578506153.398 [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-01-08T17:55:53.413Z,1578506153.413 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,Onboard,BPC1,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2020-01-08T17:55:53.425Z,1578506153.425 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-01-08T17:55:53.486Z,1578506153.486 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar 2020-01-08T17:55:53.525Z,1578506153.525 [Radio_Surface](INFO): Powering up 2020-01-08T17:55:53.534Z,1578506153.534 [CANONSampler](INFO): Powering down 2020-01-08T17:55:53.717Z,1578506153.717 [DepthRateCalculator](ERROR): Depth measurement is not active 2020-01-08T17:55:53.742Z,1578506153.742 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-01-08T17:55:53.750Z,1578506153.750 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-01-08T17:55:53.751Z,1578506153.751 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-01-08T17:55:53.758Z,1578506153.758 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-01-08T17:55:53.758Z,1578506153.758 [MassServo](DEBUG): Initializing EZServoServo. 2020-01-08T17:55:53.766Z,1578506153.766 [MassServo](DEBUG): Initializing MassServo. 2020-01-08T17:55:53.766Z,1578506153.766 [RudderServo](DEBUG): Initializing EZServoServo. 2020-01-08T17:55:53.774Z,1578506153.774 [RudderServo](DEBUG): Initializing RudderServo. 2020-01-08T17:55:53.774Z,1578506153.774 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-01-08T17:55:53.782Z,1578506153.782 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-01-08T17:55:54.605Z,1578506154.605 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-01-08T17:55:54.605Z,1578506154.605 [RudderServo](FAULT): Rudder failed to initialize 2020-01-08T17:55:54.606Z,1578506154.606 [RudderServo] Communications Fault, FailCount= 1 2020-01-08T17:55:54.606Z,1578506154.606 [RudderServo](ERROR): Communications Fault 2020-01-08T17:55:54.764Z,1578506154.764 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-01-08T17:55:54.994Z,1578506154.994 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-01-08T17:55:54.995Z,1578506154.995 [RudderServo](INFO): Powering down 2020-01-08T17:55:55.649Z,1578506155.649 [RudderServo](DEBUG): Initializing EZServoServo. 2020-01-08T17:55:55.766Z,1578506155.766 [RudderServo](DEBUG): Initializing RudderServo. 2020-01-08T17:55:55.770Z,1578506155.770 [CBIT](INFO): Clearing failed state for component RudderServo 2020-01-08T17:55:55.770Z,1578506155.770 [RudderServo] No Fault, FailCount= 1 2020-01-08T17:56:00.166Z,1578506160.166 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2020-01-08T17:56:01.603Z,1578506161.603 [CommandLine](IMPORTANT): got command restart application 2020-01-08T17:56:02.610Z,1578506162.610 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2020-01-08T17:56:02.611Z,1578506162.611 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:02.611Z,1578506162.611 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:02.625Z,1578506162.625 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-01-08T17:56:02.625Z,1578506162.625 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:02.626Z,1578506162.626 [CommandLine](INFO): Join timeout helper Thread ID is 7618 2020-01-08T17:56:02.657Z,1578506162.657 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-01-08T17:56:02.657Z,1578506162.657 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:02.658Z,1578506162.658 [NavChartDb](INFO): Join timeout helper Thread ID is 7619 2020-01-08T17:56:10.011Z,1578506170.011 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004567 2020-01-08T17:56:10.370Z,1578506170.370 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:10.370Z,1578506170.370 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:10.389Z,1578506170.389 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-01-08T17:56:10.389Z,1578506170.389 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:10.390Z,1578506170.390 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7620 2020-01-08T17:56:10.786Z,1578506170.786 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:10.786Z,1578506170.786 [WetLabsBB2FL](INFO): Powering down 2020-01-08T17:56:10.787Z,1578506170.787 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:10.801Z,1578506170.801 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-01-08T17:56:10.801Z,1578506170.801 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:10.802Z,1578506170.802 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7621 2020-01-08T17:56:11.205Z,1578506171.205 [CTD_Seabird](INFO): Powering down 2020-01-08T17:56:11.217Z,1578506171.217 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:11.218Z,1578506171.218 [CTD_Seabird](INFO): Powering down 2020-01-08T17:56:11.229Z,1578506171.229 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:11.237Z,1578506171.237 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-01-08T17:56:11.237Z,1578506171.237 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:11.238Z,1578506171.238 [Radio_Surface](INFO): Join timeout helper Thread ID is 7622 2020-01-08T17:56:11.301Z,1578506171.301 [Radio_Surface](INFO): Powering down 2020-01-08T17:56:11.302Z,1578506171.302 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:11.302Z,1578506171.302 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:11.310Z,1578506171.310 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-01-08T17:56:11.310Z,1578506171.310 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:11.311Z,1578506171.311 [DataOverHttps](INFO): Join timeout helper Thread ID is 7623 2020-01-08T17:56:12.013Z,1578506172.013 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:12.014Z,1578506172.014 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.022Z,1578506172.022 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-01-08T17:56:12.022Z,1578506172.022 [logger ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.023Z,1578506172.023 [logger](INFO): Join timeout helper Thread ID is 7624 2020-01-08T17:56:12.038Z,1578506172.038 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:12.038Z,1578506172.038 [logger ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.054Z,1578506172.054 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-01-08T17:56:12.054Z,1578506172.054 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.054Z,1578506172.054 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-01-08T17:56:12.054Z,1578506172.054 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.055Z,1578506172.055 [controlThread](INFO): Join timeout helper Thread ID is 7625 2020-01-08T17:56:12.197Z,1578506172.197 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-01-08T17:56:12.198Z,1578506172.198 [controlThread](DEBUG): Uninitializing ControlThread 2020-01-08T17:56:12.198Z,1578506172.198 [AHRS_M2](INFO): Powering down 2020-01-08T17:56:12.270Z,1578506172.270 [NAL9602](INFO): Powering down 2020-01-08T17:56:12.291Z,1578506172.291 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-01-08T17:56:12.292Z,1578506172.292 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-01-08T17:56:12.292Z,1578506172.292 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-01-08T17:56:12.293Z,1578506172.293 [MissionManager](INFO): Uninitializing Mission Default 2020-01-08T17:56:12.295Z,1578506172.295 [MissionManager](INFO): Uninitializing Mission Startup 2020-01-08T17:56:12.296Z,1578506172.296 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-01-08T17:56:12.296Z,1578506172.296 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-01-08T17:56:12.296Z,1578506172.296 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-01-08T17:56:12.297Z,1578506172.297 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-01-08T17:56:12.297Z,1578506172.297 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-01-08T17:56:12.297Z,1578506172.297 [BuoyancyServo](INFO): Powering down 2020-01-08T17:56:12.309Z,1578506172.309 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-01-08T17:56:12.309Z,1578506172.309 [ElevatorServo](INFO): Powering down 2020-01-08T17:56:12.328Z,1578506172.328 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-01-08T17:56:12.329Z,1578506172.329 [MassServo](INFO): Powering down 2020-01-08T17:56:12.348Z,1578506172.348 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-01-08T17:56:12.348Z,1578506172.348 [RudderServo](INFO): Powering down 2020-01-08T17:56:12.349Z,1578506172.349 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-01-08T17:56:12.349Z,1578506172.349 [ThrusterServo](INFO): Powering down 2020-01-08T17:56:12.350Z,1578506172.350 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-01-08T17:56:12.350Z,1578506172.350 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-01-08T17:56:12.350Z,1578506172.350 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-01-08T17:56:12.350Z,1578506172.350 [CBIT](DEBUG): Powering off loads. 2020-01-08T17:56:12.361Z,1578506172.361 [CBIT](DEBUG): Disabling WDT. 2020-01-08T17:56:12.373Z,1578506172.373 [CBIT](DEBUG): Opening all GF detection circuits. 2020-01-08T17:56:12.374Z,1578506172.374 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.690Z,1578506172.690 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.695Z,1578506172.695 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.726Z,1578506172.726 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.730Z,1578506172.730 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.765Z,1578506172.765 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-01-08T17:56:12.822Z,1578506172.822 [logger ThreadHandler](INFO): Thread cancelled.