2020-05-18T21:35:02.951Z,1589837702.951 [Supervisor](DEBUG): Initializing supervisor. 2020-05-18T21:35:02.954Z,1589837702.954 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-05-18T21:35:02.955Z,1589837702.955 [SyncHandler](INFO): Protected caller Thread ID is 3423 2020-05-18T21:35:02.956Z,1589837702.956 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-05-18T21:35:02.957Z,1589837702.957 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-05-18T21:35:02.957Z,1589837702.957 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3424 2020-05-18T21:35:02.960Z,1589837702.960 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-05-18T21:35:02.973Z,1589837702.973 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-05-18T21:35:02.974Z,1589837702.974 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-05-18T21:35:02.974Z,1589837702.974 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3425 2020-05-18T21:35:02.975Z,1589837702.975 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-05-18T21:35:02.976Z,1589837702.976 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-05-18T21:35:02.976Z,1589837702.976 [logger ThreadHandler](INFO): Protected caller Thread ID is 3426 2020-05-18T21:35:02.978Z,1589837702.978 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-05-18T21:35:02.979Z,1589837702.979 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-05-18T21:35:02.980Z,1589837702.980 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-05-18T21:35:03.074Z,1589837703.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-05-18T21:35:03.075Z,1589837703.075 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-05-18T21:35:03.268Z,1589837703.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-05-18T21:35:03.268Z,1589837703.268 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-05-18T21:35:03.400Z,1589837703.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-05-18T21:35:03.401Z,1589837703.401 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-05-18T21:35:03.993Z,1589837703.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-05-18T21:35:03.993Z,1589837703.993 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-05-18T21:35:04.435Z,1589837704.435 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-05-18T21:35:04.436Z,1589837704.436 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-05-18T21:35:04.892Z,1589837704.892 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-05-18T21:35:04.892Z,1589837704.892 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-05-18T21:35:05.178Z,1589837705.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-05-18T21:35:05.178Z,1589837705.178 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-05-18T21:35:05.484Z,1589837705.484 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-05-18T21:35:05.485Z,1589837705.485 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-05-18T21:35:06.042Z,1589837706.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-05-18T21:35:06.042Z,1589837706.042 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-05-18T21:35:06.292Z,1589837706.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-05-18T21:35:06.293Z,1589837706.293 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-05-18T21:35:06.464Z,1589837706.464 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-05-18T21:35:06.465Z,1589837706.465 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-05-18T21:35:06.594Z,1589837706.594 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-05-18T21:35:06.741Z,1589837706.741 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-05-18T21:35:06.741Z,1589837706.741 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-05-18T21:35:07.085Z,1589837707.085 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-05-18T21:35:07.086Z,1589837707.086 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-05-18T21:35:07.486Z,1589837707.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-05-18T21:35:07.488Z,1589837707.488 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2020-05-18T21:35:07.489Z,1589837707.489 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2020-05-18T21:35:07.666Z,1589837707.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2020-05-18T21:35:08.113Z,1589837708.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-05-18T21:35:08.113Z,1589837708.113 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2020-05-18T21:35:08.276Z,1589837708.276 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2020-05-18T21:35:08.556Z,1589837708.556 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2020-05-18T21:35:08.919Z,1589837708.919 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2020-05-18T21:35:09.049Z,1589837709.049 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2020-05-18T21:35:09.205Z,1589837709.205 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2020-05-18T21:35:09.357Z,1589837709.357 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2020-05-18T21:35:09.621Z,1589837709.621 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2020-05-18T21:35:09.784Z,1589837709.784 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2020-05-18T21:35:09.938Z,1589837709.938 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2020-05-18T21:35:09.939Z,1589837709.939 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-05-18T21:35:09.950Z,1589837709.950 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-05-18T21:35:10.143Z,1589837710.143 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-05-18T21:35:10.144Z,1589837710.144 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-05-18T21:35:10.373Z,1589837710.373 [BuoyancyServo] Loaded 2020-05-18T21:35:10.374Z,1589837710.374 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-05-18T21:35:10.401Z,1589837710.401 [ElevatorServo] Loaded 2020-05-18T21:35:10.401Z,1589837710.401 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-05-18T21:35:10.429Z,1589837710.429 [MassServo] Loaded 2020-05-18T21:35:10.430Z,1589837710.430 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-05-18T21:35:10.469Z,1589837710.469 [RudderServo] Loaded 2020-05-18T21:35:10.469Z,1589837710.469 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-05-18T21:35:10.508Z,1589837710.508 [ThrusterServo] Loaded 2020-05-18T21:35:10.508Z,1589837710.508 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-05-18T21:35:10.509Z,1589837710.509 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-05-18T21:35:10.509Z,1589837710.509 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-05-18T21:35:10.779Z,1589837710.779 [SBIT](DEBUG): Construct Startup Built In Test. 2020-05-18T21:35:10.844Z,1589837710.844 [SBIT] Loaded 2020-05-18T21:35:10.844Z,1589837710.844 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-05-18T21:35:10.845Z,1589837710.845 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-05-18T21:35:10.898Z,1589837710.898 [IBIT] Loaded 2020-05-18T21:35:10.899Z,1589837710.899 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-05-18T21:35:10.902Z,1589837710.902 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-05-18T21:35:11.714Z,1589837711.714 [CBIT] Loaded 2020-05-18T21:35:11.714Z,1589837711.714 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-05-18T21:35:11.715Z,1589837711.715 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-05-18T21:35:11.715Z,1589837711.715 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-05-18T21:35:12.136Z,1589837712.136 [ESPComponent] Loaded 2020-05-18T21:35:12.136Z,1589837712.136 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2020-05-18T21:35:12.163Z,1589837712.163 [PAR_Licor] Loaded 2020-05-18T21:35:12.163Z,1589837712.163 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-05-18T21:35:12.182Z,1589837712.182 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-05-18T21:35:12.182Z,1589837712.182 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-05-18T21:35:12.188Z,1589837712.188 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-05-18T21:35:12.188Z,1589837712.188 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-05-18T21:35:12.205Z,1589837712.205 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-05-18T21:35:12.205Z,1589837712.205 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-05-18T21:35:12.209Z,1589837712.209 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-05-18T21:35:12.210Z,1589837712.210 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-05-18T21:35:12.214Z,1589837712.214 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-05-18T21:35:12.214Z,1589837712.214 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-05-18T21:35:12.231Z,1589837712.231 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-05-18T21:35:12.231Z,1589837712.231 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-05-18T21:35:12.235Z,1589837712.235 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-05-18T21:35:12.236Z,1589837712.236 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-05-18T21:35:12.252Z,1589837712.252 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.257Z,1589837712.257 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.258Z,1589837712.258 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.258Z,1589837712.258 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.262Z,1589837712.262 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.262Z,1589837712.262 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.279Z,1589837712.279 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.279Z,1589837712.279 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-05-18T21:35:12.284Z,1589837712.284 [WetLabsBB2FL] Loaded 2020-05-18T21:35:12.284Z,1589837712.284 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-05-18T21:35:12.291Z,1589837712.291 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406764E0 2020-05-18T21:35:12.291Z,1589837712.291 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3505 2020-05-18T21:35:12.292Z,1589837712.292 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-05-18T21:35:12.293Z,1589837712.293 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-05-18T21:35:12.370Z,1589837712.370 [DepthRateCalculator] Loaded 2020-05-18T21:35:12.370Z,1589837712.370 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-05-18T21:35:12.388Z,1589837712.388 [PitchRateCalculator] Loaded 2020-05-18T21:35:12.388Z,1589837712.388 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-05-18T21:35:12.416Z,1589837712.416 [SpeedCalculator] Loaded 2020-05-18T21:35:12.417Z,1589837712.417 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-05-18T21:35:12.445Z,1589837712.445 [TempGradientCalculator] Loaded 2020-05-18T21:35:12.445Z,1589837712.445 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-05-18T21:35:12.451Z,1589837712.451 [YawRateCalculator] Loaded 2020-05-18T21:35:12.451Z,1589837712.451 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-05-18T21:35:12.483Z,1589837712.483 [ElevatorOffsetCalculator] Loaded 2020-05-18T21:35:12.484Z,1589837712.484 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-05-18T21:35:12.484Z,1589837712.484 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-05-18T21:35:12.485Z,1589837712.485 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-05-18T21:35:12.629Z,1589837712.629 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-05-18T21:35:12.651Z,1589837712.651 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-05-18T21:35:13.037Z,1589837713.037 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-05-18T21:35:13.037Z,1589837713.037 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-05-18T21:35:13.087Z,1589837713.087 [NavChart] Loaded 2020-05-18T21:35:13.088Z,1589837713.088 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-05-18T21:35:13.092Z,1589837713.092 [UniversalFixResidualReporter] Loaded 2020-05-18T21:35:13.092Z,1589837713.092 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-05-18T21:35:13.092Z,1589837713.092 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-05-18T21:35:13.093Z,1589837713.093 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-05-18T21:35:13.543Z,1589837713.543 [DataOverHttps] Loaded 2020-05-18T21:35:13.543Z,1589837713.543 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-05-18T21:35:13.544Z,1589837713.544 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409634E0 2020-05-18T21:35:13.545Z,1589837713.545 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3506 2020-05-18T21:35:13.558Z,1589837713.558 [Depth_Keller] Loaded 2020-05-18T21:35:13.559Z,1589837713.559 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-05-18T21:35:13.563Z,1589837713.563 [DropWeight] Loaded 2020-05-18T21:35:13.564Z,1589837713.564 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2020-05-18T21:35:13.658Z,1589837713.658 [NAL9602] Loaded 2020-05-18T21:35:13.658Z,1589837713.658 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-05-18T21:35:13.687Z,1589837713.687 [Onboard] Loaded 2020-05-18T21:35:13.687Z,1589837713.687 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2020-05-18T21:35:13.690Z,1589837713.690 [Radio_Surface] Loaded 2020-05-18T21:35:13.691Z,1589837713.691 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-05-18T21:35:13.692Z,1589837713.692 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409934E0 2020-05-18T21:35:13.692Z,1589837713.692 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3507 2020-05-18T21:35:13.826Z,1589837713.826 [DAT] Loaded 2020-05-18T21:35:13.826Z,1589837713.826 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-05-18T21:35:15.103Z,1589837715.103 [BPC1] Loaded 2020-05-18T21:35:15.104Z,1589837715.104 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-05-18T21:35:15.104Z,1589837715.104 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-05-18T21:35:15.104Z,1589837715.104 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-05-18T21:35:15.186Z,1589837715.186 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-05-18T21:35:15.187Z,1589837715.187 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-05-18T21:35:15.235Z,1589837715.235 [VerticalControl](DEBUG): Construct VerticalControl. 2020-05-18T21:35:15.317Z,1589837715.317 [VerticalControl] Loaded 2020-05-18T21:35:15.318Z,1589837715.318 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-05-18T21:35:15.318Z,1589837715.318 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-05-18T21:35:15.388Z,1589837715.388 [HorizontalControl] Loaded 2020-05-18T21:35:15.388Z,1589837715.388 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-05-18T21:35:15.389Z,1589837715.389 [SpeedControl](DEBUG): Construct SpeedControl. 2020-05-18T21:35:15.390Z,1589837715.390 [SpeedControl] Loaded 2020-05-18T21:35:15.391Z,1589837715.391 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-05-18T21:35:15.391Z,1589837715.391 [LoopControl](DEBUG): Construct LoopControl. 2020-05-18T21:35:15.392Z,1589837715.392 [LoopControl] Loaded 2020-05-18T21:35:15.392Z,1589837715.392 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-05-18T21:35:15.393Z,1589837715.393 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-05-18T21:35:15.393Z,1589837715.393 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-05-18T21:35:15.412Z,1589837715.412 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-05-18T21:35:15.412Z,1589837715.412 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-05-18T21:35:15.726Z,1589837715.726 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-05-18T21:35:15.729Z,1589837715.729 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-05-18T21:35:15.730Z,1589837715.730 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-05-18T21:35:15.737Z,1589837715.737 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-05-18T21:35:15.738Z,1589837715.738 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD44E0 2020-05-18T21:35:15.738Z,1589837715.738 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3508 2020-05-18T21:35:15.742Z,1589837715.742 [Supervisor](INFO): Main Thread ID is 2717 2020-05-18T21:35:15.742Z,1589837715.742 [Supervisor](DEBUG): Running supervisor. 2020-05-18T21:35:15.743Z,1589837715.743 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3509 2020-05-18T21:35:15.746Z,1589837715.746 [controlThread ThreadHandler](INFO): Handler Thread ID is 3510 2020-05-18T21:35:15.746Z,1589837715.746 [controlThread](DEBUG): Initializing ControlThread 2020-05-18T21:35:15.748Z,1589837715.748 [SBIT](INFO): Initialize SBIT Component. 2020-05-18T21:35:15.748Z,1589837715.748 [SBIT](IMPORTANT): git: 2020-02-26-39-g5ba86ef19 2020-05-18T21:35:15.749Z,1589837715.749 [SBIT](INFO): git hash: 5ba86ef19446a3a7971077fddc96013a7a660a2f 2020-05-18T21:35:15.749Z,1589837715.749 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-05-18T21:35:15.750Z,1589837715.750 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019 2020-05-18T21:35:15.751Z,1589837715.751 [SBIT](INFO): Beginning SBIT in 72.000000 seconds. 2020-05-18T21:35:15.752Z,1589837715.752 [IBIT](INFO): Initialize IBIT Component. 2020-05-18T21:35:15.753Z,1589837715.753 [CBIT](DEBUG): Initialize CBIT Component. 2020-05-18T21:35:15.754Z,1589837715.754 [logger ThreadHandler](INFO): Handler Thread ID is 3511 2020-05-18T21:35:15.767Z,1589837715.767 [CBIT](DEBUG): Initialized mux pins. 2020-05-18T21:35:15.767Z,1589837715.767 [CBIT](DEBUG): Initializing the watchdog timer. 2020-05-18T21:35:15.779Z,1589837715.779 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3512 2020-05-18T21:35:15.780Z,1589837715.780 [WetLabsBB2FL](INFO): Powering down 2020-05-18T21:35:15.791Z,1589837715.791 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-05-18T21:35:15.791Z,1589837715.791 [CBIT](DEBUG): Initializing heartbeat. 2020-05-18T21:35:15.819Z,1589837715.819 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3513 2020-05-18T21:35:15.820Z,1589837715.820 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-05-18T21:35:15.832Z,1589837715.832 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3514 2020-05-18T21:35:15.843Z,1589837715.843 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3515 2020-05-18T21:35:15.846Z,1589837715.846 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-05-18T21:35:15.847Z,1589837715.847 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-05-18T21:35:15.847Z,1589837715.847 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-05-18T21:35:15.847Z,1589837715.847 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-05-18T21:35:15.847Z,1589837715.847 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-05-18T21:35:15.847Z,1589837715.847 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-05-18T21:35:15.848Z,1589837715.848 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-05-18T21:35:15.848Z,1589837715.848 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-05-18T21:35:15.848Z,1589837715.848 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-05-18T21:35:15.848Z,1589837715.848 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-05-18T21:35:15.848Z,1589837715.848 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-05-18T21:35:15.848Z,1589837715.848 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-05-18T21:35:15.849Z,1589837715.849 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-05-18T21:35:15.849Z,1589837715.849 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-05-18T21:35:15.849Z,1589837715.849 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-05-18T21:35:15.849Z,1589837715.849 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-05-18T21:35:15.863Z,1589837715.863 [CBIT](DEBUG): Deactivating GF circuits. 2020-05-18T21:35:15.863Z,1589837715.863 [CBIT](DEBUG): Deactivating emergency mode. 2020-05-18T21:35:15.899Z,1589837715.899 [CBIT](DEBUG): Backplane powered. 2020-05-18T21:35:15.903Z,1589837715.903 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-05-18T21:35:15.904Z,1589837715.904 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-05-18T21:35:15.904Z,1589837715.904 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-05-18T21:35:15.904Z,1589837715.904 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-05-18T21:35:15.905Z,1589837715.905 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-05-18T21:35:15.905Z,1589837715.905 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-05-18T21:35:15.906Z,1589837715.906 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-05-18T21:35:15.907Z,1589837715.907 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-05-18T21:35:15.918Z,1589837715.918 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-05-18T21:35:15.928Z,1589837715.928 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-05-18T21:35:15.928Z,1589837715.928 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-05-18T21:35:15.929Z,1589837715.929 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-05-18T21:35:15.930Z,1589837715.930 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-05-18T21:35:15.967Z,1589837715.967 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-05-18T21:35:15.990Z,1589837715.990 [MissionManager](DEBUG): 2020-05-18T21:35:15.991Z,1589837715.991 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-05-18T21:35:16.064Z,1589837716.064 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-05-18T21:35:16.065Z,1589837716.065 [Default:A.Wait](DEBUG): Construct Wait. 2020-05-18T21:35:16.067Z,1589837716.067 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-05-18T21:35:16.090Z,1589837716.090 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-05-18T21:35:16.120Z,1589837716.120 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-05-18T21:35:16.129Z,1589837716.129 [Default:E.Execute](DEBUG): Construct Execute. 2020-05-18T21:35:16.147Z,1589837716.147 [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-05-18T21:35:16.152Z,1589837716.152 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,Depth_Keller,DropWeight,NAL9602,Onboard,DAT,BPC1,PAR_Licor,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-05-18T21:35:16.235Z,1589837716.235 [Radio_Surface](INFO): Powering up 2020-05-18T21:35:16.298Z,1589837716.298 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-05-18T21:35:16.299Z,1589837716.299 [DAT](INFO): Powering up 2020-05-18T21:35:16.299Z,1589837716.299 [DAT](DEBUG): Initializing DAT. 2020-05-18T21:35:16.355Z,1589837716.355 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-05-18T21:35:16.433Z,1589837716.433 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-05-18T21:35:16.443Z,1589837716.443 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-05-18T21:35:16.444Z,1589837716.444 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-05-18T21:35:16.455Z,1589837716.455 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-05-18T21:35:16.456Z,1589837716.456 [MassServo](DEBUG): Initializing EZServoServo. 2020-05-18T21:35:16.467Z,1589837716.467 [MassServo](DEBUG): Initializing MassServo. 2020-05-18T21:35:16.468Z,1589837716.468 [RudderServo](DEBUG): Initializing EZServoServo. 2020-05-18T21:35:16.479Z,1589837716.479 [RudderServo](DEBUG): Initializing RudderServo. 2020-05-18T21:35:16.480Z,1589837716.480 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-05-18T21:35:16.491Z,1589837716.491 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-05-18T21:35:16.604Z,1589837716.604 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-05-18T21:35:16.604Z,1589837716.604 [DropWeight] Hardware Fault, FailCount= 1 2020-05-18T21:35:16.604Z,1589837716.604 [DropWeight](ERROR): Hardware Fault 2020-05-18T21:35:16.684Z,1589837716.684 [CommandLine](FAULT): Scheduling is paused 2020-05-18T21:35:16.685Z,1589837716.685 [CBIT](INFO): Critical error at 20200518T213516 2020-05-18T21:35:16.685Z,1589837716.685 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-05-18T21:35:16.687Z,1589837716.687 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-05-18T21:35:16.688Z,1589837716.688 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-05-18T21:35:17.311Z,1589837717.311 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-05-18T21:35:17.311Z,1589837717.311 [RudderServo](FAULT): Rudder failed to initialize 2020-05-18T21:35:17.311Z,1589837717.311 [RudderServo] Communications Fault, FailCount= 1 2020-05-18T21:35:17.311Z,1589837717.311 [RudderServo](ERROR): Communications Fault 2020-05-18T21:35:17.444Z,1589837717.444 [CBIT](INFO): Critical error at 20200518T213516 2020-05-18T21:35:17.447Z,1589837717.447 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-05-18T21:35:17.672Z,1589837717.672 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-05-18T21:35:17.672Z,1589837717.672 [RudderServo](INFO): Powering down 2020-05-18T21:35:18.314Z,1589837718.314 [RudderServo](DEBUG): Initializing EZServoServo. 2020-05-18T21:35:18.432Z,1589837718.432 [RudderServo](DEBUG): Initializing RudderServo. 2020-05-18T21:35:18.436Z,1589837718.436 [CBIT](INFO): Clearing failed state for component RudderServo 2020-05-18T21:35:18.436Z,1589837718.436 [RudderServo] No Fault, FailCount= 1 2020-05-18T21:35:19.956Z,1589837719.956 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:35:43.720Z,1589837743.720 [NAL9602](INFO): Powering up NAL9602 2020-05-18T21:35:52.271Z,1589837752.271 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:35:54.628Z,1589837754.628 [NAL9602](INFO): NAL9602 initialized 2020-05-18T21:36:16.483Z,1589837776.483 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2020-05-18T21:36:16.483Z,1589837776.483 [DAT] Communications Fault, FailCount= 1 2020-05-18T21:36:16.483Z,1589837776.483 [DAT](ERROR): Communications Fault 2020-05-18T21:36:16.525Z,1589837776.525 [CBIT](ERROR): Communications Fault in component: DAT 2020-05-18T21:36:16.869Z,1589837776.869 [DAT](INFO): Powering down 2020-05-18T21:36:17.688Z,1589837777.688 [CBIT](INFO): Clearing failed state for component DAT 2020-05-18T21:36:17.688Z,1589837777.688 [DAT] No Fault, FailCount= 1 2020-05-18T21:36:20.104Z,1589837780.104 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-05-18T21:36:20.104Z,1589837780.104 [DAT](INFO): Powering up 2020-05-18T21:36:20.104Z,1589837780.104 [DAT](DEBUG): Initializing DAT. 2020-05-18T21:36:20.163Z,1589837780.163 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-05-18T21:36:24.607Z,1589837784.607 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:28.197Z,1589837788.197 [SBIT](IMPORTANT): Beginning Startup BIT 2020-05-18T21:36:28.202Z,1589837788.202 [CBIT](IMPORTANT): Beginning ground fault scan 2020-05-18T21:36:39.280Z,1589837799.280 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.005080 CHAN A1 (24V): -0.000267 CHAN A2 (12V): 0.000198 CHAN A3 (5V): -0.000555 CHAN B0 (3.3V): 0.000045 CHAN B1 (3.15aV): -0.000231 CHAN B2 (3.15bV): -0.000137 CHAN B3 (GND): 0.000565 OPEN: 0.006226 Full Scale Calc: 4.765 mA, -1.589 mA 2020-05-18T21:36:47.469Z,1589837807.469 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 150.000000 cubic_centimeter 2020-05-18T21:36:47.471Z,1589837807.471 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2020-05-18T21:36:47.644Z,1589837807.644 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,Depth_Keller,DropWeight,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2020-05-18T21:36:49.595Z,1589837809.595 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:53.223Z,1589837813.223 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:53.619Z,1589837813.619 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:54.023Z,1589837814.023 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:54.435Z,1589837814.435 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:54.851Z,1589837814.851 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:55.269Z,1589837815.269 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:55.667Z,1589837815.667 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:56.108Z,1589837816.108 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:56.555Z,1589837816.555 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:56.875Z,1589837816.875 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:57.310Z,1589837817.310 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:57.683Z,1589837817.683 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:58.071Z,1589837818.071 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:58.467Z,1589837818.467 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:58.878Z,1589837818.878 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:59.275Z,1589837819.275 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:59.488Z,1589837819.488 [CommandLine](IMPORTANT): got command report mod platform_buoyancy_position 2020-05-18T21:36:59.671Z,1589837819.671 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:36:59.677Z,1589837819.677 [Reporter](INFO): platform_buoyancy_position 881.400818 cc 2020-05-18T21:37:00.099Z,1589837820.099 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:00.106Z,1589837820.106 [Reporter](INFO): platform_buoyancy_position 874.820129 cc 2020-05-18T21:37:00.491Z,1589837820.491 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:00.498Z,1589837820.498 [Reporter](INFO): platform_buoyancy_position 870.656860 cc 2020-05-18T21:37:00.895Z,1589837820.895 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:00.916Z,1589837820.916 [Reporter](INFO): platform_buoyancy_position 865.822021 cc 2020-05-18T21:37:01.303Z,1589837821.303 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:01.310Z,1589837821.310 [Reporter](INFO): platform_buoyancy_position 859.912842 cc 2020-05-18T21:37:01.699Z,1589837821.699 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:01.706Z,1589837821.706 [Reporter](INFO): platform_buoyancy_position 855.480957 cc 2020-05-18T21:37:02.102Z,1589837822.102 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:02.109Z,1589837822.109 [Reporter](INFO): platform_buoyancy_position 849.168823 cc 2020-05-18T21:37:02.495Z,1589837822.495 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:02.501Z,1589837822.501 [Reporter](INFO): platform_buoyancy_position 844.736938 cc 2020-05-18T21:37:02.911Z,1589837822.911 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:02.918Z,1589837822.918 [Reporter](INFO): platform_buoyancy_position 838.290527 cc 2020-05-18T21:37:03.307Z,1589837823.307 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:03.313Z,1589837823.313 [Reporter](INFO): platform_buoyancy_position 833.992920 cc 2020-05-18T21:37:03.711Z,1589837823.711 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:03.718Z,1589837823.718 [Reporter](INFO): platform_buoyancy_position 827.546570 cc 2020-05-18T21:37:04.126Z,1589837824.126 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:04.132Z,1589837824.132 [Reporter](INFO): platform_buoyancy_position 821.234436 cc 2020-05-18T21:37:04.527Z,1589837824.527 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:04.533Z,1589837824.533 [Reporter](INFO): platform_buoyancy_position 816.802551 cc 2020-05-18T21:37:04.935Z,1589837824.935 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:04.942Z,1589837824.942 [Reporter](INFO): platform_buoyancy_position 812.370667 cc 2020-05-18T21:37:05.339Z,1589837825.339 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:05.346Z,1589837825.346 [Reporter](INFO): platform_buoyancy_position 806.192810 cc 2020-05-18T21:37:05.755Z,1589837825.755 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:05.761Z,1589837825.761 [Reporter](INFO): platform_buoyancy_position 801.760925 cc 2020-05-18T21:37:06.156Z,1589837826.156 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:06.163Z,1589837826.163 [Reporter](INFO): platform_buoyancy_position 795.314514 cc 2020-05-18T21:37:06.559Z,1589837826.559 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:06.584Z,1589837826.584 [Reporter](INFO): platform_buoyancy_position 791.016968 cc 2020-05-18T21:37:06.940Z,1589837826.940 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:06.947Z,1589837826.947 [Reporter](INFO): platform_buoyancy_position 784.704834 cc 2020-05-18T21:37:07.379Z,1589837827.379 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:07.386Z,1589837827.386 [Reporter](INFO): platform_buoyancy_position 780.407227 cc 2020-05-18T21:37:07.755Z,1589837827.755 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:07.778Z,1589837827.778 [Reporter](INFO): platform_buoyancy_position 774.229431 cc 2020-05-18T21:37:08.163Z,1589837828.163 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:08.169Z,1589837828.169 [Reporter](INFO): platform_buoyancy_position 769.528931 cc 2020-05-18T21:37:08.567Z,1589837828.567 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:08.574Z,1589837828.574 [Reporter](INFO): platform_buoyancy_position 764.022644 cc 2020-05-18T21:37:08.965Z,1589837828.965 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:08.974Z,1589837828.974 [Reporter](INFO): platform_buoyancy_position 758.784912 cc 2020-05-18T21:37:09.379Z,1589837829.379 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:09.386Z,1589837829.386 [Reporter](INFO): platform_buoyancy_position 753.815857 cc 2020-05-18T21:37:09.847Z,1589837829.847 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:10.021Z,1589837830.021 [Reporter](INFO): platform_buoyancy_position 748.040955 cc 2020-05-18T21:37:10.267Z,1589837830.267 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:10.709Z,1589837830.709 [Reporter](INFO): platform_buoyancy_position 741.594543 cc 2020-05-18T21:37:10.827Z,1589837830.827 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:10.936Z,1589837830.936 [Reporter](INFO): platform_buoyancy_position 735.282410 cc 2020-05-18T21:37:11.227Z,1589837831.227 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:11.329Z,1589837831.329 [Reporter](INFO): platform_buoyancy_position 728.970337 cc 2020-05-18T21:37:11.616Z,1589837831.616 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:11.722Z,1589837831.722 [Reporter](INFO): platform_buoyancy_position 724.672729 cc 2020-05-18T21:37:12.011Z,1589837832.011 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:12.109Z,1589837832.109 [Reporter](INFO): platform_buoyancy_position 720.240845 cc 2020-05-18T21:37:12.397Z,1589837832.397 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:12.498Z,1589837832.498 [Reporter](INFO): platform_buoyancy_position 714.197327 cc 2020-05-18T21:37:12.795Z,1589837832.795 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:12.965Z,1589837832.965 [Reporter](INFO): platform_buoyancy_position 709.496826 cc 2020-05-18T21:37:13.207Z,1589837833.207 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:13.485Z,1589837833.485 [Reporter](INFO): platform_buoyancy_position 703.050415 cc 2020-05-18T21:37:13.603Z,1589837833.603 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:13.649Z,1589837833.649 [Reporter](INFO): platform_buoyancy_position 698.752808 cc 2020-05-18T21:37:14.007Z,1589837834.007 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:14.056Z,1589837834.056 [Reporter](INFO): platform_buoyancy_position 693.918030 cc 2020-05-18T21:37:14.411Z,1589837834.411 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:14.533Z,1589837834.533 [Reporter](INFO): platform_buoyancy_position 688.008850 cc 2020-05-18T21:37:14.815Z,1589837834.815 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:14.822Z,1589837834.822 [Reporter](INFO): platform_buoyancy_position 681.562439 cc 2020-05-18T21:37:15.219Z,1589837835.219 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:15.225Z,1589837835.225 [Reporter](INFO): platform_buoyancy_position 677.130554 cc 2020-05-18T21:37:15.627Z,1589837835.627 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:15.633Z,1589837835.633 [Reporter](INFO): platform_buoyancy_position 672.698608 cc 2020-05-18T21:37:16.011Z,1589837836.011 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2020-05-18T21:37:16.011Z,1589837836.011 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-05-18T21:37:16.011Z,1589837836.011 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-05-18T21:37:16.055Z,1589837836.055 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:16.060Z,1589837836.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-05-18T21:37:16.062Z,1589837836.062 [Reporter](INFO): platform_buoyancy_position 666.386536 cc 2020-05-18T21:37:16.454Z,1589837836.454 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:16.459Z,1589837836.459 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-05-18T21:37:16.459Z,1589837836.459 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-05-18T21:37:16.461Z,1589837836.461 [Reporter](INFO): platform_buoyancy_position 660.208740 cc 2020-05-18T21:37:16.851Z,1589837836.851 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:16.857Z,1589837836.857 [Reporter](INFO): platform_buoyancy_position 655.642517 cc 2020-05-18T21:37:17.251Z,1589837837.251 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:17.257Z,1589837837.257 [Reporter](INFO): platform_buoyancy_position 650.136230 cc 2020-05-18T21:37:17.683Z,1589837837.683 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:17.689Z,1589837837.689 [Reporter](INFO): platform_buoyancy_position 645.032837 cc 2020-05-18T21:37:18.047Z,1589837838.047 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:18.053Z,1589837838.053 [Reporter](INFO): platform_buoyancy_position 640.600952 cc 2020-05-18T21:37:18.447Z,1589837838.447 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:18.454Z,1589837838.454 [Reporter](INFO): platform_buoyancy_position 634.423157 cc 2020-05-18T21:37:18.850Z,1589837838.850 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:18.857Z,1589837838.857 [Reporter](INFO): platform_buoyancy_position 629.856934 cc 2020-05-18T21:37:19.266Z,1589837839.266 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:19.273Z,1589837839.273 [Reporter](INFO): platform_buoyancy_position 623.410522 cc 2020-05-18T21:37:19.663Z,1589837839.663 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:19.670Z,1589837839.670 [Reporter](INFO): platform_buoyancy_position 619.247253 cc 2020-05-18T21:37:20.071Z,1589837840.071 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:20.078Z,1589837840.078 [Reporter](INFO): platform_buoyancy_position 613.069397 cc 2020-05-18T21:37:20.439Z,1589837840.439 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2020-05-18T21:37:20.439Z,1589837840.439 [DAT] Communications Fault, FailCount= 2 2020-05-18T21:37:20.439Z,1589837840.439 [DAT](ERROR): Communications Fault 2020-05-18T21:37:20.475Z,1589837840.475 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:20.480Z,1589837840.480 [CBIT](ERROR): Communications Fault in component: DAT 2020-05-18T21:37:20.488Z,1589837840.488 [Reporter](INFO): platform_buoyancy_position 608.234619 cc 2020-05-18T21:37:20.841Z,1589837840.841 [DAT](INFO): Powering down 2020-05-18T21:37:20.999Z,1589837840.999 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:21.006Z,1589837841.006 [Reporter](INFO): platform_buoyancy_position 601.922546 cc 2020-05-18T21:37:21.299Z,1589837841.299 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:21.306Z,1589837841.306 [Reporter](INFO): platform_buoyancy_position 597.624939 cc 2020-05-18T21:37:21.716Z,1589837841.716 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:21.717Z,1589837841.717 [SBIT](IMPORTANT): SBIT PASSED 2020-05-18T21:37:21.718Z,1589837841.718 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-05-18T21:37:21.718Z,1589837841.718 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2020-05-18T21:37:21.718Z,1589837841.718 [SBIT](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool; 2020-05-18T21:37:21.719Z,1589837841.719 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2020-05-18T21:37:21.719Z,1589837841.719 [SBIT](IMPORTANT): BuoyancyServo.checkingTimeout=30 second; 2020-05-18T21:37:21.719Z,1589837841.719 [SBIT](IMPORTANT): CBIT.gf12Offset=61.5 microampere; 2020-05-18T21:37:21.719Z,1589837841.719 [SBIT](IMPORTANT): CBIT.gf24Offset=148.1 microampere; 2020-05-18T21:37:21.719Z,1589837841.719 [SBIT](IMPORTANT): CBIT.gf3_15Offset=-4.3 microampere; 2020-05-18T21:37:21.719Z,1589837841.719 [SBIT](IMPORTANT): CBIT.gf3_3Offset=-2.7 microampere; 2020-05-18T21:37:21.720Z,1589837841.720 [SBIT](IMPORTANT): CBIT.gf5Offset=8.7 microampere; 2020-05-18T21:37:21.720Z,1589837841.720 [SBIT](IMPORTANT): CBIT.gfCommOffset=-27.9 microampere; 2020-05-18T21:37:21.720Z,1589837841.720 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2020-05-18T21:37:21.720Z,1589837841.720 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2020-05-18T21:37:21.720Z,1589837841.720 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2020-05-18T21:37:21.724Z,1589837841.724 [CBIT](INFO): Clearing failed state for component DAT 2020-05-18T21:37:21.724Z,1589837841.724 [DAT] No Fault, FailCount= 2 2020-05-18T21:37:21.725Z,1589837841.725 [Reporter](INFO): platform_buoyancy_position 591.312805 cc 2020-05-18T21:37:22.076Z,1589837842.076 [MissionManager](IMPORTANT): Started mission Startup 2020-05-18T21:37:22.077Z,1589837842.077 [Startup] Running Loop=1 2020-05-18T21:37:22.077Z,1589837842.077 [Startup](DEBUG): Aggregate::initialize Startup 2020-05-18T21:37:22.077Z,1589837842.077 [Startup:A.GoToSurface] Running Loop=1 2020-05-18T21:37:22.077Z,1589837842.077 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-05-18T21:37:22.078Z,1589837842.078 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-05-18T21:37:22.078Z,1589837842.078 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-05-18T21:37:22.078Z,1589837842.078 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-05-18T21:37:22.079Z,1589837842.079 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-05-18T21:37:22.079Z,1589837842.079 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-05-18T21:37:22.082Z,1589837842.082 [Startup:StartupSatComms] Running Loop=1 2020-05-18T21:37:22.082Z,1589837842.082 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-05-18T21:37:22.082Z,1589837842.082 [Startup:StartupSatComms:A] Running Loop=1 2020-05-18T21:37:22.131Z,1589837842.131 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:22.137Z,1589837842.137 [Reporter](INFO): platform_buoyancy_position 586.880920 cc 2020-05-18T21:37:22.480Z,1589837842.480 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-05-18T21:37:22.515Z,1589837842.515 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:22.521Z,1589837842.521 [Reporter](INFO): platform_buoyancy_position 582.583313 cc 2020-05-18T21:37:22.907Z,1589837842.907 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:22.913Z,1589837842.913 [Reporter](INFO): platform_buoyancy_position 576.271240 cc 2020-05-18T21:37:23.423Z,1589837843.423 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:23.429Z,1589837843.429 [Reporter](INFO): platform_buoyancy_position 569.824829 cc 2020-05-18T21:37:23.715Z,1589837843.715 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:23.722Z,1589837843.722 [Reporter](INFO): platform_buoyancy_position 565.527222 cc 2020-05-18T21:37:24.073Z,1589837844.073 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-05-18T21:37:24.073Z,1589837844.073 [DAT](INFO): Powering up 2020-05-18T21:37:24.074Z,1589837844.074 [DAT](DEBUG): Initializing DAT. 2020-05-18T21:37:24.127Z,1589837844.127 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-05-18T21:37:24.215Z,1589837844.215 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:24.242Z,1589837844.242 [Reporter](INFO): platform_buoyancy_position 558.946533 cc 2020-05-18T21:37:24.541Z,1589837844.541 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:24.547Z,1589837844.547 [Reporter](INFO): platform_buoyancy_position 554.648926 cc 2020-05-18T21:37:24.923Z,1589837844.923 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:24.929Z,1589837844.929 [Reporter](INFO): platform_buoyancy_position 550.082703 cc 2020-05-18T21:37:25.325Z,1589837845.325 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:25.331Z,1589837845.331 [Reporter](INFO): platform_buoyancy_position 544.039246 cc 2020-05-18T21:37:25.735Z,1589837845.735 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:25.748Z,1589837845.748 [Reporter](INFO): platform_buoyancy_position 538.398621 cc 2020-05-18T21:37:26.131Z,1589837846.131 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:26.137Z,1589837846.137 [Reporter](INFO): platform_buoyancy_position 533.160950 cc 2020-05-18T21:37:26.547Z,1589837846.547 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:26.553Z,1589837846.553 [Reporter](INFO): platform_buoyancy_position 528.997620 cc 2020-05-18T21:37:26.959Z,1589837846.959 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:26.965Z,1589837846.965 [Reporter](INFO): platform_buoyancy_position 522.416931 cc 2020-05-18T21:37:27.359Z,1589837847.359 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:27.365Z,1589837847.365 [Reporter](INFO): platform_buoyancy_position 518.119324 cc 2020-05-18T21:37:27.775Z,1589837847.775 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:27.781Z,1589837847.781 [Reporter](INFO): platform_buoyancy_position 511.672943 cc 2020-05-18T21:37:28.159Z,1589837848.159 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:28.165Z,1589837848.165 [Reporter](INFO): platform_buoyancy_position 506.972443 cc 2020-05-18T21:37:28.559Z,1589837848.559 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:28.565Z,1589837848.565 [Reporter](INFO): platform_buoyancy_position 501.063232 cc 2020-05-18T21:37:28.964Z,1589837848.964 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:28.969Z,1589837848.969 [Reporter](INFO): platform_buoyancy_position 496.765656 cc 2020-05-18T21:37:29.359Z,1589837849.359 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:29.366Z,1589837849.366 [Reporter](INFO): platform_buoyancy_position 492.065155 cc 2020-05-18T21:37:29.767Z,1589837849.767 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:29.773Z,1589837849.773 [Reporter](INFO): platform_buoyancy_position 485.887360 cc 2020-05-18T21:37:30.162Z,1589837850.162 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:30.168Z,1589837850.168 [Reporter](INFO): platform_buoyancy_position 481.186859 cc 2020-05-18T21:37:30.579Z,1589837850.579 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:30.585Z,1589837850.585 [Reporter](INFO): platform_buoyancy_position 475.411957 cc 2020-05-18T21:37:30.975Z,1589837850.975 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:30.981Z,1589837850.981 [Reporter](INFO): platform_buoyancy_position 470.711456 cc 2020-05-18T21:37:31.387Z,1589837851.387 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:31.393Z,1589837851.393 [Reporter](INFO): platform_buoyancy_position 464.399323 cc 2020-05-18T21:37:31.803Z,1589837851.803 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:31.809Z,1589837851.809 [Reporter](INFO): platform_buoyancy_position 460.101715 cc 2020-05-18T21:37:32.203Z,1589837852.203 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:32.209Z,1589837852.209 [Reporter](INFO): platform_buoyancy_position 453.789642 cc 2020-05-18T21:37:32.605Z,1589837852.605 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:32.612Z,1589837852.612 [Reporter](INFO): platform_buoyancy_position 449.357758 cc 2020-05-18T21:37:33.021Z,1589837853.021 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:33.027Z,1589837853.027 [Reporter](INFO): platform_buoyancy_position 444.388641 cc 2020-05-18T21:37:33.399Z,1589837853.399 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:33.405Z,1589837853.405 [Reporter](INFO): platform_buoyancy_position 438.748016 cc 2020-05-18T21:37:33.809Z,1589837853.809 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:33.815Z,1589837853.815 [Reporter](INFO): platform_buoyancy_position 433.778961 cc 2020-05-18T21:37:34.207Z,1589837854.207 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:34.221Z,1589837854.221 [Reporter](INFO): platform_buoyancy_position 427.869720 cc 2020-05-18T21:37:34.615Z,1589837854.615 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:34.621Z,1589837854.621 [Reporter](INFO): platform_buoyancy_position 423.303558 cc 2020-05-18T21:37:35.031Z,1589837855.031 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:35.037Z,1589837855.037 [Reporter](INFO): platform_buoyancy_position 417.125763 cc 2020-05-18T21:37:35.421Z,1589837855.421 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:35.427Z,1589837855.427 [Reporter](INFO): platform_buoyancy_position 412.559540 cc 2020-05-18T21:37:35.827Z,1589837855.827 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:35.840Z,1589837855.840 [Reporter](INFO): platform_buoyancy_position 406.381744 cc 2020-05-18T21:37:36.227Z,1589837856.227 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:36.233Z,1589837856.233 [Reporter](INFO): platform_buoyancy_position 400.875427 cc 2020-05-18T21:37:36.751Z,1589837856.751 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:36.757Z,1589837856.757 [Reporter](INFO): platform_buoyancy_position 393.623230 cc 2020-05-18T21:37:37.091Z,1589837857.091 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:37.097Z,1589837857.097 [Reporter](INFO): platform_buoyancy_position 389.191345 cc 2020-05-18T21:37:37.483Z,1589837857.483 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:37.507Z,1589837857.507 [Reporter](INFO): platform_buoyancy_position 384.893738 cc 2020-05-18T21:37:37.899Z,1589837857.899 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:37.922Z,1589837857.922 [Reporter](INFO): platform_buoyancy_position 378.581635 cc 2020-05-18T21:37:38.263Z,1589837858.263 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:38.286Z,1589837858.286 [Reporter](INFO): platform_buoyancy_position 374.284027 cc 2020-05-18T21:37:38.647Z,1589837858.647 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:38.653Z,1589837858.653 [Reporter](INFO): platform_buoyancy_position 369.717834 cc 2020-05-18T21:37:39.062Z,1589837859.062 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:39.068Z,1589837859.068 [Reporter](INFO): platform_buoyancy_position 363.405731 cc 2020-05-18T21:37:39.476Z,1589837859.476 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:39.482Z,1589837859.482 [Reporter](INFO): platform_buoyancy_position 359.108124 cc 2020-05-18T21:37:39.867Z,1589837859.867 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:39.873Z,1589837859.873 [Reporter](INFO): platform_buoyancy_position 352.930328 cc 2020-05-18T21:37:40.271Z,1589837860.271 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:40.277Z,1589837860.277 [Reporter](INFO): platform_buoyancy_position 348.498444 cc 2020-05-18T21:37:40.674Z,1589837860.674 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:40.681Z,1589837860.681 [Reporter](INFO): platform_buoyancy_position 342.052032 cc 2020-05-18T21:37:41.075Z,1589837861.075 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:41.098Z,1589837861.098 [Reporter](INFO): platform_buoyancy_position 337.754425 cc 2020-05-18T21:37:41.483Z,1589837861.483 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:41.489Z,1589837861.489 [Reporter](INFO): platform_buoyancy_position 331.845245 cc 2020-05-18T21:37:41.879Z,1589837861.879 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:41.885Z,1589837861.885 [Reporter](INFO): platform_buoyancy_position 326.876129 cc 2020-05-18T21:37:42.291Z,1589837862.291 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:42.307Z,1589837862.307 [Reporter](INFO): platform_buoyancy_position 322.309937 cc 2020-05-18T21:37:42.706Z,1589837862.706 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:42.712Z,1589837862.712 [Reporter](INFO): platform_buoyancy_position 316.266449 cc 2020-05-18T21:37:43.120Z,1589837863.120 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:43.126Z,1589837863.126 [Reporter](INFO): platform_buoyancy_position 311.834534 cc 2020-05-18T21:37:43.515Z,1589837863.515 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:43.521Z,1589837863.521 [Reporter](INFO): platform_buoyancy_position 305.388123 cc 2020-05-18T21:37:43.906Z,1589837863.906 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:43.912Z,1589837863.912 [Reporter](INFO): platform_buoyancy_position 301.224823 cc 2020-05-18T21:37:44.307Z,1589837864.307 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:44.331Z,1589837864.331 [Reporter](INFO): platform_buoyancy_position 296.792938 cc 2020-05-18T21:37:44.715Z,1589837864.715 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:44.721Z,1589837864.721 [Reporter](INFO): platform_buoyancy_position 290.212219 cc 2020-05-18T21:37:45.111Z,1589837865.111 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:45.117Z,1589837865.117 [Reporter](INFO): platform_buoyancy_position 284.034424 cc 2020-05-18T21:37:45.522Z,1589837865.522 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:45.529Z,1589837865.529 [Reporter](INFO): platform_buoyancy_position 279.736847 cc 2020-05-18T21:37:45.923Z,1589837865.923 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:45.946Z,1589837865.946 [Reporter](INFO): platform_buoyancy_position 273.290436 cc 2020-05-18T21:37:46.327Z,1589837866.327 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:46.333Z,1589837866.333 [Reporter](INFO): platform_buoyancy_position 268.858521 cc 2020-05-18T21:37:46.727Z,1589837866.727 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:46.733Z,1589837866.733 [Reporter](INFO): platform_buoyancy_position 262.680725 cc 2020-05-18T21:37:47.131Z,1589837867.131 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:47.140Z,1589837867.140 [Reporter](INFO): platform_buoyancy_position 258.248840 cc 2020-05-18T21:37:47.550Z,1589837867.550 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:47.557Z,1589837867.557 [Reporter](INFO): platform_buoyancy_position 252.205322 cc 2020-05-18T21:37:47.979Z,1589837867.979 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:47.985Z,1589837867.985 [Reporter](INFO): platform_buoyancy_position 247.370544 cc 2020-05-18T21:37:48.359Z,1589837868.359 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:48.365Z,1589837868.365 [Reporter](INFO): platform_buoyancy_position 243.207214 cc 2020-05-18T21:37:48.775Z,1589837868.775 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:48.781Z,1589837868.781 [Reporter](INFO): platform_buoyancy_position 236.626526 cc 2020-05-18T21:37:49.163Z,1589837869.163 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:49.169Z,1589837869.169 [Reporter](INFO): platform_buoyancy_position 231.791718 cc 2020-05-18T21:37:49.559Z,1589837869.559 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:49.565Z,1589837869.565 [Reporter](INFO): platform_buoyancy_position 226.016815 cc 2020-05-18T21:37:50.023Z,1589837870.023 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:50.029Z,1589837870.029 [Reporter](INFO): platform_buoyancy_position 219.839020 cc 2020-05-18T21:37:50.459Z,1589837870.459 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:50.465Z,1589837870.465 [Reporter](INFO): platform_buoyancy_position 214.869934 cc 2020-05-18T21:37:50.783Z,1589837870.783 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:50.789Z,1589837870.789 [Reporter](INFO): platform_buoyancy_position 210.706635 cc 2020-05-18T21:37:51.215Z,1589837871.215 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:51.221Z,1589837871.221 [Reporter](INFO): platform_buoyancy_position 204.394531 cc 2020-05-18T21:37:51.587Z,1589837871.587 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:51.593Z,1589837871.593 [Reporter](INFO): platform_buoyancy_position 199.828339 cc 2020-05-18T21:37:51.974Z,1589837871.974 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:51.980Z,1589837871.980 [Reporter](INFO): platform_buoyancy_position 194.859222 cc 2020-05-18T21:37:52.391Z,1589837872.391 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:52.397Z,1589837872.397 [Reporter](INFO): platform_buoyancy_position 189.352936 cc 2020-05-18T21:37:52.805Z,1589837872.805 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:52.811Z,1589837872.811 [Reporter](INFO): platform_buoyancy_position 182.906525 cc 2020-05-18T21:37:53.221Z,1589837873.221 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:53.227Z,1589837873.227 [Reporter](INFO): platform_buoyancy_position 178.608917 cc 2020-05-18T21:37:53.627Z,1589837873.627 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:53.651Z,1589837873.651 [Reporter](INFO): platform_buoyancy_position 172.296814 cc 2020-05-18T21:37:54.035Z,1589837874.035 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:54.041Z,1589837874.041 [Reporter](INFO): platform_buoyancy_position 167.999237 cc 2020-05-18T21:37:54.422Z,1589837874.422 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:54.428Z,1589837874.428 [Reporter](INFO): platform_buoyancy_position 161.552826 cc 2020-05-18T21:37:54.838Z,1589837874.838 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:37:54.889Z,1589837874.889 [Reporter](INFO): platform_buoyancy_position 157.389526 cc 2020-05-18T21:37:58.754Z,1589837878.754 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005353 2020-05-18T21:38:22.265Z,1589837902.265 [Startup:StartupSatComms:A](INFO): Timed out from 2020-05-18T21:37:22.1Z 2020-05-18T21:38:22.265Z,1589837902.265 [Startup:StartupSatComms:A] Stopped 2020-05-18T21:38:22.266Z,1589837902.266 [Startup:StartupSatComms:B] Running Loop=1 2020-05-18T21:38:22.664Z,1589837902.664 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-05-18T21:38:24.281Z,1589837904.281 [DAT](FAULT): failed to initialize, no bytes available on serial interface 2020-05-18T21:38:24.282Z,1589837904.282 [DAT] Communications Fault, FailCount= 3 2020-05-18T21:38:24.282Z,1589837904.282 [DAT](ERROR): Communications Fault 2020-05-18T21:38:24.320Z,1589837904.320 [CBIT](ERROR): Communications Fault in component: DAT 2020-05-18T21:38:24.673Z,1589837904.673 [DAT](INFO): Powering down 2020-05-18T21:38:25.517Z,1589837905.517 [CBIT](INFO): Clearing failed state for component DAT 2020-05-18T21:38:25.517Z,1589837905.517 [DAT] No Fault, FailCount= 3 2020-05-18T21:38:27.564Z,1589837907.564 [BuoyancyServo](INFO): checking for leaks 2020-05-18T21:38:27.605Z,1589837907.605 [Reporter](INFO): platform_buoyancy_position 150.808807 cc 2020-05-18T21:38:27.902Z,1589837907.902 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-05-18T21:38:27.902Z,1589837907.902 [DAT](INFO): Powering up 2020-05-18T21:38:27.902Z,1589837907.902 [DAT](DEBUG): Initializing DAT. 2020-05-18T21:38:27.913Z,1589837907.913 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-05-18T21:38:28.596Z,1589837908.596 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200518T171026/Courier0079.lzma 2020-05-18T21:38:29.597Z,1589837909.597 [DataOverHttps](INFO): Moved sent file to Logs/20200518T171026/Courier0079.lzma.bak 2020-05-18T21:38:29.597Z,1589837909.597 [DataOverHttps](INFO): SBD MOMSN=12336795 2020-05-18T21:38:38.633Z,1589837918.633 [CommandLine](IMPORTANT): got command exit 2020-05-18T21:38:39.639Z,1589837919.639 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:39.639Z,1589837919.639 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:39.667Z,1589837919.667 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-05-18T21:38:39.667Z,1589837919.667 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:39.668Z,1589837919.668 [CommandLine](INFO): Join timeout helper Thread ID is 3542 2020-05-18T21:38:39.668Z,1589837919.668 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-05-18T21:38:39.668Z,1589837919.668 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:39.669Z,1589837919.669 [NavChartDb](INFO): Join timeout helper Thread ID is 3543 2020-05-18T21:38:40.003Z,1589837920.003 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:40.003Z,1589837920.003 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:40.011Z,1589837920.011 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-05-18T21:38:40.011Z,1589837920.011 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:40.011Z,1589837920.011 [Radio_Surface](INFO): Join timeout helper Thread ID is 3544 2020-05-18T21:38:40.355Z,1589837920.355 [Radio_Surface](INFO): Powering down 2020-05-18T21:38:40.356Z,1589837920.356 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:40.356Z,1589837920.356 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:40.371Z,1589837920.371 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-05-18T21:38:40.371Z,1589837920.371 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:40.371Z,1589837920.371 [DataOverHttps](INFO): Join timeout helper Thread ID is 3545 2020-05-18T21:38:40.775Z,1589837920.775 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:40.776Z,1589837920.776 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:40.791Z,1589837920.791 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-05-18T21:38:40.791Z,1589837920.791 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:40.791Z,1589837920.791 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3546 2020-05-18T21:38:41.056Z,1589837921.056 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:41.056Z,1589837921.056 [WetLabsBB2FL](INFO): Powering down 2020-05-18T21:38:41.057Z,1589837921.057 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.072Z,1589837921.072 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-05-18T21:38:41.072Z,1589837921.072 [logger ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.072Z,1589837921.072 [logger](INFO): Join timeout helper Thread ID is 3547 2020-05-18T21:38:41.107Z,1589837921.107 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:41.107Z,1589837921.107 [logger ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.112Z,1589837921.112 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-05-18T21:38:41.112Z,1589837921.112 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.112Z,1589837921.112 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-05-18T21:38:41.112Z,1589837921.112 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.112Z,1589837921.112 [controlThread](INFO): Join timeout helper Thread ID is 3548 2020-05-18T21:38:41.203Z,1589837921.203 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-18T21:38:41.203Z,1589837921.203 [controlThread](DEBUG): Uninitializing ControlThread 2020-05-18T21:38:41.224Z,1589837921.224 [NAL9602](INFO): Powering down 2020-05-18T21:38:41.226Z,1589837921.226 [DAT](INFO): Powering down 2020-05-18T21:38:41.344Z,1589837921.344 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-05-18T21:38:41.345Z,1589837921.345 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-05-18T21:38:41.346Z,1589837921.346 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-05-18T21:38:41.346Z,1589837921.346 [MissionManager](INFO): Uninitializing Mission Default 2020-05-18T21:38:41.348Z,1589837921.348 [MissionManager](INFO): Uninitializing Mission Startup 2020-05-18T21:38:41.348Z,1589837921.348 [Startup] Stopped 2020-05-18T21:38:41.349Z,1589837921.349 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-05-18T21:38:41.349Z,1589837921.349 [Startup:A.GoToSurface] Stopped 2020-05-18T21:38:41.349Z,1589837921.349 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-05-18T21:38:41.349Z,1589837921.349 [Startup:StartupSatComms] Stopped 2020-05-18T21:38:41.349Z,1589837921.349 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-05-18T21:38:41.349Z,1589837921.349 [Startup:StartupSatComms:B] Stopped 2020-05-18T21:38:41.350Z,1589837921.350 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-05-18T21:38:41.350Z,1589837921.350 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-05-18T21:38:41.351Z,1589837921.351 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-05-18T21:38:41.351Z,1589837921.351 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-05-18T21:38:41.352Z,1589837921.352 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-05-18T21:38:41.352Z,1589837921.352 [BuoyancyServo](INFO): Powering down 2020-05-18T21:38:41.363Z,1589837921.363 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-05-18T21:38:41.363Z,1589837921.363 [ElevatorServo](INFO): Powering down 2020-05-18T21:38:41.364Z,1589837921.364 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-05-18T21:38:41.364Z,1589837921.364 [MassServo](INFO): Powering down 2020-05-18T21:38:41.365Z,1589837921.365 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-05-18T21:38:41.365Z,1589837921.365 [RudderServo](INFO): Powering down 2020-05-18T21:38:41.366Z,1589837921.366 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-05-18T21:38:41.366Z,1589837921.366 [ThrusterServo](INFO): Powering down 2020-05-18T21:38:41.367Z,1589837921.367 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-05-18T21:38:41.367Z,1589837921.367 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-05-18T21:38:41.367Z,1589837921.367 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-05-18T21:38:41.367Z,1589837921.367 [CBIT](DEBUG): Powering off loads. 2020-05-18T21:38:41.379Z,1589837921.379 [CBIT](DEBUG): Disabling WDT. 2020-05-18T21:38:41.391Z,1589837921.391 [CBIT](DEBUG): Opening all GF detection circuits. 2020-05-18T21:38:41.392Z,1589837921.392 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.440Z,1589837921.440 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.542Z,1589837921.542 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.559Z,1589837921.559 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.628Z,1589837921.628 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-05-18T21:38:41.687Z,1589837921.687 [logger ThreadHandler](INFO): Thread cancelled.