2020-12-01T00:54:44.241Z,1606784084.241 [Supervisor](DEBUG): Initializing supervisor.
2020-12-01T00:54:44.244Z,1606784084.244 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-12-01T00:54:44.244Z,1606784084.244 [SyncHandler](INFO): Protected caller Thread ID is 819
2020-12-01T00:54:44.245Z,1606784084.245 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-12-01T00:54:44.245Z,1606784084.245 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-12-01T00:54:44.246Z,1606784084.246 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 820
2020-12-01T00:54:44.249Z,1606784084.249 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-12-01T00:54:44.267Z,1606784084.267 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-12-01T00:54:44.268Z,1606784084.268 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-12-01T00:54:44.268Z,1606784084.268 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 821
2020-12-01T00:54:44.269Z,1606784084.269 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-12-01T00:54:44.270Z,1606784084.270 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-12-01T00:54:44.270Z,1606784084.270 [logger ThreadHandler](INFO): Protected caller Thread ID is 822
2020-12-01T00:54:44.272Z,1606784084.272 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-12-01T00:54:44.273Z,1606784084.273 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-12-01T00:54:44.277Z,1606784084.277 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-12-01T00:54:44.478Z,1606784084.478 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-12-01T00:54:44.480Z,1606784084.480 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-12-01T00:54:44.560Z,1606784084.560 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-12-01T00:54:45.030Z,1606784085.030 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-12-01T00:54:45.032Z,1606784085.032 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-12-01T00:54:45.346Z,1606784085.346 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-12-01T00:54:45.348Z,1606784085.348 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-12-01T00:54:45.444Z,1606784085.444 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-12-01T00:54:45.445Z,1606784085.445 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-12-01T00:54:45.736Z,1606784085.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-12-01T00:54:45.737Z,1606784085.737 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-12-01T00:54:45.928Z,1606784085.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-12-01T00:54:45.930Z,1606784085.930 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-12-01T00:54:46.410Z,1606784086.410 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-12-01T00:54:46.410Z,1606784086.410 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-12-01T00:54:46.515Z,1606784086.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-12-01T00:54:46.516Z,1606784086.516 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-12-01T00:54:46.616Z,1606784086.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-12-01T00:54:46.617Z,1606784086.617 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-12-01T00:54:47.803Z,1606784087.803 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-12-01T00:54:47.803Z,1606784087.803 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-12-01T00:54:48.229Z,1606784088.229 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-12-01T00:54:48.231Z,1606784088.231 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-12-01T00:54:48.420Z,1606784088.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-12-01T00:54:48.422Z,1606784088.422 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-12-01T00:54:48.565Z,1606784088.565 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-12-01T00:54:48.567Z,1606784088.567 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-12-01T00:54:48.714Z,1606784088.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-12-01T00:54:48.716Z,1606784088.716 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-12-01T00:54:48.926Z,1606784088.926 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-12-01T00:54:48.928Z,1606784088.928 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2020-12-01T00:54:48.930Z,1606784088.930 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2020-12-01T00:54:49.020Z,1606784089.020 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2020-12-01T00:54:49.104Z,1606784089.104 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2020-12-01T00:54:49.204Z,1606784089.204 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2020-12-01T00:54:49.286Z,1606784089.286 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2020-12-01T00:54:49.382Z,1606784089.382 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2020-12-01T00:54:49.482Z,1606784089.482 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2020-12-01T00:54:49.685Z,1606784089.685 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2020-12-01T00:54:49.762Z,1606784089.762 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2020-12-01T00:54:49.925Z,1606784089.925 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2020-12-01T00:54:50.069Z,1606784090.069 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2020-12-01T00:54:50.184Z,1606784090.184 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2020-12-01T00:54:50.434Z,1606784090.434 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-12-01T00:54:50.434Z,1606784090.434 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-12-01T00:54:50.449Z,1606784090.449 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-12-01T00:54:50.514Z,1606784090.514 [VerticalControl](DEBUG): Construct VerticalControl.
2020-12-01T00:54:50.575Z,1606784090.575 [VerticalControl] Loaded
2020-12-01T00:54:50.575Z,1606784090.575 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-12-01T00:54:50.575Z,1606784090.575 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-12-01T00:54:50.613Z,1606784090.613 [HorizontalControl] Loaded
2020-12-01T00:54:50.613Z,1606784090.613 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-12-01T00:54:50.614Z,1606784090.614 [SpeedControl](DEBUG): Construct SpeedControl.
2020-12-01T00:54:50.617Z,1606784090.617 [SpeedControl] Loaded
2020-12-01T00:54:50.617Z,1606784090.617 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-12-01T00:54:50.618Z,1606784090.618 [LoopControl](DEBUG): Construct LoopControl.
2020-12-01T00:54:50.618Z,1606784090.618 [LoopControl] Loaded
2020-12-01T00:54:50.619Z,1606784090.619 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-12-01T00:54:50.619Z,1606784090.619 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-12-01T00:54:50.621Z,1606784090.621 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-12-01T00:54:50.651Z,1606784090.651 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-12-01T00:54:50.651Z,1606784090.651 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-12-01T00:54:50.774Z,1606784090.774 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-12-01T00:54:50.775Z,1606784090.775 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-12-01T00:54:50.928Z,1606784090.928 [BuoyancyServo] Loaded
2020-12-01T00:54:50.928Z,1606784090.928 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-12-01T00:54:50.945Z,1606784090.945 [ElevatorServo] Loaded
2020-12-01T00:54:50.945Z,1606784090.945 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-12-01T00:54:50.960Z,1606784090.960 [MassServo] Loaded
2020-12-01T00:54:50.961Z,1606784090.961 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-12-01T00:54:50.976Z,1606784090.976 [RudderServo] Loaded
2020-12-01T00:54:50.976Z,1606784090.976 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-12-01T00:54:50.991Z,1606784090.991 [ThrusterServo] Loaded
2020-12-01T00:54:50.991Z,1606784090.991 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-12-01T00:54:50.991Z,1606784090.991 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-12-01T00:54:50.992Z,1606784090.992 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-12-01T00:54:51.135Z,1606784091.135 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-12-01T00:54:51.135Z,1606784091.135 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-12-01T00:54:51.146Z,1606784091.146 [NavChart] Loaded
2020-12-01T00:54:51.146Z,1606784091.146 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-12-01T00:54:51.150Z,1606784091.150 [UniversalFixResidualReporter] Loaded
2020-12-01T00:54:51.151Z,1606784091.151 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-12-01T00:54:51.151Z,1606784091.151 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-12-01T00:54:51.152Z,1606784091.152 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-12-01T00:54:51.280Z,1606784091.280 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-12-01T00:54:51.281Z,1606784091.281 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-12-01T00:54:51.815Z,1606784091.815 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-12-01T00:54:51.818Z,1606784091.818 [AHRS_M2](INFO): created writer for : platform_orientation
2020-12-01T00:54:51.820Z,1606784091.820 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-12-01T00:54:51.823Z,1606784091.823 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-12-01T00:54:51.823Z,1606784091.823 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-12-01T00:54:51.826Z,1606784091.826 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-12-01T00:54:51.826Z,1606784091.826 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-12-01T00:54:51.829Z,1606784091.829 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-12-01T00:54:51.972Z,1606784091.972 [AHRS_M2] Loaded
2020-12-01T00:54:51.972Z,1606784091.972 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-12-01T00:54:52.122Z,1606784092.122 [DataOverHttps] Loaded
2020-12-01T00:54:52.122Z,1606784092.122 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-12-01T00:54:52.123Z,1606784092.123 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408A34E0
2020-12-01T00:54:52.123Z,1606784092.123 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 908
2020-12-01T00:54:52.140Z,1606784092.140 [Depth_Keller] Loaded
2020-12-01T00:54:52.140Z,1606784092.140 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-12-01T00:54:52.143Z,1606784092.143 [DropWeight] Loaded
2020-12-01T00:54:52.143Z,1606784092.143 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-12-01T00:54:52.197Z,1606784092.197 [NAL9602] Loaded
2020-12-01T00:54:52.197Z,1606784092.197 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-12-01T00:54:52.223Z,1606784092.223 [Onboard] Loaded
2020-12-01T00:54:52.223Z,1606784092.223 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-12-01T00:54:52.224Z,1606784092.224 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408D34E0
2020-12-01T00:54:52.224Z,1606784092.224 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 909
2020-12-01T00:54:52.235Z,1606784092.235 [Radio_Surface] Loaded
2020-12-01T00:54:52.235Z,1606784092.235 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-12-01T00:54:52.236Z,1606784092.236 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409034E0
2020-12-01T00:54:52.236Z,1606784092.236 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 910
2020-12-01T00:54:53.004Z,1606784093.004 [BPC1] Loaded
2020-12-01T00:54:53.004Z,1606784093.004 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-12-01T00:54:53.022Z,1606784093.022 [AMEcho] Loaded
2020-12-01T00:54:53.023Z,1606784093.023 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-12-01T00:54:53.023Z,1606784093.023 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-12-01T00:54:53.024Z,1606784093.024 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-12-01T00:54:53.272Z,1606784093.272 [DepthRateCalculator] Loaded
2020-12-01T00:54:53.272Z,1606784093.272 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-12-01T00:54:53.275Z,1606784093.275 [PitchRateCalculator] Loaded
2020-12-01T00:54:53.276Z,1606784093.276 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-12-01T00:54:53.327Z,1606784093.327 [SpeedCalculator] Loaded
2020-12-01T00:54:53.327Z,1606784093.327 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-12-01T00:54:53.374Z,1606784093.374 [TempGradientCalculator] Loaded
2020-12-01T00:54:53.374Z,1606784093.374 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-12-01T00:54:53.419Z,1606784093.419 [YawRateCalculator] Loaded
2020-12-01T00:54:53.420Z,1606784093.420 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-12-01T00:54:53.550Z,1606784093.550 [ElevatorOffsetCalculator] Loaded
2020-12-01T00:54:53.550Z,1606784093.550 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-12-01T00:54:53.550Z,1606784093.550 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-12-01T00:54:53.551Z,1606784093.551 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-12-01T00:54:54.104Z,1606784094.104 [CANONSampler] Loaded
2020-12-01T00:54:54.104Z,1606784094.104 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2020-12-01T00:54:54.122Z,1606784094.122 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-12-01T00:54:54.125Z,1606784094.125 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-12-01T00:54:54.126Z,1606784094.126 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-12-01T00:54:54.128Z,1606784094.128 [CTD_Seabird](INFO): created writer for : depth
2020-12-01T00:54:54.129Z,1606784094.129 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-12-01T00:54:54.131Z,1606784094.131 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-12-01T00:54:54.132Z,1606784094.132 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-12-01T00:54:54.135Z,1606784094.135 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-12-01T00:54:54.135Z,1606784094.135 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-12-01T00:54:54.138Z,1606784094.138 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-12-01T00:54:54.139Z,1606784094.139 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-12-01T00:54:54.142Z,1606784094.142 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-12-01T00:54:54.142Z,1606784094.142 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-12-01T00:54:54.145Z,1606784094.145 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-12-01T00:54:54.146Z,1606784094.146 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water
2020-12-01T00:54:54.149Z,1606784094.149 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water
2020-12-01T00:54:54.149Z,1606784094.149 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq
2020-12-01T00:54:54.150Z,1606784094.150 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq
2020-12-01T00:54:54.166Z,1606784094.166 [CTD_Seabird] Loaded
2020-12-01T00:54:54.166Z,1606784094.166 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-12-01T00:54:54.167Z,1606784094.167 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A114E0
2020-12-01T00:54:54.167Z,1606784094.167 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 911
2020-12-01T00:54:54.184Z,1606784094.184 [PAR_Licor] Loaded
2020-12-01T00:54:54.185Z,1606784094.185 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-12-01T00:54:54.197Z,1606784094.197 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-12-01T00:54:54.197Z,1606784094.197 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-12-01T00:54:54.199Z,1606784094.199 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-12-01T00:54:54.199Z,1606784094.199 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-12-01T00:54:54.201Z,1606784094.201 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-12-01T00:54:54.202Z,1606784094.202 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-12-01T00:54:54.204Z,1606784094.204 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-12-01T00:54:54.204Z,1606784094.204 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-12-01T00:54:54.206Z,1606784094.206 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-12-01T00:54:54.206Z,1606784094.206 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-12-01T00:54:54.208Z,1606784094.208 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-12-01T00:54:54.208Z,1606784094.208 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-12-01T00:54:54.210Z,1606784094.210 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-12-01T00:54:54.210Z,1606784094.210 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-12-01T00:54:54.212Z,1606784094.212 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.214Z,1606784094.214 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.215Z,1606784094.215 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.215Z,1606784094.215 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.217Z,1606784094.217 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.217Z,1606784094.217 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.219Z,1606784094.219 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.219Z,1606784094.219 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-12-01T00:54:54.221Z,1606784094.221 [WetLabsBB2FL] Loaded
2020-12-01T00:54:54.221Z,1606784094.221 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-12-01T00:54:54.222Z,1606784094.222 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A414E0
2020-12-01T00:54:54.222Z,1606784094.222 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 912
2020-12-01T00:54:54.223Z,1606784094.223 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-12-01T00:54:54.224Z,1606784094.224 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-12-01T00:54:54.265Z,1606784094.265 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-12-01T00:54:54.266Z,1606784094.266 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-12-01T00:54:54.596Z,1606784094.596 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-12-01T00:54:54.597Z,1606784094.597 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-12-01T00:54:54.752Z,1606784094.752 [SBIT](DEBUG): Construct Startup Built In Test.
2020-12-01T00:54:54.761Z,1606784094.761 [SBIT] Loaded
2020-12-01T00:54:54.761Z,1606784094.761 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-12-01T00:54:54.762Z,1606784094.762 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-12-01T00:54:54.774Z,1606784094.774 [IBIT] Loaded
2020-12-01T00:54:54.775Z,1606784094.775 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-12-01T00:54:54.778Z,1606784094.778 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-12-01T00:54:54.875Z,1606784094.875 [CBIT] Loaded
2020-12-01T00:54:54.876Z,1606784094.876 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-12-01T00:54:54.876Z,1606784094.876 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-12-01T00:54:54.877Z,1606784094.877 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-12-01T00:54:54.974Z,1606784094.974 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-12-01T00:54:54.978Z,1606784094.978 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-12-01T00:54:54.979Z,1606784094.979 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-12-01T00:54:54.987Z,1606784094.987 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-12-01T00:54:54.988Z,1606784094.988 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B684E0
2020-12-01T00:54:54.989Z,1606784094.989 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 913
2020-12-01T00:54:54.993Z,1606784094.993 [Supervisor](INFO): Main Thread ID is 815
2020-12-01T00:54:54.993Z,1606784094.993 [Supervisor](DEBUG): Running supervisor.
2020-12-01T00:54:54.994Z,1606784094.994 [CommandLine ThreadHandler](INFO): Handler Thread ID is 914
2020-12-01T00:54:54.996Z,1606784094.996 [controlThread ThreadHandler](INFO): Handler Thread ID is 915
2020-12-01T00:54:54.997Z,1606784094.997 [controlThread](DEBUG): Initializing ControlThread
2020-12-01T00:54:54.997Z,1606784094.997 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-12-01T00:54:54.999Z,1606784094.999 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-12-01T00:54:54.000Z,1606784095.000 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-12-01T00:54:55.000Z,1606784095.000 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-12-01T00:54:55.002Z,1606784095.002 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-12-01T00:54:55.002Z,1606784095.002 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-12-01T00:54:55.007Z,1606784095.007 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-12-01T00:54:55.007Z,1606784095.007 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-12-01T00:54:55.008Z,1606784095.008 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-12-01T00:54:55.008Z,1606784095.008 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-12-01T00:54:55.009Z,1606784095.009 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-12-01T00:54:55.009Z,1606784095.009 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-12-01T00:54:55.013Z,1606784095.013 [SBIT](INFO): Initialize SBIT Component.
2020-12-01T00:54:55.014Z,1606784095.014 [SBIT](IMPORTANT): git: 2020-11-25
2020-12-01T00:54:55.014Z,1606784095.014 [SBIT](INFO): git hash: 5e13bf84858840c906f3eccd44caf880a68d7500
2020-12-01T00:54:55.014Z,1606784095.014 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-12-01T00:54:55.015Z,1606784095.015 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019
2020-12-01T00:54:55.016Z,1606784095.016 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2020-12-01T00:54:55.017Z,1606784095.017 [IBIT](INFO): Initialize IBIT Component.
2020-12-01T00:54:55.018Z,1606784095.018 [CBIT](DEBUG): Initialize CBIT Component.
2020-12-01T00:54:55.018Z,1606784095.018 [logger ThreadHandler](INFO): Handler Thread ID is 916
2020-12-01T00:54:55.029Z,1606784095.029 [CBIT](DEBUG): Initialized mux pins.
2020-12-01T00:54:55.029Z,1606784095.029 [CBIT](DEBUG): Initializing the watchdog timer.
2020-12-01T00:54:55.037Z,1606784095.037 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 917
2020-12-01T00:54:55.038Z,1606784095.038 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-12-01T00:54:55.049Z,1606784095.049 [Onboard ThreadHandler](INFO): Handler Thread ID is 918
2020-12-01T00:54:55.053Z,1606784095.053 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-12-01T00:54:55.054Z,1606784095.054 [CBIT](DEBUG): Initializing heartbeat.
2020-12-01T00:54:55.067Z,1606784095.067 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 919
2020-12-01T00:54:55.085Z,1606784095.085 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 920
2020-12-01T00:54:55.086Z,1606784095.086 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-12-01T00:54:55.090Z,1606784095.090 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 922
2020-12-01T00:54:55.091Z,1606784095.091 [WetLabsBB2FL](INFO): Powering down
2020-12-01T00:54:55.125Z,1606784095.125 [CBIT](DEBUG): Deactivating GF circuits.
2020-12-01T00:54:55.125Z,1606784095.125 [CBIT](DEBUG): Deactivating emergency mode.
2020-12-01T00:54:55.161Z,1606784095.161 [CBIT](DEBUG): Backplane powered.
2020-12-01T00:54:55.213Z,1606784095.213 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-12-01T00:54:55.224Z,1606784095.224 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 923
2020-12-01T00:54:55.339Z,1606784095.339 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-12-01T00:54:55.339Z,1606784095.339 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-12-01T00:54:55.340Z,1606784095.340 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-12-01T00:54:55.341Z,1606784095.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-12-01T00:54:55.342Z,1606784095.342 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-12-01T00:54:55.433Z,1606784095.433 [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-12-01T00:54:55.434Z,1606784095.434 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-12-01T00:54:55.494Z,1606784095.494 [Radio_Surface](INFO): Powering up
2020-12-01T00:54:55.539Z,1606784095.539 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-12-01T00:54:55.540Z,1606784095.540 [Default:A.Wait](DEBUG): Construct Wait.
2020-12-01T00:54:55.542Z,1606784095.542 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-12-01T00:54:55.584Z,1606784095.584 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-12-01T00:54:55.586Z,1606784095.586 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-12-01T00:54:55.608Z,1606784095.608 [Default:E.Execute](DEBUG): Construct Execute.
2020-12-01T00:54:55.611Z,1606784095.611 [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-12-01T00:54:55.624Z,1606784095.624 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,BPC1,AMEcho,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-12-01T00:54:55.641Z,1606784095.641 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T00:54:55.725Z,1606784095.725 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2020-12-01T00:54:55.753Z,1606784095.753 [AMEcho](INFO): Powering up
2020-12-01T00:54:55.755Z,1606784095.755 [AMEcho](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-12-01T00:54:55.773Z,1606784095.773 [CANONSampler](INFO): Powering down
2020-12-01T00:54:55.794Z,1606784095.794 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-12-01T00:54:55.880Z,1606784095.880 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-12-01T00:54:55.933Z,1606784095.933 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-12-01T00:54:55.941Z,1606784095.941 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-12-01T00:54:55.942Z,1606784095.942 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-12-01T00:54:55.949Z,1606784095.949 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-12-01T00:54:55.950Z,1606784095.950 [MassServo](DEBUG): Initializing EZServoServo.
2020-12-01T00:54:55.957Z,1606784095.957 [MassServo](DEBUG): Initializing MassServo.
2020-12-01T00:54:55.958Z,1606784095.958 [RudderServo](DEBUG): Initializing EZServoServo.
2020-12-01T00:54:55.965Z,1606784095.965 [RudderServo](DEBUG): Initializing RudderServo.
2020-12-01T00:54:55.966Z,1606784095.966 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-12-01T00:54:55.973Z,1606784095.973 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-12-01T00:54:56.155Z,1606784096.155 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2020-12-01T00:54:56.155Z,1606784096.155 [DropWeight] Hardware Fault, FailCount= 1
2020-12-01T00:54:56.155Z,1606784096.155 [DropWeight](ERROR): Hardware Fault
2020-12-01T00:54:56.321Z,1606784096.321 [AMEcho](INFO): Powering down
2020-12-01T00:54:56.352Z,1606784096.352 [CommandLine](FAULT): Scheduling is paused
2020-12-01T00:54:56.352Z,1606784096.352 [CBIT](INFO): Critical error at 20201201T005456
2020-12-01T00:54:56.353Z,1606784096.353 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-12-01T00:54:56.355Z,1606784096.355 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-12-01T00:54:56.356Z,1606784096.356 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-12-01T00:54:56.450Z,1606784096.450 [CBIT](INFO): Critical error at 20201201T005456
2020-12-01T00:54:56.846Z,1606784096.846 [AMEcho](IMPORTANT): Setting 'depthThreshold' to 20.000000
2020-12-01T00:54:59.177Z,1606784099.177 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-12-01T00:54:59.589Z,1606784099.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-12-01T00:55:00.137Z,1606784100.137 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-12-01T00:55:00.677Z,1606784100.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2020-12-01T00:55:02.117Z,1606784102.117 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2020-12-01T00:55:22.358Z,1606784122.358 [NAL9602](INFO): Powering up NAL9602
2020-12-01T00:55:33.266Z,1606784133.266 [NAL9602](INFO): NAL9602 initialized
2020-12-01T00:55:54.701Z,1606784154.701 [SBIT](IMPORTANT): Beginning Startup BIT
2020-12-01T00:55:54.705Z,1606784154.705 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-01T00:56:05.610Z,1606784165.610 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.000463
CHAN A1 (24V): 0.000825
CHAN A2 (12V): -0.001933
CHAN A3 (5V): 4.753929
CHAN B0 (3.3V): 0.001729
CHAN B1 (3.15aV): 0.000081
CHAN B2 (3.15bV): -0.000475
CHAN B3 (GND): 0.000262
OPEN: -0.000397
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-01T00:56:48.855Z,1606784208.855 [SBIT](IMPORTANT): SBIT PASSED
2020-12-01T00:56:48.856Z,1606784208.856 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-12-01T00:56:48.856Z,1606784208.856 [SBIT](IMPORTANT): AMEcho.enabled=1 bool;

2020-12-01T00:56:48.856Z,1606784208.856 [SBIT](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup=1 bool;

2020-12-01T00:56:48.861Z,1606784208.861 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter;

2020-12-01T00:56:48.861Z,1606784208.861 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 1.000000 meter;

2020-12-01T00:56:48.861Z,1606784208.861 [SBIT](IMPORTANT): PAR_Licor.parCal=1.0914 none;

2020-12-01T00:56:48.861Z,1606784208.861 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=352.865169 cubic_centimeter;

2020-12-01T00:56:48.861Z,1606784208.861 [SBIT](IMPORTANT): VerticalControl.massDefault=-9.903388 millimeter;

2020-12-01T00:56:49.276Z,1606784209.276 [MissionManager](IMPORTANT): Started mission Startup
2020-12-01T00:56:49.276Z,1606784209.276 [Startup] Running Loop=1
2020-12-01T00:56:49.277Z,1606784209.277 [Startup](DEBUG): Aggregate::initialize Startup
2020-12-01T00:56:49.277Z,1606784209.277 [Startup:A.GoToSurface] Running Loop=1
2020-12-01T00:56:49.277Z,1606784209.277 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-01T00:56:49.278Z,1606784209.278 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-12-01T00:56:49.278Z,1606784209.278 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-12-01T00:56:49.278Z,1606784209.278 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-12-01T00:56:49.279Z,1606784209.279 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-01T00:56:49.279Z,1606784209.279 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-01T00:56:49.280Z,1606784209.280 [Startup:StartupSatComms] Running Loop=1
2020-12-01T00:56:49.280Z,1606784209.280 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-12-01T00:56:49.285Z,1606784209.285 [Startup:StartupSatComms:A] Running Loop=1
2020-12-01T00:56:49.667Z,1606784209.667 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-12-01T00:57:21.775Z,1606784241.775 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004689
2020-12-01T00:57:49.588Z,1606784269.588 [Startup:StartupSatComms:A](INFO): Timed out from 2020-12-01T00:56:49.3Z
2020-12-01T00:57:49.588Z,1606784269.588 [Startup:StartupSatComms:A] Stopped
2020-12-01T00:57:49.588Z,1606784269.588 [Startup:StartupSatComms:B] Running Loop=1
2020-12-01T00:57:49.874Z,1606784269.874 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-12-01T00:57:51.401Z,1606784271.401 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20201201T005444/Courier0000.lzma
2020-12-01T00:57:52.403Z,1606784272.403 [DataOverHttps](INFO): Moved sent file to Logs/20201201T005444/Courier0000.lzma.bak
2020-12-01T00:57:52.403Z,1606784272.403 [DataOverHttps](INFO): SBD MOMSN=13368319
2020-12-01T00:57:55.250Z,1606784275.250 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-12-01T00:57:55.250Z,1606784275.250 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-01T00:57:55.260Z,1606784275.260 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-01T00:57:55.670Z,1606784275.670 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-01T00:57:55.670Z,1606784275.670 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-12-01T00:58:07.842Z,1606784287.842 [DataOverHttps](INFO): Sending 896 bytes from file Logs/20201201T005444/Express0001.lzma
2020-12-01T00:58:08.842Z,1606784288.842 [DataOverHttps](INFO): Moved sent file to Logs/20201201T005444/Express0001.lzma.bak
2020-12-01T00:58:08.843Z,1606784288.843 [DataOverHttps](INFO): SBD MOMSN=13368324
2020-12-01T00:58:10.175Z,1606784290.175 [Startup:StartupSatComms:B] Stopped
2020-12-01T00:58:10.175Z,1606784290.175 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-12-01T00:58:10.175Z,1606784290.175 [Startup:StartupSatComms] Stopped
2020-12-01T00:58:10.175Z,1606784290.175 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-12-01T00:58:10.176Z,1606784290.176 [Startup](INFO): Completed Startup
2020-12-01T00:58:10.176Z,1606784290.176 [MissionManager](INFO): Startup is completed.
2020-12-01T00:58:10.176Z,1606784290.176 [MissionManager](INFO): Uninitializing Mission Startup
2020-12-01T00:58:10.176Z,1606784290.176 [Startup] Stopped
2020-12-01T00:58:10.176Z,1606784290.176 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-12-01T00:58:10.176Z,1606784290.176 [Startup:A.GoToSurface] Stopped
2020-12-01T00:58:10.176Z,1606784290.176 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-01T00:58:10.583Z,1606784290.583 [MissionManager](IMPORTANT): Started mission Default
2020-12-01T00:58:10.583Z,1606784290.583 [Default] Running Loop=1
2020-12-01T00:58:10.583Z,1606784290.583 [Default](DEBUG): Aggregate::initialize Default
2020-12-01T00:58:10.583Z,1606784290.583 [Default:B.GoToSurface] Running Loop=1
2020-12-01T00:58:10.583Z,1606784290.583 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-01T00:58:10.583Z,1606784290.583 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-12-01T00:58:10.584Z,1606784290.584 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-12-01T00:58:10.584Z,1606784290.584 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-12-01T00:58:10.584Z,1606784290.584 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-01T00:58:10.585Z,1606784290.585 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-01T00:58:10.585Z,1606784290.585 [Default:A.Wait] Running Loop=1
2020-12-01T00:58:10.585Z,1606784290.585 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-12-01T00:58:23.939Z,1606784303.939 [Default:A.Wait](INFO): Done Waiting.
2020-12-01T00:58:23.939Z,1606784303.939 [Default:A.Wait] Stopped
2020-12-01T00:58:23.939Z,1606784303.939 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-12-01T00:58:24.336Z,1606784304.336 [Default:CheckIn] Running Loop=1
2020-12-01T00:58:24.336Z,1606784304.336 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-12-01T00:58:24.336Z,1606784304.336 [Default:CheckIn:Read_GPS] Running Loop=1
2020-12-01T00:58:24.747Z,1606784304.747 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-12-01T00:59:23.701Z,1606784363.701 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-01T00:59:23.701Z,1606784363.701 [AHRS_M2] Data Fault, FailCount= 1
2020-12-01T00:59:23.701Z,1606784363.701 [AHRS_M2](ERROR): Data Fault
2020-12-01T00:59:23.740Z,1606784363.740 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-01T00:59:24.092Z,1606784364.092 [AHRS_M2](INFO): Powering down
2020-12-01T00:59:24.957Z,1606784364.957 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T00:59:24.957Z,1606784364.957 [AHRS_M2] No Fault, FailCount= 1
2020-12-01T00:59:25.309Z,1606784365.309 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T00:59:28.861Z,1606784368.861 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:29.265Z,1606784369.265 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:29.669Z,1606784369.669 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:30.073Z,1606784370.073 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:30.477Z,1606784370.477 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:30.881Z,1606784370.881 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:31.285Z,1606784371.285 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:31.689Z,1606784371.689 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:32.093Z,1606784372.093 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:32.497Z,1606784372.497 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:32.901Z,1606784372.901 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:33.305Z,1606784373.305 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:33.721Z,1606784373.721 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:33.885Z,1606784373.885 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T00:59:44.305Z,1606784384.305 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-01T00:59:44.305Z,1606784384.305 [AHRS_M2] Data Fault, FailCount= 2
2020-12-01T00:59:44.305Z,1606784384.305 [AHRS_M2](ERROR): Data Fault
2020-12-01T00:59:44.359Z,1606784384.359 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-01T00:59:44.697Z,1606784384.697 [AHRS_M2](INFO): Powering down
2020-12-01T00:59:45.538Z,1606784385.538 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T00:59:45.538Z,1606784385.538 [AHRS_M2] No Fault, FailCount= 2
2020-12-01T00:59:45.909Z,1606784385.909 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T00:59:59.253Z,1606784399.253 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-01T00:59:59.253Z,1606784399.253 [AHRS_M2] Data Fault, FailCount= 3
2020-12-01T00:59:59.253Z,1606784399.253 [AHRS_M2](ERROR): Data Fault
2020-12-01T00:59:59.287Z,1606784399.287 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-01T00:59:59.645Z,1606784399.645 [AHRS_M2](INFO): Powering down
2020-12-01T01:00:00.478Z,1606784400.478 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T01:00:00.478Z,1606784400.478 [AHRS_M2] No Fault, FailCount= 3
2020-12-01T01:00:00.857Z,1606784400.857 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T01:00:04.165Z,1606784404.165 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:04.589Z,1606784404.589 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:04.993Z,1606784404.993 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:05.397Z,1606784405.397 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:05.801Z,1606784405.801 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:06.205Z,1606784406.205 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:06.621Z,1606784406.621 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:07.013Z,1606784407.013 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:07.417Z,1606784407.417 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:07.821Z,1606784407.821 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:08.229Z,1606784408.229 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:08.629Z,1606784408.629 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:09.033Z,1606784409.033 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:09.437Z,1606784409.437 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:09.845Z,1606784409.845 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:10.245Z,1606784410.245 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:10.649Z,1606784410.649 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:11.053Z,1606784411.053 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:11.457Z,1606784411.457 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:11.861Z,1606784411.861 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:12.265Z,1606784412.265 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:12.669Z,1606784412.669 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:13.085Z,1606784413.085 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:13.473Z,1606784413.473 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:13.905Z,1606784413.905 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:13.905Z,1606784413.905 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-12-01T01:00:13.905Z,1606784413.905 [AHRS_M2] Communications Fault, FailCount= 4
2020-12-01T01:00:13.905Z,1606784413.905 [AHRS_M2](ERROR): Communications Fault
2020-12-01T01:00:14.004Z,1606784414.004 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-12-01T01:00:14.199Z,1606784414.199 [AHRS_M2](INFO): Powering down
2020-12-01T01:00:15.084Z,1606784415.084 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T01:00:15.084Z,1606784415.084 [AHRS_M2] No Fault, FailCount= 4
2020-12-01T01:00:15.417Z,1606784415.417 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T01:00:18.773Z,1606784418.773 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:19.177Z,1606784419.177 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:19.581Z,1606784419.581 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:19.985Z,1606784419.985 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:20.381Z,1606784420.381 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:20.793Z,1606784420.793 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:21.185Z,1606784421.185 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:21.601Z,1606784421.601 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:21.995Z,1606784421.995 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:22.625Z,1606784422.625 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:22.817Z,1606784422.817 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:23.221Z,1606784423.221 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:23.470Z,1606784423.470 [CommandLine](IMPORTANT): got command burn on
2020-12-01T01:00:23.470Z,1606784423.470 [CommandLine](IMPORTANT): Activating dropweight wire
2020-12-01T01:00:23.601Z,1606784423.601 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:24.013Z,1606784424.013 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:24.657Z,1606784424.657 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:24.833Z,1606784424.833 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:25.241Z,1606784425.241 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:25.641Z,1606784425.641 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:26.273Z,1606784426.273 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:26.689Z,1606784426.689 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:26.869Z,1606784426.869 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:27.497Z,1606784427.497 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:27.901Z,1606784427.901 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:28.305Z,1606784428.305 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:00:28.305Z,1606784428.305 [AHRS_M2](FAULT): Failed to initialize within timeout.
2020-12-01T01:00:28.305Z,1606784428.305 [AHRS_M2] Communications Fault, FailCount= 5
2020-12-01T01:00:28.305Z,1606784428.305 [AHRS_M2](ERROR): Communications Fault
2020-12-01T01:00:28.350Z,1606784428.350 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2020-12-01T01:00:28.350Z,1606784428.350 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2020-12-01T01:00:28.385Z,1606784428.385 [AHRS_M2](INFO): Powering down
2020-12-01T01:00:28.478Z,1606784428.478 [CBIT](INFO): Critical error at 20201201T010028
2020-12-01T01:00:36.470Z,1606784436.470 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-12-01T01:00:56.331Z,1606784456.331 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-12-01T01:00:56.331Z,1606784456.331 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-01T01:00:56.341Z,1606784456.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-01T01:00:56.773Z,1606784456.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-01T01:00:56.773Z,1606784456.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-12-01T01:00:57.061Z,1606784457.061 [CommandLine](IMPORTANT): got command burn off
2020-12-01T01:00:57.062Z,1606784457.062 [CommandLine](IMPORTANT): Deactivating dropweight wire
2020-12-01T01:01:03.552Z,1606784463.552 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-12-01T01:01:03.555Z,1606784463.555 [BPC1](INFO): Received data from all battery sticks.
2020-12-01T01:02:57.493Z,1606784577.493 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-12-01T01:02:57.493Z,1606784577.493 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-12-01T01:02:57.493Z,1606784577.493 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-01T01:02:57.504Z,1606784577.504 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-01T01:02:57.905Z,1606784577.905 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-01T01:02:57.906Z,1606784577.906 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-12-01T01:03:15.365Z,1606784595.365 [CommandLine](IMPORTANT): got command gfscan
2020-12-01T01:03:15.698Z,1606784595.698 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-01T01:03:24.555Z,1606784604.555 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-12-01T00:58:24.3Z
2020-12-01T01:03:24.556Z,1606784604.556 [Default:CheckIn:Read_GPS] Stopped
2020-12-01T01:03:24.556Z,1606784604.556 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-12-01T01:03:24.958Z,1606784604.958 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-12-01T01:03:26.599Z,1606784606.599 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001286
CHAN A1 (24V): 0.000602
CHAN A2 (12V): -0.002248
CHAN A3 (5V): -0.001559
CHAN B0 (3.3V): 0.000084
CHAN B1 (3.15aV): -0.000448
CHAN B2 (3.15bV): -0.000429
CHAN B3 (GND): -0.000079
OPEN: -0.000368
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-01T01:04:02.541Z,1606784642.541 [CommandLine](IMPORTANT): got command gfscan
2020-12-01T01:04:02.582Z,1606784642.582 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-01T01:04:13.448Z,1606784653.448 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000914
CHAN A1 (24V): 0.000448
CHAN A2 (12V): -0.002095
CHAN A3 (5V): -0.001259
CHAN B0 (3.3V): -0.000299
CHAN B1 (3.15aV): 0.000487
CHAN B2 (3.15bV): -0.000057
CHAN B3 (GND): -0.000216
OPEN: -0.000707
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-01T01:04:19.840Z,1606784659.840 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20201201T005444/Courier0004.lzma
2020-12-01T01:04:20.842Z,1606784660.842 [DataOverHttps](INFO): Moved sent file to Logs/20201201T005444/Courier0004.lzma.bak
2020-12-01T01:04:20.843Z,1606784660.843 [DataOverHttps](INFO): SBD MOMSN=13368394
2020-12-01T01:04:35.649Z,1606784675.649 [CommandLine](IMPORTANT): got command gfscan
2020-12-01T01:04:35.669Z,1606784675.669 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-01T01:04:35.937Z,1606784675.937 [DataOverHttps](INFO): Sending 458 bytes from file Logs/20201201T005444/Express0005.lzma
2020-12-01T01:04:36.938Z,1606784676.938 [DataOverHttps](INFO): Moved sent file to Logs/20201201T005444/Express0005.lzma.bak
2020-12-01T01:04:36.939Z,1606784676.939 [DataOverHttps](INFO): SBD MOMSN=13368397
2020-12-01T01:04:38.065Z,1606784678.065 [Default:CheckIn:Read_Iridium] Stopped
2020-12-01T01:04:38.065Z,1606784678.065 [Default:CheckIn:C.Wait] Running Loop=1
2020-12-01T01:04:38.065Z,1606784678.065 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-01T01:04:46.569Z,1606784686.569 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000583
CHAN A1 (24V): 0.000734
CHAN A2 (12V): -0.002048
CHAN A3 (5V): -0.001572
CHAN B0 (3.3V): -0.000216
CHAN B1 (3.15aV): -0.000207
CHAN B2 (3.15bV): 0.000207
CHAN B3 (GND): -0.000079
OPEN: -0.000442
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-01T01:04:58.680Z,1606784698.680 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2020-12-01T01:04:58.680Z,1606784698.680 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-12-01T01:04:58.680Z,1606784698.680 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-01T01:04:58.690Z,1606784698.690 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-01T01:04:59.088Z,1606784699.088 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-01T01:04:59.088Z,1606784699.088 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-12-01T01:05:28.613Z,1606784728.613 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T01:05:28.613Z,1606784728.613 [AHRS_M2] No Fault, FailCount= 5
2020-12-01T01:05:28.961Z,1606784728.961 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T01:05:32.624Z,1606784732.624 [AHRS_M2](INFO): Failure count cleared after critical for AHRS_M2
2020-12-01T01:05:34.626Z,1606784734.626 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-12-01T01:05:34.626Z,1606784734.626 [NAL9602] Data Fault, FailCount= 1
2020-12-01T01:05:34.627Z,1606784734.627 [NAL9602](ERROR): Data Fault
2020-12-01T01:05:34.673Z,1606784734.673 [CBIT](ERROR): Data Fault in component: NAL9602
2020-12-01T01:05:35.030Z,1606784735.030 [NAL9602](INFO): Powering down
2020-12-01T01:05:35.861Z,1606784735.861 [CBIT](INFO): Clearing failed state for component NAL9602
2020-12-01T01:05:35.861Z,1606784735.861 [NAL9602] No Fault, FailCount= 1
2020-12-01T01:05:38.446Z,1606784738.446 [CommandLine](IMPORTANT): got command gfscan
2020-12-01T01:05:38.691Z,1606784738.691 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-01T01:05:49.591Z,1606784749.591 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001333
CHAN A1 (24V): 0.000369
CHAN A2 (12V): -0.001904
CHAN A3 (5V): -0.001068
CHAN B0 (3.3V): 0.000261
CHAN B1 (3.15aV): -0.000205
CHAN B2 (3.15bV): -0.000349
CHAN B3 (GND): 0.000164
OPEN: -0.000241
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-01T01:06:05.330Z,1606784765.330 [NAL9602](INFO): Powering up NAL9602
2020-12-01T01:06:16.238Z,1606784776.238 [NAL9602](INFO): NAL9602 initialized
2020-12-01T01:07:59.682Z,1606784879.682 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-12-01T01:07:59.682Z,1606784879.682 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-01T01:07:59.708Z,1606784879.708 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-01T01:08:00.100Z,1606784880.100 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-01T01:08:00.100Z,1606784880.100 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-12-01T01:08:44.509Z,1606784924.509 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-01T01:08:44.509Z,1606784924.509 [AHRS_M2] Data Fault, FailCount= 1
2020-12-01T01:08:44.509Z,1606784924.509 [AHRS_M2](ERROR): Data Fault
2020-12-01T01:08:44.591Z,1606784924.591 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-01T01:08:44.901Z,1606784924.901 [AHRS_M2](INFO): Powering down
2020-12-01T01:08:45.760Z,1606784925.760 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T01:08:45.760Z,1606784925.760 [AHRS_M2] No Fault, FailCount= 1
2020-12-01T01:08:46.112Z,1606784926.112 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T01:08:49.669Z,1606784929.669 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:08:49.833Z,1606784929.833 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:09:00.269Z,1606784940.269 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-01T01:09:00.269Z,1606784940.269 [AHRS_M2] Data Fault, FailCount= 2
2020-12-01T01:09:00.269Z,1606784940.269 [AHRS_M2](ERROR): Data Fault
2020-12-01T01:09:00.328Z,1606784940.328 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-01T01:09:00.657Z,1606784940.657 [AHRS_M2](INFO): Powering down
2020-12-01T01:09:01.490Z,1606784941.490 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T01:09:01.490Z,1606784941.490 [AHRS_M2] No Fault, FailCount= 2
2020-12-01T01:09:01.869Z,1606784941.869 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T01:09:38.654Z,1606784978.654 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-01T01:09:38.654Z,1606784978.654 [Default:CheckIn:C.Wait] Stopped
2020-12-01T01:09:38.654Z,1606784978.654 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-01T01:09:38.655Z,1606784978.655 [Default:CheckIn:D] Running Loop=1
2020-12-01T01:09:39.072Z,1606784979.072 [Default:CheckIn:D] Stopped
2020-12-01T01:09:39.072Z,1606784979.072 [Default:CheckIn:E] Running Loop=1
2020-12-01T01:09:39.483Z,1606784979.483 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.474819 min 
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn:E] Stopped
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn] Stopped
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn](INFO): Running loop #2
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn] Running Loop=2
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-12-01T01:09:39.484Z,1606784979.484 [Default:CheckIn:Read_GPS] Running Loop=1
2020-12-01T01:09:56.464Z,1606784996.464 [CBIT](INFO): Clearing failed state for component DropWeight
2020-12-01T01:09:56.464Z,1606784996.464 [DropWeight] No Fault, FailCount= 1
2020-12-01T01:10:11.773Z,1606785011.773 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2020-12-01T01:10:11.773Z,1606785011.773 [AHRS_M2] Data Fault, FailCount= 1
2020-12-01T01:10:11.773Z,1606785011.773 [AHRS_M2](ERROR): Data Fault
2020-12-01T01:10:11.822Z,1606785011.822 [CBIT](ERROR): Data Fault in component: AHRS_M2
2020-12-01T01:10:12.165Z,1606785012.165 [AHRS_M2](INFO): Powering down
2020-12-01T01:10:13.099Z,1606785013.099 [CBIT](INFO): Clearing failed state for component AHRS_M2
2020-12-01T01:10:13.099Z,1606785013.099 [AHRS_M2] No Fault, FailCount= 1
2020-12-01T01:10:13.393Z,1606785013.393 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-12-01T01:10:16.757Z,1606785016.757 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:17.181Z,1606785017.181 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:17.565Z,1606785017.565 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:17.969Z,1606785017.969 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:18.373Z,1606785018.373 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:18.777Z,1606785018.777 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:19.181Z,1606785019.181 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:19.813Z,1606785019.813 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:20.217Z,1606785020.217 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:20.621Z,1606785020.621 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:21.017Z,1606785021.017 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:21.421Z,1606785021.421 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:21.625Z,1606785021.625 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:22.001Z,1606785022.001 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:10:22.633Z,1606785022.633 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2020-12-01T01:11:00.781Z,1606785060.781 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-12-01T01:11:00.781Z,1606785060.781 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-12-01T01:11:00.791Z,1606785060.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-12-01T01:11:01.170Z,1606785061.170 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-12-01T01:11:01.170Z,1606785061.170 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-12-01T01:11:23.339Z,1606785083.339 [CommandLine](IMPORTANT): got command gfscan
2020-12-01T01:11:23.403Z,1606785083.403 [CBIT](IMPORTANT): Beginning ground fault scan
2020-12-01T01:11:34.305Z,1606785094.305 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001506
CHAN A1 (24V): 0.000702
CHAN A2 (12V): -0.001998
CHAN A3 (5V): -0.001700
CHAN B0 (3.3V): 0.000134
CHAN B1 (3.15aV): -0.000805
CHAN B2 (3.15bV): -0.000287
CHAN B3 (GND): 0.000205
OPEN: -0.000383
Full Scale Calc: 4.765 mA, -1.589 mA
2020-12-01T01:11:55.170Z,1606785115.170 [CommandLine](IMPORTANT): got command quit
2020-12-01T01:11:56.177Z,1606785116.177 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:11:56.177Z,1606785116.177 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.353Z,1606785116.353 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-12-01T01:11:56.353Z,1606785116.353 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.354Z,1606785116.354 [CommandLine](INFO): Join timeout helper Thread ID is 967
2020-12-01T01:11:56.359Z,1606785116.359 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-12-01T01:11:56.359Z,1606785116.359 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.359Z,1606785116.359 [NavChartDb](INFO): Join timeout helper Thread ID is 968
2020-12-01T01:11:56.621Z,1606785116.621 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:11:56.621Z,1606785116.621 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.637Z,1606785116.637 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-12-01T01:11:56.637Z,1606785116.637 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.637Z,1606785116.637 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 969
2020-12-01T01:11:56.977Z,1606785116.977 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:11:56.978Z,1606785116.978 [WetLabsBB2FL](INFO): Powering down
2020-12-01T01:11:56.978Z,1606785116.978 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.985Z,1606785116.985 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-12-01T01:11:56.985Z,1606785116.985 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:56.985Z,1606785116.985 [CTD_Seabird](INFO): Join timeout helper Thread ID is 970
2020-12-01T01:11:57.366Z,1606785117.366 [CTD_Seabird](INFO): Powering down
2020-12-01T01:11:57.377Z,1606785117.377 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:11:57.377Z,1606785117.377 [CTD_Seabird](INFO): Powering down
2020-12-01T01:11:57.389Z,1606785117.389 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:57.409Z,1606785117.409 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-12-01T01:11:57.409Z,1606785117.409 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:57.410Z,1606785117.410 [Radio_Surface](INFO): Join timeout helper Thread ID is 971
2020-12-01T01:11:57.813Z,1606785117.813 [Radio_Surface](INFO): Powering down
2020-12-01T01:11:57.814Z,1606785117.814 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:11:57.814Z,1606785117.814 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:57.825Z,1606785117.825 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-12-01T01:11:57.825Z,1606785117.825 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:11:57.826Z,1606785117.826 [Onboard](INFO): Join timeout helper Thread ID is 972
2020-12-01T01:11:58.221Z,1606785118.221 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-12-01T01:12:00.881Z,1606785120.881 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:12:00.881Z,1606785120.881 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:00.897Z,1606785120.897 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-12-01T01:12:00.898Z,1606785120.898 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:00.898Z,1606785120.898 [DataOverHttps](INFO): Join timeout helper Thread ID is 973
2020-12-01T01:12:01.233Z,1606785121.233 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:12:01.233Z,1606785121.233 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.237Z,1606785121.237 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-12-01T01:12:01.238Z,1606785121.238 [logger ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.238Z,1606785121.238 [logger](INFO): Join timeout helper Thread ID is 974
2020-12-01T01:12:01.257Z,1606785121.257 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:12:01.257Z,1606785121.257 [logger ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.277Z,1606785121.277 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-12-01T01:12:01.278Z,1606785121.278 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.278Z,1606785121.278 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-12-01T01:12:01.278Z,1606785121.278 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.278Z,1606785121.278 [controlThread](INFO): Join timeout helper Thread ID is 975
2020-12-01T01:12:01.325Z,1606785121.325 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-01T01:12:01.325Z,1606785121.325 [controlThread](DEBUG): Uninitializing ControlThread
2020-12-01T01:12:01.325Z,1606785121.325 [AHRS_M2](INFO): Powering down
2020-12-01T01:12:01.397Z,1606785121.397 [NAL9602](INFO): Powering down
2020-12-01T01:12:01.399Z,1606785121.399 [AMEcho](INFO): Powering down
2020-12-01T01:12:01.401Z,1606785121.401 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-12-01T01:12:01.402Z,1606785121.402 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-12-01T01:12:01.402Z,1606785121.402 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-12-01T01:12:01.402Z,1606785121.402 [MissionManager](INFO): Uninitializing Mission Default
2020-12-01T01:12:01.403Z,1606785121.403 [Default] Stopped
2020-12-01T01:12:01.403Z,1606785121.403 [Default](DEBUG): Aggregate::uninitialize Default
2020-12-01T01:12:01.403Z,1606785121.403 [Default:B.GoToSurface] Stopped
2020-12-01T01:12:01.403Z,1606785121.403 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-01T01:12:01.403Z,1606785121.403 [Default:CheckIn] Stopped
2020-12-01T01:12:01.403Z,1606785121.403 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-12-01T01:12:01.403Z,1606785121.403 [Default:CheckIn:Read_GPS] Stopped
2020-12-01T01:12:01.406Z,1606785121.406 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-12-01T01:12:01.406Z,1606785121.406 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-12-01T01:12:01.406Z,1606785121.406 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-12-01T01:12:01.406Z,1606785121.406 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-12-01T01:12:01.407Z,1606785121.407 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-12-01T01:12:01.407Z,1606785121.407 [BuoyancyServo](INFO): Powering down
2020-12-01T01:12:01.421Z,1606785121.421 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-12-01T01:12:01.421Z,1606785121.421 [ElevatorServo](INFO): Powering down
2020-12-01T01:12:01.422Z,1606785121.422 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-01T01:12:01.422Z,1606785121.422 [MassServo](INFO): Powering down
2020-12-01T01:12:01.423Z,1606785121.423 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-12-01T01:12:01.423Z,1606785121.423 [RudderServo](INFO): Powering down
2020-12-01T01:12:01.424Z,1606785121.424 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-12-01T01:12:01.424Z,1606785121.424 [ThrusterServo](INFO): Powering down
2020-12-01T01:12:01.424Z,1606785121.424 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-12-01T01:12:01.425Z,1606785121.425 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-12-01T01:12:01.425Z,1606785121.425 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-12-01T01:12:01.425Z,1606785121.425 [CBIT](DEBUG): Powering off loads.
2020-12-01T01:12:01.437Z,1606785121.437 [CBIT](DEBUG): Disabling WDT.
2020-12-01T01:12:01.449Z,1606785121.449 [CBIT](DEBUG): Opening all GF detection circuits.
2020-12-01T01:12:01.449Z,1606785121.449 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.531Z,1606785121.531 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.533Z,1606785121.533 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.538Z,1606785121.538 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.571Z,1606785121.571 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.575Z,1606785121.575 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.618Z,1606785121.618 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-01T01:12:01.680Z,1606785121.680 [logger ThreadHandler](INFO): Thread cancelled.