2020-10-01T14:13:06.942Z,1601561586.942 [Supervisor](DEBUG): Initializing supervisor.
2020-10-01T14:13:06.945Z,1601561586.945 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-10-01T14:13:06.946Z,1601561586.946 [SyncHandler](INFO): Protected caller Thread ID is 8406
2020-10-01T14:13:06.947Z,1601561586.947 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-10-01T14:13:06.947Z,1601561586.947 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-10-01T14:13:06.948Z,1601561586.948 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8407
2020-10-01T14:13:06.951Z,1601561586.951 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-10-01T14:13:06.966Z,1601561586.966 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-10-01T14:13:06.967Z,1601561586.967 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-10-01T14:13:06.967Z,1601561586.967 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8408
2020-10-01T14:13:06.968Z,1601561586.968 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-10-01T14:13:06.968Z,1601561586.968 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-10-01T14:13:06.969Z,1601561586.969 [logger ThreadHandler](INFO): Protected caller Thread ID is 8409
2020-10-01T14:13:06.971Z,1601561586.971 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-10-01T14:13:06.971Z,1601561586.971 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-10-01T14:13:06.973Z,1601561586.973 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-10-01T14:13:07.064Z,1601561587.064 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-10-01T14:13:07.065Z,1601561587.065 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-10-01T14:13:08.613Z,1601561588.613 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-10-01T14:13:08.614Z,1601561588.614 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-10-01T14:13:09.276Z,1601561589.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-10-01T14:13:09.277Z,1601561589.277 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-10-01T14:13:09.371Z,1601561589.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-10-01T14:13:09.372Z,1601561589.372 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-10-01T14:13:09.469Z,1601561589.469 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-10-01T14:13:09.470Z,1601561589.470 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-10-01T14:13:09.547Z,1601561589.547 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-10-01T14:13:09.681Z,1601561589.681 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-10-01T14:13:09.681Z,1601561589.681 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-10-01T14:13:09.954Z,1601561589.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-10-01T14:13:09.955Z,1601561589.955 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-10-01T14:13:10.383Z,1601561590.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-10-01T14:13:10.383Z,1601561590.383 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-10-01T14:13:10.521Z,1601561590.521 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-10-01T14:13:10.521Z,1601561590.521 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-10-01T14:13:10.696Z,1601561590.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-10-01T14:13:10.697Z,1601561590.697 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-10-01T14:13:11.317Z,1601561591.317 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-10-01T14:13:11.318Z,1601561591.318 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-10-01T14:13:11.546Z,1601561591.546 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-10-01T14:13:11.547Z,1601561591.547 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-10-01T14:13:11.881Z,1601561591.881 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-10-01T14:13:11.882Z,1601561591.882 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-10-01T14:13:12.269Z,1601561592.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-10-01T14:13:12.270Z,1601561592.270 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-10-01T14:13:12.573Z,1601561592.573 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-10-01T14:13:12.574Z,1601561592.574 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-10-01T14:13:12.575Z,1601561592.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-10-01T14:13:12.656Z,1601561592.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-10-01T14:13:12.801Z,1601561592.801 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-10-01T14:13:12.905Z,1601561592.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-10-01T14:13:12.987Z,1601561592.987 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-10-01T14:13:13.078Z,1601561593.078 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-10-01T14:13:13.259Z,1601561593.259 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-10-01T14:13:13.480Z,1601561593.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-10-01T14:13:13.481Z,1601561593.481 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-10-01T14:13:13.571Z,1601561593.571 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-10-01T14:13:13.664Z,1601561593.664 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-10-01T14:13:13.787Z,1601561593.787 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-10-01T14:13:13.883Z,1601561593.883 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2020-10-01T14:13:13.883Z,1601561593.883 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-10-01T14:13:13.899Z,1601561593.899 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-10-01T14:13:13.976Z,1601561593.976 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-10-01T14:13:13.976Z,1601561593.976 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-10-01T14:13:14.022Z,1601561594.022 [VerticalControl](DEBUG): Construct VerticalControl.
2020-10-01T14:13:14.128Z,1601561594.128 [VerticalControl] Loaded
2020-10-01T14:13:14.128Z,1601561594.128 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-10-01T14:13:14.129Z,1601561594.129 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-10-01T14:13:14.205Z,1601561594.205 [HorizontalControl] Loaded
2020-10-01T14:13:14.205Z,1601561594.205 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-10-01T14:13:14.206Z,1601561594.206 [SpeedControl](DEBUG): Construct SpeedControl.
2020-10-01T14:13:14.211Z,1601561594.211 [SpeedControl] Loaded
2020-10-01T14:13:14.211Z,1601561594.211 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-10-01T14:13:14.212Z,1601561594.212 [LoopControl](DEBUG): Construct LoopControl.
2020-10-01T14:13:14.212Z,1601561594.212 [LoopControl] Loaded
2020-10-01T14:13:14.213Z,1601561594.213 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-10-01T14:13:14.213Z,1601561594.213 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-10-01T14:13:14.214Z,1601561594.214 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-10-01T14:13:14.253Z,1601561594.253 [DepthRateCalculator] Loaded
2020-10-01T14:13:14.253Z,1601561594.253 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-10-01T14:13:14.258Z,1601561594.258 [PitchRateCalculator] Loaded
2020-10-01T14:13:14.258Z,1601561594.258 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-10-01T14:13:14.273Z,1601561594.273 [SpeedCalculator] Loaded
2020-10-01T14:13:14.273Z,1601561594.273 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-10-01T14:13:14.293Z,1601561594.293 [TempGradientCalculator] Loaded
2020-10-01T14:13:14.293Z,1601561594.293 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-10-01T14:13:14.298Z,1601561594.298 [YawRateCalculator] Loaded
2020-10-01T14:13:14.298Z,1601561594.298 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-10-01T14:13:14.327Z,1601561594.327 [ElevatorOffsetCalculator] Loaded
2020-10-01T14:13:14.327Z,1601561594.327 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-10-01T14:13:14.327Z,1601561594.327 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-10-01T14:13:14.328Z,1601561594.328 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-10-01T14:13:14.354Z,1601561594.354 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-10-01T14:13:14.354Z,1601561594.354 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-10-01T14:13:14.437Z,1601561594.437 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-10-01T14:13:14.438Z,1601561594.438 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-10-01T14:13:14.716Z,1601561594.716 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-10-01T14:13:14.717Z,1601561594.717 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-10-01T14:13:14.813Z,1601561594.813 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-10-01T14:13:14.813Z,1601561594.813 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-10-01T14:13:15.138Z,1601561595.138 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-10-01T14:13:15.143Z,1601561595.143 [AHRS_M2](INFO): created writer for : platform_orientation
2020-10-01T14:13:15.145Z,1601561595.145 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-10-01T14:13:15.150Z,1601561595.150 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-10-01T14:13:15.150Z,1601561595.150 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-10-01T14:13:15.155Z,1601561595.155 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-10-01T14:13:15.156Z,1601561595.156 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-10-01T14:13:15.161Z,1601561595.161 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-10-01T14:13:15.229Z,1601561595.229 [AHRS_M2] Loaded
2020-10-01T14:13:15.229Z,1601561595.229 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-10-01T14:13:15.304Z,1601561595.304 [DataOverHttps] Loaded
2020-10-01T14:13:15.305Z,1601561595.305 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-10-01T14:13:15.306Z,1601561595.306 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090E4E0
2020-10-01T14:13:15.306Z,1601561595.306 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8491
2020-10-01T14:13:15.336Z,1601561595.336 [Depth_Keller] Loaded
2020-10-01T14:13:15.336Z,1601561595.336 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-10-01T14:13:15.444Z,1601561595.444 [NAL9602] Loaded
2020-10-01T14:13:15.444Z,1601561595.444 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-10-01T14:13:15.491Z,1601561595.491 [Onboard] Loaded
2020-10-01T14:13:15.491Z,1601561595.491 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-10-01T14:13:15.492Z,1601561595.492 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093E4E0
2020-10-01T14:13:15.492Z,1601561595.492 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8492
2020-10-01T14:13:15.511Z,1601561595.511 [Radio_Surface] Loaded
2020-10-01T14:13:15.511Z,1601561595.511 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-10-01T14:13:15.512Z,1601561595.512 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096E4E0
2020-10-01T14:13:15.512Z,1601561595.512 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8493
2020-10-01T14:13:15.657Z,1601561595.657 [DAT] Loaded
2020-10-01T14:13:15.658Z,1601561595.658 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-10-01T14:13:17.255Z,1601561597.255 [BPC1] Loaded
2020-10-01T14:13:17.255Z,1601561597.255 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-10-01T14:13:17.256Z,1601561597.256 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-10-01T14:13:17.304Z,1601561597.304 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-10-01T14:13:17.469Z,1601561597.469 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-10-01T14:13:17.469Z,1601561597.469 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-10-01T14:13:17.489Z,1601561597.489 [NavChart] Loaded
2020-10-01T14:13:17.489Z,1601561597.489 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-10-01T14:13:17.493Z,1601561597.493 [UniversalFixResidualReporter] Loaded
2020-10-01T14:13:17.493Z,1601561597.493 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-10-01T14:13:17.493Z,1601561597.493 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-10-01T14:13:17.494Z,1601561597.494 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-10-01T14:13:17.628Z,1601561597.628 [SBIT](DEBUG): Construct Startup Built In Test.
2020-10-01T14:13:17.639Z,1601561597.639 [SBIT] Loaded
2020-10-01T14:13:17.639Z,1601561597.639 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-10-01T14:13:17.640Z,1601561597.640 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-10-01T14:13:17.652Z,1601561597.652 [IBIT] Loaded
2020-10-01T14:13:17.653Z,1601561597.653 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-10-01T14:13:17.656Z,1601561597.656 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-10-01T14:13:17.790Z,1601561597.790 [CBIT] Loaded
2020-10-01T14:13:17.790Z,1601561597.790 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-10-01T14:13:17.791Z,1601561597.791 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-10-01T14:13:17.791Z,1601561597.791 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-10-01T14:13:17.913Z,1601561597.913 [BuoyancyServo] Loaded
2020-10-01T14:13:17.913Z,1601561597.913 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-10-01T14:13:17.941Z,1601561597.941 [ElevatorServo] Loaded
2020-10-01T14:13:17.941Z,1601561597.941 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-10-01T14:13:17.968Z,1601561597.968 [MassServo] Loaded
2020-10-01T14:13:17.968Z,1601561597.968 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-10-01T14:13:17.995Z,1601561597.995 [RudderServo] Loaded
2020-10-01T14:13:17.995Z,1601561597.995 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-10-01T14:13:18.021Z,1601561598.021 [ThrusterServo] Loaded
2020-10-01T14:13:18.021Z,1601561598.021 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-10-01T14:13:18.022Z,1601561598.022 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-10-01T14:13:18.022Z,1601561598.022 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-10-01T14:13:18.040Z,1601561598.040 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-10-01T14:13:18.041Z,1601561598.041 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-10-01T14:13:18.268Z,1601561598.268 [BackSeatDriver] Loaded
2020-10-01T14:13:18.268Z,1601561598.268 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread.
2020-10-01T14:13:18.269Z,1601561598.269 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B054E0
2020-10-01T14:13:18.269Z,1601561598.269 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 8494
2020-10-01T14:13:18.297Z,1601561598.297 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-10-01T14:13:18.302Z,1601561598.302 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-10-01T14:13:18.302Z,1601561598.302 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-10-01T14:13:18.307Z,1601561598.307 [CTD_Seabird](INFO): created writer for : depth
2020-10-01T14:13:18.307Z,1601561598.307 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-10-01T14:13:18.312Z,1601561598.312 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-10-01T14:13:18.313Z,1601561598.313 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-10-01T14:13:18.318Z,1601561598.318 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-10-01T14:13:18.319Z,1601561598.319 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-10-01T14:13:18.323Z,1601561598.323 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-10-01T14:13:18.324Z,1601561598.324 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-10-01T14:13:18.330Z,1601561598.330 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-10-01T14:13:18.331Z,1601561598.331 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-10-01T14:13:18.336Z,1601561598.336 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-10-01T14:13:18.362Z,1601561598.362 [CTD_Seabird] Loaded
2020-10-01T14:13:18.362Z,1601561598.362 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-10-01T14:13:18.363Z,1601561598.363 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B354E0
2020-10-01T14:13:18.364Z,1601561598.364 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8495
2020-10-01T14:13:18.411Z,1601561598.411 [ESPComponent] Loaded
2020-10-01T14:13:18.412Z,1601561598.412 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2020-10-01T14:13:18.432Z,1601561598.432 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-10-01T14:13:18.433Z,1601561598.433 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-10-01T14:13:18.437Z,1601561598.437 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-10-01T14:13:18.437Z,1601561598.437 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-10-01T14:13:18.441Z,1601561598.441 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-10-01T14:13:18.441Z,1601561598.441 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-10-01T14:13:18.445Z,1601561598.445 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-10-01T14:13:18.445Z,1601561598.445 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-10-01T14:13:18.449Z,1601561598.449 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-10-01T14:13:18.449Z,1601561598.449 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-10-01T14:13:18.454Z,1601561598.454 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-10-01T14:13:18.454Z,1601561598.454 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-10-01T14:13:18.458Z,1601561598.458 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-10-01T14:13:18.458Z,1601561598.458 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-10-01T14:13:18.462Z,1601561598.462 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.466Z,1601561598.466 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.467Z,1601561598.467 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.467Z,1601561598.467 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.471Z,1601561598.471 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.471Z,1601561598.471 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.475Z,1601561598.475 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.476Z,1601561598.476 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-10-01T14:13:18.480Z,1601561598.480 [WetLabsBB2FL] Loaded
2020-10-01T14:13:18.480Z,1601561598.480 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-10-01T14:13:18.481Z,1601561598.481 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B654E0
2020-10-01T14:13:18.481Z,1601561598.481 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8496
2020-10-01T14:13:18.482Z,1601561598.482 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-10-01T14:13:18.486Z,1601561598.486 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-10-01T14:13:18.487Z,1601561598.487 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-10-01T14:13:18.493Z,1601561598.493 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-10-01T14:13:18.494Z,1601561598.494 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B954E0
2020-10-01T14:13:18.494Z,1601561598.494 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8497
2020-10-01T14:13:18.499Z,1601561598.499 [Supervisor](INFO): Main Thread ID is 8126
2020-10-01T14:13:18.499Z,1601561598.499 [Supervisor](DEBUG): Running supervisor.
2020-10-01T14:13:18.500Z,1601561598.500 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8498
2020-10-01T14:13:18.502Z,1601561598.502 [controlThread ThreadHandler](INFO): Handler Thread ID is 8499
2020-10-01T14:13:18.503Z,1601561598.503 [controlThread](DEBUG): Initializing ControlThread
2020-10-01T14:13:18.503Z,1601561598.503 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-10-01T14:13:18.505Z,1601561598.505 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-10-01T14:13:18.506Z,1601561598.506 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-10-01T14:13:18.506Z,1601561598.506 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-10-01T14:13:18.507Z,1601561598.507 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-10-01T14:13:18.507Z,1601561598.507 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-10-01T14:13:18.507Z,1601561598.507 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-10-01T14:13:18.508Z,1601561598.508 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-10-01T14:13:18.508Z,1601561598.508 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-10-01T14:13:18.509Z,1601561598.509 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-10-01T14:13:18.514Z,1601561598.514 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-10-01T14:13:18.514Z,1601561598.514 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-10-01T14:13:18.514Z,1601561598.514 [SBIT](INFO): Initialize SBIT Component.
2020-10-01T14:13:18.515Z,1601561598.515 [SBIT](IMPORTANT): git: 2020-09-25
2020-10-01T14:13:18.515Z,1601561598.515 [SBIT](INFO): git hash: 37975fc996eaab47e1849088435330a6c93ea7b4
2020-10-01T14:13:18.515Z,1601561598.515 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-10-01T14:13:18.516Z,1601561598.516 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2020-10-01T14:13:18.517Z,1601561598.517 [SBIT](INFO): Beginning SBIT in 99.000000 seconds.
2020-10-01T14:13:18.518Z,1601561598.518 [IBIT](INFO): Initialize IBIT Component.
2020-10-01T14:13:18.519Z,1601561598.519 [CBIT](DEBUG): Initialize CBIT Component.
2020-10-01T14:13:18.520Z,1601561598.520 [logger ThreadHandler](INFO): Handler Thread ID is 8500
2020-10-01T14:13:18.532Z,1601561598.532 [CBIT](DEBUG): Initialized mux pins.
2020-10-01T14:13:18.532Z,1601561598.532 [CBIT](DEBUG): Initializing the watchdog timer.
2020-10-01T14:13:18.541Z,1601561598.541 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8501
2020-10-01T14:13:18.542Z,1601561598.542 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-10-01T14:13:18.553Z,1601561598.553 [Onboard ThreadHandler](INFO): Handler Thread ID is 8502
2020-10-01T14:13:18.557Z,1601561598.557 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-10-01T14:13:18.557Z,1601561598.557 [CBIT](DEBUG): Initializing heartbeat.
2020-10-01T14:13:18.570Z,1601561598.570 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8503
2020-10-01T14:13:18.593Z,1601561598.593 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 8504
2020-10-01T14:13:18.613Z,1601561598.613 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8505
2020-10-01T14:13:18.613Z,1601561598.613 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-10-01T14:13:18.618Z,1601561598.618 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8507
2020-10-01T14:13:18.619Z,1601561598.619 [WetLabsBB2FL](INFO): Powering down
2020-10-01T14:13:18.629Z,1601561598.629 [CBIT](DEBUG): Deactivating GF circuits.
2020-10-01T14:13:18.629Z,1601561598.629 [CBIT](DEBUG): Deactivating emergency mode.
2020-10-01T14:13:18.653Z,1601561598.653 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8508
2020-10-01T14:13:18.656Z,1601561598.656 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-10-01T14:13:18.656Z,1601561598.656 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-10-01T14:13:18.656Z,1601561598.656 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-10-01T14:13:18.656Z,1601561598.656 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-10-01T14:13:18.656Z,1601561598.656 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-10-01T14:13:18.657Z,1601561598.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-10-01T14:13:18.658Z,1601561598.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-10-01T14:13:18.658Z,1601561598.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-10-01T14:13:18.658Z,1601561598.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-10-01T14:13:18.658Z,1601561598.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-10-01T14:13:18.665Z,1601561598.665 [CBIT](DEBUG): Backplane powered.
2020-10-01T14:13:18.667Z,1601561598.667 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-10-01T14:13:18.681Z,1601561598.681 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-10-01T14:13:18.724Z,1601561598.724 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2020-10-01T14:13:18.725Z,1601561598.725 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-10-01T14:13:18.797Z,1601561598.797 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-10-01T14:13:18.798Z,1601561598.798 [Default:A.Wait](DEBUG): Construct Wait.
2020-10-01T14:13:18.800Z,1601561598.800 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-10-01T14:13:18.851Z,1601561598.851 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-10-01T14:13:18.853Z,1601561598.853 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-10-01T14:13:18.871Z,1601561598.871 [Default:E.Execute](DEBUG): Construct Execute.
2020-10-01T14:13:18.874Z,1601561598.874 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2020-10-01T14:13:18.884Z,1601561598.884 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,ESPComponent,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-10-01T14:13:18.896Z,1601561598.896 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-10-01T14:13:18.977Z,1601561598.977 [Radio_Surface](INFO): Powering up
2020-10-01T14:13:19.025Z,1601561599.025 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-10-01T14:13:19.025Z,1601561599.025 [DAT](INFO): Powering up
2020-10-01T14:13:19.025Z,1601561599.025 [DAT](DEBUG): Initializing DAT.
2020-10-01T14:13:19.098Z,1601561599.098 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-10-01T14:13:19.101Z,1601561599.101 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-10-01T14:13:19.117Z,1601561599.117 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-10-01T14:13:19.119Z,1601561599.119 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-10-01T14:13:19.125Z,1601561599.125 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-10-01T14:13:19.126Z,1601561599.126 [MassServo](DEBUG): Initializing EZServoServo.
2020-10-01T14:13:19.137Z,1601561599.137 [MassServo](DEBUG): Initializing MassServo.
2020-10-01T14:13:19.138Z,1601561599.138 [RudderServo](DEBUG): Initializing EZServoServo.
2020-10-01T14:13:19.149Z,1601561599.149 [RudderServo](DEBUG): Initializing RudderServo.
2020-10-01T14:13:19.150Z,1601561599.150 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-10-01T14:13:19.161Z,1601561599.161 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-10-01T14:13:20.012Z,1601561600.012 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-10-01T14:13:20.013Z,1601561600.013 [RudderServo](FAULT): Rudder failed to initialize
2020-10-01T14:13:20.013Z,1601561600.013 [RudderServo] Communications Fault, FailCount= 1
2020-10-01T14:13:20.013Z,1601561600.013 [RudderServo](ERROR): Communications Fault
2020-10-01T14:13:20.124Z,1601561600.124 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-10-01T14:13:20.289Z,1601561600.289 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-10-01T14:13:20.289Z,1601561600.289 [RudderServo](INFO): Powering down
2020-10-01T14:13:20.951Z,1601561600.951 [RudderServo](DEBUG): Initializing EZServoServo.
2020-10-01T14:13:21.069Z,1601561601.069 [RudderServo](DEBUG): Initializing RudderServo.
2020-10-01T14:13:21.073Z,1601561601.073 [CBIT](INFO): Clearing failed state for component RudderServo
2020-10-01T14:13:21.073Z,1601561601.073 [RudderServo] No Fault, FailCount= 1
2020-10-01T14:13:22.622Z,1601561602.622 [BuoyancyServo](INFO): ready
2020-10-01T14:13:22.622Z,1601561602.622 [BuoyancyServo](INFO): need settle time
2020-10-01T14:13:25.645Z,1601561605.645 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2020-10-01T14:13:28.663Z,1601561608.663 [CBIT](CRITICAL): Environmental Failure. Press:14.507635 PSI. Humidity:51%. Temp:22 C. ABORTING MISSION
2020-10-01T14:13:28.663Z,1601561608.663 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2020-10-01T14:13:29.074Z,1601561609.074 [CommandLine](FAULT): Scheduling is paused
2020-10-01T14:13:29.074Z,1601561609.074 [CBIT](INFO): Critical error at 20201001T141328
2020-10-01T14:13:33.068Z,1601561613.068 [DAT](INFO): commRate: 800
2020-10-01T14:13:35.086Z,1601561615.086 [DAT](INFO): entering command mode
2020-10-01T14:13:35.490Z,1601561615.490 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:35.894Z,1601561615.894 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:36.298Z,1601561616.298 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:36.702Z,1601561616.702 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:37.106Z,1601561617.106 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:37.506Z,1601561617.506 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:37.914Z,1601561617.914 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:38.318Z,1601561618.318 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:38.718Z,1601561618.718 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:39.126Z,1601561619.126 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:39.530Z,1601561619.530 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:39.930Z,1601561619.930 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:40.338Z,1601561620.338 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:40.738Z,1601561620.738 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:41.142Z,1601561621.142 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:41.546Z,1601561621.546 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:41.954Z,1601561621.954 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:42.354Z,1601561622.354 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:42.758Z,1601561622.758 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:43.162Z,1601561623.162 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:43.566Z,1601561623.566 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:43.976Z,1601561623.976 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:44.374Z,1601561624.374 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:44.778Z,1601561624.778 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:45.190Z,1601561625.190 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:45.590Z,1601561625.590 [NAL9602](INFO): Powering up NAL9602
2020-10-01T14:13:45.591Z,1601561625.591 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:45.990Z,1601561625.990 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:46.398Z,1601561626.398 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:46.798Z,1601561626.798 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:47.218Z,1601561627.218 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:47.606Z,1601561627.606 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:48.031Z,1601561628.031 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:48.414Z,1601561628.414 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:48.822Z,1601561628.822 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:49.238Z,1601561629.238 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:49.626Z,1601561629.626 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:49.665Z,1601561629.665 [BuoyancyServo](FAULT): is needed
2020-10-01T14:13:50.034Z,1601561630.034 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:50.438Z,1601561630.438 [DAT](DEBUG): checking for command mode acknowledgment
2020-10-01T14:13:50.438Z,1601561630.438 [DAT](FAULT): failed to enter command mode
2020-10-01T14:13:50.838Z,1601561630.838 [DAT](INFO): entering command mode
2020-10-01T14:13:51.243Z,1601561631.243 [DAT](INFO): setting verbose to 3
2020-10-01T14:13:51.322Z,1601561631.322 [BuoyancyServo](INFO): ready
2020-10-01T14:13:51.322Z,1601561631.322 [BuoyancyServo](FAULT): is needed
2020-10-01T14:13:51.659Z,1601561631.659 [DAT](INFO): set verbose to 3
2020-10-01T14:13:51.659Z,1601561631.659 [DAT](INFO): setting DatVerbose to 27440
2020-10-01T14:13:51.741Z,1601561631.741 [BuoyancyServo](INFO): ready
2020-10-01T14:13:52.071Z,1601561632.071 [DAT](INFO): set DatVerbose to 27440
2020-10-01T14:13:52.071Z,1601561632.071 [DAT](INFO): setting transmit power to 8
2020-10-01T14:13:52.459Z,1601561632.459 [DAT](INFO): set transmit power to 8
2020-10-01T14:13:52.459Z,1601561632.459 [DAT](INFO): setting local address to 9
2020-10-01T14:13:52.896Z,1601561632.896 [DAT](INFO): set local address to 9
2020-10-01T14:13:56.498Z,1601561636.498 [NAL9602](INFO): NAL9602 initialized
2020-10-01T14:13:58.517Z,1601561638.517 [CommandLine](IMPORTANT): got command report touch platform_buoyancy_position
2020-10-01T14:14:21.988Z,1601561661.988 [BuoyancyServo](FAULT): is needed
2020-10-01T14:14:23.601Z,1601561663.601 [BuoyancyServo](INFO): ready
2020-10-01T14:14:23.601Z,1601561663.601 [BuoyancyServo](FAULT): is needed
2020-10-01T14:14:23.617Z,1601561663.617 [Reporter](INFO): platform_buoyancy_position 947.324951 cc
2020-10-01T14:14:24.041Z,1601561664.041 [BuoyancyServo](INFO): ready
2020-10-01T14:14:24.046Z,1601561664.046 [Reporter](INFO): platform_buoyancy_position 947.324951 cc
2020-10-01T14:14:27.586Z,1601561667.586 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 930.000000 cubic_centimeter
2020-10-01T14:14:27.588Z,1601561667.588 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2020-10-01T14:14:27.651Z,1601561667.651 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,ESPComponent,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-10-01T14:14:28.032Z,1601561668.032 [BuoyancyServo](FAULT): is needed
2020-10-01T14:14:29.673Z,1601561669.673 [BuoyancyServo](INFO): ready
2020-10-01T14:14:29.673Z,1601561669.673 [BuoyancyServo](INFO): requested pos: 930.000000
2020-10-01T14:14:29.718Z,1601561669.718 [Reporter](INFO): platform_buoyancy_position 945.310425 cc
2020-10-01T14:14:30.076Z,1601561670.076 [BuoyancyServo](INFO): moving
2020-10-01T14:14:30.082Z,1601561670.082 [Reporter](INFO): platform_buoyancy_position 945.847656 cc
2020-10-01T14:14:30.508Z,1601561670.508 [BuoyancyServo](INFO): moving
2020-10-01T14:14:30.514Z,1601561670.514 [Reporter](INFO): platform_buoyancy_position 945.310425 cc
2020-10-01T14:14:30.903Z,1601561670.903 [BuoyancyServo](INFO): moving
2020-10-01T14:14:30.909Z,1601561670.909 [Reporter](INFO): platform_buoyancy_position 938.729736 cc
2020-10-01T14:14:31.300Z,1601561671.300 [BuoyancyServo](INFO): moving
2020-10-01T14:14:31.325Z,1601561671.325 [Reporter](INFO): platform_buoyancy_position 938.864136 cc
2020-10-01T14:14:31.712Z,1601561671.712 [BuoyancyServo](INFO): moving
2020-10-01T14:14:31.719Z,1601561671.719 [Reporter](INFO): platform_buoyancy_position 938.864136 cc
2020-10-01T14:14:32.093Z,1601561672.093 [BuoyancyServo](INFO): moving
2020-10-01T14:14:32.105Z,1601561672.105 [Reporter](INFO): platform_buoyancy_position 938.729736 cc
2020-10-01T14:14:32.505Z,1601561672.505 [BuoyancyServo](INFO): moving
2020-10-01T14:14:32.532Z,1601561672.532 [Reporter](INFO): platform_buoyancy_position 938.729736 cc
2020-10-01T14:14:32.913Z,1601561672.913 [BuoyancyServo](INFO): moving
2020-10-01T14:14:32.918Z,1601561672.918 [Reporter](INFO): platform_buoyancy_position 936.715332 cc
2020-10-01T14:14:33.308Z,1601561673.308 [BuoyancyServo](INFO): moving
2020-10-01T14:14:33.314Z,1601561673.314 [Reporter](INFO): platform_buoyancy_position 936.580933 cc
2020-10-01T14:14:33.713Z,1601561673.713 [BuoyancyServo](INFO): moving
2020-10-01T14:14:33.726Z,1601561673.726 [Reporter](INFO): platform_buoyancy_position 936.446655 cc
2020-10-01T14:14:34.117Z,1601561674.117 [BuoyancyServo](INFO): moving
2020-10-01T14:14:34.138Z,1601561674.138 [Reporter](INFO): platform_buoyancy_position 934.432129 cc
2020-10-01T14:14:34.530Z,1601561674.530 [BuoyancyServo](INFO): ready
2020-10-01T14:14:34.551Z,1601561674.551 [Reporter](INFO): platform_buoyancy_position 932.417725 cc
2020-10-01T14:14:54.289Z,1601561694.289 [BuoyancyServo](FAULT): is needed
2020-10-01T14:14:56.341Z,1601561696.341 [BuoyancyServo](INFO): ready
2020-10-01T14:14:56.341Z,1601561696.341 [BuoyancyServo](INFO): requested pos: 930.000000
2020-10-01T14:14:56.399Z,1601561696.399 [Reporter](INFO): platform_buoyancy_position 940.609985 cc
2020-10-01T14:14:56.764Z,1601561696.764 [BuoyancyServo](INFO): moving
2020-10-01T14:14:56.770Z,1601561696.770 [Reporter](INFO): platform_buoyancy_position 940.744263 cc
2020-10-01T14:14:57.161Z,1601561697.161 [BuoyancyServo](INFO): moving
2020-10-01T14:14:57.166Z,1601561697.166 [Reporter](INFO): platform_buoyancy_position 940.341431 cc
2020-10-01T14:14:57.562Z,1601561697.562 [BuoyancyServo](INFO): moving
2020-10-01T14:14:57.568Z,1601561697.568 [Reporter](INFO): platform_buoyancy_position 932.283325 cc
2020-10-01T14:14:57.969Z,1601561697.969 [BuoyancyServo](INFO): moving
2020-10-01T14:14:57.999Z,1601561697.999 [SBIT](IMPORTANT): Beginning Startup BIT
2020-10-01T14:14:58.004Z,1601561698.004 [CBIT](IMPORTANT): Beginning ground fault scan
2020-10-01T14:14:58.006Z,1601561698.006 [Reporter](INFO): platform_buoyancy_position 934.432129 cc
2020-10-01T14:14:58.356Z,1601561698.356 [BuoyancyServo](INFO): moving
2020-10-01T14:14:58.425Z,1601561698.425 [Reporter](INFO): platform_buoyancy_position 934.432129 cc
2020-10-01T14:14:58.765Z,1601561698.765 [BuoyancyServo](INFO): moving
2020-10-01T14:14:58.798Z,1601561698.798 [Reporter](INFO): platform_buoyancy_position 934.432129 cc
2020-10-01T14:14:59.153Z,1601561699.153 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 800.000000 cubic_centimeter
2020-10-01T14:14:59.173Z,1601561699.173 [BuoyancyServo](INFO): moving
2020-10-01T14:14:59.230Z,1601561699.230 [Reporter](INFO): platform_buoyancy_position 932.552002 cc
2020-10-01T14:14:59.572Z,1601561699.572 [BuoyancyServo](INFO): moving
2020-10-01T14:14:59.798Z,1601561699.798 [Reporter](INFO): platform_buoyancy_position 932.552002 cc
2020-10-01T14:14:59.973Z,1601561699.973 [BuoyancyServo](INFO): ready
2020-10-01T14:15:03.625Z,1601561703.625 [BuoyancyServo](INFO): ready
2020-10-01T14:15:03.625Z,1601561703.625 [BuoyancyServo](INFO): requested pos: 800.000000
2020-10-01T14:15:03.789Z,1601561703.789 [Reporter](INFO): platform_buoyancy_position 932.417725 cc
2020-10-01T14:15:04.013Z,1601561704.013 [BuoyancyServo](INFO): moving
2020-10-01T14:15:04.050Z,1601561704.050 [Reporter](INFO): platform_buoyancy_position 932.283325 cc
2020-10-01T14:15:04.424Z,1601561704.424 [BuoyancyServo](INFO): moving
2020-10-01T14:15:04.463Z,1601561704.463 [Reporter](INFO): platform_buoyancy_position 929.463135 cc
2020-10-01T14:15:04.821Z,1601561704.821 [BuoyancyServo](INFO): moving
2020-10-01T14:15:04.867Z,1601561704.867 [Reporter](INFO): platform_buoyancy_position 925.971313 cc
2020-10-01T14:15:05.225Z,1601561705.225 [BuoyancyServo](INFO): moving
2020-10-01T14:15:05.357Z,1601561705.357 [Reporter](INFO): platform_buoyancy_position 921.539429 cc
2020-10-01T14:15:05.625Z,1601561705.625 [BuoyancyServo](INFO): moving
2020-10-01T14:15:05.662Z,1601561705.662 [Reporter](INFO): platform_buoyancy_position 915.227295 cc
2020-10-01T14:15:06.041Z,1601561706.041 [BuoyancyServo](INFO): moving
2020-10-01T14:15:06.071Z,1601561706.071 [Reporter](INFO): platform_buoyancy_position 910.929688 cc
2020-10-01T14:15:06.437Z,1601561706.437 [BuoyancyServo](INFO): moving
2020-10-01T14:15:06.570Z,1601561706.570 [Reporter](INFO): platform_buoyancy_position 906.229126 cc
2020-10-01T14:15:06.845Z,1601561706.845 [BuoyancyServo](INFO): moving
2020-10-01T14:15:06.878Z,1601561706.878 [Reporter](INFO): platform_buoyancy_position 900.051392 cc
2020-10-01T14:15:07.265Z,1601561707.265 [BuoyancyServo](INFO): moving
2020-10-01T14:15:07.318Z,1601561707.318 [Reporter](INFO): platform_buoyancy_position 894.276489 cc
2020-10-01T14:15:07.665Z,1601561707.665 [BuoyancyServo](INFO): moving
2020-10-01T14:15:07.805Z,1601561707.805 [Reporter](INFO): platform_buoyancy_position 889.441650 cc
2020-10-01T14:15:08.073Z,1601561708.073 [BuoyancyServo](INFO): moving
2020-10-01T14:15:08.111Z,1601561708.111 [Reporter](INFO): platform_buoyancy_position 885.144043 cc
2020-10-01T14:15:08.469Z,1601561708.469 [BuoyancyServo](INFO): moving
2020-10-01T14:15:08.509Z,1601561708.509 [Reporter](INFO): platform_buoyancy_position 878.697632 cc
2020-10-01T14:15:08.873Z,1601561708.873 [BuoyancyServo](INFO): moving
2020-10-01T14:15:09.009Z,1601561709.009 [Reporter](INFO): platform_buoyancy_position 874.400024 cc
2020-10-01T14:15:09.270Z,1601561709.270 [BuoyancyServo](INFO): moving
2020-10-01T14:15:09.309Z,1601561709.309 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.011564
CHAN A1 (24V): 0.001329
CHAN A2 (12V): -0.006118
CHAN A3 (5V): -0.002187
CHAN B0 (3.3V): 0.000970
CHAN B1 (3.15aV): -0.000328
CHAN B2 (3.15bV): -0.000675
CHAN B3 (GND): 0.002142
OPEN: 0.004958
Full Scale Calc: 4.765 mA, -1.589 mA
2020-10-01T14:15:09.311Z,1601561709.311 [Reporter](INFO): platform_buoyancy_position 869.968140 cc
2020-10-01T14:15:09.673Z,1601561709.673 [BuoyancyServo](INFO): moving
2020-10-01T14:15:09.706Z,1601561709.706 [Reporter](INFO): platform_buoyancy_position 863.521729 cc
2020-10-01T14:15:10.072Z,1601561710.072 [BuoyancyServo](INFO): moving
2020-10-01T14:15:10.110Z,1601561710.110 [Reporter](INFO): platform_buoyancy_position 859.224121 cc
2020-10-01T14:15:10.484Z,1601561710.484 [BuoyancyServo](INFO): moving
2020-10-01T14:15:10.522Z,1601561710.522 [Reporter](INFO): platform_buoyancy_position 852.777832 cc
2020-10-01T14:15:10.884Z,1601561710.884 [BuoyancyServo](INFO): moving
2020-10-01T14:15:11.006Z,1601561711.006 [Reporter](INFO): platform_buoyancy_position 848.480225 cc
2020-10-01T14:15:11.285Z,1601561711.285 [BuoyancyServo](INFO): moving
2020-10-01T14:15:11.291Z,1601561711.291 [Reporter](INFO): platform_buoyancy_position 842.168091 cc
2020-10-01T14:15:11.689Z,1601561711.689 [BuoyancyServo](INFO): moving
2020-10-01T14:15:11.708Z,1601561711.708 [Reporter](INFO): platform_buoyancy_position 837.736206 cc
2020-10-01T14:15:12.101Z,1601561712.101 [BuoyancyServo](INFO): moving
2020-10-01T14:15:12.121Z,1601561712.121 [Reporter](INFO): platform_buoyancy_position 831.289795 cc
2020-10-01T14:15:12.517Z,1601561712.517 [BuoyancyServo](INFO): moving
2020-10-01T14:15:12.570Z,1601561712.570 [Reporter](INFO): platform_buoyancy_position 826.992188 cc
2020-10-01T14:15:12.913Z,1601561712.913 [BuoyancyServo](INFO): moving
2020-10-01T14:15:13.114Z,1601561713.114 [Reporter](INFO): platform_buoyancy_position 820.680054 cc
2020-10-01T14:15:13.317Z,1601561713.317 [BuoyancyServo](INFO): moving
2020-10-01T14:15:13.402Z,1601561713.402 [Reporter](INFO): platform_buoyancy_position 816.248169 cc
2020-10-01T14:15:13.745Z,1601561713.745 [BuoyancyServo](INFO): moving
2020-10-01T14:15:13.842Z,1601561713.842 [Reporter](INFO): platform_buoyancy_position 809.936096 cc
2020-10-01T14:15:14.105Z,1601561714.105 [BuoyancyServo](INFO): ready
2020-10-01T14:15:14.193Z,1601561714.193 [Reporter](INFO): platform_buoyancy_position 805.638489 cc
2020-10-01T14:15:27.090Z,1601561727.090 [BuoyancyServo](FAULT): is needed
2020-10-01T14:15:29.072Z,1601561729.072 [BuoyancyServo](INFO): ready
2020-10-01T14:15:29.073Z,1601561729.073 [BuoyancyServo](FAULT): is needed
2020-10-01T14:15:29.194Z,1601561729.194 [Reporter](INFO): platform_buoyancy_position 809.398865 cc
2020-10-01T14:15:29.477Z,1601561729.477 [BuoyancyServo](INFO): ready
2020-10-01T14:15:29.489Z,1601561729.489 [Reporter](INFO): platform_buoyancy_position 809.936096 cc
2020-10-01T14:15:50.787Z,1601561750.787 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005222
2020-10-01T14:15:51.667Z,1601561751.667 [SBIT](IMPORTANT): SBIT PASSED
2020-10-01T14:15:51.667Z,1601561751.667 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-10-01T14:15:51.668Z,1601561751.668 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool;

2020-10-01T14:15:51.668Z,1601561751.668 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2020-10-01T14:15:51.668Z,1601561751.668 [SBIT](IMPORTANT): BuoyancyServo.loadAtStartup=1 bool;

2020-10-01T14:15:51.668Z,1601561751.668 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere;

2020-10-01T14:15:51.668Z,1601561751.668 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): DAT.surfaceThreshold=100 meter;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): DAT.verbosity=0 count;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second;

2020-10-01T14:15:51.669Z,1601561751.669 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2020-10-01T14:15:51.670Z,1601561751.670 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt;

2020-10-01T14:15:51.670Z,1601561751.670 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=0 bool;

2020-10-01T14:15:51.670Z,1601561751.670 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=170 cubic_centimeter;

2020-10-01T14:15:51.670Z,1601561751.670 [SBIT](IMPORTANT): VerticalControl.massDefault=20 millimeter;

2020-10-01T14:15:51.670Z,1601561751.670 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool;

2020-10-01T14:15:52.222Z,1601561752.222 [MissionManager](IMPORTANT): Started mission Startup
2020-10-01T14:15:52.222Z,1601561752.222 [Startup] Running Loop=1
2020-10-01T14:15:52.222Z,1601561752.222 [Startup](DEBUG): Aggregate::initialize Startup
2020-10-01T14:15:52.222Z,1601561752.222 [Startup:A.GoToSurface] Running Loop=1
2020-10-01T14:15:52.222Z,1601561752.222 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-01T14:15:52.223Z,1601561752.223 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-01T14:15:52.223Z,1601561752.223 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-01T14:15:52.224Z,1601561752.224 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-01T14:15:52.253Z,1601561752.253 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-01T14:15:52.253Z,1601561752.253 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-01T14:15:52.261Z,1601561752.261 [Startup:StartupSatComms] Running Loop=1
2020-10-01T14:15:52.261Z,1601561752.261 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-10-01T14:15:52.261Z,1601561752.261 [Startup:StartupSatComms:A] Running Loop=1
2020-10-01T14:15:52.501Z,1601561752.501 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-10-01T14:15:59.761Z,1601561759.761 [BuoyancyServo](FAULT): is needed
2020-10-01T14:16:01.778Z,1601561761.778 [BuoyancyServo](INFO): ready
2020-10-01T14:16:01.785Z,1601561761.785 [BuoyancyServo](FAULT): is needed
2020-10-01T14:16:01.790Z,1601561761.790 [Reporter](INFO): platform_buoyancy_position 807.652954 cc
2020-10-01T14:16:02.185Z,1601561762.185 [BuoyancyServo](INFO): ready
2020-10-01T14:16:02.197Z,1601561762.197 [Reporter](INFO): platform_buoyancy_position 807.787292 cc
2020-10-01T14:16:04.803Z,1601561764.803 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 980.000000 cubic_centimeter
2020-10-01T14:16:04.999Z,1601561764.999 [BuoyancyServo](FAULT): is needed
2020-10-01T14:16:07.057Z,1601561767.057 [BuoyancyServo](INFO): ready
2020-10-01T14:16:07.057Z,1601561767.057 [BuoyancyServo](INFO): requested pos: 980.000000
2020-10-01T14:16:07.108Z,1601561767.108 [Reporter](INFO): platform_buoyancy_position 807.787292 cc
2020-10-01T14:16:07.445Z,1601561767.445 [BuoyancyServo](INFO): moving
2020-10-01T14:16:07.450Z,1601561767.450 [Reporter](INFO): platform_buoyancy_position 809.801758 cc
2020-10-01T14:16:07.837Z,1601561767.837 [BuoyancyServo](INFO): moving
2020-10-01T14:16:07.842Z,1601561767.842 [Reporter](INFO): platform_buoyancy_position 809.936096 cc
2020-10-01T14:16:08.245Z,1601561768.245 [BuoyancyServo](INFO): moving
2020-10-01T14:16:08.257Z,1601561768.257 [Reporter](INFO): platform_buoyancy_position 807.652954 cc
2020-10-01T14:16:08.661Z,1601561768.661 [BuoyancyServo](INFO): moving
2020-10-01T14:16:08.677Z,1601561768.677 [Reporter](INFO): platform_buoyancy_position 814.905151 cc
2020-10-01T14:16:09.060Z,1601561769.060 [BuoyancyServo](INFO): moving
2020-10-01T14:16:09.066Z,1601561769.066 [Reporter](INFO): platform_buoyancy_position 822.694580 cc
2020-10-01T14:16:09.457Z,1601561769.457 [BuoyancyServo](INFO): moving
2020-10-01T14:16:09.462Z,1601561769.462 [Reporter](INFO): platform_buoyancy_position 827.126465 cc
2020-10-01T14:16:09.857Z,1601561769.857 [BuoyancyServo](INFO): moving
2020-10-01T14:16:09.869Z,1601561769.869 [Reporter](INFO): platform_buoyancy_position 833.438599 cc
2020-10-01T14:16:10.285Z,1601561770.285 [BuoyancyServo](INFO): moving
2020-10-01T14:16:10.290Z,1601561770.290 [Reporter](INFO): platform_buoyancy_position 839.079224 cc
2020-10-01T14:16:10.685Z,1601561770.685 [BuoyancyServo](INFO): moving
2020-10-01T14:16:10.698Z,1601561770.698 [Reporter](INFO): platform_buoyancy_position 844.316895 cc
2020-10-01T14:16:11.096Z,1601561771.096 [BuoyancyServo](INFO): moving
2020-10-01T14:16:11.102Z,1601561771.102 [Reporter](INFO): platform_buoyancy_position 850.629028 cc
2020-10-01T14:16:11.496Z,1601561771.496 [BuoyancyServo](INFO): moving
2020-10-01T14:16:11.502Z,1601561771.502 [Reporter](INFO): platform_buoyancy_position 855.060913 cc
2020-10-01T14:16:11.884Z,1601561771.884 [BuoyancyServo](INFO): moving
2020-10-01T14:16:11.903Z,1601561771.903 [Reporter](INFO): platform_buoyancy_position 859.895630 cc
2020-10-01T14:16:12.277Z,1601561772.277 [BuoyancyServo](INFO): moving
2020-10-01T14:16:12.282Z,1601561772.282 [Reporter](INFO): platform_buoyancy_position 865.670532 cc
2020-10-01T14:16:12.693Z,1601561772.693 [BuoyancyServo](INFO): moving
2020-10-01T14:16:12.698Z,1601561772.698 [Reporter](INFO): platform_buoyancy_position 870.102539 cc
2020-10-01T14:16:13.101Z,1601561773.101 [BuoyancyServo](INFO): moving
2020-10-01T14:16:13.106Z,1601561773.106 [Reporter](INFO): platform_buoyancy_position 876.414551 cc
2020-10-01T14:16:13.497Z,1601561773.497 [BuoyancyServo](INFO): moving
2020-10-01T14:16:13.502Z,1601561773.502 [Reporter](INFO): platform_buoyancy_position 880.846436 cc
2020-10-01T14:16:13.909Z,1601561773.909 [BuoyancyServo](INFO): moving
2020-10-01T14:16:13.914Z,1601561773.914 [Reporter](INFO): platform_buoyancy_position 887.158569 cc
2020-10-01T14:16:14.313Z,1601561774.313 [BuoyancyServo](INFO): moving
2020-10-01T14:16:14.318Z,1601561774.318 [Reporter](INFO): platform_buoyancy_position 891.590454 cc
2020-10-01T14:16:14.713Z,1601561774.713 [BuoyancyServo](INFO): moving
2020-10-01T14:16:14.718Z,1601561774.718 [Reporter](INFO): platform_buoyancy_position 897.902588 cc
2020-10-01T14:16:15.116Z,1601561775.116 [BuoyancyServo](INFO): moving
2020-10-01T14:16:15.138Z,1601561775.138 [Reporter](INFO): platform_buoyancy_position 902.334473 cc
2020-10-01T14:16:15.533Z,1601561775.533 [BuoyancyServo](INFO): moving
2020-10-01T14:16:15.546Z,1601561775.546 [Reporter](INFO): platform_buoyancy_position 908.646606 cc
2020-10-01T14:16:15.945Z,1601561775.945 [BuoyancyServo](INFO): moving
2020-10-01T14:16:15.950Z,1601561775.950 [Reporter](INFO): platform_buoyancy_position 913.078491 cc
2020-10-01T14:16:16.344Z,1601561776.344 [BuoyancyServo](INFO): moving
2020-10-01T14:16:16.350Z,1601561776.350 [Reporter](INFO): platform_buoyancy_position 919.390625 cc
2020-10-01T14:16:16.749Z,1601561776.749 [BuoyancyServo](INFO): moving
2020-10-01T14:16:16.754Z,1601561776.754 [Reporter](INFO): platform_buoyancy_position 923.822510 cc
2020-10-01T14:16:17.165Z,1601561777.165 [BuoyancyServo](INFO): moving
2020-10-01T14:16:17.171Z,1601561777.171 [Reporter](INFO): platform_buoyancy_position 930.268921 cc
2020-10-01T14:16:17.570Z,1601561777.570 [BuoyancyServo](INFO): moving
2020-10-01T14:16:17.595Z,1601561777.595 [Reporter](INFO): platform_buoyancy_position 934.566528 cc
2020-10-01T14:16:17.957Z,1601561777.957 [BuoyancyServo](INFO): moving
2020-10-01T14:16:17.967Z,1601561777.967 [Reporter](INFO): platform_buoyancy_position 938.998413 cc
2020-10-01T14:16:18.353Z,1601561778.353 [BuoyancyServo](INFO): moving
2020-10-01T14:16:18.375Z,1601561778.375 [Reporter](INFO): platform_buoyancy_position 945.310425 cc
2020-10-01T14:16:18.738Z,1601561778.738 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-10-01T14:16:18.738Z,1601561778.738 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:16:18.793Z,1601561778.793 [BuoyancyServo](INFO): moving
2020-10-01T14:16:18.797Z,1601561778.797 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:16:18.805Z,1601561778.805 [Reporter](INFO): platform_buoyancy_position 951.622559 cc
2020-10-01T14:16:19.393Z,1601561779.393 [BuoyancyServo](INFO): moving
2020-10-01T14:16:19.397Z,1601561779.397 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:16:19.397Z,1601561779.397 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-10-01T14:16:19.398Z,1601561779.398 [Reporter](INFO): platform_buoyancy_position 958.068970 cc
2020-10-01T14:16:19.609Z,1601561779.609 [BuoyancyServo](INFO): moving
2020-10-01T14:16:19.615Z,1601561779.615 [Reporter](INFO): platform_buoyancy_position 962.366577 cc
2020-10-01T14:16:19.997Z,1601561779.997 [BuoyancyServo](INFO): moving
2020-10-01T14:16:20.005Z,1601561780.005 [Reporter](INFO): platform_buoyancy_position 966.798462 cc
2020-10-01T14:16:20.397Z,1601561780.397 [BuoyancyServo](INFO): ready
2020-10-01T14:16:20.420Z,1601561780.420 [Reporter](INFO): platform_buoyancy_position 970.961792 cc
2020-10-01T14:16:32.514Z,1601561792.514 [BuoyancyServo](FAULT): is needed
2020-10-01T14:16:34.509Z,1601561794.509 [BuoyancyServo](INFO): ready
2020-10-01T14:16:34.509Z,1601561794.509 [BuoyancyServo](INFO): need settle time
2020-10-01T14:16:34.509Z,1601561794.509 [BuoyancyServo](FAULT): is needed
2020-10-01T14:16:34.530Z,1601561794.530 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:16:34.913Z,1601561794.913 [BuoyancyServo](INFO): ready
2020-10-01T14:16:34.918Z,1601561794.918 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:16:52.264Z,1601561812.264 [Startup:StartupSatComms:A](INFO): Timed out from 2020-10-01T14:15:52.3Z
2020-10-01T14:16:52.264Z,1601561812.264 [Startup:StartupSatComms:A] Stopped
2020-10-01T14:16:52.264Z,1601561812.264 [Startup:StartupSatComms:B] Running Loop=1
2020-10-01T14:16:52.673Z,1601561812.673 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-10-01T14:16:57.704Z,1601561817.704 [DataOverHttps](INFO): Sending 251 bytes from file Logs/20201001T140838/Courier0000.lzma
2020-10-01T14:16:58.706Z,1601561818.706 [DataOverHttps](INFO): Moved sent file to Logs/20201001T140838/Courier0000.lzma.bak
2020-10-01T14:16:58.706Z,1601561818.706 [DataOverHttps](INFO): SBD MOMSN=12702593
2020-10-01T14:17:05.285Z,1601561825.285 [BuoyancyServo](FAULT): is needed
2020-10-01T14:17:06.929Z,1601561826.929 [BuoyancyServo](INFO): ready
2020-10-01T14:17:06.929Z,1601561826.929 [BuoyancyServo](FAULT): is needed
2020-10-01T14:17:06.935Z,1601561826.935 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:17:07.321Z,1601561827.321 [BuoyancyServo](INFO): ready
2020-10-01T14:17:07.326Z,1601561827.326 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:17:14.427Z,1601561834.427 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201001T140838/Courier0004.lzma
2020-10-01T14:17:15.426Z,1601561835.426 [DataOverHttps](INFO): Moved sent file to Logs/20201001T140838/Courier0004.lzma.bak
2020-10-01T14:17:15.426Z,1601561835.426 [DataOverHttps](INFO): SBD MOMSN=12702597
2020-10-01T14:17:31.000Z,1601561851.000 [DataOverHttps](INFO): Sending 250 bytes from file Logs/20201001T141306/Courier0000.lzma
2020-10-01T14:17:32.002Z,1601561852.002 [DataOverHttps](INFO): Moved sent file to Logs/20201001T141306/Courier0000.lzma.bak
2020-10-01T14:17:32.002Z,1601561852.002 [DataOverHttps](INFO): SBD MOMSN=12702599
2020-10-01T14:17:37.610Z,1601561857.610 [BuoyancyServo](FAULT): is needed
2020-10-01T14:17:39.259Z,1601561859.259 [BuoyancyServo](INFO): ready
2020-10-01T14:17:39.260Z,1601561859.260 [BuoyancyServo](FAULT): is needed
2020-10-01T14:17:39.274Z,1601561859.274 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:17:39.717Z,1601561859.717 [BuoyancyServo](INFO): ready
2020-10-01T14:17:39.724Z,1601561859.724 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:17:48.709Z,1601561868.709 [DataOverHttps](INFO): Sending 193 bytes from file Logs/20200930T213943/Express0017.lzma
2020-10-01T14:17:49.714Z,1601561869.714 [DataOverHttps](INFO): Moved sent file to Logs/20200930T213943/Express0017.lzma.bak
2020-10-01T14:17:49.715Z,1601561869.715 [DataOverHttps](INFO): SBD MOMSN=12702603
2020-10-01T14:17:52.541Z,1601561872.541 [Startup:StartupSatComms:B](INFO): Timed out from 2020-10-01T14:16:52.3Z
2020-10-01T14:17:52.541Z,1601561872.541 [Startup:StartupSatComms:B] Stopped
2020-10-01T14:17:52.541Z,1601561872.541 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-10-01T14:17:52.541Z,1601561872.541 [Startup:StartupSatComms] Stopped
2020-10-01T14:17:52.541Z,1601561872.541 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-10-01T14:17:52.542Z,1601561872.542 [Startup](INFO): Completed Startup
2020-10-01T14:17:52.542Z,1601561872.542 [MissionManager](INFO): Startup is completed.
2020-10-01T14:17:52.542Z,1601561872.542 [MissionManager](INFO): Uninitializing Mission Startup
2020-10-01T14:17:52.542Z,1601561872.542 [Startup] Stopped
2020-10-01T14:17:52.542Z,1601561872.542 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-10-01T14:17:52.542Z,1601561872.542 [Startup:A.GoToSurface] Stopped
2020-10-01T14:17:52.542Z,1601561872.542 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-01T14:17:52.956Z,1601561872.956 [MissionManager](IMPORTANT): Started mission Default
2020-10-01T14:17:52.957Z,1601561872.957 [Default] Running Loop=1
2020-10-01T14:17:52.957Z,1601561872.957 [Default](DEBUG): Aggregate::initialize Default
2020-10-01T14:17:52.957Z,1601561872.957 [Default:B.GoToSurface] Running Loop=1
2020-10-01T14:17:52.957Z,1601561872.957 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-10-01T14:17:52.957Z,1601561872.957 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-10-01T14:17:52.957Z,1601561872.957 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-10-01T14:17:52.958Z,1601561872.958 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-10-01T14:17:52.958Z,1601561872.958 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-10-01T14:17:52.958Z,1601561872.958 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-10-01T14:17:52.959Z,1601561872.959 [Default:A.Wait] Running Loop=1
2020-10-01T14:17:52.959Z,1601561872.959 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-10-01T14:18:06.298Z,1601561886.298 [Default:A.Wait](INFO): Done Waiting.
2020-10-01T14:18:06.298Z,1601561886.298 [Default:A.Wait] Stopped
2020-10-01T14:18:06.298Z,1601561886.298 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-10-01T14:18:06.406Z,1601561886.406 [DataOverHttps](INFO): Sending 1422 bytes from file Logs/20201001T140545/Express0001.lzma
2020-10-01T14:18:06.745Z,1601561886.745 [Default:CheckIn] Running Loop=1
2020-10-01T14:18:06.746Z,1601561886.746 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-10-01T14:18:06.746Z,1601561886.746 [Default:CheckIn:Read_GPS] Running Loop=1
2020-10-01T14:18:07.150Z,1601561887.150 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-10-01T14:18:07.406Z,1601561887.406 [DataOverHttps](INFO): Moved sent file to Logs/20201001T140545/Express0001.lzma.bak
2020-10-01T14:18:07.406Z,1601561887.406 [DataOverHttps](INFO): SBD MOMSN=12702626
2020-10-01T14:18:09.911Z,1601561889.911 [BuoyancyServo](FAULT): is needed
2020-10-01T14:18:11.589Z,1601561891.589 [BuoyancyServo](INFO): ready
2020-10-01T14:18:11.589Z,1601561891.589 [BuoyancyServo](FAULT): is needed
2020-10-01T14:18:11.594Z,1601561891.594 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:18:11.973Z,1601561891.973 [BuoyancyServo](INFO): ready
2020-10-01T14:18:11.978Z,1601561891.978 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:18:42.244Z,1601561922.244 [BuoyancyServo](FAULT): is needed
2020-10-01T14:18:44.281Z,1601561924.281 [BuoyancyServo](INFO): ready
2020-10-01T14:18:44.281Z,1601561924.281 [BuoyancyServo](FAULT): is needed
2020-10-01T14:18:44.286Z,1601561924.286 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:18:44.681Z,1601561924.681 [BuoyancyServo](INFO): ready
2020-10-01T14:18:44.693Z,1601561924.693 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:18:59.596Z,1601561939.596 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-10-01T14:19:14.601Z,1601561954.601 [BuoyancyServo](FAULT): is needed
2020-10-01T14:19:16.608Z,1601561956.608 [BuoyancyServo](INFO): ready
2020-10-01T14:19:16.609Z,1601561956.609 [BuoyancyServo](FAULT): is needed
2020-10-01T14:19:16.614Z,1601561956.614 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:19:17.013Z,1601561957.013 [BuoyancyServo](INFO): ready
2020-10-01T14:19:17.018Z,1601561957.018 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:19:19.797Z,1601561959.797 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-10-01T14:19:19.797Z,1601561959.797 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:19:19.807Z,1601561959.807 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:19:20.214Z,1601561960.214 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:19:20.214Z,1601561960.214 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-10-01T14:19:47.291Z,1601561987.291 [BuoyancyServo](FAULT): is needed
2020-10-01T14:19:48.953Z,1601561988.953 [BuoyancyServo](INFO): ready
2020-10-01T14:19:48.953Z,1601561988.953 [BuoyancyServo](FAULT): is needed
2020-10-01T14:19:48.958Z,1601561988.958 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:19:49.365Z,1601561989.365 [BuoyancyServo](INFO): ready
2020-10-01T14:19:49.380Z,1601561989.380 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:20:19.622Z,1601562019.622 [BuoyancyServo](FAULT): is needed
2020-10-01T14:20:21.725Z,1601562021.725 [BuoyancyServo](INFO): ready
2020-10-01T14:20:21.739Z,1601562021.739 [BuoyancyServo](FAULT): is needed
2020-10-01T14:20:21.745Z,1601562021.745 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:20:22.057Z,1601562022.057 [BuoyancyServo](INFO): ready
2020-10-01T14:20:22.062Z,1601562022.062 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:20:49.087Z,1601562049.087 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-10-01T14:20:49.091Z,1601562049.091 [BPC1](INFO): Received data from all battery sticks.
2020-10-01T14:20:52.363Z,1601562052.363 [BuoyancyServo](FAULT): is needed
2020-10-01T14:20:54.403Z,1601562054.403 [BuoyancyServo](INFO): ready
2020-10-01T14:20:54.403Z,1601562054.403 [BuoyancyServo](FAULT): is needed
2020-10-01T14:20:54.410Z,1601562054.410 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:20:54.789Z,1601562054.789 [BuoyancyServo](INFO): ready
2020-10-01T14:20:54.794Z,1601562054.794 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:21:25.051Z,1601562085.051 [BuoyancyServo](FAULT): is needed
2020-10-01T14:21:27.113Z,1601562087.113 [BuoyancyServo](INFO): ready
2020-10-01T14:21:27.113Z,1601562087.113 [BuoyancyServo](FAULT): is needed
2020-10-01T14:21:27.145Z,1601562087.145 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:21:27.525Z,1601562087.525 [BuoyancyServo](INFO): ready
2020-10-01T14:21:27.550Z,1601562087.550 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:21:57.783Z,1601562117.783 [BuoyancyServo](FAULT): is needed
2020-10-01T14:21:59.425Z,1601562119.425 [BuoyancyServo](INFO): ready
2020-10-01T14:21:59.425Z,1601562119.425 [BuoyancyServo](FAULT): is needed
2020-10-01T14:21:59.430Z,1601562119.430 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:21:59.841Z,1601562119.841 [BuoyancyServo](INFO): ready
2020-10-01T14:21:59.846Z,1601562119.846 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:22:20.804Z,1601562140.804 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-10-01T14:22:20.804Z,1601562140.804 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:22:20.815Z,1601562140.815 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:22:21.221Z,1601562141.221 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:22:21.221Z,1601562141.221 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-10-01T14:22:30.085Z,1601562150.085 [BuoyancyServo](FAULT): is needed
2020-10-01T14:22:31.737Z,1601562151.737 [BuoyancyServo](INFO): ready
2020-10-01T14:22:31.737Z,1601562151.737 [BuoyancyServo](FAULT): is needed
2020-10-01T14:22:31.743Z,1601562151.743 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:22:32.140Z,1601562152.140 [BuoyancyServo](INFO): ready
2020-10-01T14:22:32.146Z,1601562152.146 [Reporter](INFO): platform_buoyancy_position 986.540588 cc
2020-10-01T14:23:02.424Z,1601562182.424 [BuoyancyServo](FAULT): is needed
2020-10-01T14:23:04.084Z,1601562184.084 [BuoyancyServo](INFO): ready
2020-10-01T14:23:04.085Z,1601562184.085 [BuoyancyServo](FAULT): is needed
2020-10-01T14:23:04.090Z,1601562184.090 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:23:04.464Z,1601562184.464 [BuoyancyServo](INFO): ready
2020-10-01T14:23:04.470Z,1601562184.470 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:23:06.853Z,1601562186.853 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-01T14:18:06.7Z
2020-10-01T14:23:06.854Z,1601562186.854 [Default:CheckIn:Read_GPS] Stopped
2020-10-01T14:23:06.854Z,1601562186.854 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-10-01T14:23:07.261Z,1601562187.261 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-10-01T14:23:14.076Z,1601562194.076 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20201001T141306/Courier0004.lzma
2020-10-01T14:23:15.078Z,1601562195.078 [DataOverHttps](INFO): Moved sent file to Logs/20201001T141306/Courier0004.lzma.bak
2020-10-01T14:23:15.078Z,1601562195.078 [DataOverHttps](INFO): SBD MOMSN=12702768
2020-10-01T14:23:31.638Z,1601562211.638 [DataOverHttps](INFO): Sending 1160 bytes from file Logs/20201001T140838/Express0001.lzma
2020-10-01T14:23:32.638Z,1601562212.638 [DataOverHttps](INFO): Moved sent file to Logs/20201001T140838/Express0001.lzma.bak
2020-10-01T14:23:32.638Z,1601562212.638 [DataOverHttps](INFO): SBD MOMSN=12702770
2020-10-01T14:23:34.754Z,1601562214.754 [BuoyancyServo](FAULT): is needed
2020-10-01T14:23:36.405Z,1601562216.405 [BuoyancyServo](INFO): ready
2020-10-01T14:23:36.405Z,1601562216.405 [BuoyancyServo](FAULT): is needed
2020-10-01T14:23:36.410Z,1601562216.410 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:23:36.793Z,1601562216.793 [BuoyancyServo](INFO): ready
2020-10-01T14:23:36.798Z,1601562216.798 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:23:58.336Z,1601562238.336 [DataOverHttps](INFO): Sending 88 bytes from file Logs/20201001T140838/Express0005.lzma
2020-10-01T14:23:59.338Z,1601562239.338 [DataOverHttps](INFO): Moved sent file to Logs/20201001T140838/Express0005.lzma.bak
2020-10-01T14:23:59.338Z,1601562239.338 [DataOverHttps](INFO): SBD MOMSN=12702814
2020-10-01T14:23:59.782Z,1601562239.782 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-10-01T14:23:59.782Z,1601562239.782 [NAL9602] Data Fault, FailCount= 1
2020-10-01T14:23:59.782Z,1601562239.782 [NAL9602](ERROR): Data Fault
2020-10-01T14:23:59.798Z,1601562239.798 [CBIT](ERROR): Data Fault in component: NAL9602
2020-10-01T14:24:00.178Z,1601562240.178 [NAL9602](INFO): Powering down
2020-10-01T14:24:01.018Z,1601562241.018 [CBIT](INFO): Clearing failed state for component NAL9602
2020-10-01T14:24:01.018Z,1601562241.018 [NAL9602] No Fault, FailCount= 1
2020-10-01T14:24:07.061Z,1601562247.061 [BuoyancyServo](FAULT): is needed
2020-10-01T14:24:09.114Z,1601562249.114 [BuoyancyServo](INFO): ready
2020-10-01T14:24:09.114Z,1601562249.114 [BuoyancyServo](FAULT): is needed
2020-10-01T14:24:09.150Z,1601562249.150 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:24:09.525Z,1601562249.525 [BuoyancyServo](INFO): ready
2020-10-01T14:24:09.530Z,1601562249.530 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:24:17.822Z,1601562257.822 [DataOverHttps](INFO): Sending 1285 bytes from file Logs/20201001T141306/Express0001.lzma
2020-10-01T14:24:18.822Z,1601562258.822 [DataOverHttps](INFO): Moved sent file to Logs/20201001T141306/Express0001.lzma.bak
2020-10-01T14:24:18.822Z,1601562258.822 [DataOverHttps](INFO): SBD MOMSN=12702862
2020-10-01T14:24:30.482Z,1601562270.482 [NAL9602](INFO): Powering up NAL9602
2020-10-01T14:24:35.328Z,1601562275.328 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20201001T141306/Express0005.lzma
2020-10-01T14:24:36.330Z,1601562276.330 [DataOverHttps](INFO): Moved sent file to Logs/20201001T141306/Express0005.lzma.bak
2020-10-01T14:24:36.330Z,1601562276.330 [DataOverHttps](INFO): SBD MOMSN=12702913
2020-10-01T14:24:38.985Z,1601562278.985 [Default:CheckIn:Read_Iridium] Stopped
2020-10-01T14:24:38.985Z,1601562278.985 [Default:CheckIn:C.Wait] Running Loop=1
2020-10-01T14:24:38.985Z,1601562278.985 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-10-01T14:24:39.798Z,1601562279.798 [BuoyancyServo](FAULT): is needed
2020-10-01T14:24:41.391Z,1601562281.391 [NAL9602](INFO): NAL9602 initialized
2020-10-01T14:24:41.470Z,1601562281.470 [BuoyancyServo](INFO): ready
2020-10-01T14:24:41.470Z,1601562281.470 [BuoyancyServo](FAULT): is needed
2020-10-01T14:24:41.488Z,1601562281.488 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:24:41.833Z,1601562281.833 [BuoyancyServo](INFO): ready
2020-10-01T14:24:41.838Z,1601562281.838 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:25:12.110Z,1601562312.110 [BuoyancyServo](FAULT): is needed
2020-10-01T14:25:14.181Z,1601562314.181 [BuoyancyServo](INFO): ready
2020-10-01T14:25:14.181Z,1601562314.181 [BuoyancyServo](FAULT): is needed
2020-10-01T14:25:14.217Z,1601562314.217 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:25:14.584Z,1601562314.584 [BuoyancyServo](INFO): ready
2020-10-01T14:25:14.590Z,1601562314.590 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:25:21.796Z,1601562321.796 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-10-01T14:25:21.796Z,1601562321.796 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:25:21.807Z,1601562321.807 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:25:22.221Z,1601562322.221 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:25:22.221Z,1601562322.221 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-10-01T14:25:44.838Z,1601562344.838 [BuoyancyServo](FAULT): is needed
2020-10-01T14:25:46.501Z,1601562346.501 [BuoyancyServo](INFO): ready
2020-10-01T14:25:46.501Z,1601562346.501 [BuoyancyServo](FAULT): is needed
2020-10-01T14:25:46.506Z,1601562346.506 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:25:46.909Z,1601562346.909 [BuoyancyServo](INFO): ready
2020-10-01T14:25:46.922Z,1601562346.922 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:26:17.175Z,1601562377.175 [BuoyancyServo](FAULT): is needed
2020-10-01T14:26:18.813Z,1601562378.813 [BuoyancyServo](INFO): ready
2020-10-01T14:26:18.813Z,1601562378.813 [BuoyancyServo](FAULT): is needed
2020-10-01T14:26:18.838Z,1601562378.838 [Reporter](INFO): platform_buoyancy_position 987.749329 cc
2020-10-01T14:26:19.223Z,1601562379.223 [BuoyancyServo](INFO): ready
2020-10-01T14:26:19.252Z,1601562379.252 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:26:49.484Z,1601562409.484 [BuoyancyServo](FAULT): is needed
2020-10-01T14:26:51.137Z,1601562411.137 [BuoyancyServo](INFO): ready
2020-10-01T14:26:51.137Z,1601562411.137 [BuoyancyServo](FAULT): is needed
2020-10-01T14:26:51.170Z,1601562411.170 [Reporter](INFO): platform_buoyancy_position 987.614990 cc
2020-10-01T14:26:51.549Z,1601562411.549 [BuoyancyServo](INFO): ready
2020-10-01T14:26:51.563Z,1601562411.563 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:27:21.806Z,1601562441.806 [BuoyancyServo](FAULT): is needed
2020-10-01T14:27:23.848Z,1601562443.848 [BuoyancyServo](INFO): ready
2020-10-01T14:27:23.849Z,1601562443.849 [BuoyancyServo](FAULT): is needed
2020-10-01T14:27:23.854Z,1601562443.854 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:27:24.245Z,1601562444.245 [BuoyancyServo](INFO): ready
2020-10-01T14:27:24.250Z,1601562444.250 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:27:54.526Z,1601562474.526 [BuoyancyServo](FAULT): is needed
2020-10-01T14:27:56.173Z,1601562476.173 [BuoyancyServo](INFO): ready
2020-10-01T14:27:56.173Z,1601562476.173 [BuoyancyServo](FAULT): is needed
2020-10-01T14:27:56.178Z,1601562476.178 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:27:56.588Z,1601562476.588 [BuoyancyServo](INFO): ready
2020-10-01T14:27:56.594Z,1601562476.594 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:28:22.788Z,1601562502.788 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-10-01T14:28:22.788Z,1601562502.788 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:28:22.855Z,1601562502.855 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:28:23.198Z,1601562503.198 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:28:23.198Z,1601562503.198 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-10-01T14:28:26.858Z,1601562506.858 [BuoyancyServo](FAULT): is needed
2020-10-01T14:28:28.901Z,1601562508.901 [BuoyancyServo](INFO): ready
2020-10-01T14:28:28.901Z,1601562508.901 [BuoyancyServo](FAULT): is needed
2020-10-01T14:28:28.929Z,1601562508.929 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:28:29.293Z,1601562509.293 [BuoyancyServo](INFO): ready
2020-10-01T14:28:29.298Z,1601562509.298 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:28:59.566Z,1601562539.566 [BuoyancyServo](FAULT): is needed
2020-10-01T14:29:01.221Z,1601562541.221 [BuoyancyServo](INFO): ready
2020-10-01T14:29:01.221Z,1601562541.221 [BuoyancyServo](FAULT): is needed
2020-10-01T14:29:01.226Z,1601562541.226 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:29:01.616Z,1601562541.616 [BuoyancyServo](INFO): ready
2020-10-01T14:29:01.622Z,1601562541.622 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:29:31.890Z,1601562571.890 [BuoyancyServo](FAULT): is needed
2020-10-01T14:29:33.545Z,1601562573.545 [BuoyancyServo](INFO): ready
2020-10-01T14:29:33.545Z,1601562573.545 [BuoyancyServo](FAULT): is needed
2020-10-01T14:29:33.550Z,1601562573.550 [Reporter](INFO): platform_buoyancy_position 987.883545 cc
2020-10-01T14:29:33.957Z,1601562573.957 [BuoyancyServo](INFO): ready
2020-10-01T14:29:33.963Z,1601562573.963 [Reporter](INFO): platform_buoyancy_position 986.406250 cc
2020-10-01T14:29:39.573Z,1601562579.573 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-10-01T14:29:39.573Z,1601562579.573 [Default:CheckIn:C.Wait] Stopped
2020-10-01T14:29:39.573Z,1601562579.573 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-10-01T14:29:39.574Z,1601562579.574 [Default:CheckIn:D] Running Loop=1
2020-10-01T14:29:39.969Z,1601562579.969 [Default:CheckIn:D] Stopped
2020-10-01T14:29:39.969Z,1601562579.969 [Default:CheckIn:E] Running Loop=1
2020-10-01T14:29:40.375Z,1601562580.375 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.783545 min 
2020-10-01T14:29:40.375Z,1601562580.375 [Default:CheckIn:E] Stopped
2020-10-01T14:29:40.375Z,1601562580.375 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-10-01T14:29:40.376Z,1601562580.376 [Default:CheckIn] Stopped
2020-10-01T14:29:40.376Z,1601562580.376 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-10-01T14:29:40.376Z,1601562580.376 [Default:CheckIn](INFO): Running loop #2
2020-10-01T14:29:40.376Z,1601562580.376 [Default:CheckIn] Running Loop=2
2020-10-01T14:29:40.376Z,1601562580.376 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-10-01T14:29:40.376Z,1601562580.376 [Default:CheckIn:Read_GPS] Running Loop=1
2020-10-01T14:30:04.223Z,1601562604.223 [BuoyancyServo](FAULT): is needed
2020-10-01T14:30:05.841Z,1601562605.841 [BuoyancyServo](INFO): ready
2020-10-01T14:30:05.841Z,1601562605.841 [BuoyancyServo](FAULT): is needed
2020-10-01T14:30:05.846Z,1601562605.846 [Reporter](INFO): platform_buoyancy_position 987.077698 cc
2020-10-01T14:30:06.245Z,1601562606.245 [BuoyancyServo](INFO): ready
2020-10-01T14:30:06.257Z,1601562606.257 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:30:36.525Z,1601562636.525 [BuoyancyServo](FAULT): is needed
2020-10-01T14:30:38.177Z,1601562638.177 [BuoyancyServo](INFO): ready
2020-10-01T14:30:38.177Z,1601562638.177 [BuoyancyServo](FAULT): is needed
2020-10-01T14:30:38.182Z,1601562638.182 [Reporter](INFO): platform_buoyancy_position 987.212036 cc
2020-10-01T14:30:38.593Z,1601562638.593 [BuoyancyServo](INFO): ready
2020-10-01T14:30:38.598Z,1601562638.598 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:31:08.864Z,1601562668.864 [BuoyancyServo](FAULT): is needed
2020-10-01T14:31:10.893Z,1601562670.893 [BuoyancyServo](INFO): ready
2020-10-01T14:31:10.893Z,1601562670.893 [BuoyancyServo](FAULT): is needed
2020-10-01T14:31:10.898Z,1601562670.898 [Reporter](INFO): platform_buoyancy_position 986.809265 cc
2020-10-01T14:31:11.305Z,1601562671.305 [BuoyancyServo](INFO): ready
2020-10-01T14:31:11.317Z,1601562671.317 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:31:23.815Z,1601562683.815 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-10-01T14:31:23.815Z,1601562683.815 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:31:23.826Z,1601562683.826 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:31:24.238Z,1601562684.238 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:31:24.238Z,1601562684.238 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-10-01T14:31:41.574Z,1601562701.574 [BuoyancyServo](FAULT): is needed
2020-10-01T14:31:43.240Z,1601562703.240 [BuoyancyServo](INFO): ready
2020-10-01T14:31:43.241Z,1601562703.241 [BuoyancyServo](FAULT): is needed
2020-10-01T14:31:43.246Z,1601562703.246 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:31:43.629Z,1601562703.629 [BuoyancyServo](INFO): ready
2020-10-01T14:31:43.634Z,1601562703.634 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:32:13.886Z,1601562733.886 [BuoyancyServo](FAULT): is needed
2020-10-01T14:32:15.545Z,1601562735.545 [BuoyancyServo](INFO): ready
2020-10-01T14:32:15.545Z,1601562735.545 [BuoyancyServo](FAULT): is needed
2020-10-01T14:32:15.550Z,1601562735.550 [Reporter](INFO): platform_buoyancy_position 988.152222 cc
2020-10-01T14:32:15.961Z,1601562735.961 [BuoyancyServo](INFO): ready
2020-10-01T14:32:15.966Z,1601562735.966 [Reporter](INFO): platform_buoyancy_position 987.212036 cc
2020-10-01T14:32:46.262Z,1601562766.262 [BuoyancyServo](FAULT): is needed
2020-10-01T14:32:48.273Z,1601562768.273 [BuoyancyServo](INFO): ready
2020-10-01T14:32:48.273Z,1601562768.273 [BuoyancyServo](FAULT): is needed
2020-10-01T14:32:48.278Z,1601562768.278 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:32:48.657Z,1601562768.657 [BuoyancyServo](INFO): ready
2020-10-01T14:32:48.663Z,1601562768.663 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:33:18.948Z,1601562798.948 [BuoyancyServo](FAULT): is needed
2020-10-01T14:33:20.588Z,1601562800.588 [BuoyancyServo](INFO): ready
2020-10-01T14:33:20.589Z,1601562800.589 [BuoyancyServo](FAULT): is needed
2020-10-01T14:33:20.594Z,1601562800.594 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:33:20.981Z,1601562800.981 [BuoyancyServo](INFO): ready
2020-10-01T14:33:20.986Z,1601562800.986 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:33:51.270Z,1601562831.270 [BuoyancyServo](FAULT): is needed
2020-10-01T14:33:53.327Z,1601562833.327 [BuoyancyServo](INFO): ready
2020-10-01T14:33:53.327Z,1601562833.327 [BuoyancyServo](FAULT): is needed
2020-10-01T14:33:53.333Z,1601562833.333 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:33:53.721Z,1601562833.721 [BuoyancyServo](INFO): ready
2020-10-01T14:33:53.726Z,1601562833.726 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:34:23.996Z,1601562863.996 [BuoyancyServo](FAULT): is needed
2020-10-01T14:34:24.800Z,1601562864.800 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-10-01T14:34:24.800Z,1601562864.800 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:34:24.827Z,1601562864.827 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:34:25.207Z,1601562865.207 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:34:25.207Z,1601562865.207 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-10-01T14:34:26.033Z,1601562866.033 [BuoyancyServo](INFO): ready
2020-10-01T14:34:26.033Z,1601562866.033 [BuoyancyServo](FAULT): is needed
2020-10-01T14:34:26.038Z,1601562866.038 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:34:26.438Z,1601562866.438 [BuoyancyServo](INFO): ready
2020-10-01T14:34:26.446Z,1601562866.446 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:34:40.543Z,1601562880.543 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-01T14:29:40.4Z
2020-10-01T14:34:40.543Z,1601562880.543 [Default:CheckIn:Read_GPS] Stopped
2020-10-01T14:34:40.543Z,1601562880.543 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-10-01T14:34:43.358Z,1601562883.358 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-10-01T14:34:43.358Z,1601562883.358 [NAL9602] Data Fault, FailCount= 2
2020-10-01T14:34:43.358Z,1601562883.358 [NAL9602](ERROR): Data Fault
2020-10-01T14:34:43.374Z,1601562883.374 [CBIT](ERROR): Data Fault in component: NAL9602
2020-10-01T14:34:43.762Z,1601562883.762 [NAL9602](INFO): Powering down
2020-10-01T14:34:44.582Z,1601562884.582 [CBIT](INFO): Clearing failed state for component NAL9602
2020-10-01T14:34:44.582Z,1601562884.582 [NAL9602] No Fault, FailCount= 2
2020-10-01T14:34:56.040Z,1601562896.040 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201001T141306/Courier0007.lzma
2020-10-01T14:34:56.697Z,1601562896.697 [BuoyancyServo](FAULT): is needed
2020-10-01T14:34:57.042Z,1601562897.042 [DataOverHttps](INFO): Moved sent file to Logs/20201001T141306/Courier0007.lzma.bak
2020-10-01T14:34:57.042Z,1601562897.042 [DataOverHttps](INFO): SBD MOMSN=12703021
2020-10-01T14:34:58.761Z,1601562898.761 [BuoyancyServo](INFO): ready
2020-10-01T14:34:58.761Z,1601562898.761 [BuoyancyServo](FAULT): is needed
2020-10-01T14:34:58.766Z,1601562898.766 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:34:59.173Z,1601562899.173 [BuoyancyServo](INFO): ready
2020-10-01T14:34:59.178Z,1601562899.178 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:35:13.621Z,1601562913.621 [DataOverHttps](INFO): Sending 343 bytes from file Logs/20201001T141306/Express0008.lzma
2020-10-01T14:35:14.062Z,1601562914.062 [NAL9602](INFO): Powering up NAL9602
2020-10-01T14:35:14.622Z,1601562914.622 [DataOverHttps](INFO): Moved sent file to Logs/20201001T141306/Express0008.lzma.bak
2020-10-01T14:35:14.622Z,1601562914.622 [DataOverHttps](INFO): SBD MOMSN=12703023
2020-10-01T14:35:16.897Z,1601562916.897 [Default:CheckIn:Read_Iridium] Stopped
2020-10-01T14:35:16.897Z,1601562916.897 [Default:CheckIn:C.Wait] Running Loop=1
2020-10-01T14:35:16.897Z,1601562916.897 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-10-01T14:35:24.970Z,1601562924.970 [NAL9602](INFO): NAL9602 initialized
2020-10-01T14:35:29.422Z,1601562929.422 [BuoyancyServo](FAULT): is needed
2020-10-01T14:35:31.092Z,1601562931.092 [BuoyancyServo](INFO): ready
2020-10-01T14:35:31.093Z,1601562931.093 [BuoyancyServo](FAULT): is needed
2020-10-01T14:35:31.098Z,1601562931.098 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:35:31.492Z,1601562931.492 [BuoyancyServo](INFO): ready
2020-10-01T14:35:31.498Z,1601562931.498 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:36:01.753Z,1601562961.753 [BuoyancyServo](FAULT): is needed
2020-10-01T14:36:03.473Z,1601562963.473 [BuoyancyServo](INFO): ready
2020-10-01T14:36:03.473Z,1601562963.473 [BuoyancyServo](FAULT): is needed
2020-10-01T14:36:03.496Z,1601562963.496 [Reporter](INFO): platform_buoyancy_position 988.152222 cc
2020-10-01T14:36:03.813Z,1601562963.813 [BuoyancyServo](INFO): ready
2020-10-01T14:36:03.881Z,1601562963.881 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:36:34.098Z,1601562994.098 [BuoyancyServo](FAULT): is needed
2020-10-01T14:36:36.140Z,1601562996.140 [BuoyancyServo](INFO): ready
2020-10-01T14:36:36.141Z,1601562996.141 [BuoyancyServo](FAULT): is needed
2020-10-01T14:36:36.163Z,1601562996.163 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:36:36.525Z,1601562996.525 [BuoyancyServo](INFO): ready
2020-10-01T14:36:36.530Z,1601562996.530 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:37:06.798Z,1601563026.798 [BuoyancyServo](FAULT): is needed
2020-10-01T14:37:08.473Z,1601563028.473 [BuoyancyServo](INFO): ready
2020-10-01T14:37:08.473Z,1601563028.473 [BuoyancyServo](FAULT): is needed
2020-10-01T14:37:08.478Z,1601563028.478 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:37:08.857Z,1601563028.857 [BuoyancyServo](INFO): ready
2020-10-01T14:37:08.862Z,1601563028.862 [Reporter](INFO): platform_buoyancy_position 986.406250 cc
2020-10-01T14:37:25.784Z,1601563045.784 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-10-01T14:37:25.784Z,1601563045.784 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:37:25.818Z,1601563045.818 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:37:26.222Z,1601563046.222 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:37:26.222Z,1601563046.222 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-10-01T14:37:39.122Z,1601563059.122 [BuoyancyServo](FAULT): is needed
2020-10-01T14:37:40.773Z,1601563060.773 [BuoyancyServo](INFO): ready
2020-10-01T14:37:40.773Z,1601563060.773 [BuoyancyServo](FAULT): is needed
2020-10-01T14:37:40.778Z,1601563060.778 [Reporter](INFO): platform_buoyancy_position 986.540588 cc
2020-10-01T14:37:41.181Z,1601563061.181 [BuoyancyServo](INFO): ready
2020-10-01T14:37:41.195Z,1601563061.195 [Reporter](INFO): platform_buoyancy_position 987.212036 cc
2020-10-01T14:38:11.454Z,1601563091.454 [BuoyancyServo](FAULT): is needed
2020-10-01T14:38:13.113Z,1601563093.113 [BuoyancyServo](INFO): ready
2020-10-01T14:38:13.113Z,1601563093.113 [BuoyancyServo](FAULT): is needed
2020-10-01T14:38:13.118Z,1601563093.118 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:38:13.493Z,1601563093.493 [BuoyancyServo](INFO): ready
2020-10-01T14:38:13.498Z,1601563093.498 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:38:43.782Z,1601563123.782 [BuoyancyServo](FAULT): is needed
2020-10-01T14:38:45.816Z,1601563125.816 [BuoyancyServo](INFO): ready
2020-10-01T14:38:45.817Z,1601563125.817 [BuoyancyServo](FAULT): is needed
2020-10-01T14:38:45.847Z,1601563125.847 [Reporter](INFO): platform_buoyancy_position 987.346375 cc
2020-10-01T14:38:46.233Z,1601563126.233 [BuoyancyServo](INFO): ready
2020-10-01T14:38:46.238Z,1601563126.238 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:39:16.502Z,1601563156.502 [BuoyancyServo](FAULT): is needed
2020-10-01T14:39:18.537Z,1601563158.537 [BuoyancyServo](INFO): ready
2020-10-01T14:39:18.537Z,1601563158.537 [BuoyancyServo](FAULT): is needed
2020-10-01T14:39:18.542Z,1601563158.542 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:39:18.936Z,1601563158.936 [BuoyancyServo](INFO): ready
2020-10-01T14:39:18.942Z,1601563158.942 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:39:49.218Z,1601563189.218 [BuoyancyServo](FAULT): is needed
2020-10-01T14:39:51.269Z,1601563191.269 [BuoyancyServo](INFO): ready
2020-10-01T14:39:51.269Z,1601563191.269 [BuoyancyServo](FAULT): is needed
2020-10-01T14:39:51.274Z,1601563191.274 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:39:51.668Z,1601563191.668 [BuoyancyServo](INFO): ready
2020-10-01T14:39:51.674Z,1601563191.674 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:40:17.495Z,1601563217.495 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-10-01T14:40:17.495Z,1601563217.495 [Default:CheckIn:C.Wait] Stopped
2020-10-01T14:40:17.495Z,1601563217.495 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-10-01T14:40:17.495Z,1601563217.495 [Default:CheckIn:D] Running Loop=1
2020-10-01T14:40:17.907Z,1601563217.907 [Default:CheckIn:D] Stopped
2020-10-01T14:40:17.907Z,1601563217.907 [Default:CheckIn:E] Running Loop=1
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.415833 min 
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn:E] Stopped
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn] Stopped
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn](INFO): Running loop #3
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn] Running Loop=3
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-10-01T14:40:18.290Z,1601563218.290 [Default:CheckIn:Read_GPS] Running Loop=1
2020-10-01T14:40:21.962Z,1601563221.962 [BuoyancyServo](FAULT): is needed
2020-10-01T14:40:23.573Z,1601563223.573 [BuoyancyServo](INFO): ready
2020-10-01T14:40:23.573Z,1601563223.573 [BuoyancyServo](FAULT): is needed
2020-10-01T14:40:23.588Z,1601563223.588 [Reporter](INFO): platform_buoyancy_position 987.749329 cc
2020-10-01T14:40:23.997Z,1601563223.997 [BuoyancyServo](INFO): ready
2020-10-01T14:40:24.002Z,1601563224.002 [Reporter](INFO): platform_buoyancy_position 986.406250 cc
2020-10-01T14:40:26.772Z,1601563226.772 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2020-10-01T14:40:26.772Z,1601563226.772 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:40:26.783Z,1601563226.783 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:40:27.195Z,1601563227.195 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:40:27.195Z,1601563227.195 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2020-10-01T14:40:54.260Z,1601563254.260 [BuoyancyServo](FAULT): is needed
2020-10-01T14:40:56.301Z,1601563256.301 [BuoyancyServo](INFO): ready
2020-10-01T14:40:56.301Z,1601563256.301 [BuoyancyServo](FAULT): is needed
2020-10-01T14:40:56.306Z,1601563256.306 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:40:56.720Z,1601563256.720 [BuoyancyServo](INFO): ready
2020-10-01T14:40:56.742Z,1601563256.742 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:41:26.990Z,1601563286.990 [BuoyancyServo](FAULT): is needed
2020-10-01T14:41:29.028Z,1601563289.028 [BuoyancyServo](INFO): ready
2020-10-01T14:41:29.029Z,1601563289.029 [BuoyancyServo](FAULT): is needed
2020-10-01T14:41:29.046Z,1601563289.046 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2020-10-01T14:41:29.441Z,1601563289.441 [BuoyancyServo](INFO): ready
2020-10-01T14:41:29.446Z,1601563289.446 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:41:59.705Z,1601563319.705 [BuoyancyServo](FAULT): is needed
2020-10-01T14:42:01.364Z,1601563321.364 [BuoyancyServo](INFO): ready
2020-10-01T14:42:01.365Z,1601563321.365 [BuoyancyServo](FAULT): is needed
2020-10-01T14:42:01.370Z,1601563321.370 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:42:01.753Z,1601563321.753 [BuoyancyServo](INFO): ready
2020-10-01T14:42:01.759Z,1601563321.759 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:42:32.033Z,1601563352.033 [BuoyancyServo](FAULT): is needed
2020-10-01T14:42:34.069Z,1601563354.069 [BuoyancyServo](INFO): ready
2020-10-01T14:42:34.069Z,1601563354.069 [BuoyancyServo](FAULT): is needed
2020-10-01T14:42:34.074Z,1601563354.074 [Reporter](INFO): platform_buoyancy_position 986.406250 cc
2020-10-01T14:42:34.477Z,1601563354.477 [BuoyancyServo](INFO): ready
2020-10-01T14:42:34.482Z,1601563354.482 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:43:04.760Z,1601563384.760 [BuoyancyServo](FAULT): is needed
2020-10-01T14:43:06.808Z,1601563386.808 [BuoyancyServo](INFO): ready
2020-10-01T14:43:06.809Z,1601563386.809 [BuoyancyServo](FAULT): is needed
2020-10-01T14:43:06.832Z,1601563386.832 [Reporter](INFO): platform_buoyancy_position 986.540588 cc
2020-10-01T14:43:07.193Z,1601563387.193 [BuoyancyServo](INFO): ready
2020-10-01T14:43:07.198Z,1601563387.198 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:43:27.780Z,1601563407.780 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2020-10-01T14:43:27.780Z,1601563407.780 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-10-01T14:43:27.790Z,1601563407.790 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-10-01T14:43:28.173Z,1601563408.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-10-01T14:43:28.173Z,1601563408.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2020-10-01T14:43:37.484Z,1601563417.484 [BuoyancyServo](FAULT): is needed
2020-10-01T14:43:39.129Z,1601563419.129 [BuoyancyServo](INFO): ready
2020-10-01T14:43:39.129Z,1601563419.129 [BuoyancyServo](FAULT): is needed
2020-10-01T14:43:39.146Z,1601563419.146 [Reporter](INFO): platform_buoyancy_position 987.614990 cc
2020-10-01T14:43:39.540Z,1601563419.540 [BuoyancyServo](INFO): ready
2020-10-01T14:43:39.546Z,1601563419.546 [Reporter](INFO): platform_buoyancy_position 986.406250 cc
2020-10-01T14:44:09.786Z,1601563449.786 [BuoyancyServo](FAULT): is needed
2020-10-01T14:44:11.429Z,1601563451.429 [BuoyancyServo](INFO): ready
2020-10-01T14:44:11.429Z,1601563451.429 [BuoyancyServo](FAULT): is needed
2020-10-01T14:44:11.435Z,1601563451.435 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:44:11.849Z,1601563451.849 [BuoyancyServo](INFO): ready
2020-10-01T14:44:11.854Z,1601563451.854 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:44:42.120Z,1601563482.120 [BuoyancyServo](FAULT): is needed
2020-10-01T14:44:43.765Z,1601563483.765 [BuoyancyServo](INFO): ready
2020-10-01T14:44:43.765Z,1601563483.765 [BuoyancyServo](FAULT): is needed
2020-10-01T14:44:43.796Z,1601563483.796 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2020-10-01T14:44:44.192Z,1601563484.192 [BuoyancyServo](INFO): ready
2020-10-01T14:44:44.198Z,1601563484.198 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2020-10-01T14:45:00.434Z,1601563500.434 [CommandLine](IMPORTANT): got command restart application
2020-10-01T14:45:01.441Z,1601563501.441 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:01.441Z,1601563501.441 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.596Z,1601563501.596 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-10-01T14:45:01.596Z,1601563501.596 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.597Z,1601563501.597 [CommandLine](INFO): Join timeout helper Thread ID is 8622
2020-10-01T14:45:01.597Z,1601563501.597 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-10-01T14:45:01.598Z,1601563501.598 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.598Z,1601563501.598 [NavChartDb](INFO): Join timeout helper Thread ID is 8623
2020-10-01T14:45:01.757Z,1601563501.757 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:01.757Z,1601563501.757 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.776Z,1601563501.776 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-10-01T14:45:01.776Z,1601563501.776 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.777Z,1601563501.777 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8624
2020-10-01T14:45:01.833Z,1601563501.833 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:01.833Z,1601563501.833 [WetLabsBB2FL](INFO): Powering down
2020-10-01T14:45:01.834Z,1601563501.834 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.836Z,1601563501.836 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-10-01T14:45:01.836Z,1601563501.836 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:01.837Z,1601563501.837 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8625
2020-10-01T14:45:02.588Z,1601563502.588 [CTD_Seabird](INFO): Powering down
2020-10-01T14:45:02.600Z,1601563502.600 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:02.601Z,1601563502.601 [CTD_Seabird](INFO): Powering down
2020-10-01T14:45:02.612Z,1601563502.612 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:02.620Z,1601563502.620 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler
2020-10-01T14:45:02.620Z,1601563502.620 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:02.621Z,1601563502.621 [BackSeatDriver](INFO): Join timeout helper Thread ID is 8626
2020-10-01T14:45:02.849Z,1601563502.849 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:02.849Z,1601563502.849 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:02.862Z,1601563502.862 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-10-01T14:45:02.863Z,1601563502.863 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:02.865Z,1601563502.865 [Radio_Surface](INFO): Join timeout helper Thread ID is 8627
2020-10-01T14:45:03.252Z,1601563503.252 [Radio_Surface](INFO): Powering down
2020-10-01T14:45:03.253Z,1601563503.253 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:03.254Z,1601563503.254 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:03.265Z,1601563503.265 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-10-01T14:45:03.265Z,1601563503.265 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:03.266Z,1601563503.266 [Onboard](INFO): Join timeout helper Thread ID is 8628
2020-10-01T14:45:03.889Z,1601563503.889 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-10-01T14:45:05.156Z,1601563505.156 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:05.157Z,1601563505.157 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.161Z,1601563505.161 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-10-01T14:45:05.161Z,1601563505.161 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.162Z,1601563505.162 [DataOverHttps](INFO): Join timeout helper Thread ID is 8629
2020-10-01T14:45:05.896Z,1601563505.896 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:05.897Z,1601563505.897 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.910Z,1601563505.910 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-10-01T14:45:05.910Z,1601563505.910 [logger ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.910Z,1601563505.910 [logger](INFO): Join timeout helper Thread ID is 8630
2020-10-01T14:45:05.948Z,1601563505.948 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:05.949Z,1601563505.949 [logger ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.973Z,1601563505.973 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-10-01T14:45:05.973Z,1601563505.973 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.973Z,1601563505.973 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-10-01T14:45:05.973Z,1601563505.973 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:05.974Z,1601563505.974 [controlThread](INFO): Join timeout helper Thread ID is 8631
2020-10-01T14:45:05.990Z,1601563505.990 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-10-01T14:45:05.990Z,1601563505.990 [controlThread](DEBUG): Uninitializing ControlThread
2020-10-01T14:45:05.990Z,1601563505.990 [AHRS_M2](INFO): Powering down
2020-10-01T14:45:06.061Z,1601563506.061 [NAL9602](INFO): Powering down
2020-10-01T14:45:06.062Z,1601563506.062 [DAT](INFO): Powering down
2020-10-01T14:45:06.182Z,1601563506.182 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-10-01T14:45:06.183Z,1601563506.183 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-10-01T14:45:06.184Z,1601563506.184 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-10-01T14:45:06.184Z,1601563506.184 [MissionManager](INFO): Uninitializing Mission Default
2020-10-01T14:45:06.184Z,1601563506.184 [Default] Stopped
2020-10-01T14:45:06.184Z,1601563506.184 [Default](DEBUG): Aggregate::uninitialize Default
2020-10-01T14:45:06.184Z,1601563506.184 [Default:B.GoToSurface] Stopped
2020-10-01T14:45:06.185Z,1601563506.185 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-10-01T14:45:06.185Z,1601563506.185 [Default:CheckIn] Stopped
2020-10-01T14:45:06.185Z,1601563506.185 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-10-01T14:45:06.185Z,1601563506.185 [Default:CheckIn:Read_GPS] Stopped
2020-10-01T14:45:06.187Z,1601563506.187 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-10-01T14:45:06.187Z,1601563506.187 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-10-01T14:45:06.188Z,1601563506.188 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-10-01T14:45:06.188Z,1601563506.188 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-10-01T14:45:06.189Z,1601563506.189 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-10-01T14:45:06.189Z,1601563506.189 [BuoyancyServo](INFO): Powering down
2020-10-01T14:45:06.200Z,1601563506.200 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-10-01T14:45:06.201Z,1601563506.201 [ElevatorServo](INFO): Powering down
2020-10-01T14:45:06.201Z,1601563506.201 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-10-01T14:45:06.201Z,1601563506.201 [MassServo](INFO): Powering down
2020-10-01T14:45:06.202Z,1601563506.202 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-10-01T14:45:06.202Z,1601563506.202 [RudderServo](INFO): Powering down
2020-10-01T14:45:06.203Z,1601563506.203 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-10-01T14:45:06.203Z,1601563506.203 [ThrusterServo](INFO): Powering down
2020-10-01T14:45:06.204Z,1601563506.204 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-10-01T14:45:06.204Z,1601563506.204 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-10-01T14:45:06.205Z,1601563506.205 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-10-01T14:45:06.205Z,1601563506.205 [CBIT](DEBUG): Powering off loads.
2020-10-01T14:45:06.216Z,1601563506.216 [CBIT](DEBUG): Disabling WDT.
2020-10-01T14:45:06.228Z,1601563506.228 [CBIT](DEBUG): Opening all GF detection circuits.
2020-10-01T14:45:06.229Z,1601563506.229 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.325Z,1601563506.325 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.327Z,1601563506.327 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.332Z,1601563506.332 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.399Z,1601563506.399 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.404Z,1601563506.404 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.407Z,1601563506.407 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.422Z,1601563506.422 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-10-01T14:45:06.485Z,1601563506.485 [logger ThreadHandler](INFO): Thread cancelled.