2020-11-09T21:16:35.102Z,1604956595.102 [Supervisor](DEBUG): Initializing supervisor. 2020-11-09T21:16:35.105Z,1604956595.105 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-11-09T21:16:35.106Z,1604956595.106 [SyncHandler](INFO): Protected caller Thread ID is 834 2020-11-09T21:16:35.106Z,1604956595.106 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-11-09T21:16:35.107Z,1604956595.107 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-11-09T21:16:35.107Z,1604956595.107 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 835 2020-11-09T21:16:35.110Z,1604956595.110 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-11-09T21:16:35.127Z,1604956595.127 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-11-09T21:16:35.128Z,1604956595.128 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-11-09T21:16:35.128Z,1604956595.128 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 836 2020-11-09T21:16:35.129Z,1604956595.129 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-11-09T21:16:35.130Z,1604956595.130 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-11-09T21:16:35.130Z,1604956595.130 [logger ThreadHandler](INFO): Protected caller Thread ID is 837 2020-11-09T21:16:35.133Z,1604956595.133 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-11-09T21:16:35.133Z,1604956595.133 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-11-09T21:16:35.137Z,1604956595.137 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-11-09T21:16:35.231Z,1604956595.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-11-09T21:16:35.233Z,1604956595.233 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-11-09T21:16:35.802Z,1604956595.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-11-09T21:16:35.803Z,1604956595.803 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-11-09T21:16:35.999Z,1604956595.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-11-09T21:16:35.999Z,1604956595.999 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-11-09T21:16:36.096Z,1604956596.096 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-11-09T21:16:36.098Z,1604956596.098 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-11-09T21:16:36.201Z,1604956596.201 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-11-09T21:16:36.203Z,1604956596.203 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-11-09T21:16:36.284Z,1604956596.284 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-11-09T21:16:36.420Z,1604956596.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-11-09T21:16:36.421Z,1604956596.421 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-11-09T21:16:36.702Z,1604956596.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-11-09T21:16:36.703Z,1604956596.703 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-11-09T21:16:37.193Z,1604956597.193 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-11-09T21:16:37.194Z,1604956597.194 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-11-09T21:16:37.345Z,1604956597.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-11-09T21:16:37.347Z,1604956597.347 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-11-09T21:16:37.531Z,1604956597.531 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-11-09T21:16:37.532Z,1604956597.532 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-11-09T21:16:38.007Z,1604956598.007 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-11-09T21:16:38.508Z,1604956598.508 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-11-09T21:16:38.827Z,1604956598.827 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-11-09T21:16:38.829Z,1604956598.829 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-11-09T21:16:39.024Z,1604956599.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-11-09T21:16:39.026Z,1604956599.026 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-11-09T21:16:39.426Z,1604956599.426 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-11-09T21:16:39.428Z,1604956599.428 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-11-09T21:16:39.743Z,1604956599.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-11-09T21:16:39.745Z,1604956599.745 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-11-09T21:16:39.747Z,1604956599.747 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-11-09T21:16:39.830Z,1604956599.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-11-09T21:16:39.980Z,1604956599.980 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-11-09T21:16:40.086Z,1604956600.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-11-09T21:16:40.171Z,1604956600.171 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-11-09T21:16:40.264Z,1604956600.264 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-11-09T21:16:40.468Z,1604956600.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-11-09T21:16:40.717Z,1604956600.717 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-11-09T21:16:40.717Z,1604956600.717 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-11-09T21:16:40.810Z,1604956600.810 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-11-09T21:16:40.907Z,1604956600.907 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-11-09T21:16:41.037Z,1604956601.037 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-11-09T21:16:41.135Z,1604956601.135 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2020-11-09T21:16:41.136Z,1604956601.136 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-11-09T21:16:41.154Z,1604956601.154 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-11-09T21:16:41.249Z,1604956601.249 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-11-09T21:16:41.249Z,1604956601.249 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-11-09T21:16:41.312Z,1604956601.312 [VerticalControl](DEBUG): Construct VerticalControl. 2020-11-09T21:16:41.370Z,1604956601.370 [VerticalControl] Loaded 2020-11-09T21:16:41.370Z,1604956601.370 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-11-09T21:16:41.370Z,1604956601.370 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-11-09T21:16:41.408Z,1604956601.408 [HorizontalControl] Loaded 2020-11-09T21:16:41.408Z,1604956601.408 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-11-09T21:16:41.409Z,1604956601.409 [SpeedControl](DEBUG): Construct SpeedControl. 2020-11-09T21:16:41.412Z,1604956601.412 [SpeedControl] Loaded 2020-11-09T21:16:41.412Z,1604956601.412 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-11-09T21:16:41.413Z,1604956601.413 [LoopControl](DEBUG): Construct LoopControl. 2020-11-09T21:16:41.413Z,1604956601.413 [LoopControl] Loaded 2020-11-09T21:16:41.413Z,1604956601.413 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-11-09T21:16:41.414Z,1604956601.414 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-11-09T21:16:41.414Z,1604956601.414 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-11-09T21:16:41.467Z,1604956601.467 [DepthRateCalculator] Loaded 2020-11-09T21:16:41.467Z,1604956601.467 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-11-09T21:16:41.470Z,1604956601.470 [PitchRateCalculator] Loaded 2020-11-09T21:16:41.470Z,1604956601.470 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-11-09T21:16:41.478Z,1604956601.478 [SpeedCalculator] Loaded 2020-11-09T21:16:41.478Z,1604956601.478 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-11-09T21:16:41.489Z,1604956601.489 [TempGradientCalculator] Loaded 2020-11-09T21:16:41.490Z,1604956601.490 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-11-09T21:16:41.492Z,1604956601.492 [YawRateCalculator] Loaded 2020-11-09T21:16:41.492Z,1604956601.492 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-11-09T21:16:41.507Z,1604956601.507 [ElevatorOffsetCalculator] Loaded 2020-11-09T21:16:41.507Z,1604956601.507 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-11-09T21:16:41.508Z,1604956601.508 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-11-09T21:16:41.508Z,1604956601.508 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-11-09T21:16:41.549Z,1604956601.549 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-11-09T21:16:41.549Z,1604956601.549 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-11-09T21:16:41.676Z,1604956601.676 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-11-09T21:16:41.677Z,1604956601.677 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-11-09T21:16:42.001Z,1604956602.001 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-11-09T21:16:42.001Z,1604956602.001 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-11-09T21:16:42.122Z,1604956602.122 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-11-09T21:16:42.122Z,1604956602.122 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-11-09T21:16:42.678Z,1604956602.678 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-11-09T21:16:42.680Z,1604956602.680 [AHRS_M2](INFO): created writer for : platform_orientation 2020-11-09T21:16:42.682Z,1604956602.682 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-11-09T21:16:42.685Z,1604956602.685 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-11-09T21:16:42.685Z,1604956602.685 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-11-09T21:16:42.688Z,1604956602.688 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-11-09T21:16:42.688Z,1604956602.688 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-11-09T21:16:42.691Z,1604956602.691 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-11-09T21:16:42.773Z,1604956602.773 [AHRS_M2] Loaded 2020-11-09T21:16:42.773Z,1604956602.773 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-11-09T21:16:42.911Z,1604956602.911 [DataOverHttps] Loaded 2020-11-09T21:16:42.912Z,1604956602.912 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-11-09T21:16:42.913Z,1604956602.913 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090E4E0 2020-11-09T21:16:42.913Z,1604956602.913 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 920 2020-11-09T21:16:42.929Z,1604956602.929 [Depth_Keller] Loaded 2020-11-09T21:16:42.930Z,1604956602.930 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-11-09T21:16:42.932Z,1604956602.932 [DropWeight] Loaded 2020-11-09T21:16:42.932Z,1604956602.932 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2020-11-09T21:16:42.986Z,1604956602.986 [NAL9602] Loaded 2020-11-09T21:16:42.986Z,1604956602.986 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-11-09T21:16:43.011Z,1604956603.011 [Onboard] Loaded 2020-11-09T21:16:43.011Z,1604956603.011 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-11-09T21:16:43.012Z,1604956603.012 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093E4E0 2020-11-09T21:16:43.013Z,1604956603.013 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 921 2020-11-09T21:16:43.023Z,1604956603.023 [Radio_Surface] Loaded 2020-11-09T21:16:43.023Z,1604956603.023 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-11-09T21:16:43.024Z,1604956603.024 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096E4E0 2020-11-09T21:16:43.024Z,1604956603.024 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 922 2020-11-09T21:16:43.051Z,1604956603.051 [RDI_Pathfinder] Loaded 2020-11-09T21:16:43.051Z,1604956603.051 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2020-11-09T21:16:43.122Z,1604956603.122 [DAT] Loaded 2020-11-09T21:16:43.122Z,1604956603.122 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-11-09T21:16:43.882Z,1604956603.882 [BPC1] Loaded 2020-11-09T21:16:43.882Z,1604956603.882 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-11-09T21:16:43.883Z,1604956603.883 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-11-09T21:16:43.884Z,1604956603.884 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-11-09T21:16:44.017Z,1604956604.017 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-11-09T21:16:44.017Z,1604956604.017 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-11-09T21:16:44.032Z,1604956604.032 [NavChart] Loaded 2020-11-09T21:16:44.032Z,1604956604.032 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-11-09T21:16:44.044Z,1604956604.044 [UniversalFixResidualReporter] Loaded 2020-11-09T21:16:44.045Z,1604956604.045 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-11-09T21:16:44.045Z,1604956604.045 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-11-09T21:16:44.420Z,1604956604.420 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-11-09T21:16:44.660Z,1604956604.660 [SBIT](DEBUG): Construct Startup Built In Test. 2020-11-09T21:16:44.682Z,1604956604.682 [SBIT] Loaded 2020-11-09T21:16:44.682Z,1604956604.682 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-11-09T21:16:44.683Z,1604956604.683 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-11-09T21:16:44.696Z,1604956604.696 [IBIT] Loaded 2020-11-09T21:16:44.696Z,1604956604.696 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-11-09T21:16:44.699Z,1604956604.699 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-11-09T21:16:44.794Z,1604956604.794 [CBIT] Loaded 2020-11-09T21:16:44.795Z,1604956604.795 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-11-09T21:16:44.795Z,1604956604.795 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-11-09T21:16:44.796Z,1604956604.796 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-11-09T21:16:44.926Z,1604956604.926 [BuoyancyServo] Loaded 2020-11-09T21:16:44.926Z,1604956604.926 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-11-09T21:16:44.943Z,1604956604.943 [ElevatorServo] Loaded 2020-11-09T21:16:44.943Z,1604956604.943 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-11-09T21:16:44.959Z,1604956604.959 [MassServo] Loaded 2020-11-09T21:16:44.959Z,1604956604.959 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-11-09T21:16:44.974Z,1604956604.974 [RudderServo] Loaded 2020-11-09T21:16:44.975Z,1604956604.975 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-11-09T21:16:44.990Z,1604956604.990 [ThrusterServo] Loaded 2020-11-09T21:16:44.990Z,1604956604.990 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-11-09T21:16:44.990Z,1604956604.990 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-11-09T21:16:44.991Z,1604956604.991 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-11-09T21:16:45.020Z,1604956605.020 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-11-09T21:16:45.021Z,1604956605.021 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-11-09T21:16:45.307Z,1604956605.307 [BackSeatDriver] Loaded 2020-11-09T21:16:45.307Z,1604956605.307 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread. 2020-11-09T21:16:45.308Z,1604956605.308 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B064E0 2020-11-09T21:16:45.309Z,1604956605.309 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 923 2020-11-09T21:16:45.328Z,1604956605.328 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-11-09T21:16:45.331Z,1604956605.331 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-11-09T21:16:45.331Z,1604956605.331 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-11-09T21:16:45.334Z,1604956605.334 [CTD_Seabird](INFO): created writer for : depth 2020-11-09T21:16:45.334Z,1604956605.334 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-11-09T21:16:45.337Z,1604956605.337 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-11-09T21:16:45.337Z,1604956605.337 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-11-09T21:16:45.340Z,1604956605.340 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-11-09T21:16:45.341Z,1604956605.341 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-11-09T21:16:45.343Z,1604956605.343 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-11-09T21:16:45.344Z,1604956605.344 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-11-09T21:16:45.347Z,1604956605.347 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-11-09T21:16:45.348Z,1604956605.348 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-11-09T21:16:45.351Z,1604956605.351 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-11-09T21:16:45.364Z,1604956605.364 [CTD_Seabird] Loaded 2020-11-09T21:16:45.364Z,1604956605.364 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-11-09T21:16:45.365Z,1604956605.365 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B364E0 2020-11-09T21:16:45.365Z,1604956605.365 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 924 2020-11-09T21:16:45.383Z,1604956605.383 [PAR_Licor] Loaded 2020-11-09T21:16:45.383Z,1604956605.383 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-11-09T21:16:45.395Z,1604956605.395 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-11-09T21:16:45.396Z,1604956605.396 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-11-09T21:16:45.398Z,1604956605.398 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-11-09T21:16:45.398Z,1604956605.398 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-11-09T21:16:45.400Z,1604956605.400 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-11-09T21:16:45.400Z,1604956605.400 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-11-09T21:16:45.402Z,1604956605.402 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-11-09T21:16:45.402Z,1604956605.402 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-11-09T21:16:45.404Z,1604956605.404 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-11-09T21:16:45.404Z,1604956605.404 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-11-09T21:16:45.406Z,1604956605.406 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-11-09T21:16:45.406Z,1604956605.406 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-11-09T21:16:45.408Z,1604956605.408 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-11-09T21:16:45.408Z,1604956605.408 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-11-09T21:16:45.410Z,1604956605.410 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.412Z,1604956605.412 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.413Z,1604956605.413 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.413Z,1604956605.413 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.415Z,1604956605.415 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.415Z,1604956605.415 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.417Z,1604956605.417 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.417Z,1604956605.417 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-11-09T21:16:45.419Z,1604956605.419 [WetLabsBB2FL] Loaded 2020-11-09T21:16:45.419Z,1604956605.419 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-11-09T21:16:45.420Z,1604956605.420 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B664E0 2020-11-09T21:16:45.421Z,1604956605.421 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 925 2020-11-09T21:16:45.661Z,1604956605.661 [WetLabsUBAT..SerialDriver](INFO): Created logger 2020-11-09T21:16:45.661Z,1604956605.661 [WetLabsUBAT..SerialDriver](INFO): publishing on LCM channel WetLabsUBAT 2020-11-09T21:16:45.662Z,1604956605.662 [WetLabsUBAT..StreamSerialDriver](INFO): Created logger 2020-11-09T21:16:45.666Z,1604956605.666 [WetLabsUBAT](INFO): readConfig(): serialNo_: UBAT0051, uartName_: /dev/ttyC1, optionalArgs_: 2020-11-09T21:16:45.667Z,1604956605.667 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsUBAT.biolum_potential 2020-11-09T21:16:45.667Z,1604956605.667 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(): dataName: biolum_potential 2020-11-09T21:16:45.669Z,1604956605.669 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsUBAT.flow_rate 2020-11-09T21:16:45.669Z,1604956605.669 [WetLabsUBAT](DEBUG): LcmSlateWriter::add(): dataName: flow_rate 2020-11-09T21:16:45.672Z,1604956605.672 [WetLabsUBAT] Loaded 2020-11-09T21:16:45.672Z,1604956605.672 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2020-11-09T21:16:45.673Z,1604956605.673 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40B964E0 2020-11-09T21:16:45.673Z,1604956605.673 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 926 2020-11-09T21:16:45.674Z,1604956605.674 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-11-09T21:16:45.678Z,1604956605.678 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-11-09T21:16:45.679Z,1604956605.679 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-11-09T21:16:45.687Z,1604956605.687 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-11-09T21:16:45.688Z,1604956605.688 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BC64E0 2020-11-09T21:16:45.688Z,1604956605.688 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 927 2020-11-09T21:16:45.693Z,1604956605.693 [Supervisor](INFO): Main Thread ID is 828 2020-11-09T21:16:45.693Z,1604956605.693 [Supervisor](DEBUG): Running supervisor. 2020-11-09T21:16:45.694Z,1604956605.694 [CommandLine ThreadHandler](INFO): Handler Thread ID is 928 2020-11-09T21:16:45.697Z,1604956605.697 [controlThread ThreadHandler](INFO): Handler Thread ID is 929 2020-11-09T21:16:45.697Z,1604956605.697 [controlThread](DEBUG): Initializing ControlThread 2020-11-09T21:16:45.698Z,1604956605.698 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-11-09T21:16:45.700Z,1604956605.700 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-11-09T21:16:45.701Z,1604956605.701 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-11-09T21:16:45.701Z,1604956605.701 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-11-09T21:16:45.701Z,1604956605.701 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-11-09T21:16:45.702Z,1604956605.702 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-11-09T21:16:45.702Z,1604956605.702 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-11-09T21:16:45.702Z,1604956605.702 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-11-09T21:16:45.703Z,1604956605.703 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-11-09T21:16:45.703Z,1604956605.703 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-11-09T21:16:45.711Z,1604956605.711 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-11-09T21:16:45.711Z,1604956605.711 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-11-09T21:16:45.712Z,1604956605.712 [SBIT](INFO): Initialize SBIT Component. 2020-11-09T21:16:45.712Z,1604956605.712 [SBIT](IMPORTANT): git: 2020-11-09 2020-11-09T21:16:45.712Z,1604956605.712 [SBIT](INFO): git hash: f81f2d5d64572d3a213bb5cdbf8311bdbfca79ef 2020-11-09T21:16:45.713Z,1604956605.713 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-11-09T21:16:45.714Z,1604956605.714 [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-11-09T21:16:45.715Z,1604956605.715 [SBIT](INFO): Beginning SBIT in 56.000000 seconds. 2020-11-09T21:16:45.715Z,1604956605.715 [IBIT](INFO): Initialize IBIT Component. 2020-11-09T21:16:45.716Z,1604956605.716 [CBIT](DEBUG): Initialize CBIT Component. 2020-11-09T21:16:45.717Z,1604956605.717 [logger ThreadHandler](INFO): Handler Thread ID is 930 2020-11-09T21:16:45.728Z,1604956605.728 [CBIT](DEBUG): Initialized mux pins. 2020-11-09T21:16:45.728Z,1604956605.728 [CBIT](DEBUG): Initializing the watchdog timer. 2020-11-09T21:16:45.736Z,1604956605.736 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 931 2020-11-09T21:16:45.737Z,1604956605.737 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-11-09T21:16:45.748Z,1604956605.748 [Onboard ThreadHandler](INFO): Handler Thread ID is 932 2020-11-09T21:16:45.752Z,1604956605.752 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-11-09T21:16:45.753Z,1604956605.753 [CBIT](DEBUG): Initializing heartbeat. 2020-11-09T21:16:45.781Z,1604956605.781 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 933 2020-11-09T21:16:45.796Z,1604956605.796 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 934 2020-11-09T21:16:45.808Z,1604956605.808 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 935 2020-11-09T21:16:45.809Z,1604956605.809 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-11-09T21:16:45.813Z,1604956605.813 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 937 2020-11-09T21:16:45.814Z,1604956605.814 [WetLabsBB2FL](INFO): Powering down 2020-11-09T21:16:45.824Z,1604956605.824 [CBIT](DEBUG): Deactivating GF circuits. 2020-11-09T21:16:45.824Z,1604956605.824 [CBIT](DEBUG): Deactivating emergency mode. 2020-11-09T21:16:45.825Z,1604956605.825 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 938 2020-11-09T21:16:45.832Z,1604956605.832 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 939 2020-11-09T21:16:45.841Z,1604956605.841 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-11-09T21:16:45.841Z,1604956605.841 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-11-09T21:16:45.841Z,1604956605.841 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-11-09T21:16:45.841Z,1604956605.841 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-11-09T21:16:45.841Z,1604956605.841 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-11-09T21:16:45.842Z,1604956605.842 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-11-09T21:16:45.843Z,1604956605.843 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-11-09T21:16:45.843Z,1604956605.843 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-11-09T21:16:45.843Z,1604956605.843 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-11-09T21:16:45.843Z,1604956605.843 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-11-09T21:16:45.860Z,1604956605.860 [CBIT](DEBUG): Backplane powered. 2020-11-09T21:16:45.873Z,1604956605.873 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-11-09T21:16:45.929Z,1604956605.929 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-11-09T21:16:45.955Z,1604956605.955 [MissionManager](DEBUG): 2020-11-09T21:16:45.956Z,1604956605.956 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-11-09T21:16:46.038Z,1604956606.038 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-11-09T21:16:46.039Z,1604956606.039 [Default:A.Wait](DEBUG): Construct Wait. 2020-11-09T21:16:46.051Z,1604956606.051 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-11-09T21:16:46.098Z,1604956606.098 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-11-09T21:16:46.100Z,1604956606.100 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-11-09T21:16:46.122Z,1604956606.122 [Default:E.Execute](DEBUG): Construct Execute. 2020-11-09T21:16:46.125Z,1604956606.125 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2020-11-09T21:16:46.146Z,1604956606.146 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,RDI_Pathfinder,DAT,BPC1,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-11-09T21:16:46.164Z,1604956606.164 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-11-09T21:16:46.184Z,1604956606.184 [Radio_Surface](INFO): Powering up 2020-11-09T21:16:46.391Z,1604956606.391 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-11-09T21:16:46.391Z,1604956606.391 [DAT](INFO): Powering up 2020-11-09T21:16:46.391Z,1604956606.391 [DAT](DEBUG): Initializing DAT. 2020-11-09T21:16:46.421Z,1604956606.421 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-11-09T21:16:46.586Z,1604956606.586 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-11-09T21:16:46.592Z,1604956606.592 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-11-09T21:16:46.593Z,1604956606.593 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-11-09T21:16:46.600Z,1604956606.600 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-11-09T21:16:46.601Z,1604956606.601 [MassServo](DEBUG): Initializing EZServoServo. 2020-11-09T21:16:46.608Z,1604956606.608 [MassServo](DEBUG): Initializing MassServo. 2020-11-09T21:16:46.609Z,1604956606.609 [RudderServo](DEBUG): Initializing EZServoServo. 2020-11-09T21:16:46.616Z,1604956606.616 [RudderServo](DEBUG): Initializing RudderServo. 2020-11-09T21:16:46.617Z,1604956606.617 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-11-09T21:16:46.624Z,1604956606.624 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-11-09T21:16:46.729Z,1604956606.729 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-11-09T21:16:46.729Z,1604956606.729 [DropWeight] Hardware Fault, FailCount= 1 2020-11-09T21:16:46.729Z,1604956606.729 [DropWeight](ERROR): Hardware Fault 2020-11-09T21:16:46.814Z,1604956606.814 [CommandLine](FAULT): Scheduling is paused 2020-11-09T21:16:46.814Z,1604956606.814 [CBIT](INFO): Critical error at 20201109T211646 2020-11-09T21:16:46.814Z,1604956606.814 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-11-09T21:16:46.817Z,1604956606.817 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-11-09T21:16:46.817Z,1604956606.817 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-11-09T21:16:47.065Z,1604956607.065 [CBIT](INFO): Critical error at 20201109T211646 2020-11-09T21:17:00.431Z,1604956620.431 [DAT](INFO): commRate: 800 2020-11-09T21:17:02.841Z,1604956622.841 [DAT](INFO): entering command mode 2020-11-09T21:17:03.234Z,1604956623.234 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:03.648Z,1604956623.648 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:04.042Z,1604956624.042 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:04.456Z,1604956624.456 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:04.850Z,1604956624.850 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:05.264Z,1604956625.264 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:05.654Z,1604956625.654 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:06.104Z,1604956626.104 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:06.465Z,1604956626.465 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:06.870Z,1604956626.870 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:07.289Z,1604956627.289 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:07.678Z,1604956627.678 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:08.092Z,1604956628.092 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:08.482Z,1604956628.482 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:08.893Z,1604956628.893 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:09.323Z,1604956629.323 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:09.694Z,1604956629.694 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:10.102Z,1604956630.102 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:10.518Z,1604956630.518 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:10.906Z,1604956630.906 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:11.313Z,1604956631.313 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:11.747Z,1604956631.747 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:12.126Z,1604956632.126 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:12.540Z,1604956632.540 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:12.940Z,1604956632.940 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:13.329Z,1604956633.329 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:17:13.345Z,1604956633.345 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:13.741Z,1604956633.741 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:14.171Z,1604956634.171 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:14.542Z,1604956634.542 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:14.950Z,1604956634.950 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:15.365Z,1604956635.365 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:15.754Z,1604956635.754 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:16.173Z,1604956636.173 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:16.566Z,1604956636.566 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:16.966Z,1604956636.966 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:17.399Z,1604956637.399 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:17.774Z,1604956637.774 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:18.192Z,1604956638.192 [DAT](DEBUG): checking for command mode acknowledgment 2020-11-09T21:17:18.192Z,1604956638.192 [DAT](FAULT): failed to enter command mode 2020-11-09T21:17:18.607Z,1604956638.607 [DAT](INFO): entering command mode 2020-11-09T21:17:18.988Z,1604956638.988 [DAT](INFO): setting verbose to 3 2020-11-09T21:17:19.401Z,1604956639.401 [DAT](INFO): set verbose to 3 2020-11-09T21:17:19.402Z,1604956639.402 [DAT](INFO): setting DatVerbose to 27440 2020-11-09T21:17:19.811Z,1604956639.811 [DAT](INFO): set DatVerbose to 27440 2020-11-09T21:17:19.811Z,1604956639.811 [DAT](INFO): setting transmit power to 8 2020-11-09T21:17:20.199Z,1604956640.199 [DAT](INFO): set transmit power to 8 2020-11-09T21:17:20.199Z,1604956640.199 [DAT](INFO): setting local address to 9 2020-11-09T21:17:20.618Z,1604956640.618 [DAT](INFO): set local address to 9 2020-11-09T21:17:24.241Z,1604956644.241 [NAL9602](INFO): NAL9602 initialized 2020-11-09T21:17:42.465Z,1604956662.465 [SBIT](IMPORTANT): Beginning Startup BIT 2020-11-09T21:17:42.470Z,1604956662.470 [CBIT](IMPORTANT): Beginning ground fault scan 2020-11-09T21:17:53.435Z,1604956673.435 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.000167 CHAN A1 (24V): -0.002082 CHAN A2 (12V): -0.007126 CHAN A3 (5V): -0.002786 CHAN B0 (3.3V): 0.000784 CHAN B1 (3.15aV): -0.000678 CHAN B2 (3.15bV): 0.000446 CHAN B3 (GND): 0.001698 OPEN: -0.003737 Full Scale Calc: 4.765 mA, -1.589 mA 2020-11-09T21:18:17.245Z,1604956697.245 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:18:36.188Z,1604956716.188 [SBIT](IMPORTANT): SBIT PASSED 2020-11-09T21:18:36.188Z,1604956716.188 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-11-09T21:18:36.189Z,1604956716.189 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2020-11-09T21:18:36.189Z,1604956716.189 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere; 2020-11-09T21:18:36.189Z,1604956716.189 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): DAT.surfaceThreshold=100 meter; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): DAT.verbosity=0 count; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): PAR_Licor.parCal=1.01146 none; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool; 2020-11-09T21:18:36.190Z,1604956716.190 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=203.794028 cubic_centimeter; 2020-11-09T21:18:36.191Z,1604956716.191 [SBIT](IMPORTANT): VerticalControl.massDefault=9.170314 millimeter; 2020-11-09T21:18:36.191Z,1604956716.191 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool; 2020-11-09T21:18:36.584Z,1604956716.584 [MissionManager](IMPORTANT): Started mission Startup 2020-11-09T21:18:36.584Z,1604956716.584 [Startup] Running Loop=1 2020-11-09T21:18:36.584Z,1604956716.584 [Startup](DEBUG): Aggregate::initialize Startup 2020-11-09T21:18:36.584Z,1604956716.584 [Startup:A.GoToSurface] Running Loop=1 2020-11-09T21:18:36.585Z,1604956716.585 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-11-09T21:18:36.585Z,1604956716.585 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-11-09T21:18:36.586Z,1604956716.586 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-11-09T21:18:36.586Z,1604956716.586 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-11-09T21:18:36.586Z,1604956716.586 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-11-09T21:18:36.587Z,1604956716.587 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-11-09T21:18:36.588Z,1604956716.588 [Startup:StartupSatComms] Running Loop=1 2020-11-09T21:18:36.588Z,1604956716.588 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-11-09T21:18:36.588Z,1604956716.588 [Startup:StartupSatComms:A] Running Loop=1 2020-11-09T21:18:36.979Z,1604956716.979 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-11-09T21:19:14.763Z,1604956754.763 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005054 2020-11-09T21:19:36.797Z,1604956776.797 [Startup:StartupSatComms:A](INFO): Timed out from 2020-11-09T21:18:36.6Z 2020-11-09T21:19:36.797Z,1604956776.797 [Startup:StartupSatComms:A] Stopped 2020-11-09T21:19:36.797Z,1604956776.797 [Startup:StartupSatComms:B] Running Loop=1 2020-11-09T21:19:37.182Z,1604956777.182 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-11-09T21:19:44.343Z,1604956784.343 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20201109T210949/Courier0004.lzma 2020-11-09T21:19:45.335Z,1604956785.335 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:19:45.346Z,1604956785.346 [DataOverHttps](INFO): Moved sent file to Logs/20201109T210949/Courier0004.lzma.bak 2020-11-09T21:19:45.346Z,1604956785.346 [DataOverHttps](INFO): SBD MOMSN=13153918 2020-11-09T21:19:45.712Z,1604956785.712 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-11-09T21:19:45.712Z,1604956785.712 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:19:45.730Z,1604956785.730 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:19:46.146Z,1604956786.146 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:19:46.146Z,1604956786.146 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-11-09T21:20:00.307Z,1604956800.307 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20201109T211635/Courier0000.lzma 2020-11-09T21:20:01.310Z,1604956801.310 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0000.lzma.bak 2020-11-09T21:20:01.310Z,1604956801.310 [DataOverHttps](INFO): SBD MOMSN=13153920 2020-11-09T21:20:11.998Z,1604956811.998 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:20:17.231Z,1604956817.231 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20201109T210949/Express0005.lzma 2020-11-09T21:20:18.233Z,1604956818.233 [DataOverHttps](INFO): Moved sent file to Logs/20201109T210949/Express0005.lzma.bak 2020-11-09T21:20:18.234Z,1604956818.234 [DataOverHttps](INFO): SBD MOMSN=13153925 2020-11-09T21:20:34.117Z,1604956834.117 [DataOverHttps](INFO): Sending 1010 bytes from file Logs/20201109T211635/Express0001.lzma 2020-11-09T21:20:35.118Z,1604956835.118 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0001.lzma.bak 2020-11-09T21:20:35.118Z,1604956835.118 [DataOverHttps](INFO): SBD MOMSN=13153927 2020-11-09T21:20:36.192Z,1604956836.192 [Startup:StartupSatComms:B] Stopped 2020-11-09T21:20:36.193Z,1604956836.193 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-11-09T21:20:36.193Z,1604956836.193 [Startup:StartupSatComms] Stopped 2020-11-09T21:20:36.193Z,1604956836.193 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-11-09T21:20:36.193Z,1604956836.193 [Startup](INFO): Completed Startup 2020-11-09T21:20:36.194Z,1604956836.194 [MissionManager](INFO): Startup is completed. 2020-11-09T21:20:36.194Z,1604956836.194 [MissionManager](INFO): Uninitializing Mission Startup 2020-11-09T21:20:36.194Z,1604956836.194 [Startup] Stopped 2020-11-09T21:20:36.194Z,1604956836.194 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-11-09T21:20:36.194Z,1604956836.194 [Startup:A.GoToSurface] Stopped 2020-11-09T21:20:36.194Z,1604956836.194 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-11-09T21:20:36.578Z,1604956836.578 [MissionManager](IMPORTANT): Started mission Default 2020-11-09T21:20:36.578Z,1604956836.578 [Default] Running Loop=1 2020-11-09T21:20:36.578Z,1604956836.578 [Default](DEBUG): Aggregate::initialize Default 2020-11-09T21:20:36.578Z,1604956836.578 [Default:B.GoToSurface] Running Loop=1 2020-11-09T21:20:36.578Z,1604956836.578 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-11-09T21:20:36.579Z,1604956836.579 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-11-09T21:20:36.579Z,1604956836.579 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-11-09T21:20:36.579Z,1604956836.579 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-11-09T21:20:36.579Z,1604956836.579 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-11-09T21:20:36.580Z,1604956836.580 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-11-09T21:20:36.580Z,1604956836.580 [Default:A.Wait] Running Loop=1 2020-11-09T21:20:36.580Z,1604956836.580 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-11-09T21:20:49.904Z,1604956849.904 [Default:A.Wait](INFO): Done Waiting. 2020-11-09T21:20:49.904Z,1604956849.904 [Default:A.Wait] Stopped 2020-11-09T21:20:49.905Z,1604956849.905 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T21:20:50.321Z,1604956850.321 [Default:CheckIn] Running Loop=1 2020-11-09T21:20:50.321Z,1604956850.321 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T21:20:50.321Z,1604956850.321 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T21:20:50.715Z,1604956850.715 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2020-11-09T21:20:51.982Z,1604956851.982 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:22:00.295Z,1604956920.295 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:22:27.689Z,1604956947.689 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-11-09T21:22:46.689Z,1604956966.689 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-11-09T21:22:46.689Z,1604956966.689 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:22:46.699Z,1604956966.699 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:22:47.118Z,1604956967.118 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:22:47.118Z,1604956967.118 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-11-09T21:22:54.446Z,1604956974.446 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:23:35.246Z,1604957015.246 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T21:24:16.393Z,1604957056.393 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-11-09T21:24:16.396Z,1604957056.396 [BPC1](INFO): Received data from all battery sticks. 2020-11-09T21:25:47.684Z,1604957147.684 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2020-11-09T21:25:47.684Z,1604957147.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:25:47.694Z,1604957147.694 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:25:48.110Z,1604957148.110 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:25:48.110Z,1604957148.110 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2020-11-09T21:25:50.510Z,1604957150.510 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T21:20:50.3Z 2020-11-09T21:25:50.510Z,1604957150.510 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T21:25:50.510Z,1604957150.510 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T21:25:50.918Z,1604957150.918 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-11-09T21:25:57.443Z,1604957157.443 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20201109T211635/Courier0004.lzma 2020-11-09T21:25:58.446Z,1604957158.446 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0004.lzma.bak 2020-11-09T21:25:58.446Z,1604957158.446 [DataOverHttps](INFO): SBD MOMSN=13153956 2020-11-09T21:26:14.408Z,1604957174.408 [DataOverHttps](INFO): Sending 294 bytes from file Logs/20201109T211635/Express0005.lzma 2020-11-09T21:26:15.410Z,1604957175.410 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0005.lzma.bak 2020-11-09T21:26:15.410Z,1604957175.410 [DataOverHttps](INFO): SBD MOMSN=13153960 2020-11-09T21:26:16.791Z,1604957176.791 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T21:26:16.791Z,1604957176.791 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T21:26:16.791Z,1604957176.791 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T21:27:27.057Z,1604957247.057 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-11-09T21:27:27.058Z,1604957247.058 [NAL9602] Data Fault, FailCount= 1 2020-11-09T21:27:27.058Z,1604957247.058 [NAL9602](ERROR): Data Fault 2020-11-09T21:27:27.075Z,1604957247.075 [CBIT](ERROR): Data Fault in component: NAL9602 2020-11-09T21:27:27.457Z,1604957247.457 [NAL9602](INFO): Powering down 2020-11-09T21:27:28.299Z,1604957248.299 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:27:28.299Z,1604957248.299 [NAL9602] No Fault, FailCount= 1 2020-11-09T21:27:57.757Z,1604957277.757 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:28:18.367Z,1604957298.367 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:28:18.367Z,1604957298.367 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T21:28:18.367Z,1604957298.367 [NAL9602](ERROR): Communications Fault 2020-11-09T21:28:18.395Z,1604957298.395 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:28:18.761Z,1604957298.761 [NAL9602](INFO): Powering down 2020-11-09T21:28:19.591Z,1604957299.591 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:28:19.591Z,1604957299.591 [NAL9602] No Fault, FailCount= 2 2020-11-09T21:28:48.685Z,1604957328.685 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2020-11-09T21:28:48.685Z,1604957328.685 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:28:48.695Z,1604957328.695 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:28:49.061Z,1604957329.061 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:28:49.097Z,1604957329.097 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:28:49.098Z,1604957329.098 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2020-11-09T21:29:09.674Z,1604957349.674 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:29:09.674Z,1604957349.674 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T21:29:09.674Z,1604957349.674 [NAL9602](ERROR): Communications Fault 2020-11-09T21:29:09.713Z,1604957349.713 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:29:10.077Z,1604957350.077 [NAL9602](INFO): Powering down 2020-11-09T21:29:10.899Z,1604957350.899 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:29:10.900Z,1604957350.900 [NAL9602] No Fault, FailCount= 3 2020-11-09T21:29:40.379Z,1604957380.379 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:29:57.054Z,1604957397.054 [CommandLine](IMPORTANT): got command failComponent 2020-11-09T21:29:57.055Z,1604957397.055 [CommandLine](IMPORTANT): Failed components: 2020-11-09T21:29:57.056Z,1604957397.056 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2020-11-09T21:30:00.977Z,1604957400.977 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:30:00.977Z,1604957400.977 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T21:30:00.978Z,1604957400.978 [NAL9602](ERROR): Communications Fault 2020-11-09T21:30:00.999Z,1604957400.999 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:30:01.386Z,1604957401.386 [NAL9602](INFO): Powering down 2020-11-09T21:30:02.240Z,1604957402.240 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:30:02.240Z,1604957402.240 [NAL9602] No Fault, FailCount= 4 2020-11-09T21:30:31.682Z,1604957431.682 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:30:52.285Z,1604957452.285 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:30:52.286Z,1604957452.286 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T21:30:52.286Z,1604957452.286 [NAL9602](ERROR): Communications Fault 2020-11-09T21:30:52.314Z,1604957452.314 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:30:52.314Z,1604957452.314 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T21:30:52.694Z,1604957452.694 [NAL9602](INFO): Powering down 2020-11-09T21:30:52.717Z,1604957452.717 [CBIT](INFO): Critical error at 20201109T213052 2020-11-09T21:31:17.375Z,1604957477.375 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T21:31:17.375Z,1604957477.375 [Default:CheckIn:C.Wait] Stopped 2020-11-09T21:31:17.375Z,1604957477.375 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T21:31:17.375Z,1604957477.375 [Default:CheckIn:D] Running Loop=1 2020-11-09T21:31:17.756Z,1604957477.756 [Default:CheckIn:D] Stopped 2020-11-09T21:31:17.756Z,1604957477.756 [Default:CheckIn:E] Running Loop=1 2020-11-09T21:31:18.184Z,1604957478.184 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.686145 min 2020-11-09T21:31:18.184Z,1604957478.184 [Default:CheckIn:E] Stopped 2020-11-09T21:31:18.184Z,1604957478.184 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T21:31:18.184Z,1604957478.184 [Default:CheckIn] Stopped 2020-11-09T21:31:18.185Z,1604957478.185 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T21:31:18.185Z,1604957478.185 [Default:CheckIn](INFO): Running loop #2 2020-11-09T21:31:18.185Z,1604957478.185 [Default:CheckIn] Running Loop=2 2020-11-09T21:31:18.185Z,1604957478.185 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T21:31:18.185Z,1604957478.185 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T21:31:46.863Z,1604957506.863 [CBIT](INFO): Clearing failed state for component DropWeight 2020-11-09T21:31:46.863Z,1604957506.863 [DropWeight] No Fault, FailCount= 1 2020-11-09T21:31:49.691Z,1604957509.691 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2020-11-09T21:31:49.691Z,1604957509.691 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:31:49.701Z,1604957509.701 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:31:50.104Z,1604957510.104 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:31:50.104Z,1604957510.104 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2020-11-09T21:32:52.322Z,1604957572.322 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:32:52.322Z,1604957572.322 [NAL9602] No Fault, FailCount= 5 2020-11-09T21:32:52.673Z,1604957572.673 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:33:13.278Z,1604957593.278 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:33:13.278Z,1604957593.278 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T21:33:13.278Z,1604957593.278 [NAL9602](ERROR): Communications Fault 2020-11-09T21:33:13.305Z,1604957593.305 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:33:13.685Z,1604957593.685 [NAL9602](INFO): Powering down 2020-11-09T21:33:14.525Z,1604957594.525 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:33:14.525Z,1604957594.525 [NAL9602] No Fault, FailCount= 1 2020-11-09T21:33:43.989Z,1604957623.989 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:34:04.594Z,1604957644.594 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:34:04.594Z,1604957644.594 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T21:34:04.594Z,1604957644.594 [NAL9602](ERROR): Communications Fault 2020-11-09T21:34:04.629Z,1604957644.629 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:34:04.989Z,1604957644.989 [NAL9602](INFO): Powering down 2020-11-09T21:34:05.822Z,1604957645.822 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:34:05.822Z,1604957645.822 [NAL9602] No Fault, FailCount= 2 2020-11-09T21:34:35.299Z,1604957675.299 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:34:50.666Z,1604957690.666 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2020-11-09T21:34:50.666Z,1604957690.666 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:34:50.676Z,1604957690.676 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:34:51.086Z,1604957691.086 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:34:51.086Z,1604957691.086 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2020-11-09T21:34:55.901Z,1604957695.901 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:34:55.901Z,1604957695.901 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T21:34:55.902Z,1604957695.902 [NAL9602](ERROR): Communications Fault 2020-11-09T21:34:55.935Z,1604957695.935 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:34:56.305Z,1604957696.305 [NAL9602](INFO): Powering down 2020-11-09T21:34:57.144Z,1604957697.144 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:34:57.144Z,1604957697.144 [NAL9602] No Fault, FailCount= 3 2020-11-09T21:35:26.597Z,1604957726.597 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:35:47.207Z,1604957747.207 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:35:47.207Z,1604957747.207 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T21:35:47.207Z,1604957747.207 [NAL9602](ERROR): Communications Fault 2020-11-09T21:35:47.239Z,1604957747.239 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:35:47.625Z,1604957747.625 [NAL9602](INFO): Powering down 2020-11-09T21:35:48.471Z,1604957748.471 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:35:48.471Z,1604957748.471 [NAL9602] No Fault, FailCount= 4 2020-11-09T21:36:17.909Z,1604957777.909 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:36:18.339Z,1604957778.339 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T21:31:18.2Z 2020-11-09T21:36:18.339Z,1604957778.339 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T21:36:18.339Z,1604957778.339 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T21:36:25.339Z,1604957785.339 [DataOverHttps](INFO): Sending 90 bytes from file Logs/20201109T211635/Courier0007.lzma 2020-11-09T21:36:26.342Z,1604957786.342 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0007.lzma.bak 2020-11-09T21:36:26.342Z,1604957786.342 [DataOverHttps](INFO): SBD MOMSN=13154076 2020-11-09T21:36:38.513Z,1604957798.513 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:36:38.513Z,1604957798.513 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T21:36:38.513Z,1604957798.513 [NAL9602](ERROR): Communications Fault 2020-11-09T21:36:38.574Z,1604957798.574 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:36:38.574Z,1604957798.574 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T21:36:38.918Z,1604957798.918 [NAL9602](INFO): Powering down 2020-11-09T21:36:38.953Z,1604957798.953 [CBIT](INFO): Critical error at 20201109T213638 2020-11-09T21:36:42.039Z,1604957802.039 [DataOverHttps](INFO): Sending 254 bytes from file Logs/20201109T211635/Express0008.lzma 2020-11-09T21:36:43.044Z,1604957803.044 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0008.lzma.bak 2020-11-09T21:36:43.045Z,1604957803.045 [DataOverHttps](INFO): SBD MOMSN=13154079 2020-11-09T21:36:44.200Z,1604957804.200 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T21:36:44.200Z,1604957804.200 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T21:36:44.200Z,1604957804.200 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T21:37:51.649Z,1604957871.649 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2020-11-09T21:37:51.649Z,1604957871.649 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:37:51.660Z,1604957871.660 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:37:52.073Z,1604957872.073 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:37:52.073Z,1604957872.073 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2020-11-09T21:38:38.525Z,1604957918.525 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:38:38.525Z,1604957918.525 [NAL9602] No Fault, FailCount= 5 2020-11-09T21:38:38.901Z,1604957918.901 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:38:59.519Z,1604957939.519 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:38:59.519Z,1604957939.519 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T21:38:59.519Z,1604957939.519 [NAL9602](ERROR): Communications Fault 2020-11-09T21:38:59.536Z,1604957939.536 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:38:59.917Z,1604957939.917 [NAL9602](INFO): Powering down 2020-11-09T21:39:00.742Z,1604957940.742 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:39:00.742Z,1604957940.742 [NAL9602] No Fault, FailCount= 1 2020-11-09T21:39:30.233Z,1604957970.233 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:39:50.821Z,1604957990.821 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:39:50.822Z,1604957990.822 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T21:39:50.822Z,1604957990.822 [NAL9602](ERROR): Communications Fault 2020-11-09T21:39:50.862Z,1604957990.862 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:39:51.229Z,1604957991.229 [NAL9602](INFO): Powering down 2020-11-09T21:39:52.086Z,1604957992.086 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:39:52.086Z,1604957992.086 [NAL9602] No Fault, FailCount= 2 2020-11-09T21:40:21.529Z,1604958021.529 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:40:42.134Z,1604958042.134 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:40:42.134Z,1604958042.134 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T21:40:42.134Z,1604958042.134 [NAL9602](ERROR): Communications Fault 2020-11-09T21:40:42.151Z,1604958042.151 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:40:42.539Z,1604958042.539 [NAL9602](INFO): Powering down 2020-11-09T21:40:43.362Z,1604958043.362 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:40:43.362Z,1604958043.362 [NAL9602] No Fault, FailCount= 3 2020-11-09T21:40:52.653Z,1604958052.653 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2020-11-09T21:40:52.653Z,1604958052.653 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:40:52.663Z,1604958052.663 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:40:53.066Z,1604958053.066 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:40:53.066Z,1604958053.066 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2020-11-09T21:41:12.834Z,1604958072.834 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:41:33.438Z,1604958093.438 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:41:33.438Z,1604958093.438 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T21:41:33.438Z,1604958093.438 [NAL9602](ERROR): Communications Fault 2020-11-09T21:41:33.483Z,1604958093.483 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:41:33.837Z,1604958093.837 [NAL9602](INFO): Powering down 2020-11-09T21:41:34.671Z,1604958094.671 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:41:34.671Z,1604958094.671 [NAL9602] No Fault, FailCount= 4 2020-11-09T21:41:44.763Z,1604958104.763 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T21:41:44.763Z,1604958104.763 [Default:CheckIn:C.Wait] Stopped 2020-11-09T21:41:44.763Z,1604958104.763 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T21:41:44.763Z,1604958104.763 [Default:CheckIn:D] Running Loop=1 2020-11-09T21:41:45.178Z,1604958105.178 [Default:CheckIn:D] Stopped 2020-11-09T21:41:45.178Z,1604958105.178 [Default:CheckIn:E] Running Loop=1 2020-11-09T21:41:45.576Z,1604958105.576 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.143331 min 2020-11-09T21:41:45.576Z,1604958105.576 [Default:CheckIn:E] Stopped 2020-11-09T21:41:45.576Z,1604958105.576 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T21:41:45.576Z,1604958105.576 [Default:CheckIn] Stopped 2020-11-09T21:41:45.577Z,1604958105.577 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T21:41:45.577Z,1604958105.577 [Default:CheckIn](INFO): Running loop #3 2020-11-09T21:41:45.577Z,1604958105.577 [Default:CheckIn] Running Loop=3 2020-11-09T21:41:45.577Z,1604958105.577 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T21:41:45.577Z,1604958105.577 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T21:42:04.145Z,1604958124.145 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:42:24.745Z,1604958144.745 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:42:24.746Z,1604958144.746 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T21:42:24.746Z,1604958144.746 [NAL9602](ERROR): Communications Fault 2020-11-09T21:42:24.763Z,1604958144.763 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:42:24.763Z,1604958144.763 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T21:42:25.149Z,1604958145.149 [NAL9602](INFO): Powering down 2020-11-09T21:42:25.176Z,1604958145.176 [CBIT](INFO): Critical error at 20201109T214224 2020-11-09T21:43:53.673Z,1604958233.673 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2020-11-09T21:43:53.673Z,1604958233.673 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:43:53.711Z,1604958233.711 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:43:54.086Z,1604958234.086 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:43:54.086Z,1604958234.086 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2020-11-09T21:44:24.751Z,1604958264.751 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:44:24.751Z,1604958264.751 [NAL9602] No Fault, FailCount= 5 2020-11-09T21:44:25.144Z,1604958265.144 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:44:45.745Z,1604958285.745 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:44:45.745Z,1604958285.745 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T21:44:45.746Z,1604958285.746 [NAL9602](ERROR): Communications Fault 2020-11-09T21:44:45.763Z,1604958285.763 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:44:46.153Z,1604958286.153 [NAL9602](INFO): Powering down 2020-11-09T21:44:46.994Z,1604958286.994 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:44:46.995Z,1604958286.995 [NAL9602] No Fault, FailCount= 1 2020-11-09T21:45:16.445Z,1604958316.445 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:45:37.066Z,1604958337.066 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:45:37.066Z,1604958337.066 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T21:45:37.066Z,1604958337.066 [NAL9602](ERROR): Communications Fault 2020-11-09T21:45:37.112Z,1604958337.112 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:45:37.465Z,1604958337.465 [NAL9602](INFO): Powering down 2020-11-09T21:45:38.337Z,1604958338.337 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:45:38.337Z,1604958338.337 [NAL9602] No Fault, FailCount= 2 2020-11-09T21:46:07.753Z,1604958367.753 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:46:28.358Z,1604958388.358 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:46:28.358Z,1604958388.358 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T21:46:28.358Z,1604958388.358 [NAL9602](ERROR): Communications Fault 2020-11-09T21:46:28.421Z,1604958388.421 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:46:28.761Z,1604958388.761 [NAL9602](INFO): Powering down 2020-11-09T21:46:29.593Z,1604958389.593 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:46:29.593Z,1604958389.593 [NAL9602] No Fault, FailCount= 3 2020-11-09T21:46:45.745Z,1604958405.745 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T21:41:45.6Z 2020-11-09T21:46:45.745Z,1604958405.745 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T21:46:45.745Z,1604958405.745 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T21:46:53.295Z,1604958413.295 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20201109T211635/Courier0010.lzma 2020-11-09T21:46:54.298Z,1604958414.298 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0010.lzma.bak 2020-11-09T21:46:54.298Z,1604958414.298 [DataOverHttps](INFO): SBD MOMSN=13154187 2020-11-09T21:46:54.641Z,1604958414.641 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2020-11-09T21:46:54.641Z,1604958414.641 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:46:54.651Z,1604958414.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:46:55.060Z,1604958415.060 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:46:55.061Z,1604958415.061 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2020-11-09T21:46:59.065Z,1604958419.065 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:47:09.951Z,1604958429.951 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20201109T211635/Express0011.lzma 2020-11-09T21:47:10.954Z,1604958430.954 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0011.lzma.bak 2020-11-09T21:47:10.954Z,1604958430.954 [DataOverHttps](INFO): SBD MOMSN=13154191 2020-11-09T21:47:12.014Z,1604958432.014 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T21:47:12.014Z,1604958432.014 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T21:47:12.014Z,1604958432.014 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T21:47:19.669Z,1604958439.669 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:47:19.669Z,1604958439.669 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T21:47:19.669Z,1604958439.669 [NAL9602](ERROR): Communications Fault 2020-11-09T21:47:19.725Z,1604958439.725 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:47:20.069Z,1604958440.069 [NAL9602](INFO): Powering down 2020-11-09T21:47:20.929Z,1604958440.929 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:47:20.929Z,1604958440.929 [NAL9602] No Fault, FailCount= 4 2020-11-09T21:47:50.365Z,1604958470.365 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:48:10.970Z,1604958490.970 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:48:10.970Z,1604958490.970 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T21:48:10.970Z,1604958490.970 [NAL9602](ERROR): Communications Fault 2020-11-09T21:48:11.013Z,1604958491.013 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:48:11.013Z,1604958491.013 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T21:48:11.373Z,1604958491.373 [NAL9602](INFO): Powering down 2020-11-09T21:48:11.419Z,1604958491.419 [CBIT](INFO): Critical error at 20201109T214811 2020-11-09T21:49:55.621Z,1604958595.621 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2020-11-09T21:49:55.621Z,1604958595.621 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:49:55.631Z,1604958595.631 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:49:56.083Z,1604958596.083 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:49:56.083Z,1604958596.083 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2020-11-09T21:50:10.990Z,1604958610.990 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:50:10.990Z,1604958610.990 [NAL9602] No Fault, FailCount= 5 2020-11-09T21:50:11.361Z,1604958611.361 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:50:31.975Z,1604958631.975 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:50:31.975Z,1604958631.975 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T21:50:31.975Z,1604958631.975 [NAL9602](ERROR): Communications Fault 2020-11-09T21:50:31.999Z,1604958631.999 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:50:32.377Z,1604958632.377 [NAL9602](INFO): Powering down 2020-11-09T21:50:33.208Z,1604958633.208 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:50:33.208Z,1604958633.208 [NAL9602] No Fault, FailCount= 1 2020-11-09T21:51:02.673Z,1604958662.673 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:51:23.277Z,1604958683.277 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:51:23.277Z,1604958683.277 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T21:51:23.277Z,1604958683.277 [NAL9602](ERROR): Communications Fault 2020-11-09T21:51:23.362Z,1604958683.362 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:51:23.681Z,1604958683.681 [NAL9602](INFO): Powering down 2020-11-09T21:51:24.535Z,1604958684.535 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:51:24.535Z,1604958684.535 [NAL9602] No Fault, FailCount= 2 2020-11-09T21:51:53.985Z,1604958713.985 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:52:12.598Z,1604958732.598 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T21:52:12.598Z,1604958732.598 [Default:CheckIn:C.Wait] Stopped 2020-11-09T21:52:12.598Z,1604958732.598 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T21:52:12.598Z,1604958732.598 [Default:CheckIn:D] Running Loop=1 2020-11-09T21:52:12.982Z,1604958732.982 [Default:CheckIn:D] Stopped 2020-11-09T21:52:12.982Z,1604958732.982 [Default:CheckIn:E] Running Loop=1 2020-11-09T21:52:13.395Z,1604958733.395 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.606730 min 2020-11-09T21:52:13.395Z,1604958733.395 [Default:CheckIn:E] Stopped 2020-11-09T21:52:13.395Z,1604958733.395 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T21:52:13.395Z,1604958733.395 [Default:CheckIn] Stopped 2020-11-09T21:52:13.396Z,1604958733.396 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T21:52:13.396Z,1604958733.396 [Default:CheckIn](INFO): Running loop #4 2020-11-09T21:52:13.396Z,1604958733.396 [Default:CheckIn] Running Loop=4 2020-11-09T21:52:13.396Z,1604958733.396 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T21:52:13.396Z,1604958733.396 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T21:52:14.585Z,1604958734.585 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:52:14.586Z,1604958734.586 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T21:52:14.586Z,1604958734.586 [NAL9602](ERROR): Communications Fault 2020-11-09T21:52:14.607Z,1604958734.607 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:52:14.993Z,1604958734.993 [NAL9602](INFO): Powering down 2020-11-09T21:52:15.818Z,1604958735.818 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:52:15.819Z,1604958735.819 [NAL9602] No Fault, FailCount= 3 2020-11-09T21:52:45.289Z,1604958765.289 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:52:56.617Z,1604958776.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2020-11-09T21:52:56.617Z,1604958776.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:52:56.627Z,1604958776.627 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:52:57.070Z,1604958777.070 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:52:57.070Z,1604958777.070 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2020-11-09T21:53:05.889Z,1604958785.889 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:53:05.890Z,1604958785.890 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T21:53:05.890Z,1604958785.890 [NAL9602](ERROR): Communications Fault 2020-11-09T21:53:05.911Z,1604958785.911 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:53:06.303Z,1604958786.303 [NAL9602](INFO): Powering down 2020-11-09T21:53:07.156Z,1604958787.156 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:53:07.156Z,1604958787.156 [NAL9602] No Fault, FailCount= 4 2020-11-09T21:53:36.601Z,1604958816.601 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:53:57.206Z,1604958837.206 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:53:57.206Z,1604958837.206 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T21:53:57.206Z,1604958837.206 [NAL9602](ERROR): Communications Fault 2020-11-09T21:53:57.276Z,1604958837.276 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:53:57.277Z,1604958837.277 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T21:53:57.601Z,1604958837.601 [NAL9602](INFO): Powering down 2020-11-09T21:53:57.625Z,1604958837.625 [CBIT](INFO): Critical error at 20201109T215357 2020-11-09T21:55:57.216Z,1604958957.216 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:55:57.216Z,1604958957.216 [NAL9602] No Fault, FailCount= 5 2020-11-09T21:55:57.597Z,1604958957.597 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:55:57.617Z,1604958957.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2020-11-09T21:55:57.617Z,1604958957.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:55:57.631Z,1604958957.631 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:55:58.039Z,1604958958.039 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:55:58.039Z,1604958958.039 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2020-11-09T21:56:18.198Z,1604958978.198 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:56:18.198Z,1604958978.198 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T21:56:18.198Z,1604958978.198 [NAL9602](ERROR): Communications Fault 2020-11-09T21:56:18.261Z,1604958978.261 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:56:18.597Z,1604958978.597 [NAL9602](INFO): Powering down 2020-11-09T21:56:19.435Z,1604958979.435 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:56:19.435Z,1604958979.435 [NAL9602] No Fault, FailCount= 1 2020-11-09T21:56:48.901Z,1604959008.901 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:57:09.501Z,1604959029.501 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:57:09.501Z,1604959029.501 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T21:57:09.502Z,1604959029.502 [NAL9602](ERROR): Communications Fault 2020-11-09T21:57:09.543Z,1604959029.543 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:57:09.909Z,1604959029.909 [NAL9602](INFO): Powering down 2020-11-09T21:57:10.741Z,1604959030.741 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:57:10.741Z,1604959030.741 [NAL9602] No Fault, FailCount= 2 2020-11-09T21:57:13.591Z,1604959033.591 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T21:52:13.4Z 2020-11-09T21:57:13.591Z,1604959033.591 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T21:57:13.591Z,1604959033.591 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T21:57:21.159Z,1604959041.159 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20201109T211635/Courier0013.lzma 2020-11-09T21:57:22.162Z,1604959042.162 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0013.lzma.bak 2020-11-09T21:57:22.162Z,1604959042.162 [DataOverHttps](INFO): SBD MOMSN=13154306 2020-11-09T21:57:37.887Z,1604959057.887 [DataOverHttps](INFO): Sending 109 bytes from file Logs/20201109T211635/Express0014.lzma 2020-11-09T21:57:38.890Z,1604959058.890 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0014.lzma.bak 2020-11-09T21:57:38.891Z,1604959058.891 [DataOverHttps](INFO): SBD MOMSN=13154310 2020-11-09T21:57:40.213Z,1604959060.213 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:57:40.233Z,1604959060.233 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T21:57:40.233Z,1604959060.233 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T21:57:40.233Z,1604959060.233 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T21:58:00.817Z,1604959080.817 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:58:00.817Z,1604959080.817 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T21:58:00.817Z,1604959080.817 [NAL9602](ERROR): Communications Fault 2020-11-09T21:58:00.864Z,1604959080.864 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:58:01.227Z,1604959081.227 [NAL9602](INFO): Powering down 2020-11-09T21:58:02.048Z,1604959082.048 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:58:02.048Z,1604959082.048 [NAL9602] No Fault, FailCount= 3 2020-11-09T21:58:31.513Z,1604959111.513 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:58:52.125Z,1604959132.125 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:58:52.126Z,1604959132.126 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T21:58:52.126Z,1604959132.126 [NAL9602](ERROR): Communications Fault 2020-11-09T21:58:52.172Z,1604959132.172 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:58:52.521Z,1604959132.521 [NAL9602](INFO): Powering down 2020-11-09T21:58:53.410Z,1604959133.410 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T21:58:53.410Z,1604959133.410 [NAL9602] No Fault, FailCount= 4 2020-11-09T21:58:58.593Z,1604959138.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2020-11-09T21:58:58.593Z,1604959138.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T21:58:58.603Z,1604959138.603 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T21:58:59.014Z,1604959139.014 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T21:58:59.014Z,1604959139.014 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2020-11-09T21:59:22.825Z,1604959162.825 [NAL9602](INFO): Powering up NAL9602 2020-11-09T21:59:43.429Z,1604959183.429 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T21:59:43.430Z,1604959183.430 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T21:59:43.430Z,1604959183.430 [NAL9602](ERROR): Communications Fault 2020-11-09T21:59:43.477Z,1604959183.477 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T21:59:43.478Z,1604959183.478 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T21:59:43.833Z,1604959183.833 [NAL9602](INFO): Powering down 2020-11-09T21:59:43.857Z,1604959183.857 [CBIT](INFO): Critical error at 20201109T215943 2020-11-09T22:01:03.075Z,1604959263.075 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-11-09T22:01:43.442Z,1604959303.442 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:01:43.442Z,1604959303.442 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:01:43.831Z,1604959303.831 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:01:48.265Z,1604959308.265 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-11-09T22:01:48.265Z,1604959308.265 [DropWeight] Hardware Fault, FailCount= 1 2020-11-09T22:01:48.265Z,1604959308.265 [DropWeight](ERROR): Hardware Fault 2020-11-09T22:01:48.299Z,1604959308.299 [CBIT](INFO): Critical error at 20201109T220148 2020-11-09T22:01:48.301Z,1604959308.301 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-11-09T22:01:48.302Z,1604959308.302 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-11-09T22:01:48.701Z,1604959308.701 [CBIT](INFO): Critical error at 20201109T220148 2020-11-09T22:01:59.631Z,1604959319.631 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2020-11-09T22:01:59.631Z,1604959319.631 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:01:59.641Z,1604959319.641 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:02:00.022Z,1604959320.022 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:02:00.023Z,1604959320.023 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2020-11-09T22:02:04.445Z,1604959324.445 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:02:04.445Z,1604959324.445 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:02:04.445Z,1604959324.445 [NAL9602](ERROR): Communications Fault 2020-11-09T22:02:04.495Z,1604959324.495 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:02:04.849Z,1604959324.849 [NAL9602](INFO): Powering down 2020-11-09T22:02:05.683Z,1604959325.683 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:02:05.683Z,1604959325.683 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:02:35.154Z,1604959355.154 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:02:40.813Z,1604959360.813 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T22:02:40.813Z,1604959360.813 [Default:CheckIn:C.Wait] Stopped 2020-11-09T22:02:40.813Z,1604959360.813 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T22:02:40.813Z,1604959360.813 [Default:CheckIn:D] Running Loop=1 2020-11-09T22:02:41.228Z,1604959361.228 [Default:CheckIn:D] Stopped 2020-11-09T22:02:41.228Z,1604959361.228 [Default:CheckIn:E] Running Loop=1 2020-11-09T22:02:41.634Z,1604959361.634 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.077490 min 2020-11-09T22:02:41.634Z,1604959361.634 [Default:CheckIn:E] Stopped 2020-11-09T22:02:41.634Z,1604959361.634 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T22:02:41.635Z,1604959361.635 [Default:CheckIn] Stopped 2020-11-09T22:02:41.635Z,1604959361.635 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T22:02:41.635Z,1604959361.635 [Default:CheckIn](INFO): Running loop #5 2020-11-09T22:02:41.635Z,1604959361.635 [Default:CheckIn] Running Loop=5 2020-11-09T22:02:41.635Z,1604959361.635 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T22:02:41.635Z,1604959361.635 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T22:02:55.759Z,1604959375.759 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:02:55.759Z,1604959375.759 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:02:55.759Z,1604959375.759 [NAL9602](ERROR): Communications Fault 2020-11-09T22:02:55.787Z,1604959375.787 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:02:56.157Z,1604959376.157 [NAL9602](INFO): Powering down 2020-11-09T22:02:56.983Z,1604959376.983 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:02:56.983Z,1604959376.983 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:03:26.453Z,1604959406.453 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:03:47.057Z,1604959427.057 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:03:47.057Z,1604959427.057 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:03:47.057Z,1604959427.057 [NAL9602](ERROR): Communications Fault 2020-11-09T22:03:47.079Z,1604959427.079 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:03:47.465Z,1604959427.465 [NAL9602](INFO): Powering down 2020-11-09T22:03:48.306Z,1604959428.306 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:03:48.306Z,1604959428.306 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:04:17.765Z,1604959457.765 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:04:38.365Z,1604959478.365 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:04:38.365Z,1604959478.365 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:04:38.365Z,1604959478.365 [NAL9602](ERROR): Communications Fault 2020-11-09T22:04:38.414Z,1604959478.414 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:04:38.773Z,1604959478.773 [NAL9602](INFO): Powering down 2020-11-09T22:04:39.601Z,1604959479.601 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:04:39.601Z,1604959479.601 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:05:00.626Z,1604959500.626 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2020-11-09T22:05:00.626Z,1604959500.626 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:05:00.649Z,1604959500.649 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:05:01.010Z,1604959501.010 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:05:01.010Z,1604959501.010 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2020-11-09T22:05:09.073Z,1604959509.073 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:05:29.673Z,1604959529.673 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:05:29.673Z,1604959529.673 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:05:29.673Z,1604959529.673 [NAL9602](ERROR): Communications Fault 2020-11-09T22:05:29.695Z,1604959529.695 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:05:29.695Z,1604959529.695 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:05:30.093Z,1604959530.093 [NAL9602](INFO): Powering down 2020-11-09T22:05:30.119Z,1604959530.119 [CBIT](INFO): Critical error at 20201109T220529 2020-11-09T22:07:29.687Z,1604959649.687 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:07:29.687Z,1604959649.687 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:07:30.081Z,1604959650.081 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:07:41.810Z,1604959661.810 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T22:02:41.6Z 2020-11-09T22:07:41.810Z,1604959661.810 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T22:07:41.810Z,1604959661.810 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T22:07:48.683Z,1604959668.683 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201109T211635/Courier0016.lzma 2020-11-09T22:07:49.686Z,1604959669.686 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0016.lzma.bak 2020-11-09T22:07:49.686Z,1604959669.686 [DataOverHttps](INFO): SBD MOMSN=13154412 2020-11-09T22:07:50.681Z,1604959670.681 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:07:50.681Z,1604959670.681 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:07:50.681Z,1604959670.681 [NAL9602](ERROR): Communications Fault 2020-11-09T22:07:50.718Z,1604959670.718 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:07:51.089Z,1604959671.089 [NAL9602](INFO): Powering down 2020-11-09T22:07:51.928Z,1604959671.928 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:07:51.928Z,1604959671.928 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:08:01.667Z,1604959681.667 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2020-11-09T22:08:01.667Z,1604959681.667 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:08:01.689Z,1604959681.689 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:08:02.035Z,1604959682.035 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:08:02.035Z,1604959682.035 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2020-11-09T22:08:05.543Z,1604959685.543 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20201109T211635/Express0017.lzma 2020-11-09T22:08:06.546Z,1604959686.546 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0017.lzma.bak 2020-11-09T22:08:06.546Z,1604959686.546 [DataOverHttps](INFO): SBD MOMSN=13154418 2020-11-09T22:08:07.661Z,1604959687.661 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T22:08:07.661Z,1604959687.661 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T22:08:07.661Z,1604959687.661 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T22:08:21.385Z,1604959701.385 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:08:41.995Z,1604959721.995 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:08:41.995Z,1604959721.995 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:08:41.996Z,1604959721.996 [NAL9602](ERROR): Communications Fault 2020-11-09T22:08:42.017Z,1604959722.017 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:08:42.389Z,1604959722.389 [NAL9602](INFO): Powering down 2020-11-09T22:08:43.232Z,1604959723.232 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:08:43.232Z,1604959723.232 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:09:12.693Z,1604959752.693 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:09:33.303Z,1604959773.303 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:09:33.303Z,1604959773.303 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:09:33.303Z,1604959773.303 [NAL9602](ERROR): Communications Fault 2020-11-09T22:09:33.331Z,1604959773.331 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:09:33.697Z,1604959773.697 [NAL9602](INFO): Powering down 2020-11-09T22:09:34.523Z,1604959774.523 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:09:34.523Z,1604959774.523 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:10:04.003Z,1604959804.003 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:10:24.601Z,1604959824.601 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:10:24.601Z,1604959824.601 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:10:24.601Z,1604959824.601 [NAL9602](ERROR): Communications Fault 2020-11-09T22:10:24.629Z,1604959824.629 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:10:25.020Z,1604959825.020 [NAL9602](INFO): Powering down 2020-11-09T22:10:25.864Z,1604959825.864 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:10:25.864Z,1604959825.864 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:10:55.309Z,1604959855.309 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:11:02.605Z,1604959862.605 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2020-11-09T22:11:02.605Z,1604959862.605 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:11:02.616Z,1604959862.616 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:11:03.001Z,1604959863.001 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:11:03.002Z,1604959863.002 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2020-11-09T22:11:15.918Z,1604959875.918 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:11:15.918Z,1604959875.918 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:11:15.918Z,1604959875.918 [NAL9602](ERROR): Communications Fault 2020-11-09T22:11:15.935Z,1604959875.935 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:11:15.935Z,1604959875.935 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:11:16.317Z,1604959876.317 [NAL9602](INFO): Powering down 2020-11-09T22:11:16.393Z,1604959876.393 [CBIT](INFO): Critical error at 20201109T221115 2020-11-09T22:11:18.748Z,1604959878.748 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-11-09T22:13:08.264Z,1604959988.264 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T22:13:08.264Z,1604959988.264 [Default:CheckIn:C.Wait] Stopped 2020-11-09T22:13:08.264Z,1604959988.264 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T22:13:08.264Z,1604959988.264 [Default:CheckIn:D] Running Loop=1 2020-11-09T22:13:08.677Z,1604959988.677 [Default:CheckIn:D] Stopped 2020-11-09T22:13:08.677Z,1604959988.677 [Default:CheckIn:E] Running Loop=1 2020-11-09T22:13:09.049Z,1604959989.049 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.534985 min 2020-11-09T22:13:09.050Z,1604959989.050 [Default:CheckIn:E] Stopped 2020-11-09T22:13:09.050Z,1604959989.050 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T22:13:09.050Z,1604959989.050 [Default:CheckIn] Stopped 2020-11-09T22:13:09.050Z,1604959989.050 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T22:13:09.051Z,1604959989.051 [Default:CheckIn](INFO): Running loop #6 2020-11-09T22:13:09.051Z,1604959989.051 [Default:CheckIn] Running Loop=6 2020-11-09T22:13:09.051Z,1604959989.051 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T22:13:09.051Z,1604959989.051 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T22:13:15.951Z,1604959995.951 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:13:15.951Z,1604959995.951 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:13:16.301Z,1604959996.301 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:13:36.909Z,1604960016.909 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:13:36.909Z,1604960016.909 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:13:36.909Z,1604960016.909 [NAL9602](ERROR): Communications Fault 2020-11-09T22:13:36.951Z,1604960016.951 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:13:37.309Z,1604960017.309 [NAL9602](INFO): Powering down 2020-11-09T22:13:38.149Z,1604960018.149 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:13:38.149Z,1604960018.149 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:14:03.585Z,1604960043.585 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2020-11-09T22:14:03.585Z,1604960043.585 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:14:03.595Z,1604960043.595 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:14:04.044Z,1604960044.044 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:14:04.044Z,1604960044.044 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2020-11-09T22:14:07.617Z,1604960047.617 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:14:28.221Z,1604960068.221 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:14:28.221Z,1604960068.221 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:14:28.221Z,1604960068.221 [NAL9602](ERROR): Communications Fault 2020-11-09T22:14:28.252Z,1604960068.252 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:14:28.621Z,1604960068.621 [NAL9602](INFO): Powering down 2020-11-09T22:14:29.453Z,1604960069.453 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:14:29.453Z,1604960069.453 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:14:58.921Z,1604960098.921 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:15:19.525Z,1604960119.525 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:15:19.525Z,1604960119.525 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:15:19.525Z,1604960119.525 [NAL9602](ERROR): Communications Fault 2020-11-09T22:15:19.547Z,1604960119.547 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:15:19.925Z,1604960119.925 [NAL9602](INFO): Powering down 2020-11-09T22:15:20.766Z,1604960120.766 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:15:20.766Z,1604960120.766 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:15:50.229Z,1604960150.229 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:16:10.837Z,1604960170.837 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:16:10.837Z,1604960170.837 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:16:10.837Z,1604960170.837 [NAL9602](ERROR): Communications Fault 2020-11-09T22:16:10.855Z,1604960170.855 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:16:11.233Z,1604960171.233 [NAL9602](INFO): Powering down 2020-11-09T22:16:12.095Z,1604960172.095 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:16:12.095Z,1604960172.095 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:16:41.534Z,1604960201.534 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:16:48.435Z,1604960208.435 [CBIT](INFO): Clearing failed state for component DropWeight 2020-11-09T22:16:48.435Z,1604960208.435 [DropWeight] No Fault, FailCount= 1 2020-11-09T22:17:02.141Z,1604960222.141 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:17:02.141Z,1604960222.141 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:17:02.141Z,1604960222.141 [NAL9602](ERROR): Communications Fault 2020-11-09T22:17:02.219Z,1604960222.219 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:17:02.219Z,1604960222.219 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:17:02.549Z,1604960222.549 [NAL9602](INFO): Powering down 2020-11-09T22:17:02.594Z,1604960222.594 [CBIT](INFO): Critical error at 20201109T221702 2020-11-09T22:17:04.601Z,1604960224.601 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2020-11-09T22:17:04.601Z,1604960224.601 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:17:04.619Z,1604960224.619 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:17:04.990Z,1604960224.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:17:04.990Z,1604960224.990 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2020-11-09T22:18:09.227Z,1604960289.227 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T22:13:09.1Z 2020-11-09T22:18:09.227Z,1604960289.227 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T22:18:09.227Z,1604960289.227 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T22:18:16.927Z,1604960296.927 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20201109T211635/Courier0019.lzma 2020-11-09T22:18:17.930Z,1604960297.930 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0019.lzma.bak 2020-11-09T22:18:17.930Z,1604960297.930 [DataOverHttps](INFO): SBD MOMSN=13154531 2020-11-09T22:18:33.815Z,1604960313.815 [DataOverHttps](INFO): Sending 109 bytes from file Logs/20201109T211635/Express0020.lzma 2020-11-09T22:18:34.818Z,1604960314.818 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0020.lzma.bak 2020-11-09T22:18:34.818Z,1604960314.818 [DataOverHttps](INFO): SBD MOMSN=13154535 2020-11-09T22:18:35.890Z,1604960315.890 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T22:18:35.890Z,1604960315.890 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T22:18:35.890Z,1604960315.890 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T22:19:02.181Z,1604960342.181 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:19:02.181Z,1604960342.181 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:19:02.537Z,1604960342.537 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:19:23.142Z,1604960363.142 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:19:23.142Z,1604960363.142 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:19:23.142Z,1604960363.142 [NAL9602](ERROR): Communications Fault 2020-11-09T22:19:23.185Z,1604960363.185 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:19:23.549Z,1604960363.549 [NAL9602](INFO): Powering down 2020-11-09T22:19:24.373Z,1604960364.373 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:19:24.374Z,1604960364.374 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:19:53.845Z,1604960393.845 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:20:05.575Z,1604960405.575 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2020-11-09T22:20:05.575Z,1604960405.575 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:20:05.585Z,1604960405.585 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:20:05.998Z,1604960405.998 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:20:05.998Z,1604960405.998 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2020-11-09T22:20:14.450Z,1604960414.450 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:20:14.450Z,1604960414.450 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:20:14.450Z,1604960414.450 [NAL9602](ERROR): Communications Fault 2020-11-09T22:20:14.467Z,1604960414.467 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:20:14.853Z,1604960414.853 [NAL9602](INFO): Powering down 2020-11-09T22:20:15.694Z,1604960415.694 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:20:15.694Z,1604960415.694 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:20:45.153Z,1604960445.153 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:21:05.761Z,1604960465.761 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:21:05.762Z,1604960465.762 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:21:05.762Z,1604960465.762 [NAL9602](ERROR): Communications Fault 2020-11-09T22:21:05.792Z,1604960465.792 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:21:06.161Z,1604960466.161 [NAL9602](INFO): Powering down 2020-11-09T22:21:06.986Z,1604960466.986 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:21:06.986Z,1604960466.986 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:21:36.461Z,1604960496.461 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:21:57.071Z,1604960517.071 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:21:57.071Z,1604960517.071 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:21:57.071Z,1604960517.071 [NAL9602](ERROR): Communications Fault 2020-11-09T22:21:57.088Z,1604960517.088 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:21:57.473Z,1604960517.473 [NAL9602](INFO): Powering down 2020-11-09T22:21:58.297Z,1604960518.297 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:21:58.298Z,1604960518.298 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:22:27.775Z,1604960547.775 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:22:48.369Z,1604960568.369 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:22:48.370Z,1604960568.370 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:22:48.370Z,1604960568.370 [NAL9602](ERROR): Communications Fault 2020-11-09T22:22:48.437Z,1604960568.437 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:22:48.438Z,1604960568.438 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:22:48.778Z,1604960568.778 [NAL9602](INFO): Powering down 2020-11-09T22:22:48.820Z,1604960568.820 [CBIT](INFO): Critical error at 20201109T222248 2020-11-09T22:23:06.565Z,1604960586.565 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2020-11-09T22:23:06.566Z,1604960586.566 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:23:06.576Z,1604960586.576 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:23:06.990Z,1604960586.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:23:06.990Z,1604960586.990 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2020-11-09T22:23:36.457Z,1604960616.457 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T22:23:36.457Z,1604960616.457 [Default:CheckIn:C.Wait] Stopped 2020-11-09T22:23:36.457Z,1604960616.457 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T22:23:36.457Z,1604960616.457 [Default:CheckIn:D] Running Loop=1 2020-11-09T22:23:36.872Z,1604960616.872 [Default:CheckIn:D] Stopped 2020-11-09T22:23:36.872Z,1604960616.872 [Default:CheckIn:E] Running Loop=1 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.004891 min 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn:E] Stopped 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn] Stopped 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn](INFO): Running loop #7 2020-11-09T22:23:37.271Z,1604960617.271 [Default:CheckIn] Running Loop=7 2020-11-09T22:23:37.272Z,1604960617.272 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T22:23:37.272Z,1604960617.272 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T22:24:48.377Z,1604960688.377 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:24:48.378Z,1604960688.378 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:24:48.761Z,1604960688.761 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:25:09.365Z,1604960709.365 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:25:09.365Z,1604960709.365 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:25:09.365Z,1604960709.365 [NAL9602](ERROR): Communications Fault 2020-11-09T22:25:09.433Z,1604960709.433 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:25:09.773Z,1604960709.773 [NAL9602](INFO): Powering down 2020-11-09T22:25:10.625Z,1604960710.625 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:25:10.625Z,1604960710.625 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:25:40.080Z,1604960740.080 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:26:00.681Z,1604960760.681 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:26:00.681Z,1604960760.681 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:26:00.681Z,1604960760.681 [NAL9602](ERROR): Communications Fault 2020-11-09T22:26:00.760Z,1604960760.760 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:26:01.085Z,1604960761.085 [NAL9602](INFO): Powering down 2020-11-09T22:26:01.926Z,1604960761.926 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:26:01.926Z,1604960761.926 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:26:07.565Z,1604960767.565 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2020-11-09T22:26:07.565Z,1604960767.565 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:26:07.575Z,1604960767.575 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:26:07.978Z,1604960767.978 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:26:07.978Z,1604960767.978 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2020-11-09T22:26:31.391Z,1604960791.391 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:26:51.990Z,1604960811.990 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:26:51.990Z,1604960811.990 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:26:51.990Z,1604960811.990 [NAL9602](ERROR): Communications Fault 2020-11-09T22:26:52.015Z,1604960812.015 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:26:52.402Z,1604960812.402 [NAL9602](INFO): Powering down 2020-11-09T22:26:53.262Z,1604960813.262 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:26:53.262Z,1604960813.262 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:27:22.693Z,1604960842.693 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:27:24.795Z,1604960844.795 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:27:43.299Z,1604960863.299 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:27:43.299Z,1604960863.299 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:27:43.299Z,1604960863.299 [NAL9602](ERROR): Communications Fault 2020-11-09T22:27:43.327Z,1604960863.327 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:27:43.705Z,1604960863.705 [NAL9602](INFO): Powering down 2020-11-09T22:27:44.527Z,1604960864.527 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:27:44.527Z,1604960864.527 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:28:14.007Z,1604960894.007 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:28:34.626Z,1604960914.626 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:28:34.626Z,1604960914.626 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:28:34.626Z,1604960914.626 [NAL9602](ERROR): Communications Fault 2020-11-09T22:28:34.678Z,1604960914.678 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:28:34.678Z,1604960914.678 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:28:35.010Z,1604960915.010 [NAL9602](INFO): Powering down 2020-11-09T22:28:35.048Z,1604960915.048 [CBIT](INFO): Critical error at 20201109T222834 2020-11-09T22:28:37.453Z,1604960917.453 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T22:23:37.3Z 2020-11-09T22:28:37.453Z,1604960917.453 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T22:28:37.453Z,1604960917.453 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T22:28:44.775Z,1604960924.775 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20201109T211635/Courier0022.lzma 2020-11-09T22:28:45.778Z,1604960925.778 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0022.lzma.bak 2020-11-09T22:28:45.778Z,1604960925.778 [DataOverHttps](INFO): SBD MOMSN=13154637 2020-11-09T22:28:46.408Z,1604960926.408 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:29:01.679Z,1604960941.679 [DataOverHttps](INFO): Sending 108 bytes from file Logs/20201109T211635/Express0023.lzma 2020-11-09T22:29:02.682Z,1604960942.682 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0023.lzma.bak 2020-11-09T22:29:02.682Z,1604960942.682 [DataOverHttps](INFO): SBD MOMSN=13154642 2020-11-09T22:29:03.730Z,1604960943.730 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T22:29:03.730Z,1604960943.730 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T22:29:03.730Z,1604960943.730 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T22:29:08.574Z,1604960948.574 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2020-11-09T22:29:08.574Z,1604960948.574 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:29:08.596Z,1604960948.596 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:29:08.997Z,1604960948.997 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:29:08.998Z,1604960948.998 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2020-11-09T22:29:13.051Z,1604960953.051 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:30:07.188Z,1604961007.188 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:30:34.675Z,1604961034.675 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:30:34.675Z,1604961034.675 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:30:35.009Z,1604961035.009 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:30:45.979Z,1604961045.979 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:30:55.613Z,1604961055.613 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:30:55.613Z,1604961055.613 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:30:55.613Z,1604961055.613 [NAL9602](ERROR): Communications Fault 2020-11-09T22:30:55.650Z,1604961055.650 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:30:56.026Z,1604961056.026 [NAL9602](INFO): Powering down 2020-11-09T22:30:56.843Z,1604961056.843 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:30:56.843Z,1604961056.843 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:30:57.541Z,1604961057.541 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-11-09T22:30:58.918Z,1604961058.918 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:31:25.604Z,1604961085.604 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-11-09T22:31:26.329Z,1604961086.329 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:31:46.935Z,1604961106.935 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:31:46.935Z,1604961106.935 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:31:46.935Z,1604961106.935 [NAL9602](ERROR): Communications Fault 2020-11-09T22:31:46.963Z,1604961106.963 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:31:47.341Z,1604961107.341 [NAL9602](INFO): Powering down 2020-11-09T22:31:48.169Z,1604961108.169 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:31:48.170Z,1604961108.170 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:32:04.877Z,1604961124.877 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-11-09T22:32:09.565Z,1604961129.565 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2020-11-09T22:32:09.565Z,1604961129.565 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:32:09.613Z,1604961129.613 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:32:09.990Z,1604961129.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:32:09.990Z,1604961129.990 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2020-11-09T22:32:17.637Z,1604961137.637 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:32:17.707Z,1604961137.707 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-11-09T22:32:30.651Z,1604961150.651 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-11-09T22:32:38.245Z,1604961158.245 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:32:38.245Z,1604961158.245 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:32:38.245Z,1604961158.245 [NAL9602](ERROR): Communications Fault 2020-11-09T22:32:38.291Z,1604961158.291 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:32:38.645Z,1604961158.645 [NAL9602](INFO): Powering down 2020-11-09T22:32:39.520Z,1604961159.520 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:32:39.520Z,1604961159.520 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:32:44.330Z,1604961164.330 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-11-09T22:32:44.332Z,1604961164.332 [BPC1](INFO): Received data from all battery sticks. 2020-11-09T22:33:08.942Z,1604961188.942 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:33:29.546Z,1604961209.546 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:33:29.546Z,1604961209.546 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:33:29.546Z,1604961209.546 [NAL9602](ERROR): Communications Fault 2020-11-09T22:33:29.571Z,1604961209.571 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:33:29.950Z,1604961209.950 [NAL9602](INFO): Powering down 2020-11-09T22:33:30.794Z,1604961210.794 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:33:30.794Z,1604961210.794 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:34:00.257Z,1604961240.257 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:34:04.317Z,1604961244.317 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T22:34:04.317Z,1604961244.317 [Default:CheckIn:C.Wait] Stopped 2020-11-09T22:34:04.317Z,1604961244.317 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T22:34:04.318Z,1604961244.318 [Default:CheckIn:D] Running Loop=1 2020-11-09T22:34:04.734Z,1604961244.734 [Default:CheckIn:D] Stopped 2020-11-09T22:34:04.734Z,1604961244.734 [Default:CheckIn:E] Running Loop=1 2020-11-09T22:34:05.116Z,1604961245.116 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.469271 min 2020-11-09T22:34:05.116Z,1604961245.116 [Default:CheckIn:E] Stopped 2020-11-09T22:34:05.116Z,1604961245.116 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T22:34:05.116Z,1604961245.116 [Default:CheckIn] Stopped 2020-11-09T22:34:05.117Z,1604961245.117 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T22:34:05.117Z,1604961245.117 [Default:CheckIn](INFO): Running loop #8 2020-11-09T22:34:05.117Z,1604961245.117 [Default:CheckIn] Running Loop=8 2020-11-09T22:34:05.117Z,1604961245.117 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T22:34:05.117Z,1604961245.117 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T22:34:20.857Z,1604961260.857 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:34:20.858Z,1604961260.858 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:34:20.858Z,1604961260.858 [NAL9602](ERROR): Communications Fault 2020-11-09T22:34:20.904Z,1604961260.904 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:34:20.905Z,1604961260.905 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:34:21.261Z,1604961261.261 [NAL9602](INFO): Powering down 2020-11-09T22:34:21.327Z,1604961261.327 [CBIT](INFO): Critical error at 20201109T223420 2020-11-09T22:35:10.557Z,1604961310.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2020-11-09T22:35:10.557Z,1604961310.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:35:10.567Z,1604961310.567 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:35:10.979Z,1604961310.979 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:35:10.979Z,1604961310.979 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2020-11-09T22:36:20.866Z,1604961380.866 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:36:20.866Z,1604961380.866 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:36:21.259Z,1604961381.259 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:36:41.857Z,1604961401.857 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:36:41.858Z,1604961401.858 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:36:41.858Z,1604961401.858 [NAL9602](ERROR): Communications Fault 2020-11-09T22:36:41.899Z,1604961401.899 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:36:42.261Z,1604961402.261 [NAL9602](INFO): Powering down 2020-11-09T22:36:43.093Z,1604961403.093 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:36:43.093Z,1604961403.093 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:37:12.563Z,1604961432.563 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:37:33.166Z,1604961453.166 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:37:33.166Z,1604961453.166 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:37:33.166Z,1604961453.166 [NAL9602](ERROR): Communications Fault 2020-11-09T22:37:33.194Z,1604961453.194 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:37:33.574Z,1604961453.574 [NAL9602](INFO): Powering down 2020-11-09T22:37:34.424Z,1604961454.424 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:37:34.424Z,1604961454.424 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:38:03.865Z,1604961483.865 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:38:11.557Z,1604961491.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2020-11-09T22:38:11.557Z,1604961491.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:38:11.567Z,1604961491.567 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:38:11.969Z,1604961491.969 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:38:11.969Z,1604961491.969 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2020-11-09T22:38:24.469Z,1604961504.469 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:38:24.470Z,1604961504.470 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:38:24.470Z,1604961504.470 [NAL9602](ERROR): Communications Fault 2020-11-09T22:38:24.495Z,1604961504.495 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:38:24.893Z,1604961504.893 [NAL9602](INFO): Powering down 2020-11-09T22:38:25.703Z,1604961505.703 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:38:25.703Z,1604961505.703 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:38:55.181Z,1604961535.181 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:39:05.312Z,1604961545.312 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T22:34:05.1Z 2020-11-09T22:39:05.312Z,1604961545.312 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T22:39:05.312Z,1604961545.312 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T22:39:12.503Z,1604961552.503 [DataOverHttps](INFO): Sending 101 bytes from file Logs/20201109T211635/Courier0025.lzma 2020-11-09T22:39:13.506Z,1604961553.506 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0025.lzma.bak 2020-11-09T22:39:13.506Z,1604961553.506 [DataOverHttps](INFO): SBD MOMSN=13154757 2020-11-09T22:39:15.789Z,1604961555.789 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:39:15.789Z,1604961555.789 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:39:15.789Z,1604961555.789 [NAL9602](ERROR): Communications Fault 2020-11-09T22:39:15.806Z,1604961555.806 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:39:16.193Z,1604961556.193 [NAL9602](INFO): Powering down 2020-11-09T22:39:17.050Z,1604961557.050 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:39:17.050Z,1604961557.050 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:39:29.287Z,1604961569.287 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20201109T211635/Express0026.lzma 2020-11-09T22:39:30.290Z,1604961570.290 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0026.lzma.bak 2020-11-09T22:39:30.290Z,1604961570.290 [DataOverHttps](INFO): SBD MOMSN=13154760 2020-11-09T22:39:31.549Z,1604961571.549 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T22:39:31.549Z,1604961571.549 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T22:39:31.549Z,1604961571.549 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T22:39:46.489Z,1604961586.489 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:40:07.098Z,1604961607.098 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:40:07.098Z,1604961607.098 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:40:07.098Z,1604961607.098 [NAL9602](ERROR): Communications Fault 2020-11-09T22:40:07.149Z,1604961607.149 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:40:07.150Z,1604961607.150 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:40:07.497Z,1604961607.497 [NAL9602](INFO): Powering down 2020-11-09T22:40:07.521Z,1604961607.521 [CBIT](INFO): Critical error at 20201109T224007 2020-11-09T22:41:12.591Z,1604961672.591 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2020-11-09T22:41:12.591Z,1604961672.591 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:41:12.622Z,1604961672.622 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:41:12.974Z,1604961672.974 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:41:12.974Z,1604961672.974 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2020-11-09T22:42:07.121Z,1604961727.121 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:42:07.121Z,1604961727.121 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:42:07.489Z,1604961727.489 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:42:28.097Z,1604961748.097 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:42:28.098Z,1604961748.098 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:42:28.098Z,1604961748.098 [NAL9602](ERROR): Communications Fault 2020-11-09T22:42:28.143Z,1604961748.143 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:42:28.497Z,1604961748.497 [NAL9602](INFO): Powering down 2020-11-09T22:42:29.333Z,1604961749.333 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:42:29.333Z,1604961749.333 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:42:58.803Z,1604961778.803 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:43:19.401Z,1604961799.401 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:43:19.401Z,1604961799.401 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:43:19.401Z,1604961799.401 [NAL9602](ERROR): Communications Fault 2020-11-09T22:43:19.419Z,1604961799.419 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:43:19.805Z,1604961799.805 [NAL9602](INFO): Powering down 2020-11-09T22:43:20.653Z,1604961800.653 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:43:20.653Z,1604961800.653 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:43:50.105Z,1604961830.105 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:44:10.706Z,1604961850.706 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:44:10.706Z,1604961850.706 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:44:10.706Z,1604961850.706 [NAL9602](ERROR): Communications Fault 2020-11-09T22:44:10.755Z,1604961850.755 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:44:11.132Z,1604961851.132 [NAL9602](INFO): Powering down 2020-11-09T22:44:11.946Z,1604961851.946 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:44:11.947Z,1604961851.947 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:44:13.570Z,1604961853.570 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2020-11-09T22:44:13.570Z,1604961853.570 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:44:13.605Z,1604961853.605 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:44:13.974Z,1604961853.974 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:44:13.974Z,1604961853.974 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2020-11-09T22:44:32.141Z,1604961872.141 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T22:44:32.141Z,1604961872.141 [Default:CheckIn:C.Wait] Stopped 2020-11-09T22:44:32.141Z,1604961872.141 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T22:44:32.142Z,1604961872.142 [Default:CheckIn:D] Running Loop=1 2020-11-09T22:44:32.534Z,1604961872.534 [Default:CheckIn:D] Stopped 2020-11-09T22:44:32.534Z,1604961872.534 [Default:CheckIn:E] Running Loop=1 2020-11-09T22:44:32.945Z,1604961872.945 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.932601 min 2020-11-09T22:44:32.945Z,1604961872.945 [Default:CheckIn:E] Stopped 2020-11-09T22:44:32.945Z,1604961872.945 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T22:44:32.945Z,1604961872.945 [Default:CheckIn] Stopped 2020-11-09T22:44:32.945Z,1604961872.945 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T22:44:32.946Z,1604961872.946 [Default:CheckIn](INFO): Running loop #9 2020-11-09T22:44:32.946Z,1604961872.946 [Default:CheckIn] Running Loop=9 2020-11-09T22:44:32.946Z,1604961872.946 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T22:44:32.946Z,1604961872.946 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T22:44:41.417Z,1604961881.417 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:45:02.018Z,1604961902.018 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:45:02.018Z,1604961902.018 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:45:02.018Z,1604961902.018 [NAL9602](ERROR): Communications Fault 2020-11-09T22:45:02.070Z,1604961902.070 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:45:02.421Z,1604961902.421 [NAL9602](INFO): Powering down 2020-11-09T22:45:03.277Z,1604961903.277 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:45:03.277Z,1604961903.277 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:45:32.721Z,1604961932.721 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:45:53.325Z,1604961953.325 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:45:53.326Z,1604961953.326 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:45:53.326Z,1604961953.326 [NAL9602](ERROR): Communications Fault 2020-11-09T22:45:53.367Z,1604961953.367 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:45:53.367Z,1604961953.367 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:45:53.729Z,1604961953.729 [NAL9602](INFO): Powering down 2020-11-09T22:45:53.771Z,1604961953.771 [CBIT](INFO): Critical error at 20201109T224553 2020-11-09T22:46:49.885Z,1604962009.885 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-11-09T22:46:49.885Z,1604962009.885 [DropWeight] Hardware Fault, FailCount= 1 2020-11-09T22:46:49.885Z,1604962009.885 [DropWeight](ERROR): Hardware Fault 2020-11-09T22:46:49.905Z,1604962009.905 [CBIT](INFO): Critical error at 20201109T224649 2020-11-09T22:46:49.907Z,1604962009.907 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-11-09T22:46:49.907Z,1604962009.907 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-11-09T22:46:50.366Z,1604962010.366 [CBIT](INFO): Critical error at 20201109T224649 2020-11-09T22:47:14.541Z,1604962034.541 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2020-11-09T22:47:14.541Z,1604962034.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:47:14.550Z,1604962034.550 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:47:14.977Z,1604962034.977 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:47:14.977Z,1604962034.977 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2020-11-09T22:47:53.367Z,1604962073.367 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:47:53.367Z,1604962073.367 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:47:53.721Z,1604962073.721 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:48:14.321Z,1604962094.321 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:48:14.321Z,1604962094.321 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:48:14.321Z,1604962094.321 [NAL9602](ERROR): Communications Fault 2020-11-09T22:48:14.349Z,1604962094.349 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:48:14.725Z,1604962094.725 [NAL9602](INFO): Powering down 2020-11-09T22:48:15.580Z,1604962095.580 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:48:15.580Z,1604962095.580 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:48:45.025Z,1604962125.025 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:49:05.629Z,1604962145.629 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:49:05.629Z,1604962145.629 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:49:05.630Z,1604962145.630 [NAL9602](ERROR): Communications Fault 2020-11-09T22:49:05.677Z,1604962145.677 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:49:06.037Z,1604962146.037 [NAL9602](INFO): Powering down 2020-11-09T22:49:06.879Z,1604962146.879 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:49:06.879Z,1604962146.879 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:49:33.118Z,1604962173.118 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T22:44:32.9Z 2020-11-09T22:49:33.118Z,1604962173.118 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T22:49:33.118Z,1604962173.118 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T22:49:36.333Z,1604962176.333 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:49:40.427Z,1604962180.427 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20201109T211635/Courier0028.lzma 2020-11-09T22:49:41.430Z,1604962181.430 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0028.lzma.bak 2020-11-09T22:49:41.430Z,1604962181.430 [DataOverHttps](INFO): SBD MOMSN=13154870 2020-11-09T22:49:56.941Z,1604962196.941 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:49:56.941Z,1604962196.941 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:49:56.941Z,1604962196.941 [NAL9602](ERROR): Communications Fault 2020-11-09T22:49:56.983Z,1604962196.983 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:49:57.267Z,1604962197.267 [DataOverHttps](INFO): Sending 117 bytes from file Logs/20201109T211635/Express0029.lzma 2020-11-09T22:49:57.345Z,1604962197.345 [NAL9602](INFO): Powering down 2020-11-09T22:49:58.176Z,1604962198.176 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:49:58.176Z,1604962198.176 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:49:58.270Z,1604962198.270 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0029.lzma.bak 2020-11-09T22:49:58.270Z,1604962198.270 [DataOverHttps](INFO): SBD MOMSN=13154876 2020-11-09T22:49:59.378Z,1604962199.378 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T22:49:59.378Z,1604962199.378 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T22:49:59.378Z,1604962199.378 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T22:50:15.537Z,1604962215.537 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2020-11-09T22:50:15.537Z,1604962215.537 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:50:15.547Z,1604962215.547 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:50:15.950Z,1604962215.950 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:50:15.950Z,1604962215.950 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2020-11-09T22:50:27.645Z,1604962227.645 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:50:48.245Z,1604962248.245 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:50:48.246Z,1604962248.246 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:50:48.246Z,1604962248.246 [NAL9602](ERROR): Communications Fault 2020-11-09T22:50:48.273Z,1604962248.273 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:50:48.657Z,1604962248.657 [NAL9602](INFO): Powering down 2020-11-09T22:50:49.483Z,1604962249.483 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:50:49.483Z,1604962249.483 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:51:19.005Z,1604962279.005 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:51:39.625Z,1604962299.625 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:51:39.625Z,1604962299.625 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:51:39.625Z,1604962299.625 [NAL9602](ERROR): Communications Fault 2020-11-09T22:51:39.677Z,1604962299.677 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:51:39.678Z,1604962299.678 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:51:40.019Z,1604962300.019 [NAL9602](INFO): Powering down 2020-11-09T22:51:40.039Z,1604962300.039 [CBIT](INFO): Critical error at 20201109T225139 2020-11-09T22:52:15.980Z,1604962335.980 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-11-09T22:53:16.582Z,1604962396.582 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2020-11-09T22:53:16.583Z,1604962396.583 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:53:16.609Z,1604962396.609 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:53:16.994Z,1604962396.994 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:53:16.994Z,1604962396.994 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2020-11-09T22:53:40.030Z,1604962420.030 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:53:40.031Z,1604962420.031 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:53:40.401Z,1604962420.401 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:54:01.015Z,1604962441.015 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:54:01.015Z,1604962441.015 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:54:01.015Z,1604962441.015 [NAL9602](ERROR): Communications Fault 2020-11-09T22:54:01.032Z,1604962441.032 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:54:01.413Z,1604962441.413 [NAL9602](INFO): Powering down 2020-11-09T22:54:02.243Z,1604962442.243 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:54:02.243Z,1604962442.243 [NAL9602] No Fault, FailCount= 1 2020-11-09T22:54:31.714Z,1604962471.714 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:54:52.313Z,1604962492.313 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:54:52.313Z,1604962492.313 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T22:54:52.313Z,1604962492.313 [NAL9602](ERROR): Communications Fault 2020-11-09T22:54:52.347Z,1604962492.347 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:54:52.721Z,1604962492.721 [NAL9602](INFO): Powering down 2020-11-09T22:54:53.552Z,1604962493.552 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:54:53.552Z,1604962493.552 [NAL9602] No Fault, FailCount= 2 2020-11-09T22:55:00.014Z,1604962500.014 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T22:55:00.014Z,1604962500.014 [Default:CheckIn:C.Wait] Stopped 2020-11-09T22:55:00.014Z,1604962500.014 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T22:55:00.014Z,1604962500.014 [Default:CheckIn:D] Running Loop=1 2020-11-09T22:55:00.406Z,1604962500.406 [Default:CheckIn:D] Stopped 2020-11-09T22:55:00.406Z,1604962500.406 [Default:CheckIn:E] Running Loop=1 2020-11-09T22:55:00.816Z,1604962500.816 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.397127 min 2020-11-09T22:55:00.816Z,1604962500.816 [Default:CheckIn:E] Stopped 2020-11-09T22:55:00.816Z,1604962500.816 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T22:55:00.816Z,1604962500.816 [Default:CheckIn] Stopped 2020-11-09T22:55:00.816Z,1604962500.816 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T22:55:00.817Z,1604962500.817 [Default:CheckIn](INFO): Running loop #10 2020-11-09T22:55:00.817Z,1604962500.817 [Default:CheckIn] Running Loop=10 2020-11-09T22:55:00.817Z,1604962500.817 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T22:55:00.817Z,1604962500.817 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T22:55:23.021Z,1604962523.021 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:55:43.625Z,1604962543.625 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:55:43.625Z,1604962543.625 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T22:55:43.625Z,1604962543.625 [NAL9602](ERROR): Communications Fault 2020-11-09T22:55:43.667Z,1604962543.667 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:55:44.025Z,1604962544.025 [NAL9602](INFO): Powering down 2020-11-09T22:55:44.867Z,1604962544.867 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:55:44.867Z,1604962544.867 [NAL9602] No Fault, FailCount= 3 2020-11-09T22:56:14.325Z,1604962574.325 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:56:17.580Z,1604962577.580 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2020-11-09T22:56:17.580Z,1604962577.580 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:56:17.591Z,1604962577.591 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:56:18.002Z,1604962578.002 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:56:18.002Z,1604962578.002 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2020-11-09T22:56:34.933Z,1604962594.933 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:56:34.933Z,1604962594.933 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T22:56:34.933Z,1604962594.933 [NAL9602](ERROR): Communications Fault 2020-11-09T22:56:34.958Z,1604962594.958 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:56:35.337Z,1604962595.337 [NAL9602](INFO): Powering down 2020-11-09T22:56:36.203Z,1604962596.203 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:56:36.203Z,1604962596.203 [NAL9602] No Fault, FailCount= 4 2020-11-09T22:57:05.633Z,1604962625.633 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:57:26.265Z,1604962646.265 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:57:26.265Z,1604962646.265 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T22:57:26.265Z,1604962646.265 [NAL9602](ERROR): Communications Fault 2020-11-09T22:57:26.294Z,1604962646.294 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:57:26.294Z,1604962646.294 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T22:57:26.673Z,1604962646.673 [NAL9602](INFO): Powering down 2020-11-09T22:57:26.700Z,1604962646.700 [CBIT](INFO): Critical error at 20201109T225726 2020-11-09T22:59:18.593Z,1604962758.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34 2020-11-09T22:59:18.593Z,1604962758.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T22:59:18.603Z,1604962758.603 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T22:59:19.006Z,1604962759.006 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T22:59:19.006Z,1604962759.006 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34 2020-11-09T22:59:26.296Z,1604962766.296 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:59:26.297Z,1604962766.297 [NAL9602] No Fault, FailCount= 5 2020-11-09T22:59:26.661Z,1604962766.661 [NAL9602](INFO): Powering up NAL9602 2020-11-09T22:59:47.269Z,1604962787.269 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T22:59:47.269Z,1604962787.269 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T22:59:47.269Z,1604962787.269 [NAL9602](ERROR): Communications Fault 2020-11-09T22:59:47.320Z,1604962787.320 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T22:59:47.673Z,1604962787.673 [NAL9602](INFO): Powering down 2020-11-09T22:59:48.493Z,1604962788.493 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T22:59:48.493Z,1604962788.493 [NAL9602] No Fault, FailCount= 1 2020-11-09T23:00:01.010Z,1604962801.010 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T22:55:00.8Z 2020-11-09T23:00:01.010Z,1604962801.010 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T23:00:01.010Z,1604962801.010 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T23:00:08.675Z,1604962808.675 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20201109T211635/Courier0031.lzma 2020-11-09T23:00:09.678Z,1604962809.678 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0031.lzma.bak 2020-11-09T23:00:09.678Z,1604962809.678 [DataOverHttps](INFO): SBD MOMSN=13154974 2020-11-09T23:00:17.965Z,1604962817.965 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:00:25.327Z,1604962825.327 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20201109T211635/Express0032.lzma 2020-11-09T23:00:26.330Z,1604962826.330 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0032.lzma.bak 2020-11-09T23:00:26.330Z,1604962826.330 [DataOverHttps](INFO): SBD MOMSN=13154978 2020-11-09T23:00:27.677Z,1604962827.677 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T23:00:27.677Z,1604962827.677 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T23:00:27.677Z,1604962827.677 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T23:00:38.573Z,1604962838.573 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:00:38.574Z,1604962838.574 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T23:00:38.574Z,1604962838.574 [NAL9602](ERROR): Communications Fault 2020-11-09T23:00:38.591Z,1604962838.591 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:00:38.983Z,1604962838.983 [NAL9602](INFO): Powering down 2020-11-09T23:00:39.807Z,1604962839.807 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:00:39.807Z,1604962839.807 [NAL9602] No Fault, FailCount= 2 2020-11-09T23:01:09.277Z,1604962869.277 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:01:29.897Z,1604962889.897 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:01:29.897Z,1604962889.897 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T23:01:29.897Z,1604962889.897 [NAL9602](ERROR): Communications Fault 2020-11-09T23:01:29.915Z,1604962889.915 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:01:30.305Z,1604962890.305 [NAL9602](INFO): Powering down 2020-11-09T23:01:31.159Z,1604962891.159 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:01:31.159Z,1604962891.159 [NAL9602] No Fault, FailCount= 3 2020-11-09T23:01:50.130Z,1604962910.130 [CBIT](INFO): Clearing failed state for component DropWeight 2020-11-09T23:01:50.130Z,1604962910.130 [DropWeight] No Fault, FailCount= 1 2020-11-09T23:02:00.605Z,1604962920.605 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:02:19.609Z,1604962939.609 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35 2020-11-09T23:02:19.609Z,1604962939.609 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T23:02:19.619Z,1604962939.619 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T23:02:20.025Z,1604962940.025 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T23:02:20.025Z,1604962940.025 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35 2020-11-09T23:02:21.209Z,1604962941.209 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:02:21.209Z,1604962941.209 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T23:02:21.210Z,1604962941.210 [NAL9602](ERROR): Communications Fault 2020-11-09T23:02:21.230Z,1604962941.230 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:02:21.609Z,1604962941.609 [NAL9602](INFO): Powering down 2020-11-09T23:02:22.437Z,1604962942.437 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:02:22.438Z,1604962942.438 [NAL9602] No Fault, FailCount= 4 2020-11-09T23:02:51.913Z,1604962971.913 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:03:12.521Z,1604962992.521 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:03:12.521Z,1604962992.521 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T23:03:12.522Z,1604962992.522 [NAL9602](ERROR): Communications Fault 2020-11-09T23:03:12.539Z,1604962992.539 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:03:12.539Z,1604962992.539 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T23:03:12.917Z,1604962992.917 [NAL9602](INFO): Powering down 2020-11-09T23:03:12.941Z,1604962992.941 [CBIT](INFO): Critical error at 20201109T230312 2020-11-09T23:05:12.541Z,1604963112.541 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:05:12.542Z,1604963112.542 [NAL9602] No Fault, FailCount= 5 2020-11-09T23:05:12.909Z,1604963112.909 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:05:20.602Z,1604963120.602 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36 2020-11-09T23:05:20.602Z,1604963120.602 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T23:05:20.628Z,1604963120.628 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T23:05:21.009Z,1604963121.009 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T23:05:21.009Z,1604963121.009 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36 2020-11-09T23:05:28.289Z,1604963128.289 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-11-09T23:05:28.289Z,1604963128.289 [Default:CheckIn:C.Wait] Stopped 2020-11-09T23:05:28.289Z,1604963128.289 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T23:05:28.289Z,1604963128.289 [Default:CheckIn:D] Running Loop=1 2020-11-09T23:05:28.674Z,1604963128.674 [Default:CheckIn:D] Stopped 2020-11-09T23:05:28.674Z,1604963128.674 [Default:CheckIn:E] Running Loop=1 2020-11-09T23:05:29.082Z,1604963129.082 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.868262 min 2020-11-09T23:05:29.082Z,1604963129.082 [Default:CheckIn:E] Stopped 2020-11-09T23:05:29.082Z,1604963129.082 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-11-09T23:05:29.082Z,1604963129.082 [Default:CheckIn] Stopped 2020-11-09T23:05:29.083Z,1604963129.083 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T23:05:29.083Z,1604963129.083 [Default:CheckIn](INFO): Running loop #11 2020-11-09T23:05:29.083Z,1604963129.083 [Default:CheckIn] Running Loop=11 2020-11-09T23:05:29.083Z,1604963129.083 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-11-09T23:05:29.083Z,1604963129.083 [Default:CheckIn:Read_GPS] Running Loop=1 2020-11-09T23:05:33.509Z,1604963133.509 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:05:33.510Z,1604963133.510 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T23:05:33.510Z,1604963133.510 [NAL9602](ERROR): Communications Fault 2020-11-09T23:05:33.527Z,1604963133.527 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:05:33.921Z,1604963133.921 [NAL9602](INFO): Powering down 2020-11-09T23:05:34.764Z,1604963134.764 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:05:34.764Z,1604963134.764 [NAL9602] No Fault, FailCount= 1 2020-11-09T23:06:04.217Z,1604963164.217 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:06:24.825Z,1604963184.825 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:06:24.826Z,1604963184.826 [NAL9602] Communications Fault, FailCount= 2 2020-11-09T23:06:24.826Z,1604963184.826 [NAL9602](ERROR): Communications Fault 2020-11-09T23:06:24.897Z,1604963184.897 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:06:25.225Z,1604963185.225 [NAL9602](INFO): Powering down 2020-11-09T23:06:26.112Z,1604963186.112 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:06:26.112Z,1604963186.112 [NAL9602] No Fault, FailCount= 2 2020-11-09T23:06:55.529Z,1604963215.529 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:07:16.142Z,1604963236.142 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:07:16.142Z,1604963236.142 [NAL9602] Communications Fault, FailCount= 3 2020-11-09T23:07:16.142Z,1604963236.142 [NAL9602](ERROR): Communications Fault 2020-11-09T23:07:16.170Z,1604963236.170 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:07:16.533Z,1604963236.533 [NAL9602](INFO): Powering down 2020-11-09T23:07:17.368Z,1604963237.368 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:07:17.368Z,1604963237.368 [NAL9602] No Fault, FailCount= 3 2020-11-09T23:07:46.833Z,1604963266.833 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:08:07.437Z,1604963287.437 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:08:07.438Z,1604963287.438 [NAL9602] Communications Fault, FailCount= 4 2020-11-09T23:08:07.438Z,1604963287.438 [NAL9602](ERROR): Communications Fault 2020-11-09T23:08:07.465Z,1604963287.465 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:08:07.847Z,1604963287.847 [NAL9602](INFO): Powering down 2020-11-09T23:08:08.666Z,1604963288.666 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:08:08.667Z,1604963288.667 [NAL9602] No Fault, FailCount= 4 2020-11-09T23:08:21.617Z,1604963301.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37 2020-11-09T23:08:21.617Z,1604963301.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T23:08:21.634Z,1604963301.634 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T23:08:21.998Z,1604963301.998 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T23:08:21.998Z,1604963301.998 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37 2020-11-09T23:08:38.141Z,1604963318.141 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:08:58.745Z,1604963338.745 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:08:58.745Z,1604963338.745 [NAL9602] Communications Fault, FailCount= 5 2020-11-09T23:08:58.745Z,1604963338.745 [NAL9602](ERROR): Communications Fault 2020-11-09T23:08:58.805Z,1604963338.805 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:08:58.806Z,1604963338.806 [CBIT](CRITICAL): Communications Fault in component: NAL9602 2020-11-09T23:08:59.149Z,1604963339.149 [NAL9602](INFO): Powering down 2020-11-09T23:08:59.192Z,1604963339.192 [CBIT](INFO): Critical error at 20201109T230858 2020-11-09T23:10:29.270Z,1604963429.270 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-11-09T23:05:29.1Z 2020-11-09T23:10:29.270Z,1604963429.270 [Default:CheckIn:Read_GPS] Stopped 2020-11-09T23:10:29.270Z,1604963429.270 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-11-09T23:10:36.239Z,1604963436.239 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20201109T211635/Courier0034.lzma 2020-11-09T23:10:37.242Z,1604963437.242 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Courier0034.lzma.bak 2020-11-09T23:10:37.242Z,1604963437.242 [DataOverHttps](INFO): SBD MOMSN=13155092 2020-11-09T23:10:52.911Z,1604963452.911 [DataOverHttps](INFO): Sending 110 bytes from file Logs/20201109T211635/Express0035.lzma 2020-11-09T23:10:53.914Z,1604963453.914 [DataOverHttps](INFO): Moved sent file to Logs/20201109T211635/Express0035.lzma.bak 2020-11-09T23:10:53.914Z,1604963453.914 [DataOverHttps](INFO): SBD MOMSN=13155096 2020-11-09T23:10:55.111Z,1604963455.111 [Default:CheckIn:Read_Iridium] Stopped 2020-11-09T23:10:55.111Z,1604963455.111 [Default:CheckIn:C.Wait] Running Loop=1 2020-11-09T23:10:55.111Z,1604963455.111 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-11-09T23:10:58.778Z,1604963458.778 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:10:58.778Z,1604963458.778 [NAL9602] No Fault, FailCount= 5 2020-11-09T23:10:59.137Z,1604963459.137 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:11:19.741Z,1604963479.741 [NAL9602](ERROR): NAL9602 initialization error. 2020-11-09T23:11:19.741Z,1604963479.741 [NAL9602] Communications Fault, FailCount= 1 2020-11-09T23:11:19.741Z,1604963479.741 [NAL9602](ERROR): Communications Fault 2020-11-09T23:11:19.816Z,1604963479.816 [CBIT](ERROR): Communications Fault in component: NAL9602 2020-11-09T23:11:20.145Z,1604963480.145 [NAL9602](INFO): Powering down 2020-11-09T23:11:21.004Z,1604963481.004 [CBIT](INFO): Clearing failed state for component NAL9602 2020-11-09T23:11:21.004Z,1604963481.004 [NAL9602] No Fault, FailCount= 1 2020-11-09T23:11:22.622Z,1604963482.622 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38 2020-11-09T23:11:22.622Z,1604963482.622 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-11-09T23:11:22.648Z,1604963482.648 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-11-09T23:11:23.053Z,1604963483.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-11-09T23:11:23.053Z,1604963483.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38 2020-11-09T23:11:50.445Z,1604963510.445 [NAL9602](INFO): Powering up NAL9602 2020-11-09T23:11:59.493Z,1604963519.493 [CommandLine](IMPORTANT): got command failComponent 2020-11-09T23:11:59.494Z,1604963519.494 [CommandLine](IMPORTANT): Failed components: 2020-11-09T23:11:59.494Z,1604963519.494 [CommandLine](IMPORTANT): No failed Components. 2020-11-09T23:12:04.005Z,1604963524.005 [CommandLine](IMPORTANT): got command quit 2020-11-09T23:12:05.012Z,1604963525.012 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:05.012Z,1604963525.012 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.016Z,1604963525.016 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-11-09T23:12:05.016Z,1604963525.016 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.017Z,1604963525.017 [CommandLine](INFO): Join timeout helper Thread ID is 1037 2020-11-09T23:12:05.024Z,1604963525.024 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-11-09T23:12:05.024Z,1604963525.024 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.024Z,1604963525.024 [NavChartDb](INFO): Join timeout helper Thread ID is 1038 2020-11-09T23:12:05.116Z,1604963525.116 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:05.116Z,1604963525.116 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.128Z,1604963525.128 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2020-11-09T23:12:05.128Z,1604963525.128 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.128Z,1604963525.128 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1039 2020-11-09T23:12:05.516Z,1604963525.516 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:05.516Z,1604963525.516 [WetLabsUBAT](INFO): Powering down 2020-11-09T23:12:05.517Z,1604963525.517 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.536Z,1604963525.536 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-11-09T23:12:05.536Z,1604963525.536 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.536Z,1604963525.536 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1040 2020-11-09T23:12:05.732Z,1604963525.732 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:05.732Z,1604963525.732 [WetLabsBB2FL](INFO): Powering down 2020-11-09T23:12:05.733Z,1604963525.733 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.740Z,1604963525.740 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-11-09T23:12:05.740Z,1604963525.740 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.740Z,1604963525.740 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1041 2020-11-09T23:12:05.768Z,1604963525.768 [CTD_Seabird](INFO): Powering down 2020-11-09T23:12:05.780Z,1604963525.780 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:05.780Z,1604963525.780 [CTD_Seabird](INFO): Powering down 2020-11-09T23:12:05.804Z,1604963525.804 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.825Z,1604963525.825 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler 2020-11-09T23:12:05.825Z,1604963525.825 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.825Z,1604963525.825 [BackSeatDriver](INFO): Join timeout helper Thread ID is 1042 2020-11-09T23:12:05.916Z,1604963525.916 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:05.916Z,1604963525.916 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.921Z,1604963525.921 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-11-09T23:12:05.921Z,1604963525.921 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:05.921Z,1604963525.921 [Radio_Surface](INFO): Join timeout helper Thread ID is 1043 2020-11-09T23:12:06.300Z,1604963526.300 [Radio_Surface](INFO): Powering down 2020-11-09T23:12:06.301Z,1604963526.301 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:06.301Z,1604963526.301 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.305Z,1604963526.305 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2020-11-09T23:12:06.305Z,1604963526.305 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.305Z,1604963526.305 [Onboard](INFO): Join timeout helper Thread ID is 1044 2020-11-09T23:12:06.536Z,1604963526.536 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:06.536Z,1604963526.536 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.546Z,1604963526.546 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-11-09T23:12:06.546Z,1604963526.546 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.547Z,1604963526.547 [DataOverHttps](INFO): Join timeout helper Thread ID is 1045 2020-11-09T23:12:06.796Z,1604963526.796 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:06.796Z,1604963526.796 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.812Z,1604963526.812 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-11-09T23:12:06.813Z,1604963526.813 [logger ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.813Z,1604963526.813 [logger](INFO): Join timeout helper Thread ID is 1046 2020-11-09T23:12:06.832Z,1604963526.832 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:06.832Z,1604963526.832 [logger ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.852Z,1604963526.852 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-11-09T23:12:06.853Z,1604963526.853 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.853Z,1604963526.853 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-11-09T23:12:06.853Z,1604963526.853 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:06.853Z,1604963526.853 [controlThread](INFO): Join timeout helper Thread ID is 1047 2020-11-09T23:12:06.996Z,1604963526.996 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-11-09T23:12:06.996Z,1604963526.996 [controlThread](DEBUG): Uninitializing ControlThread 2020-11-09T23:12:06.997Z,1604963526.997 [AHRS_M2](INFO): Powering down 2020-11-09T23:12:07.068Z,1604963527.068 [NAL9602](INFO): Powering down 2020-11-09T23:12:07.140Z,1604963527.140 [RDI_Pathfinder](INFO): Powering down 2020-11-09T23:12:07.141Z,1604963527.141 [DAT](INFO): Powering down 2020-11-09T23:12:07.261Z,1604963527.261 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-11-09T23:12:07.262Z,1604963527.262 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-11-09T23:12:07.262Z,1604963527.262 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-11-09T23:12:07.263Z,1604963527.263 [MissionManager](INFO): Uninitializing Mission Default 2020-11-09T23:12:07.263Z,1604963527.263 [Default] Stopped 2020-11-09T23:12:07.263Z,1604963527.263 [Default](DEBUG): Aggregate::uninitialize Default 2020-11-09T23:12:07.263Z,1604963527.263 [Default:B.GoToSurface] Stopped 2020-11-09T23:12:07.263Z,1604963527.263 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-11-09T23:12:07.263Z,1604963527.263 [Default:CheckIn] Stopped 2020-11-09T23:12:07.263Z,1604963527.263 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-11-09T23:12:07.263Z,1604963527.263 [Default:CheckIn:C.Wait] Stopped 2020-11-09T23:12:07.263Z,1604963527.263 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-11-09T23:12:07.266Z,1604963527.266 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-11-09T23:12:07.266Z,1604963527.266 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-11-09T23:12:07.266Z,1604963527.266 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-11-09T23:12:07.266Z,1604963527.266 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-11-09T23:12:07.267Z,1604963527.267 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-11-09T23:12:07.267Z,1604963527.267 [BuoyancyServo](INFO): Powering down 2020-11-09T23:12:07.280Z,1604963527.280 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-11-09T23:12:07.280Z,1604963527.280 [ElevatorServo](INFO): Powering down 2020-11-09T23:12:07.281Z,1604963527.281 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-11-09T23:12:07.281Z,1604963527.281 [MassServo](INFO): Powering down 2020-11-09T23:12:07.282Z,1604963527.282 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-11-09T23:12:07.282Z,1604963527.282 [RudderServo](INFO): Powering down 2020-11-09T23:12:07.282Z,1604963527.282 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-11-09T23:12:07.283Z,1604963527.283 [ThrusterServo](INFO): Powering down 2020-11-09T23:12:07.283Z,1604963527.283 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-11-09T23:12:07.284Z,1604963527.284 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-11-09T23:12:07.284Z,1604963527.284 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-11-09T23:12:07.284Z,1604963527.284 [CBIT](DEBUG): Powering off loads. 2020-11-09T23:12:07.296Z,1604963527.296 [CBIT](DEBUG): Disabling WDT. 2020-11-09T23:12:07.308Z,1604963527.308 [CBIT](DEBUG): Opening all GF detection circuits. 2020-11-09T23:12:07.309Z,1604963527.309 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.396Z,1604963527.396 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.398Z,1604963527.398 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.403Z,1604963527.403 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.461Z,1604963527.461 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.462Z,1604963527.462 [WetLabsUBAT](INFO): WetLabs destructor: _dataLog is not open 2020-11-09T23:12:07.462Z,1604963527.462 [WetLabsUBAT](INFO): WetLabs destructor: done 2020-11-09T23:12:07.470Z,1604963527.470 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.473Z,1604963527.473 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.476Z,1604963527.476 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.486Z,1604963527.486 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-11-09T23:12:07.550Z,1604963527.550 [logger ThreadHandler](INFO): Thread cancelled.