2020-06-08T18:27:17.928Z,1591640837.928 [Supervisor](DEBUG): Initializing supervisor.
2020-06-08T18:27:17.931Z,1591640837.931 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-06-08T18:27:17.932Z,1591640837.932 [SyncHandler](INFO): Protected caller Thread ID is 2780
2020-06-08T18:27:17.933Z,1591640837.933 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-06-08T18:27:17.934Z,1591640837.934 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-06-08T18:27:17.934Z,1591640837.934 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2781
2020-06-08T18:27:17.937Z,1591640837.937 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-06-08T18:27:17.950Z,1591640837.950 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-06-08T18:27:17.951Z,1591640837.951 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-06-08T18:27:17.951Z,1591640837.951 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2782
2020-06-08T18:27:17.952Z,1591640837.952 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-06-08T18:27:17.953Z,1591640837.953 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-06-08T18:27:17.953Z,1591640837.953 [logger ThreadHandler](INFO): Protected caller Thread ID is 2783
2020-06-08T18:27:17.955Z,1591640837.955 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-06-08T18:27:17.955Z,1591640837.955 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-06-08T18:27:17.957Z,1591640837.957 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-06-08T18:27:18.049Z,1591640838.049 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-06-08T18:27:18.050Z,1591640838.050 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-06-08T18:27:18.635Z,1591640838.635 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-06-08T18:27:18.635Z,1591640838.635 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-06-08T18:27:18.825Z,1591640838.825 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-06-08T18:27:18.826Z,1591640838.826 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-06-08T18:27:18.922Z,1591640838.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-06-08T18:27:18.923Z,1591640838.923 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-06-08T18:27:19.022Z,1591640839.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-06-08T18:27:19.023Z,1591640839.023 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-06-08T18:27:19.101Z,1591640839.101 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-06-08T18:27:19.236Z,1591640839.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-06-08T18:27:19.236Z,1591640839.236 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-06-08T18:27:19.523Z,1591640839.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-06-08T18:27:19.523Z,1591640839.523 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-06-08T18:27:19.988Z,1591640839.988 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-06-08T18:27:19.988Z,1591640839.988 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-06-08T18:27:20.256Z,1591640840.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-06-08T18:27:20.256Z,1591640840.256 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-06-08T18:27:20.451Z,1591640840.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-06-08T18:27:20.451Z,1591640840.451 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-06-08T18:27:20.932Z,1591640840.932 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-06-08T18:27:20.933Z,1591640840.933 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-06-08T18:27:21.147Z,1591640841.147 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-06-08T18:27:21.147Z,1591640841.147 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-06-08T18:27:21.349Z,1591640841.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-06-08T18:27:21.349Z,1591640841.349 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-06-08T18:27:21.753Z,1591640841.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-06-08T18:27:21.753Z,1591640841.753 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-06-08T18:27:22.128Z,1591640842.128 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-06-08T18:27:22.130Z,1591640842.130 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-06-08T18:27:22.131Z,1591640842.131 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-06-08T18:27:22.354Z,1591640842.354 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-06-08T18:27:22.643Z,1591640842.643 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-06-08T18:27:22.859Z,1591640842.859 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-06-08T18:27:23.005Z,1591640843.005 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-06-08T18:27:23.103Z,1591640843.103 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-06-08T18:27:23.302Z,1591640843.302 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-06-08T18:27:23.528Z,1591640843.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-06-08T18:27:23.529Z,1591640843.529 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-06-08T18:27:23.621Z,1591640843.621 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-06-08T18:27:23.717Z,1591640843.717 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-06-08T18:27:23.856Z,1591640843.856 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-06-08T18:27:23.955Z,1591640843.955 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2020-06-08T18:27:23.955Z,1591640843.955 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-06-08T18:27:23.966Z,1591640843.966 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-06-08T18:27:24.041Z,1591640844.041 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-06-08T18:27:24.041Z,1591640844.041 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-06-08T18:27:24.089Z,1591640844.089 [VerticalControl](DEBUG): Construct VerticalControl.
2020-06-08T18:27:24.196Z,1591640844.196 [VerticalControl] Loaded
2020-06-08T18:27:24.196Z,1591640844.196 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-06-08T18:27:24.197Z,1591640844.197 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-06-08T18:27:24.274Z,1591640844.274 [HorizontalControl] Loaded
2020-06-08T18:27:24.274Z,1591640844.274 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-06-08T18:27:24.275Z,1591640844.275 [SpeedControl](DEBUG): Construct SpeedControl.
2020-06-08T18:27:24.280Z,1591640844.280 [SpeedControl] Loaded
2020-06-08T18:27:24.281Z,1591640844.281 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-06-08T18:27:24.281Z,1591640844.281 [LoopControl](DEBUG): Construct LoopControl.
2020-06-08T18:27:24.282Z,1591640844.282 [LoopControl] Loaded
2020-06-08T18:27:24.282Z,1591640844.282 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-06-08T18:27:24.282Z,1591640844.282 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-06-08T18:27:24.283Z,1591640844.283 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-06-08T18:27:24.323Z,1591640844.323 [DepthRateCalculator] Loaded
2020-06-08T18:27:24.323Z,1591640844.323 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-06-08T18:27:24.328Z,1591640844.328 [PitchRateCalculator] Loaded
2020-06-08T18:27:24.328Z,1591640844.328 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-06-08T18:27:24.344Z,1591640844.344 [SpeedCalculator] Loaded
2020-06-08T18:27:24.344Z,1591640844.344 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-06-08T18:27:24.364Z,1591640844.364 [TempGradientCalculator] Loaded
2020-06-08T18:27:24.364Z,1591640844.364 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-06-08T18:27:24.369Z,1591640844.369 [YawRateCalculator] Loaded
2020-06-08T18:27:24.370Z,1591640844.370 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-06-08T18:27:24.398Z,1591640844.398 [ElevatorOffsetCalculator] Loaded
2020-06-08T18:27:24.398Z,1591640844.398 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-06-08T18:27:24.399Z,1591640844.399 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-06-08T18:27:24.399Z,1591640844.399 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-06-08T18:27:24.426Z,1591640844.426 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-06-08T18:27:24.426Z,1591640844.426 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-06-08T18:27:24.506Z,1591640844.506 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-06-08T18:27:24.506Z,1591640844.506 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-06-08T18:27:24.786Z,1591640844.786 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-06-08T18:27:24.787Z,1591640844.787 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-06-08T18:27:24.882Z,1591640844.882 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-06-08T18:27:24.882Z,1591640844.882 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-06-08T18:27:25.188Z,1591640845.188 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-06-08T18:27:25.193Z,1591640845.193 [AHRS_M2](INFO): created writer for : platform_orientation
2020-06-08T18:27:25.194Z,1591640845.194 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-06-08T18:27:25.199Z,1591640845.199 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-06-08T18:27:25.200Z,1591640845.200 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-06-08T18:27:25.205Z,1591640845.205 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-06-08T18:27:25.205Z,1591640845.205 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-06-08T18:27:25.211Z,1591640845.211 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-06-08T18:27:25.281Z,1591640845.281 [AHRS_M2] Loaded
2020-06-08T18:27:25.281Z,1591640845.281 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-06-08T18:27:25.356Z,1591640845.356 [DataOverHttps] Loaded
2020-06-08T18:27:25.357Z,1591640845.357 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-06-08T18:27:25.358Z,1591640845.358 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409054E0
2020-06-08T18:27:25.358Z,1591640845.358 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2865
2020-06-08T18:27:25.371Z,1591640845.371 [Depth_Keller] Loaded
2020-06-08T18:27:25.371Z,1591640845.371 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-06-08T18:27:25.465Z,1591640845.465 [NAL9602] Loaded
2020-06-08T18:27:25.465Z,1591640845.465 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-06-08T18:27:25.501Z,1591640845.501 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2020-06-08T18:27:25.501Z,1591640845.501 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2020-06-08T18:27:25.502Z,1591640845.502 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2020-06-08T18:27:25.502Z,1591640845.502 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2020-06-08T18:27:25.503Z,1591640845.503 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2020-06-08T18:27:25.503Z,1591640845.503 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2020-06-08T18:27:25.504Z,1591640845.504 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2020-06-08T18:27:25.504Z,1591640845.504 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2020-06-08T18:27:25.505Z,1591640845.505 [Onboard] Loaded
2020-06-08T18:27:25.505Z,1591640845.505 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-06-08T18:27:25.508Z,1591640845.508 [Radio_Surface] Loaded
2020-06-08T18:27:25.508Z,1591640845.508 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-06-08T18:27:25.509Z,1591640845.509 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0
2020-06-08T18:27:25.510Z,1591640845.510 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2866
2020-06-08T18:27:25.551Z,1591640845.551 [RDI_Pathfinder] Loaded
2020-06-08T18:27:25.552Z,1591640845.552 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-06-08T18:27:25.681Z,1591640845.681 [DAT] Loaded
2020-06-08T18:27:25.681Z,1591640845.681 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-06-08T18:27:27.143Z,1591640847.143 [BPC1] Loaded
2020-06-08T18:27:27.143Z,1591640847.143 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-06-08T18:27:27.144Z,1591640847.144 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-06-08T18:27:27.144Z,1591640847.144 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-06-08T18:27:27.467Z,1591640847.467 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-06-08T18:27:27.467Z,1591640847.467 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-06-08T18:27:27.489Z,1591640847.489 [NavChart] Loaded
2020-06-08T18:27:27.489Z,1591640847.489 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-06-08T18:27:27.493Z,1591640847.493 [UniversalFixResidualReporter] Loaded
2020-06-08T18:27:27.493Z,1591640847.493 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-06-08T18:27:27.494Z,1591640847.494 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-06-08T18:27:27.494Z,1591640847.494 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-06-08T18:27:27.712Z,1591640847.712 [SBIT](DEBUG): Construct Startup Built In Test.
2020-06-08T18:27:27.722Z,1591640847.722 [SBIT] Loaded
2020-06-08T18:27:27.723Z,1591640847.723 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-06-08T18:27:27.723Z,1591640847.723 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-06-08T18:27:27.736Z,1591640847.736 [IBIT] Loaded
2020-06-08T18:27:27.736Z,1591640847.736 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-06-08T18:27:27.739Z,1591640847.739 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-06-08T18:27:27.872Z,1591640847.872 [CBIT] Loaded
2020-06-08T18:27:27.873Z,1591640847.873 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-06-08T18:27:27.873Z,1591640847.873 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-06-08T18:27:27.873Z,1591640847.873 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-06-08T18:27:27.971Z,1591640847.971 [ElevatorServo] Loaded
2020-06-08T18:27:27.971Z,1591640847.971 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-06-08T18:27:27.981Z,1591640847.981 [MassServo] Loaded
2020-06-08T18:27:27.982Z,1591640847.982 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-06-08T18:27:27.992Z,1591640847.992 [RudderServo] Loaded
2020-06-08T18:27:27.993Z,1591640847.993 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-06-08T18:27:28.003Z,1591640848.003 [ThrusterServo] Loaded
2020-06-08T18:27:28.003Z,1591640848.003 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-06-08T18:27:28.004Z,1591640848.004 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-06-08T18:27:28.004Z,1591640848.004 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-06-08T18:27:28.022Z,1591640848.022 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-06-08T18:27:28.023Z,1591640848.023 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-06-08T18:27:28.238Z,1591640848.238 [BackSeatDriver] Loaded
2020-06-08T18:27:28.238Z,1591640848.238 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread.
2020-06-08T18:27:28.239Z,1591640848.239 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40ACB4E0
2020-06-08T18:27:28.239Z,1591640848.239 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 2867
2020-06-08T18:27:28.249Z,1591640848.249 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-06-08T18:27:28.254Z,1591640848.254 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-06-08T18:27:28.254Z,1591640848.254 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-06-08T18:27:28.259Z,1591640848.259 [CTD_Seabird](INFO): created writer for : depth
2020-06-08T18:27:28.260Z,1591640848.260 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-06-08T18:27:28.264Z,1591640848.264 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-06-08T18:27:28.265Z,1591640848.265 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-06-08T18:27:28.270Z,1591640848.270 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-06-08T18:27:28.271Z,1591640848.271 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-06-08T18:27:28.275Z,1591640848.275 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-06-08T18:27:28.276Z,1591640848.276 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-06-08T18:27:28.281Z,1591640848.281 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-06-08T18:27:28.282Z,1591640848.282 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-06-08T18:27:28.287Z,1591640848.287 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-06-08T18:27:28.313Z,1591640848.313 [CTD_Seabird] Loaded
2020-06-08T18:27:28.313Z,1591640848.313 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-06-08T18:27:28.314Z,1591640848.314 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AFB4E0
2020-06-08T18:27:28.315Z,1591640848.315 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2868
2020-06-08T18:27:28.321Z,1591640848.321 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-06-08T18:27:28.321Z,1591640848.321 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-06-08T18:27:28.325Z,1591640848.325 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-06-08T18:27:28.325Z,1591640848.325 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-06-08T18:27:28.329Z,1591640848.329 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-06-08T18:27:28.330Z,1591640848.330 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-06-08T18:27:28.334Z,1591640848.334 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-06-08T18:27:28.334Z,1591640848.334 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-06-08T18:27:28.338Z,1591640848.338 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-06-08T18:27:28.338Z,1591640848.338 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-06-08T18:27:28.342Z,1591640848.342 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-06-08T18:27:28.342Z,1591640848.342 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-06-08T18:27:28.346Z,1591640848.346 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-06-08T18:27:28.347Z,1591640848.347 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-06-08T18:27:28.350Z,1591640848.350 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.355Z,1591640848.355 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.355Z,1591640848.355 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.356Z,1591640848.356 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.360Z,1591640848.360 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.360Z,1591640848.360 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.364Z,1591640848.364 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.364Z,1591640848.364 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T18:27:28.368Z,1591640848.368 [WetLabsBB2FL] Loaded
2020-06-08T18:27:28.369Z,1591640848.369 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-06-08T18:27:28.370Z,1591640848.370 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B2B4E0
2020-06-08T18:27:28.370Z,1591640848.370 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2869
2020-06-08T18:27:28.371Z,1591640848.371 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-06-08T18:27:28.374Z,1591640848.374 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-06-08T18:27:28.375Z,1591640848.375 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-06-08T18:27:28.382Z,1591640848.382 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-06-08T18:27:28.383Z,1591640848.383 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B5B4E0
2020-06-08T18:27:28.383Z,1591640848.383 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2870
2020-06-08T18:27:28.387Z,1591640848.387 [Supervisor](INFO): Main Thread ID is 2243
2020-06-08T18:27:28.388Z,1591640848.388 [Supervisor](DEBUG): Running supervisor.
2020-06-08T18:27:28.388Z,1591640848.388 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2871
2020-06-08T18:27:28.391Z,1591640848.391 [controlThread ThreadHandler](INFO): Handler Thread ID is 2872
2020-06-08T18:27:28.391Z,1591640848.391 [controlThread](DEBUG): Initializing ControlThread
2020-06-08T18:27:28.392Z,1591640848.392 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-06-08T18:27:28.394Z,1591640848.394 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-06-08T18:27:28.394Z,1591640848.394 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-06-08T18:27:28.395Z,1591640848.395 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-06-08T18:27:28.395Z,1591640848.395 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-06-08T18:27:28.396Z,1591640848.396 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-06-08T18:27:28.396Z,1591640848.396 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-06-08T18:27:28.396Z,1591640848.396 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-06-08T18:27:28.397Z,1591640848.397 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-06-08T18:27:28.397Z,1591640848.397 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-06-08T18:27:28.404Z,1591640848.404 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-06-08T18:27:28.404Z,1591640848.404 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-06-08T18:27:28.404Z,1591640848.404 [SBIT](INFO): Initialize SBIT Component.
2020-06-08T18:27:28.405Z,1591640848.405 [SBIT](IMPORTANT): git: 2020-05-06_C-20-ge0f639e
2020-06-08T18:27:28.405Z,1591640848.405 [SBIT](INFO): git hash: e0f639ec5017482b41982bca3db784e9d0ef310d
2020-06-08T18:27:28.405Z,1591640848.405 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-06-08T18:27:28.405Z,1591640848.405 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2020-06-08T18:27:28.407Z,1591640848.407 [SBIT](INFO): Beginning SBIT in 76.000000 seconds.
2020-06-08T18:27:28.407Z,1591640848.407 [IBIT](INFO): Initialize IBIT Component.
2020-06-08T18:27:28.408Z,1591640848.408 [CBIT](DEBUG): Initialize CBIT Component.
2020-06-08T18:27:28.409Z,1591640848.409 [logger ThreadHandler](INFO): Handler Thread ID is 2873
2020-06-08T18:27:28.422Z,1591640848.422 [CBIT](DEBUG): Initialized mux pins.
2020-06-08T18:27:28.422Z,1591640848.422 [CBIT](DEBUG): Initializing the watchdog timer.
2020-06-08T18:27:28.426Z,1591640848.426 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2874
2020-06-08T18:27:28.427Z,1591640848.427 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-06-08T18:27:28.434Z,1591640848.434 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2875
2020-06-08T18:27:28.442Z,1591640848.442 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 2876
2020-06-08T18:27:28.446Z,1591640848.446 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-06-08T18:27:28.446Z,1591640848.446 [CBIT](DEBUG): Initializing heartbeat.
2020-06-08T18:27:28.454Z,1591640848.454 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2877
2020-06-08T18:27:28.455Z,1591640848.455 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-06-08T18:27:28.460Z,1591640848.460 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2879
2020-06-08T18:27:28.460Z,1591640848.460 [WetLabsBB2FL](INFO): Powering down
2020-06-08T18:27:28.498Z,1591640848.498 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2880
2020-06-08T18:27:28.501Z,1591640848.501 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-06-08T18:27:28.501Z,1591640848.501 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-06-08T18:27:28.502Z,1591640848.502 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-06-08T18:27:28.502Z,1591640848.502 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-06-08T18:27:28.502Z,1591640848.502 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-06-08T18:27:28.502Z,1591640848.502 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-06-08T18:27:28.503Z,1591640848.503 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-06-08T18:27:28.504Z,1591640848.504 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-06-08T18:27:28.504Z,1591640848.504 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-06-08T18:27:28.504Z,1591640848.504 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-06-08T18:27:28.518Z,1591640848.518 [CBIT](DEBUG): Deactivating GF circuits.
2020-06-08T18:27:28.518Z,1591640848.518 [CBIT](DEBUG): Deactivating emergency mode.
2020-06-08T18:27:28.554Z,1591640848.554 [CBIT](DEBUG): Backplane powered.
2020-06-08T18:27:28.556Z,1591640848.556 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-06-08T18:27:28.565Z,1591640848.565 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-06-08T18:27:28.577Z,1591640848.577 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2020-06-08T18:27:28.577Z,1591640848.577 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-06-08T18:27:28.659Z,1591640848.659 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-06-08T18:27:28.660Z,1591640848.660 [Default:A.Wait](DEBUG): Construct Wait.
2020-06-08T18:27:28.678Z,1591640848.678 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-06-08T18:27:28.701Z,1591640848.701 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-06-08T18:27:28.704Z,1591640848.704 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-06-08T18:27:28.729Z,1591640848.729 [Default:E.Execute](DEBUG): Construct Execute.
2020-06-08T18:27:28.732Z,1591640848.732 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2020-06-08T18:27:28.752Z,1591640848.752 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,Onboard,RDI_Pathfinder,DAT,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-06-08T18:27:28.770Z,1591640848.770 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-06-08T18:27:28.803Z,1591640848.803 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-06-08T18:27:28.833Z,1591640848.833 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-06-08T18:27:28.833Z,1591640848.833 [DAT](INFO): Powering up
2020-06-08T18:27:28.833Z,1591640848.833 [DAT](DEBUG): Initializing DAT.
2020-06-08T18:27:28.838Z,1591640848.838 [Radio_Surface](INFO): Powering up
2020-06-08T18:27:28.894Z,1591640848.894 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-06-08T18:27:28.912Z,1591640848.912 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-06-08T18:27:28.913Z,1591640848.913 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-06-08T18:27:28.927Z,1591640848.927 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-06-08T18:27:28.929Z,1591640848.929 [MassServo](DEBUG): Initializing EZServoServo.
2020-06-08T18:27:28.954Z,1591640848.954 [MassServo](DEBUG): Initializing MassServo.
2020-06-08T18:27:28.956Z,1591640848.956 [RudderServo](DEBUG): Initializing EZServoServo.
2020-06-08T18:27:28.970Z,1591640848.970 [RudderServo](DEBUG): Initializing RudderServo.
2020-06-08T18:27:28.971Z,1591640848.971 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-06-08T18:27:28.986Z,1591640848.986 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-06-08T18:27:29.222Z,1591640849.222 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-06-08T18:27:29.894Z,1591640849.894 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-06-08T18:27:29.894Z,1591640849.894 [RudderServo](FAULT): Rudder failed to initialize
2020-06-08T18:27:29.894Z,1591640849.894 [RudderServo] Communications Fault, FailCount= 1
2020-06-08T18:27:29.894Z,1591640849.894 [RudderServo](ERROR): Communications Fault
2020-06-08T18:27:30.005Z,1591640850.005 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-06-08T18:27:30.113Z,1591640850.113 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-06-08T18:27:30.114Z,1591640850.114 [RudderServo](INFO): Powering down
2020-06-08T18:27:30.849Z,1591640850.849 [RudderServo](DEBUG): Initializing EZServoServo.
2020-06-08T18:27:30.967Z,1591640850.967 [RudderServo](DEBUG): Initializing RudderServo.
2020-06-08T18:27:30.971Z,1591640850.971 [CBIT](INFO): Clearing failed state for component RudderServo
2020-06-08T18:27:30.971Z,1591640850.971 [RudderServo] No Fault, FailCount= 1
2020-06-08T18:27:41.375Z,1591640861.375 [DAT](INFO): commRate: 800
2020-06-08T18:27:41.375Z,1591640861.375 [DAT](INFO): commRate: 800
2020-06-08T18:27:41.750Z,1591640861.750 [DAT](INFO): entering command mode
2020-06-08T18:27:42.163Z,1591640862.163 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:42.569Z,1591640862.569 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:42.962Z,1591640862.962 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:43.375Z,1591640863.375 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:43.781Z,1591640863.781 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:44.173Z,1591640864.173 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:44.578Z,1591640864.578 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:45.002Z,1591640865.002 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:45.386Z,1591640865.386 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:45.790Z,1591640865.790 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:46.205Z,1591640866.205 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:46.609Z,1591640866.609 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:47.002Z,1591640867.002 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:47.426Z,1591640867.426 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:47.811Z,1591640867.811 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:48.215Z,1591640868.215 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:48.631Z,1591640868.631 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:49.021Z,1591640869.021 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:49.437Z,1591640869.437 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:49.830Z,1591640869.830 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:50.234Z,1591640870.234 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:50.649Z,1591640870.649 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:51.043Z,1591640871.043 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:51.464Z,1591640871.464 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:51.846Z,1591640871.846 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T18:27:51.847Z,1591640871.847 [DAT](FAULT): failed to enter command mode
2020-06-08T18:27:52.250Z,1591640872.250 [DAT](INFO): entering command mode
2020-06-08T18:27:52.670Z,1591640872.670 [DAT](INFO): setting verbose to 3
2020-06-08T18:27:53.069Z,1591640873.069 [DAT](INFO): set verbose to 3
2020-06-08T18:27:53.069Z,1591640873.069 [DAT](INFO): setting DatVerbose to 27440
2020-06-08T18:27:53.463Z,1591640873.463 [DAT](INFO): set DatVerbose to 27440
2020-06-08T18:27:53.463Z,1591640873.463 [DAT](INFO): setting transmit power to 8
2020-06-08T18:27:53.911Z,1591640873.911 [DAT](INFO): set transmit power to 8
2020-06-08T18:27:53.912Z,1591640873.912 [DAT](INFO): setting local address to 9
2020-06-08T18:27:54.291Z,1591640874.291 [DAT](INFO): set local address to 9
2020-06-08T18:27:55.471Z,1591640875.471 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:28:06.383Z,1591640886.383 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:28:44.791Z,1591640924.791 [SBIT](IMPORTANT): Beginning Startup BIT
2020-06-08T18:28:44.795Z,1591640924.795 [CBIT](IMPORTANT): Beginning ground fault scan
2020-06-08T18:28:55.939Z,1591640935.939 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.027552
CHAN A1 (24V): 0.036607
CHAN A2 (12V): -0.007644
CHAN A3 (5V): -0.001872
CHAN B0 (3.3V): 0.000229
CHAN B1 (3.15aV): -0.000452
CHAN B2 (3.15bV): 0.000233
CHAN B3 (GND): 0.001613
OPEN: 0.005112
Full Scale Calc: 4.765 mA, -1.589 mA
2020-06-08T18:29:37.353Z,1591640977.353 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-06-08T18:29:38.177Z,1591640978.177 [SBIT](IMPORTANT): SBIT PASSED
2020-06-08T18:29:38.177Z,1591640978.177 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-06-08T18:29:38.178Z,1591640978.178 [SBIT](IMPORTANT): BuoyancyServo.loadAtStartup=0 bool;

2020-06-08T18:29:38.178Z,1591640978.178 [SBIT](IMPORTANT): DataOverHttps.verbosity=0 count;

2020-06-08T18:29:38.178Z,1591640978.178 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=15 ampere_hour;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=413.311030 cubic_centimeter;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): VerticalControl.massDefault=-14.023880 millimeter;

2020-06-08T18:29:38.179Z,1591640978.179 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool;

2020-06-08T18:29:38.568Z,1591640978.568 [MissionManager](IMPORTANT): Started mission Startup
2020-06-08T18:29:38.568Z,1591640978.568 [Startup] Running Loop=1
2020-06-08T18:29:38.568Z,1591640978.568 [Startup](DEBUG): Aggregate::initialize Startup
2020-06-08T18:29:38.568Z,1591640978.568 [Startup:A.GoToSurface] Running Loop=1
2020-06-08T18:29:38.568Z,1591640978.568 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-06-08T18:29:38.569Z,1591640978.569 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-06-08T18:29:38.570Z,1591640978.570 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-06-08T18:29:38.570Z,1591640978.570 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-06-08T18:29:38.570Z,1591640978.570 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-06-08T18:29:38.571Z,1591640978.571 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-06-08T18:29:38.572Z,1591640978.572 [Startup:StartupSatComms] Running Loop=1
2020-06-08T18:29:38.572Z,1591640978.572 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-06-08T18:29:38.572Z,1591640978.572 [Startup:StartupSatComms:A] Running Loop=1
2020-06-08T18:29:38.964Z,1591640978.964 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-06-08T18:29:56.541Z,1591640996.541 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005444
2020-06-08T18:30:28.688Z,1591641028.688 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-06-08T18:30:28.688Z,1591641028.688 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:30:28.746Z,1591641028.746 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:30:29.291Z,1591641029.291 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:30:29.292Z,1591641029.292 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-06-08T18:30:38.743Z,1591641038.743 [Startup:StartupSatComms:A](INFO): Timed out from 2020-06-08T18:29:38.6Z
2020-06-08T18:30:38.743Z,1591641038.743 [Startup:StartupSatComms:A] Stopped
2020-06-08T18:30:38.743Z,1591641038.743 [Startup:StartupSatComms:B] Running Loop=1
2020-06-08T18:30:39.151Z,1591641039.151 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-06-08T18:30:46.315Z,1591641046.315 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20200608T181819/Courier0004.lzma
2020-06-08T18:30:47.319Z,1591641047.319 [DataOverHttps](INFO): Moved sent file to Logs/20200608T181819/Courier0004.lzma.bak
2020-06-08T18:30:47.319Z,1591641047.319 [DataOverHttps](INFO): SBD MOMSN=12372661
2020-06-08T18:31:03.294Z,1591641063.294 [DataOverHttps](INFO): Sending 397 bytes from file Logs/20200608T181819/Express0005.lzma
2020-06-08T18:31:04.296Z,1591641064.296 [DataOverHttps](INFO): Moved sent file to Logs/20200608T181819/Express0005.lzma.bak
2020-06-08T18:31:04.296Z,1591641064.296 [DataOverHttps](INFO): SBD MOMSN=12372664
2020-06-08T18:31:21.900Z,1591641081.900 [DataOverHttps](INFO): Sending 994 bytes from file Logs/20200608T182717/Express0001.lzma
2020-06-08T18:31:22.900Z,1591641082.900 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0001.lzma.bak
2020-06-08T18:31:22.900Z,1591641082.900 [DataOverHttps](INFO): SBD MOMSN=12372684
2020-06-08T18:31:24.838Z,1591641084.838 [Startup:StartupSatComms:B] Stopped
2020-06-08T18:31:24.838Z,1591641084.838 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-06-08T18:31:24.838Z,1591641084.838 [Startup:StartupSatComms] Stopped
2020-06-08T18:31:24.838Z,1591641084.838 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-06-08T18:31:24.839Z,1591641084.839 [Startup](INFO): Completed Startup
2020-06-08T18:31:24.839Z,1591641084.839 [MissionManager](INFO): Startup is completed.
2020-06-08T18:31:24.839Z,1591641084.839 [MissionManager](INFO): Uninitializing Mission Startup
2020-06-08T18:31:24.839Z,1591641084.839 [Startup] Stopped
2020-06-08T18:31:24.839Z,1591641084.839 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-06-08T18:31:24.839Z,1591641084.839 [Startup:A.GoToSurface] Stopped
2020-06-08T18:31:24.839Z,1591641084.839 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-06-08T18:31:25.205Z,1591641085.205 [MissionManager](IMPORTANT): Started mission Default
2020-06-08T18:31:25.206Z,1591641085.206 [Default] Running Loop=1
2020-06-08T18:31:25.206Z,1591641085.206 [Default](DEBUG): Aggregate::initialize Default
2020-06-08T18:31:25.206Z,1591641085.206 [Default:B.GoToSurface] Running Loop=1
2020-06-08T18:31:25.206Z,1591641085.206 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-06-08T18:31:25.206Z,1591641085.206 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-06-08T18:31:25.207Z,1591641085.207 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-06-08T18:31:25.207Z,1591641085.207 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-06-08T18:31:25.207Z,1591641085.207 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-06-08T18:31:25.208Z,1591641085.208 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-06-08T18:31:25.208Z,1591641085.208 [Default:A.Wait] Running Loop=1
2020-06-08T18:31:25.208Z,1591641085.208 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:31:38.571Z,1591641098.571 [Default:A.Wait](INFO): Done Waiting.
2020-06-08T18:31:38.571Z,1591641098.571 [Default:A.Wait] Stopped
2020-06-08T18:31:38.572Z,1591641098.572 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:31:38.978Z,1591641098.978 [Default:CheckIn] Running Loop=1
2020-06-08T18:31:38.978Z,1591641098.978 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:31:38.979Z,1591641098.979 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:31:39.363Z,1591641099.363 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-06-08T18:33:09.816Z,1591641189.816 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-06-08T18:33:29.664Z,1591641209.664 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-06-08T18:33:29.664Z,1591641209.664 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:33:29.677Z,1591641209.677 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:33:30.076Z,1591641210.076 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:33:30.076Z,1591641210.076 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-06-08T18:34:44.799Z,1591641284.799 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T18:34:44.802Z,1591641284.802 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T18:36:30.637Z,1591641390.637 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-06-08T18:36:30.637Z,1591641390.637 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:36:30.647Z,1591641390.647 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:36:31.046Z,1591641391.046 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:36:31.046Z,1591641391.046 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-06-08T18:36:39.123Z,1591641399.123 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:31:38.0Z
2020-06-08T18:36:39.123Z,1591641399.123 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:36:39.123Z,1591641399.123 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:36:39.536Z,1591641399.536 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-06-08T18:36:46.021Z,1591641406.021 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20200608T182717/Courier0004.lzma
2020-06-08T18:36:47.024Z,1591641407.024 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Courier0004.lzma.bak
2020-06-08T18:36:47.024Z,1591641407.024 [DataOverHttps](INFO): SBD MOMSN=12372732
2020-06-08T18:37:02.986Z,1591641422.986 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20200608T182717/Express0005.lzma
2020-06-08T18:37:03.988Z,1591641423.988 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0005.lzma.bak
2020-06-08T18:37:03.988Z,1591641423.988 [DataOverHttps](INFO): SBD MOMSN=12372734
2020-06-08T18:37:05.875Z,1591641425.875 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:37:05.875Z,1591641425.875 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:37:05.875Z,1591641425.875 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:38:08.040Z,1591641488.040 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:38:08.040Z,1591641488.040 [NAL9602] Data Fault, FailCount= 1
2020-06-08T18:38:08.040Z,1591641488.040 [NAL9602](ERROR): Data Fault
2020-06-08T18:38:08.095Z,1591641488.095 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:38:08.453Z,1591641488.453 [NAL9602](INFO): Powering down
2020-06-08T18:38:09.315Z,1591641489.315 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:38:09.315Z,1591641489.315 [NAL9602] No Fault, FailCount= 1
2020-06-08T18:38:38.747Z,1591641518.747 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:38:49.659Z,1591641529.659 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:39:31.723Z,1591641571.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-06-08T18:39:31.723Z,1591641571.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:39:31.741Z,1591641571.741 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:39:32.111Z,1591641572.111 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:39:32.111Z,1591641572.111 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-06-08T18:42:06.456Z,1591641726.456 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:42:06.456Z,1591641726.456 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:42:06.456Z,1591641726.456 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:42:06.456Z,1591641726.456 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:42:06.847Z,1591641726.847 [Default:CheckIn:D] Stopped
2020-06-08T18:42:06.847Z,1591641726.847 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.694029 min 
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn:E] Stopped
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn] Stopped
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn](INFO): Running loop #2
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn] Running Loop=2
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:42:07.241Z,1591641727.241 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:42:32.701Z,1591641752.701 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-06-08T18:42:32.701Z,1591641752.701 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:42:32.713Z,1591641752.713 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:42:33.127Z,1591641753.127 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:42:33.127Z,1591641753.127 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-06-08T18:45:33.718Z,1591641933.718 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-06-08T18:45:33.718Z,1591641933.718 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:45:33.744Z,1591641933.744 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:45:34.110Z,1591641934.110 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:45:34.111Z,1591641934.111 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-06-08T18:47:07.431Z,1591642027.431 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:42:07.2Z
2020-06-08T18:47:07.431Z,1591642027.431 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:47:07.431Z,1591642027.431 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:47:14.726Z,1591642034.726 [DataOverHttps](INFO): Sending 289 bytes from file Logs/20200608T182717/Express0008.lzma
2020-06-08T18:47:15.728Z,1591642035.728 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0008.lzma.bak
2020-06-08T18:47:15.728Z,1591642035.728 [DataOverHttps](INFO): SBD MOMSN=12372757
2020-06-08T18:47:17.535Z,1591642037.535 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:47:17.535Z,1591642037.535 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:47:17.535Z,1591642037.535 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:48:34.704Z,1591642114.704 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-06-08T18:48:34.704Z,1591642114.704 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:48:34.713Z,1591642114.713 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:48:35.111Z,1591642115.111 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:48:35.111Z,1591642115.111 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-06-08T18:48:50.838Z,1591642130.838 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:48:50.838Z,1591642130.838 [NAL9602] Data Fault, FailCount= 2
2020-06-08T18:48:50.838Z,1591642130.838 [NAL9602](ERROR): Data Fault
2020-06-08T18:48:50.931Z,1591642130.931 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:48:51.215Z,1591642131.215 [NAL9602](INFO): Powering down
2020-06-08T18:48:52.068Z,1591642132.068 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:48:52.069Z,1591642132.069 [NAL9602] No Fault, FailCount= 2
2020-06-08T18:49:21.520Z,1591642161.520 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:49:32.423Z,1591642172.423 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:51:02.968Z,1591642262.968 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-06-08T18:51:35.690Z,1591642295.690 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-06-08T18:51:35.690Z,1591642295.690 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:51:35.704Z,1591642295.704 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:51:36.112Z,1591642296.112 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:51:36.112Z,1591642296.112 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-06-08T18:52:18.109Z,1591642338.109 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:52:18.109Z,1591642338.109 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:52:18.109Z,1591642338.109 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:52:18.109Z,1591642338.109 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:52:18.529Z,1591642338.529 [Default:CheckIn:D] Stopped
2020-06-08T18:52:18.529Z,1591642338.529 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:52:18.915Z,1591642338.915 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.888727 min 
2020-06-08T18:52:18.915Z,1591642338.915 [Default:CheckIn:E] Stopped
2020-06-08T18:52:18.915Z,1591642338.915 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:52:18.915Z,1591642338.915 [Default:CheckIn] Stopped
2020-06-08T18:52:18.915Z,1591642338.915 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:52:18.916Z,1591642338.916 [Default:CheckIn](INFO): Running loop #3
2020-06-08T18:52:18.916Z,1591642338.916 [Default:CheckIn] Running Loop=3
2020-06-08T18:52:18.916Z,1591642338.916 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:52:18.916Z,1591642338.916 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:54:36.683Z,1591642476.683 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2020-06-08T18:54:36.683Z,1591642476.683 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:54:36.693Z,1591642476.693 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:54:37.074Z,1591642477.074 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:54:37.074Z,1591642477.074 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2020-06-08T18:57:19.073Z,1591642639.073 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:52:18.9Z
2020-06-08T18:57:19.073Z,1591642639.073 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:57:19.073Z,1591642639.073 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:57:26.166Z,1591642646.166 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20200608T182717/Express0011.lzma
2020-06-08T18:57:27.168Z,1591642647.168 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0011.lzma.bak
2020-06-08T18:57:27.168Z,1591642647.168 [DataOverHttps](INFO): SBD MOMSN=12372808
2020-06-08T18:57:28.785Z,1591642648.785 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:57:28.785Z,1591642648.785 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:57:28.786Z,1591642648.786 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:57:37.652Z,1591642657.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2020-06-08T18:57:37.652Z,1591642657.652 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:57:37.661Z,1591642657.661 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:57:38.089Z,1591642658.089 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:57:38.090Z,1591642658.090 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2020-06-08T18:59:33.975Z,1591642773.975 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:59:33.975Z,1591642773.975 [NAL9602] Data Fault, FailCount= 3
2020-06-08T18:59:33.975Z,1591642773.975 [NAL9602](ERROR): Data Fault
2020-06-08T18:59:34.031Z,1591642774.031 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:59:34.383Z,1591642774.383 [NAL9602](INFO): Powering down
2020-06-08T18:59:35.227Z,1591642775.227 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:59:35.227Z,1591642775.227 [NAL9602] No Fault, FailCount= 3
2020-06-08T19:00:04.687Z,1591642804.687 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:00:15.595Z,1591642815.595 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:00:38.674Z,1591642838.674 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2020-06-08T19:00:38.674Z,1591642838.674 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:00:38.692Z,1591642838.692 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:00:39.062Z,1591642839.062 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:00:39.062Z,1591642839.062 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2020-06-08T19:02:29.357Z,1591642949.357 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:02:29.357Z,1591642949.357 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:02:29.357Z,1591642949.357 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:02:29.357Z,1591642949.357 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:02:29.774Z,1591642949.774 [Default:CheckIn:D] Stopped
2020-06-08T19:02:29.774Z,1591642949.774 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:02:30.172Z,1591642950.172 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.076131 min 
2020-06-08T19:02:30.172Z,1591642950.172 [Default:CheckIn:E] Stopped
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn] Stopped
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn](INFO): Running loop #4
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn] Running Loop=4
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:02:30.173Z,1591642950.173 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:03:39.681Z,1591643019.681 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2020-06-08T19:03:39.681Z,1591643019.681 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:03:39.714Z,1591643019.714 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:03:40.074Z,1591643020.074 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:03:40.074Z,1591643020.074 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2020-06-08T19:06:28.924Z,1591643188.924 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T19:06:40.651Z,1591643200.651 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2020-06-08T19:06:40.651Z,1591643200.651 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:06:40.661Z,1591643200.661 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:06:41.062Z,1591643201.062 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:06:41.062Z,1591643201.062 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2020-06-08T19:07:30.382Z,1591643250.382 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:02:30.2Z
2020-06-08T19:07:30.382Z,1591643250.382 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:07:30.382Z,1591643250.382 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:07:37.989Z,1591643257.989 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20200608T182717/Express0014.lzma
2020-06-08T19:07:38.992Z,1591643258.992 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0014.lzma.bak
2020-06-08T19:07:38.992Z,1591643258.992 [DataOverHttps](INFO): SBD MOMSN=12372827
2020-06-08T19:07:40.851Z,1591643260.851 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:07:40.852Z,1591643260.852 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:07:40.852Z,1591643260.852 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:09:41.663Z,1591643381.663 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2020-06-08T19:09:41.664Z,1591643381.664 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:09:41.673Z,1591643381.673 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:09:42.043Z,1591643382.043 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:09:42.043Z,1591643382.043 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2020-06-08T19:10:16.755Z,1591643416.755 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:10:16.755Z,1591643416.755 [NAL9602] Data Fault, FailCount= 4
2020-06-08T19:10:16.755Z,1591643416.755 [NAL9602](ERROR): Data Fault
2020-06-08T19:10:16.823Z,1591643416.823 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:10:17.159Z,1591643417.159 [NAL9602](INFO): Powering down
2020-06-08T19:10:18.006Z,1591643418.006 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:10:18.007Z,1591643418.007 [NAL9602] No Fault, FailCount= 4
2020-06-08T19:10:47.463Z,1591643447.463 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:10:58.371Z,1591643458.371 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:11:09.721Z,1591643469.721 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T19:12:41.451Z,1591643561.451 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:12:41.451Z,1591643561.451 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:12:41.452Z,1591643561.452 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:12:41.452Z,1591643561.452 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:12:41.832Z,1591643561.832 [Default:CheckIn:D] Stopped
2020-06-08T19:12:41.832Z,1591643561.832 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.277100 min 
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn:E] Stopped
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn] Stopped
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn](INFO): Running loop #5
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn] Running Loop=5
2020-06-08T19:12:42.248Z,1591643562.248 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:12:42.249Z,1591643562.249 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:12:42.652Z,1591643562.652 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2020-06-08T19:12:42.652Z,1591643562.652 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:12:42.673Z,1591643562.673 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:12:43.054Z,1591643563.054 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:12:43.054Z,1591643563.054 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2020-06-08T19:15:43.637Z,1591643743.637 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2020-06-08T19:15:43.637Z,1591643743.637 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:15:43.670Z,1591643743.670 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:15:44.053Z,1591643744.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:15:44.053Z,1591643744.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2020-06-08T19:17:42.424Z,1591643862.424 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:12:42.2Z
2020-06-08T19:17:42.424Z,1591643862.424 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:17:42.424Z,1591643862.424 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:17:49.717Z,1591643869.717 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T182717/Express0017.lzma
2020-06-08T19:17:50.720Z,1591643870.720 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0017.lzma.bak
2020-06-08T19:17:50.720Z,1591643870.720 [DataOverHttps](INFO): SBD MOMSN=12372846
2020-06-08T19:17:52.522Z,1591643872.522 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:17:52.523Z,1591643872.523 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:17:52.523Z,1591643872.523 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:18:44.621Z,1591643924.621 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2020-06-08T19:18:44.621Z,1591643924.621 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:18:44.631Z,1591643924.631 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:18:45.058Z,1591643925.058 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:18:45.058Z,1591643925.058 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2020-06-08T19:20:59.945Z,1591644059.945 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:20:59.945Z,1591644059.945 [NAL9602] Data Fault, FailCount= 5
2020-06-08T19:20:59.945Z,1591644059.945 [NAL9602](ERROR): Data Fault
2020-06-08T19:21:00.026Z,1591644060.026 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:21:00.027Z,1591644060.027 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T19:21:00.342Z,1591644060.342 [NAL9602](INFO): Powering down
2020-06-08T19:21:00.405Z,1591644060.405 [CommandLine](FAULT): Scheduling is paused
2020-06-08T19:21:00.406Z,1591644060.406 [CBIT](INFO): Critical error at 20200608T192100
2020-06-08T19:21:00.406Z,1591644060.406 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-06-08T19:21:45.617Z,1591644105.617 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2020-06-08T19:21:45.617Z,1591644105.617 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:21:45.627Z,1591644105.627 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:21:46.014Z,1591644106.014 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:21:46.015Z,1591644106.015 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2020-06-08T19:22:53.079Z,1591644173.079 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:22:53.079Z,1591644173.079 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:22:53.079Z,1591644173.079 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:22:53.079Z,1591644173.079 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:22:53.489Z,1591644173.489 [Default:CheckIn:D] Stopped
2020-06-08T19:22:53.489Z,1591644173.489 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.471391 min 
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn:E] Stopped
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn] Stopped
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn](INFO): Running loop #6
2020-06-08T19:22:53.887Z,1591644173.887 [Default:CheckIn] Running Loop=6
2020-06-08T19:22:53.888Z,1591644173.888 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:22:53.888Z,1591644173.888 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:22:59.951Z,1591644179.951 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:22:59.951Z,1591644179.951 [NAL9602] No Fault, FailCount= 5
2020-06-08T19:23:00.330Z,1591644180.330 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:23:11.231Z,1591644191.231 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:24:46.608Z,1591644286.608 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2020-06-08T19:24:46.608Z,1591644286.608 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:24:46.617Z,1591644286.617 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:24:47.019Z,1591644287.019 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:24:47.019Z,1591644287.019 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2020-06-08T19:27:47.619Z,1591644467.619 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2020-06-08T19:27:47.619Z,1591644467.619 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:27:47.629Z,1591644467.629 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:27:48.006Z,1591644468.006 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:27:48.006Z,1591644468.006 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2020-06-08T19:27:54.051Z,1591644474.051 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:22:53.9Z
2020-06-08T19:27:54.051Z,1591644474.051 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:27:54.051Z,1591644474.051 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:28:01.185Z,1591644481.185 [DataOverHttps](INFO): Sending 93 bytes from file Logs/20200608T182717/Courier0019.lzma
2020-06-08T19:28:02.184Z,1591644482.184 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Courier0019.lzma.bak
2020-06-08T19:28:02.184Z,1591644482.184 [DataOverHttps](INFO): SBD MOMSN=12372861
2020-06-08T19:28:02.557Z,1591644482.557 [RDI_Pathfinder](ERROR): only read 1 of 4 data items
2020-06-08T19:28:18.182Z,1591644498.182 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20200608T182717/Express0020.lzma
2020-06-08T19:28:19.184Z,1591644499.184 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0020.lzma.bak
2020-06-08T19:28:19.184Z,1591644499.184 [DataOverHttps](INFO): SBD MOMSN=12372864
2020-06-08T19:28:20.741Z,1591644500.741 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:28:20.741Z,1591644500.741 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:28:20.741Z,1591644500.741 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:30:48.613Z,1591644648.613 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2020-06-08T19:30:48.613Z,1591644648.613 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:30:48.642Z,1591644648.642 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:30:49.011Z,1591644649.011 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:30:49.011Z,1591644649.011 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2020-06-08T19:31:40.712Z,1591644700.712 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T19:33:12.795Z,1591644792.795 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:33:12.795Z,1591644792.795 [NAL9602] Data Fault, FailCount= 1
2020-06-08T19:33:12.795Z,1591644792.795 [NAL9602](ERROR): Data Fault
2020-06-08T19:33:12.853Z,1591644792.853 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:33:13.187Z,1591644793.187 [NAL9602](INFO): Powering down
2020-06-08T19:33:14.059Z,1591644794.059 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:33:14.059Z,1591644794.059 [NAL9602] No Fault, FailCount= 1
2020-06-08T19:33:21.303Z,1591644801.303 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:33:21.303Z,1591644801.303 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:33:21.303Z,1591644801.303 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:33:21.303Z,1591644801.303 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:33:21.715Z,1591644801.715 [Default:CheckIn:D] Stopped
2020-06-08T19:33:21.715Z,1591644801.715 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:33:22.107Z,1591644802.107 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.941821 min 
2020-06-08T19:33:22.107Z,1591644802.107 [Default:CheckIn:E] Stopped
2020-06-08T19:33:22.107Z,1591644802.107 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:33:22.107Z,1591644802.107 [Default:CheckIn] Stopped
2020-06-08T19:33:22.107Z,1591644802.107 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:33:22.107Z,1591644802.107 [Default:CheckIn](INFO): Running loop #7
2020-06-08T19:33:22.108Z,1591644802.108 [Default:CheckIn] Running Loop=7
2020-06-08T19:33:22.108Z,1591644802.108 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:33:22.108Z,1591644802.108 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:33:43.495Z,1591644823.495 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:33:49.567Z,1591644829.567 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2020-06-08T19:33:49.567Z,1591644829.567 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:33:49.576Z,1591644829.576 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:33:49.999Z,1591644829.999 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:33:49.999Z,1591644829.999 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2020-06-08T19:33:54.403Z,1591644834.403 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:36:50.575Z,1591645010.575 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2020-06-08T19:36:50.575Z,1591645010.575 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:36:50.584Z,1591645010.584 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:36:51.007Z,1591645011.007 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:36:51.008Z,1591645011.008 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2020-06-08T19:37:27.755Z,1591645047.755 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T19:38:22.273Z,1591645102.273 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:33:22.1Z
2020-06-08T19:38:22.273Z,1591645102.273 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:38:22.273Z,1591645102.273 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:38:29.858Z,1591645109.858 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20200608T182717/Express0023.lzma
2020-06-08T19:38:30.860Z,1591645110.860 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0023.lzma.bak
2020-06-08T19:38:30.860Z,1591645110.860 [DataOverHttps](INFO): SBD MOMSN=12372896
2020-06-08T19:38:32.527Z,1591645112.527 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:38:32.527Z,1591645112.527 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:38:32.528Z,1591645112.528 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:39:51.574Z,1591645191.574 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2020-06-08T19:39:51.574Z,1591645191.574 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:39:51.591Z,1591645191.591 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:39:51.979Z,1591645191.979 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:39:51.979Z,1591645191.979 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2020-06-08T19:42:16.195Z,1591645336.195 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T19:42:16.197Z,1591645336.197 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T19:42:52.562Z,1591645372.562 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25
2020-06-08T19:42:52.562Z,1591645372.562 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:42:52.591Z,1591645372.591 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:42:52.974Z,1591645372.974 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:42:52.974Z,1591645372.974 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25
2020-06-08T19:43:32.975Z,1591645412.975 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:43:32.975Z,1591645412.975 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:43:32.975Z,1591645412.975 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:43:32.975Z,1591645412.975 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:43:33.375Z,1591645413.375 [Default:CheckIn:D] Stopped
2020-06-08T19:43:33.375Z,1591645413.375 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.136157 min 
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn:E] Stopped
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn] Stopped
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn](INFO): Running loop #8
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn] Running Loop=8
2020-06-08T19:43:33.780Z,1591645413.780 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:43:33.781Z,1591645413.781 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:43:57.975Z,1591645437.975 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:43:57.975Z,1591645437.975 [NAL9602] Data Fault, FailCount= 2
2020-06-08T19:43:57.975Z,1591645437.975 [NAL9602](ERROR): Data Fault
2020-06-08T19:43:58.029Z,1591645438.029 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:43:58.383Z,1591645438.383 [NAL9602](INFO): Powering down
2020-06-08T19:43:59.221Z,1591645439.221 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:43:59.221Z,1591645439.221 [NAL9602] No Fault, FailCount= 2
2020-06-08T19:44:28.683Z,1591645468.683 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:44:39.595Z,1591645479.595 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:45:53.573Z,1591645553.573 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26
2020-06-08T19:45:53.573Z,1591645553.573 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:45:53.614Z,1591645553.614 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:45:53.978Z,1591645553.978 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:45:53.978Z,1591645553.978 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26
2020-06-08T19:48:33.955Z,1591645713.955 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:43:33.8Z
2020-06-08T19:48:33.955Z,1591645713.955 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:48:33.955Z,1591645713.955 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:48:41.201Z,1591645721.201 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20200608T182717/Courier0025.lzma
2020-06-08T19:48:42.204Z,1591645722.204 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Courier0025.lzma.bak
2020-06-08T19:48:42.204Z,1591645722.204 [DataOverHttps](INFO): SBD MOMSN=12372916
2020-06-08T19:48:54.553Z,1591645734.553 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27
2020-06-08T19:48:54.553Z,1591645734.553 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:48:54.575Z,1591645734.575 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:48:54.970Z,1591645734.970 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:48:54.970Z,1591645734.970 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27
2020-06-08T19:48:58.177Z,1591645738.177 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20200608T182717/Express0026.lzma
2020-06-08T19:48:59.180Z,1591645739.180 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0026.lzma.bak
2020-06-08T19:48:59.180Z,1591645739.180 [DataOverHttps](INFO): SBD MOMSN=12372920
2020-06-08T19:49:01.015Z,1591645741.015 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:49:01.015Z,1591645741.015 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:49:01.015Z,1591645741.015 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:51:55.542Z,1591645915.542 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28
2020-06-08T19:51:55.542Z,1591645915.542 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:51:55.552Z,1591645915.552 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:51:55.948Z,1591645915.948 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:51:55.948Z,1591645915.948 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28
2020-06-08T19:54:01.607Z,1591646041.607 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:54:01.607Z,1591646041.607 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:54:01.608Z,1591646041.608 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:54:01.608Z,1591646041.608 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:54:01.987Z,1591646041.987 [Default:CheckIn:D] Stopped
2020-06-08T19:54:01.987Z,1591646041.987 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:54:02.415Z,1591646042.415 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.613029 min 
2020-06-08T19:54:02.416Z,1591646042.416 [Default:CheckIn:E] Stopped
2020-06-08T19:54:02.416Z,1591646042.416 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:54:02.416Z,1591646042.416 [Default:CheckIn] Stopped
2020-06-08T19:54:02.416Z,1591646042.416 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:54:02.417Z,1591646042.417 [Default:CheckIn](INFO): Running loop #9
2020-06-08T19:54:02.417Z,1591646042.417 [Default:CheckIn] Running Loop=9
2020-06-08T19:54:02.417Z,1591646042.417 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:54:02.418Z,1591646042.418 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:54:40.747Z,1591646080.747 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:54:40.747Z,1591646080.747 [NAL9602] Data Fault, FailCount= 3
2020-06-08T19:54:40.747Z,1591646080.747 [NAL9602](ERROR): Data Fault
2020-06-08T19:54:40.807Z,1591646080.807 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:54:41.147Z,1591646081.147 [NAL9602](INFO): Powering down
2020-06-08T19:54:42.004Z,1591646082.004 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:54:42.004Z,1591646082.004 [NAL9602] No Fault, FailCount= 3
2020-06-08T19:54:56.540Z,1591646096.540 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29
2020-06-08T19:54:56.540Z,1591646096.540 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:54:56.549Z,1591646096.549 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:54:56.948Z,1591646096.948 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:54:56.948Z,1591646096.948 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29
2020-06-08T19:55:11.447Z,1591646111.447 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:55:22.361Z,1591646122.361 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:57:57.547Z,1591646277.547 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30
2020-06-08T19:57:57.547Z,1591646277.547 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:57:57.591Z,1591646277.591 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:57:57.967Z,1591646277.967 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:57:57.967Z,1591646277.967 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30
2020-06-08T19:59:02.563Z,1591646342.563 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:54:02.4Z
2020-06-08T19:59:02.563Z,1591646342.563 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:59:02.563Z,1591646342.563 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:59:09.834Z,1591646349.834 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T182717/Express0029.lzma
2020-06-08T19:59:10.839Z,1591646350.839 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0029.lzma.bak
2020-06-08T19:59:10.839Z,1591646350.839 [DataOverHttps](INFO): SBD MOMSN=12372939
2020-06-08T19:59:12.689Z,1591646352.689 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:59:12.689Z,1591646352.689 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:59:12.690Z,1591646352.690 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:00:58.517Z,1591646458.517 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31
2020-06-08T20:00:58.517Z,1591646458.517 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:00:58.527Z,1591646458.527 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:00:58.940Z,1591646458.940 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:00:58.941Z,1591646458.941 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31
2020-06-08T20:03:59.510Z,1591646639.510 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32
2020-06-08T20:03:59.510Z,1591646639.510 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:03:59.531Z,1591646639.531 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:03:59.977Z,1591646639.977 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:03:59.977Z,1591646639.977 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32
2020-06-08T20:04:13.236Z,1591646653.236 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:04:13.236Z,1591646653.236 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:04:13.237Z,1591646653.237 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:04:13.237Z,1591646653.237 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:04:13.657Z,1591646653.657 [Default:CheckIn:D] Stopped
2020-06-08T20:04:13.657Z,1591646653.657 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:04:14.052Z,1591646654.052 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 92.807520 min 
2020-06-08T20:04:14.052Z,1591646654.052 [Default:CheckIn:E] Stopped
2020-06-08T20:04:14.052Z,1591646654.052 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:04:14.052Z,1591646654.052 [Default:CheckIn] Stopped
2020-06-08T20:04:14.052Z,1591646654.052 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:04:14.053Z,1591646654.053 [Default:CheckIn](INFO): Running loop #10
2020-06-08T20:04:14.053Z,1591646654.053 [Default:CheckIn] Running Loop=10
2020-06-08T20:04:14.053Z,1591646654.053 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:04:14.053Z,1591646654.053 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:05:23.911Z,1591646723.911 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:05:23.911Z,1591646723.911 [NAL9602] Data Fault, FailCount= 4
2020-06-08T20:05:23.911Z,1591646723.911 [NAL9602](ERROR): Data Fault
2020-06-08T20:05:23.971Z,1591646723.971 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:05:24.331Z,1591646724.331 [NAL9602](INFO): Powering down
2020-06-08T20:05:25.160Z,1591646725.160 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:05:25.160Z,1591646725.160 [NAL9602] No Fault, FailCount= 4
2020-06-08T20:05:54.623Z,1591646754.623 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:06:05.535Z,1591646765.535 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:07:00.524Z,1591646820.524 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33
2020-06-08T20:07:00.524Z,1591646820.524 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:07:00.533Z,1591646820.533 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:07:00.938Z,1591646820.938 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:07:00.939Z,1591646820.939 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33
2020-06-08T20:09:14.219Z,1591646954.219 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:04:14.1Z
2020-06-08T20:09:14.219Z,1591646954.219 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:09:14.219Z,1591646954.219 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:09:21.486Z,1591646961.486 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20200608T182717/Express0032.lzma
2020-06-08T20:09:22.488Z,1591646962.488 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0032.lzma.bak
2020-06-08T20:09:22.488Z,1591646962.488 [DataOverHttps](INFO): SBD MOMSN=12372954
2020-06-08T20:09:24.374Z,1591646964.374 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:09:24.374Z,1591646964.374 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:09:24.374Z,1591646964.374 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:10:01.517Z,1591647001.517 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34
2020-06-08T20:10:01.517Z,1591647001.517 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:10:01.559Z,1591647001.559 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:10:01.926Z,1591647001.926 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:10:01.926Z,1591647001.926 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34
2020-06-08T20:13:02.482Z,1591647182.482 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35
2020-06-08T20:13:02.482Z,1591647182.482 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:13:02.528Z,1591647182.528 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:13:02.903Z,1591647182.903 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:13:02.903Z,1591647182.903 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35
2020-06-08T20:14:24.917Z,1591647264.917 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:14:24.917Z,1591647264.917 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:14:24.917Z,1591647264.917 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:14:24.917Z,1591647264.917 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:14:25.303Z,1591647265.303 [Default:CheckIn:D] Stopped
2020-06-08T20:14:25.303Z,1591647265.303 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:14:25.723Z,1591647265.723 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 103.001619 min 
2020-06-08T20:14:25.723Z,1591647265.723 [Default:CheckIn:E] Stopped
2020-06-08T20:14:25.723Z,1591647265.723 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:14:25.724Z,1591647265.724 [Default:CheckIn] Stopped
2020-06-08T20:14:25.724Z,1591647265.724 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:14:25.724Z,1591647265.724 [Default:CheckIn](INFO): Running loop #11
2020-06-08T20:14:25.724Z,1591647265.724 [Default:CheckIn] Running Loop=11
2020-06-08T20:14:25.724Z,1591647265.724 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:14:25.724Z,1591647265.724 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:16:03.499Z,1591647363.499 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36
2020-06-08T20:16:03.499Z,1591647363.499 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:16:03.509Z,1591647363.509 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:16:03.902Z,1591647363.902 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:16:03.902Z,1591647363.902 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36
2020-06-08T20:16:08.699Z,1591647368.699 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:16:08.699Z,1591647368.699 [NAL9602] Data Fault, FailCount= 5
2020-06-08T20:16:08.699Z,1591647368.699 [NAL9602](ERROR): Data Fault
2020-06-08T20:16:08.759Z,1591647368.759 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:16:08.760Z,1591647368.760 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T20:16:09.103Z,1591647369.103 [NAL9602](INFO): Powering down
2020-06-08T20:16:09.181Z,1591647369.181 [CBIT](INFO): Critical error at 20200608T201608
2020-06-08T20:18:08.733Z,1591647488.733 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:18:08.733Z,1591647488.733 [NAL9602] No Fault, FailCount= 5
2020-06-08T20:18:09.091Z,1591647489.091 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:18:20.006Z,1591647500.006 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:19:04.490Z,1591647544.490 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37
2020-06-08T20:19:04.490Z,1591647544.490 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:19:04.499Z,1591647544.499 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:19:04.893Z,1591647544.893 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:19:04.893Z,1591647544.893 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37
2020-06-08T20:19:25.895Z,1591647565.895 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:14:25.7Z
2020-06-08T20:19:25.895Z,1591647565.895 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:19:25.895Z,1591647565.895 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:19:33.529Z,1591647573.529 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20200608T182717/Courier0034.lzma
2020-06-08T20:19:34.535Z,1591647574.535 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Courier0034.lzma.bak
2020-06-08T20:19:34.535Z,1591647574.535 [DataOverHttps](INFO): SBD MOMSN=12372974
2020-06-08T20:19:50.510Z,1591647590.510 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200608T182717/Express0035.lzma
2020-06-08T20:19:51.512Z,1591647591.512 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0035.lzma.bak
2020-06-08T20:19:51.512Z,1591647591.512 [DataOverHttps](INFO): SBD MOMSN=12372977
2020-06-08T20:19:53.388Z,1591647593.388 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:19:53.388Z,1591647593.388 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:19:53.388Z,1591647593.388 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:22:05.509Z,1591647725.509 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38
2020-06-08T20:22:05.509Z,1591647725.509 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:22:05.519Z,1591647725.519 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:22:05.923Z,1591647725.923 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:22:05.923Z,1591647725.923 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38
2020-06-08T20:22:48.745Z,1591647768.745 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-06-08T20:24:53.983Z,1591647893.983 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:24:53.983Z,1591647893.983 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:24:53.983Z,1591647893.983 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:24:53.983Z,1591647893.983 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:24:54.387Z,1591647894.387 [Default:CheckIn:D] Stopped
2020-06-08T20:24:54.387Z,1591647894.387 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:24:54.810Z,1591647894.810 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 113.486361 min 
2020-06-08T20:24:54.810Z,1591647894.810 [Default:CheckIn:E] Stopped
2020-06-08T20:24:54.810Z,1591647894.810 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:24:54.810Z,1591647894.810 [Default:CheckIn] Stopped
2020-06-08T20:24:54.810Z,1591647894.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:24:54.811Z,1591647894.811 [Default:CheckIn](INFO): Running loop #12
2020-06-08T20:24:54.811Z,1591647894.811 [Default:CheckIn] Running Loop=12
2020-06-08T20:24:54.811Z,1591647894.811 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:24:54.811Z,1591647894.811 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:25:06.503Z,1591647906.503 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 39
2020-06-08T20:25:06.503Z,1591647906.503 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:25:06.517Z,1591647906.517 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:25:06.909Z,1591647906.909 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:25:06.909Z,1591647906.909 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 39
2020-06-08T20:28:07.497Z,1591648087.497 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 40
2020-06-08T20:28:07.497Z,1591648087.497 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:28:07.538Z,1591648087.538 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:28:07.893Z,1591648087.893 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:28:07.893Z,1591648087.893 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 40
2020-06-08T20:28:21.595Z,1591648101.595 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:28:21.595Z,1591648101.595 [NAL9602] Data Fault, FailCount= 1
2020-06-08T20:28:21.595Z,1591648101.595 [NAL9602](ERROR): Data Fault
2020-06-08T20:28:21.675Z,1591648101.675 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:28:22.000Z,1591648102.000 [NAL9602](INFO): Powering down
2020-06-08T20:28:22.867Z,1591648102.867 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:28:22.867Z,1591648102.867 [NAL9602] No Fault, FailCount= 1
2020-06-08T20:28:52.300Z,1591648132.300 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:29:03.203Z,1591648143.203 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:29:54.959Z,1591648194.959 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:24:54.8Z
2020-06-08T20:29:54.959Z,1591648194.959 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:29:54.960Z,1591648194.960 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:30:02.553Z,1591648202.553 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200608T182717/Express0038.lzma
2020-06-08T20:30:03.556Z,1591648203.556 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0038.lzma.bak
2020-06-08T20:30:03.556Z,1591648203.556 [DataOverHttps](INFO): SBD MOMSN=12372995
2020-06-08T20:30:05.462Z,1591648205.462 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:30:05.463Z,1591648205.463 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:30:05.463Z,1591648205.463 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:31:08.485Z,1591648268.485 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41
2020-06-08T20:31:08.486Z,1591648268.486 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:31:08.495Z,1591648268.495 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:31:08.899Z,1591648268.899 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:31:08.899Z,1591648268.899 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41
2020-06-08T20:33:54.929Z,1591648434.929 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-06-08T20:34:09.485Z,1591648449.485 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 42
2020-06-08T20:34:09.485Z,1591648449.485 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:34:09.514Z,1591648449.514 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:34:09.891Z,1591648449.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:34:09.891Z,1591648449.891 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 42
2020-06-08T20:35:06.031Z,1591648506.031 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:35:06.031Z,1591648506.031 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:35:06.031Z,1591648506.031 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:35:06.031Z,1591648506.031 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:35:06.437Z,1591648506.437 [Default:CheckIn:D] Stopped
2020-06-08T20:35:06.437Z,1591648506.437 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:35:06.860Z,1591648506.860 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 123.687191 min 
2020-06-08T20:35:06.860Z,1591648506.860 [Default:CheckIn:E] Stopped
2020-06-08T20:35:06.860Z,1591648506.860 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:35:06.861Z,1591648506.861 [Default:CheckIn] Stopped
2020-06-08T20:35:06.861Z,1591648506.861 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:35:06.861Z,1591648506.861 [Default:CheckIn](INFO): Running loop #13
2020-06-08T20:35:06.861Z,1591648506.861 [Default:CheckIn] Running Loop=13
2020-06-08T20:35:06.861Z,1591648506.861 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:35:06.861Z,1591648506.861 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:37:10.493Z,1591648630.493 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 43
2020-06-08T20:37:10.493Z,1591648630.493 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:37:10.519Z,1591648630.519 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:37:10.890Z,1591648630.890 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:37:10.890Z,1591648630.890 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 43
2020-06-08T20:37:14.958Z,1591648634.958 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-06-08T20:39:04.371Z,1591648744.371 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:39:04.371Z,1591648744.371 [NAL9602] Data Fault, FailCount= 2
2020-06-08T20:39:04.371Z,1591648744.371 [NAL9602](ERROR): Data Fault
2020-06-08T20:39:04.455Z,1591648744.455 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:39:04.775Z,1591648744.775 [NAL9602](INFO): Powering down
2020-06-08T20:39:05.627Z,1591648745.627 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:39:05.627Z,1591648745.627 [NAL9602] No Fault, FailCount= 2
2020-06-08T20:39:35.106Z,1591648775.106 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:39:45.983Z,1591648785.983 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:40:07.019Z,1591648807.019 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:35:06.9Z
2020-06-08T20:40:07.019Z,1591648807.019 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:40:07.019Z,1591648807.019 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:40:11.489Z,1591648811.489 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 44
2020-06-08T20:40:11.489Z,1591648811.489 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:40:11.522Z,1591648811.522 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:40:11.901Z,1591648811.901 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:40:11.901Z,1591648811.901 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 44
2020-06-08T20:40:13.549Z,1591648813.549 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20200608T182717/Express0041.lzma
2020-06-08T20:40:14.548Z,1591648814.548 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0041.lzma.bak
2020-06-08T20:40:14.548Z,1591648814.548 [DataOverHttps](INFO): SBD MOMSN=12373011
2020-06-08T20:40:16.333Z,1591648816.333 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:40:16.334Z,1591648816.334 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:40:16.334Z,1591648816.334 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:43:12.455Z,1591648992.455 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 45
2020-06-08T20:43:12.455Z,1591648992.455 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:43:12.465Z,1591648992.465 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:43:12.881Z,1591648992.881 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:43:12.881Z,1591648992.881 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 45
2020-06-08T20:45:16.913Z,1591649116.913 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:45:16.913Z,1591649116.913 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:45:16.913Z,1591649116.913 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:45:16.913Z,1591649116.913 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:45:17.315Z,1591649117.315 [Default:CheckIn:D] Stopped
2020-06-08T20:45:17.315Z,1591649117.315 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.868490 min 
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn:E] Stopped
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn] Stopped
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn](INFO): Running loop #14
2020-06-08T20:45:17.721Z,1591649117.721 [Default:CheckIn] Running Loop=14
2020-06-08T20:45:17.722Z,1591649117.722 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:45:17.722Z,1591649117.722 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:46:13.458Z,1591649173.458 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 46
2020-06-08T20:46:13.458Z,1591649173.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:46:13.475Z,1591649173.475 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:46:13.910Z,1591649173.910 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:46:13.910Z,1591649173.910 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 46
2020-06-08T20:47:40.727Z,1591649260.727 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T20:49:14.450Z,1591649354.450 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 47
2020-06-08T20:49:14.450Z,1591649354.450 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:49:14.467Z,1591649354.467 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:49:14.859Z,1591649354.859 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:49:14.859Z,1591649354.859 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 47
2020-06-08T20:49:45.969Z,1591649385.969 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T20:49:45.972Z,1591649385.972 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T20:49:47.143Z,1591649387.143 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:49:47.143Z,1591649387.143 [NAL9602] Data Fault, FailCount= 3
2020-06-08T20:49:47.143Z,1591649387.143 [NAL9602](ERROR): Data Fault
2020-06-08T20:49:47.196Z,1591649387.196 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:49:47.539Z,1591649387.539 [NAL9602](INFO): Powering down
2020-06-08T20:49:48.410Z,1591649388.410 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:49:48.410Z,1591649388.410 [NAL9602] No Fault, FailCount= 3
2020-06-08T20:50:17.847Z,1591649417.847 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:50:17.891Z,1591649417.891 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:45:17.7Z
2020-06-08T20:50:17.891Z,1591649417.891 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:50:17.891Z,1591649417.891 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:50:25.357Z,1591649425.357 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20200608T182717/Courier0043.lzma
2020-06-08T20:50:26.360Z,1591649426.360 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Courier0043.lzma.bak
2020-06-08T20:50:26.360Z,1591649426.360 [DataOverHttps](INFO): SBD MOMSN=12373031
2020-06-08T20:50:28.751Z,1591649428.751 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:50:44.370Z,1591649444.370 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20200608T182717/Express0044.lzma
2020-06-08T20:50:45.372Z,1591649445.372 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0044.lzma.bak
2020-06-08T20:50:45.372Z,1591649445.372 [DataOverHttps](INFO): SBD MOMSN=12373033
2020-06-08T20:50:47.776Z,1591649447.776 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:50:47.776Z,1591649447.776 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:50:47.776Z,1591649447.776 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:52:15.464Z,1591649535.464 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 48
2020-06-08T20:52:15.464Z,1591649535.464 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:52:15.474Z,1591649535.474 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:52:15.859Z,1591649535.859 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:52:15.859Z,1591649535.859 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 48
2020-06-08T20:55:16.475Z,1591649716.475 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 49
2020-06-08T20:55:16.475Z,1591649716.475 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:55:16.485Z,1591649716.485 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:55:16.854Z,1591649716.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:55:16.855Z,1591649716.855 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 49
2020-06-08T20:55:48.373Z,1591649748.373 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:55:48.373Z,1591649748.373 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:55:48.373Z,1591649748.373 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:55:48.373Z,1591649748.373 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:55:48.747Z,1591649748.747 [Default:CheckIn:D] Stopped
2020-06-08T20:55:48.747Z,1591649748.747 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.392350 min 
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn:E] Stopped
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn] Stopped
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn](INFO): Running loop #15
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn] Running Loop=15
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:55:49.152Z,1591649749.152 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:58:17.443Z,1591649897.443 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 50
2020-06-08T20:58:17.443Z,1591649897.443 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:58:17.452Z,1591649897.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:58:17.825Z,1591649897.825 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:58:17.825Z,1591649897.825 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 50
2020-06-08T21:00:29.907Z,1591650029.907 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:00:29.907Z,1591650029.907 [NAL9602] Data Fault, FailCount= 4
2020-06-08T21:00:29.907Z,1591650029.907 [NAL9602](ERROR): Data Fault
2020-06-08T21:00:29.975Z,1591650029.975 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:00:30.329Z,1591650030.329 [NAL9602](INFO): Powering down
2020-06-08T21:00:31.182Z,1591650031.182 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:00:31.182Z,1591650031.182 [NAL9602] No Fault, FailCount= 4
2020-06-08T21:00:49.372Z,1591650049.372 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:55:49.2Z
2020-06-08T21:00:49.372Z,1591650049.372 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:00:49.372Z,1591650049.372 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:00:56.738Z,1591650056.738 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20200608T182717/Express0047.lzma
2020-06-08T21:00:57.740Z,1591650057.740 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0047.lzma.bak
2020-06-08T21:00:57.740Z,1591650057.740 [DataOverHttps](INFO): SBD MOMSN=12373092
2020-06-08T21:00:59.466Z,1591650059.466 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:00:59.466Z,1591650059.466 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:00:59.466Z,1591650059.466 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:01:00.611Z,1591650060.611 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:01:11.520Z,1591650071.520 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:01:18.415Z,1591650078.415 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 51
2020-06-08T21:01:18.415Z,1591650078.415 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:01:18.425Z,1591650078.425 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:01:18.835Z,1591650078.835 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:01:18.835Z,1591650078.835 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 51
2020-06-08T21:04:19.119Z,1591650259.119 [CommandLine](IMPORTANT): got command failComponent
2020-06-08T21:04:19.119Z,1591650259.119 [CommandLine](IMPORTANT): Failed components:
2020-06-08T21:04:19.120Z,1591650259.120 [CommandLine](IMPORTANT): No failed Components.
2020-06-08T21:04:19.451Z,1591650259.451 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 52
2020-06-08T21:04:19.451Z,1591650259.451 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:04:19.461Z,1591650259.461 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:04:19.919Z,1591650259.919 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:04:19.919Z,1591650259.919 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 52
2020-06-08T21:04:21.361Z,1591650261.361 [CommandLine](IMPORTANT): got command failComponent
2020-06-08T21:04:21.361Z,1591650261.361 [CommandLine](IMPORTANT): Failed components:
2020-06-08T21:04:21.361Z,1591650261.361 [CommandLine](IMPORTANT): No failed Components.
2020-06-08T21:04:23.125Z,1591650263.125 [CommandLine](IMPORTANT): got command show stack
2020-06-08T21:04:23.125Z,1591650263.125 [CommandLine](IMPORTANT): Behavior Stack:

2020-06-08T21:04:23.125Z,1591650263.125 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface
2020-06-08T21:04:23.125Z,1591650263.125 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:C.Wait
2020-06-08T21:04:35.622Z,1591650275.622 [DAT](INFO): unknown deviceResponse_: x time:20:59:13.1358

2020-06-08T21:06:00.107Z,1591650360.107 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:06:00.107Z,1591650360.107 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:06:00.107Z,1591650360.107 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:06:00.107Z,1591650360.107 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:06:00.523Z,1591650360.523 [Default:CheckIn:D] Stopped
2020-06-08T21:06:00.523Z,1591650360.523 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:06:00.903Z,1591650360.903 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 154.588623 min 
2020-06-08T21:06:00.903Z,1591650360.903 [Default:CheckIn:E] Stopped
2020-06-08T21:06:00.903Z,1591650360.903 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:06:00.903Z,1591650360.903 [Default:CheckIn] Stopped
2020-06-08T21:06:00.904Z,1591650360.904 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:06:00.904Z,1591650360.904 [Default:CheckIn](INFO): Running loop #16
2020-06-08T21:06:00.904Z,1591650360.904 [Default:CheckIn] Running Loop=16
2020-06-08T21:06:00.904Z,1591650360.904 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:06:00.904Z,1591650360.904 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:07:20.494Z,1591650440.494 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 53
2020-06-08T21:07:20.494Z,1591650440.494 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:07:20.527Z,1591650440.527 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:07:20.958Z,1591650440.958 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:07:20.958Z,1591650440.958 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 53
2020-06-08T21:10:21.511Z,1591650621.511 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 54
2020-06-08T21:10:21.511Z,1591650621.511 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:10:21.521Z,1591650621.521 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:10:21.915Z,1591650621.915 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:10:21.915Z,1591650621.915 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 54
2020-06-08T21:11:01.089Z,1591650661.089 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:06:00.9Z
2020-06-08T21:11:01.089Z,1591650661.089 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:11:01.089Z,1591650661.089 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:11:08.730Z,1591650668.730 [DataOverHttps](INFO): Sending 283 bytes from file Logs/20200608T182717/Express0050.lzma
2020-06-08T21:11:09.732Z,1591650669.732 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0050.lzma.bak
2020-06-08T21:11:09.732Z,1591650669.732 [DataOverHttps](INFO): SBD MOMSN=12373109
2020-06-08T21:11:11.688Z,1591650671.688 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:11:11.688Z,1591650671.688 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:11:11.688Z,1591650671.688 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:11:14.035Z,1591650674.035 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:11:14.035Z,1591650674.035 [NAL9602] Data Fault, FailCount= 5
2020-06-08T21:11:14.035Z,1591650674.035 [NAL9602](ERROR): Data Fault
2020-06-08T21:11:14.104Z,1591650674.104 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:11:14.104Z,1591650674.104 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T21:11:14.449Z,1591650674.449 [NAL9602](INFO): Powering down
2020-06-08T21:11:14.530Z,1591650674.530 [CBIT](INFO): Critical error at 20200608T211114
2020-06-08T21:13:14.075Z,1591650794.075 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:13:14.075Z,1591650794.075 [NAL9602] No Fault, FailCount= 5
2020-06-08T21:13:14.439Z,1591650794.439 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:13:22.541Z,1591650802.541 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 55
2020-06-08T21:13:22.541Z,1591650802.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:13:22.571Z,1591650802.571 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:13:22.954Z,1591650802.954 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:13:22.954Z,1591650802.954 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 55
2020-06-08T21:13:25.339Z,1591650805.339 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:16:12.235Z,1591650972.235 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:16:12.235Z,1591650972.235 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:16:12.235Z,1591650972.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:16:12.235Z,1591650972.235 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:16:12.646Z,1591650972.646 [Default:CheckIn:D] Stopped
2020-06-08T21:16:12.647Z,1591650972.647 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:16:13.053Z,1591650973.053 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 164.790674 min 
2020-06-08T21:16:13.053Z,1591650973.053 [Default:CheckIn:E] Stopped
2020-06-08T21:16:13.053Z,1591650973.053 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:16:13.053Z,1591650973.053 [Default:CheckIn] Stopped
2020-06-08T21:16:13.053Z,1591650973.053 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:16:13.054Z,1591650973.054 [Default:CheckIn](INFO): Running loop #17
2020-06-08T21:16:13.054Z,1591650973.054 [Default:CheckIn] Running Loop=17
2020-06-08T21:16:13.054Z,1591650973.054 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:16:13.054Z,1591650973.054 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:16:23.557Z,1591650983.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 56
2020-06-08T21:16:23.557Z,1591650983.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:16:23.575Z,1591650983.575 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:16:23.954Z,1591650983.954 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:16:23.955Z,1591650983.955 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 56
2020-06-08T21:19:24.569Z,1591651164.569 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 57
2020-06-08T21:19:24.569Z,1591651164.569 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:19:24.604Z,1591651164.604 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:19:25.096Z,1591651165.096 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:19:25.096Z,1591651165.096 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 57
2020-06-08T21:21:13.229Z,1591651273.229 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:16:13.1Z
2020-06-08T21:21:13.229Z,1591651273.229 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:21:13.229Z,1591651273.229 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:21:20.161Z,1591651280.161 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20200608T182717/Courier0052.lzma
2020-06-08T21:21:21.164Z,1591651281.164 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Courier0052.lzma.bak
2020-06-08T21:21:21.164Z,1591651281.164 [DataOverHttps](INFO): SBD MOMSN=12373139
2020-06-08T21:21:37.130Z,1591651297.130 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20200608T182717/Express0053.lzma
2020-06-08T21:21:38.132Z,1591651298.132 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0053.lzma.bak
2020-06-08T21:21:38.132Z,1591651298.132 [DataOverHttps](INFO): SBD MOMSN=12373142
2020-06-08T21:21:39.919Z,1591651299.919 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:21:39.919Z,1591651299.919 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:21:39.919Z,1591651299.919 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:22:25.546Z,1591651345.546 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 58
2020-06-08T21:22:25.546Z,1591651345.546 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:22:25.582Z,1591651345.582 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:22:26.005Z,1591651346.005 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:22:26.006Z,1591651346.006 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 58
2020-06-08T21:23:26.936Z,1591651406.936 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:23:26.936Z,1591651406.936 [NAL9602] Data Fault, FailCount= 1
2020-06-08T21:23:26.937Z,1591651406.937 [NAL9602](ERROR): Data Fault
2020-06-08T21:23:26.971Z,1591651406.971 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:23:27.331Z,1591651407.331 [NAL9602](INFO): Powering down
2020-06-08T21:23:28.228Z,1591651408.228 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:23:28.228Z,1591651408.228 [NAL9602] No Fault, FailCount= 1
2020-06-08T21:23:57.258Z,1591651437.258 [DAT](INFO): Received command:set _.pressure 0.519661 atmosphere
2020-06-08T21:23:57.888Z,1591651437.888 [CommandLine](IMPORTANT): got command set _.pressure 0.519661 atmosphere
2020-06-08T21:23:57.894Z,1591651437.894 [DAT](INFO): Sending ack
2020-06-08T21:23:57.895Z,1591651437.895 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2020-06-08T21:23:57.975Z,1591651437.975 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:23:58.003Z,1591651438.003 [DAT](INFO): setting remote address to 8
2020-06-08T21:23:58.374Z,1591651438.374 [DAT](INFO): set remote address to 8
2020-06-08T21:23:58.375Z,1591651438.375 [DAT](INFO): entering online mode
2020-06-08T21:23:58.743Z,1591651438.743 [DAT](INFO): commRate: 800
2020-06-08T21:23:58.744Z,1591651438.744 [DAT](INFO): online mode acknowledged
2020-06-08T21:23:58.744Z,1591651438.744 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2020-06-08T21:24:01.979Z,1591651441.979 [DAT](DEBUG): In parseResponses, sent ack so set commsState_ = SENDING_VERIFIED
2020-06-08T21:24:01.979Z,1591651441.979 [DAT](DEBUG): In sendingVerified, data done so set commsState_ = SENDING_FILL_BUFFER
2020-06-08T21:24:08.835Z,1591651448.835 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:24:10.087Z,1591651450.087 [DAT](INFO): Received command:set _.temperature 22.849482 celsius
2020-06-08T21:24:10.858Z,1591651450.858 [CommandLine](IMPORTANT): got command set _.temperature 22.849482 celsius
2020-06-08T21:24:10.864Z,1591651450.864 [DAT](INFO): Sending ack
2020-06-08T21:24:22.244Z,1591651462.244 [DAT](INFO): Received command:set _.humidity 10.218533 percent
2020-06-08T21:24:22.846Z,1591651462.846 [CommandLine](IMPORTANT): got command set _.humidity 10.218533 percent
2020-06-08T21:24:22.852Z,1591651462.852 [DAT](INFO): Sending ack
2020-06-08T21:25:26.743Z,1591651526.743 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 59
2020-06-08T21:25:26.743Z,1591651526.743 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:25:26.769Z,1591651526.769 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:25:27.162Z,1591651527.162 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:25:27.162Z,1591651527.162 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 59
2020-06-08T21:26:40.684Z,1591651600.684 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:26:40.684Z,1591651600.684 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:26:40.684Z,1591651600.684 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:26:40.684Z,1591651600.684 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:26:41.083Z,1591651601.083 [Default:CheckIn:D] Stopped
2020-06-08T21:26:41.083Z,1591651601.083 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 175.264616 min 
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn:E] Stopped
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn] Stopped
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn](INFO): Running loop #18
2020-06-08T21:26:41.484Z,1591651601.484 [Default:CheckIn] Running Loop=18
2020-06-08T21:26:41.485Z,1591651601.485 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:26:41.485Z,1591651601.485 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:28:27.728Z,1591651707.728 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 60
2020-06-08T21:28:27.728Z,1591651707.728 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:28:27.762Z,1591651707.762 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:28:28.145Z,1591651708.145 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:28:28.145Z,1591651708.145 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 60
2020-06-08T21:31:28.741Z,1591651888.741 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 61
2020-06-08T21:31:28.741Z,1591651888.741 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:31:28.758Z,1591651888.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:31:29.150Z,1591651889.150 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:31:29.150Z,1591651889.150 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 61
2020-06-08T21:31:41.667Z,1591651901.667 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:26:41.5Z
2020-06-08T21:31:41.667Z,1591651901.667 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:31:41.667Z,1591651901.667 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:31:49.526Z,1591651909.526 [DataOverHttps](INFO): Sending 245 bytes from file Logs/20200608T182717/Express0056.lzma
2020-06-08T21:31:50.531Z,1591651910.531 [DataOverHttps](INFO): Moved sent file to Logs/20200608T182717/Express0056.lzma.bak
2020-06-08T21:31:50.531Z,1591651910.531 [DataOverHttps](INFO): SBD MOMSN=12373165
2020-06-08T21:31:52.178Z,1591651912.178 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:31:52.178Z,1591651912.178 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:31:52.178Z,1591651912.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:34:11.919Z,1591652051.919 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:34:11.920Z,1591652051.920 [NAL9602] Data Fault, FailCount= 2
2020-06-08T21:34:11.920Z,1591652051.920 [NAL9602](ERROR): Data Fault
2020-06-08T21:34:11.991Z,1591652051.991 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:34:12.338Z,1591652052.338 [NAL9602](INFO): Powering down
2020-06-08T21:34:13.178Z,1591652053.178 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:34:13.178Z,1591652053.178 [NAL9602] No Fault, FailCount= 2
2020-06-08T21:34:29.722Z,1591652069.722 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 62
2020-06-08T21:34:29.722Z,1591652069.722 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:34:29.751Z,1591652069.751 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:34:30.133Z,1591652070.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:34:30.133Z,1591652070.133 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 62
2020-06-08T21:34:42.627Z,1591652082.627 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:34:53.531Z,1591652093.531 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:36:50.335Z,1591652210.335 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T21:36:52.747Z,1591652212.747 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:36:52.747Z,1591652212.747 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:36:52.747Z,1591652212.747 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:36:52.747Z,1591652212.747 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:36:53.160Z,1591652213.160 [Default:CheckIn:D] Stopped
2020-06-08T21:36:53.160Z,1591652213.160 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:36:53.576Z,1591652213.576 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 185.465902 min 
2020-06-08T21:36:53.576Z,1591652213.576 [Default:CheckIn:E] Stopped
2020-06-08T21:36:53.576Z,1591652213.576 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:36:53.576Z,1591652213.576 [Default:CheckIn] Stopped
2020-06-08T21:36:53.576Z,1591652213.576 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:36:53.577Z,1591652213.577 [Default:CheckIn](INFO): Running loop #19
2020-06-08T21:36:53.577Z,1591652213.577 [Default:CheckIn] Running Loop=19
2020-06-08T21:36:53.577Z,1591652213.577 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:36:53.577Z,1591652213.577 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:37:09.667Z,1591652229.667 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.727345
2020-06-08T21:37:09.733Z,1591652229.733 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-06-08T21:37:30.746Z,1591652250.746 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 63
2020-06-08T21:37:30.746Z,1591652250.746 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:37:30.777Z,1591652250.777 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:37:31.150Z,1591652251.150 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:37:31.150Z,1591652251.150 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 63
2020-06-08T21:37:41.799Z,1591652261.799 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:38:16.950Z,1591652296.950 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:38:52.090Z,1591652332.090 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:39:27.238Z,1591652367.238 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:40:02.390Z,1591652402.390 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:40:31.748Z,1591652431.748 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 64
2020-06-08T21:40:31.748Z,1591652431.748 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:40:31.758Z,1591652431.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:40:32.134Z,1591652432.134 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:40:32.134Z,1591652432.134 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 64
2020-06-08T21:40:37.530Z,1591652437.530 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:41:12.674Z,1591652472.674 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:41:47.823Z,1591652507.823 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:41:53.752Z,1591652513.752 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:36:53.6Z
2020-06-08T21:41:53.752Z,1591652513.752 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:41:53.752Z,1591652513.752 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:42:22.962Z,1591652542.962 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:42:58.103Z,1591652578.103 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:43:32.678Z,1591652612.678 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 65
2020-06-08T21:43:32.678Z,1591652612.678 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:43:32.688Z,1591652612.688 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:43:33.063Z,1591652613.063 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:43:33.063Z,1591652613.063 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 65
2020-06-08T21:43:33.250Z,1591652613.250 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:44:08.390Z,1591652648.390 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:44:43.530Z,1591652683.530 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:44:55.419Z,1591652695.419 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:44:55.419Z,1591652695.419 [NAL9602] Data Fault, FailCount= 3
2020-06-08T21:44:55.419Z,1591652695.419 [NAL9602](ERROR): Data Fault
2020-06-08T21:44:55.477Z,1591652695.477 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:44:55.823Z,1591652695.823 [NAL9602](INFO): Powering down
2020-06-08T21:44:56.679Z,1591652696.679 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:44:56.679Z,1591652696.679 [NAL9602] No Fault, FailCount= 3
2020-06-08T21:45:18.678Z,1591652718.678 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:45:26.115Z,1591652726.115 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:45:37.031Z,1591652737.031 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:45:53.818Z,1591652753.818 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:46:28.962Z,1591652788.962 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:46:34.025Z,1591652794.025 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 66
2020-06-08T21:46:34.025Z,1591652794.025 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:46:34.035Z,1591652794.035 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:46:34.148Z,1591652794.148 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:46:34.148Z,1591652794.148 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 66
2020-06-08T21:47:04.106Z,1591652824.106 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:47:39.274Z,1591652859.274 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:48:14.414Z,1591652894.414 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:48:49.566Z,1591652929.566 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:49:24.706Z,1591652964.706 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:49:34.541Z,1591652974.541 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 67
2020-06-08T21:49:34.541Z,1591652974.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:49:34.550Z,1591652974.550 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:49:34.659Z,1591652974.659 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:49:34.659Z,1591652974.659 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 67
2020-06-08T21:49:59.846Z,1591652999.846 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:50:34.987Z,1591653034.987 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:51:10.126Z,1591653070.126 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:51:45.266Z,1591653105.266 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:52:20.406Z,1591653140.406 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:52:35.283Z,1591653155.283 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 68
2020-06-08T21:52:35.283Z,1591653155.283 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:52:35.382Z,1591653155.382 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:52:35.579Z,1591653155.579 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:52:35.579Z,1591653155.579 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 68
2020-06-08T21:52:55.559Z,1591653175.559 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:53:30.706Z,1591653210.706 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:54:05.846Z,1591653245.846 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:54:40.986Z,1591653280.986 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:55:16.126Z,1591653316.126 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:55:35.963Z,1591653335.963 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 69
2020-06-08T21:55:35.963Z,1591653335.963 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:55:35.973Z,1591653335.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:55:36.403Z,1591653336.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:55:36.403Z,1591653336.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 69
2020-06-08T21:55:39.313Z,1591653339.313 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:55:39.313Z,1591653339.313 [NAL9602] Data Fault, FailCount= 4
2020-06-08T21:55:39.313Z,1591653339.313 [NAL9602](ERROR): Data Fault
2020-06-08T21:55:39.404Z,1591653339.404 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:55:39.711Z,1591653339.711 [NAL9602](INFO): Powering down
2020-06-08T21:55:40.575Z,1591653340.575 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:55:40.575Z,1591653340.575 [NAL9602] No Fault, FailCount= 4
2020-06-08T21:55:51.266Z,1591653351.266 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:56:10.011Z,1591653370.011 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:56:20.922Z,1591653380.922 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:56:26.419Z,1591653386.419 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:56:34.738Z,1591653394.738 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2020-06-08T21:57:01.558Z,1591653421.558 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:57:14.926Z,1591653434.926 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T21:57:14.932Z,1591653434.932 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T21:57:36.714Z,1591653456.714 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:58:11.862Z,1591653491.862 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:58:37.086Z,1591653517.086 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 70
2020-06-08T21:58:37.086Z,1591653517.086 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:58:37.124Z,1591653517.124 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:58:37.952Z,1591653517.952 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:58:37.952Z,1591653517.952 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 70
2020-06-08T21:58:47.010Z,1591653527.010 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:59:22.160Z,1591653562.160 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T21:59:57.306Z,1591653597.306 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:00:32.447Z,1591653632.447 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:01:07.586Z,1591653667.586 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:01:38.452Z,1591653698.452 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 71
2020-06-08T22:01:38.452Z,1591653698.452 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T22:01:38.487Z,1591653698.487 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T22:01:38.581Z,1591653698.581 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T22:01:38.581Z,1591653698.581 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 71
2020-06-08T22:01:42.738Z,1591653702.738 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:02:17.890Z,1591653737.890 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:02:53.030Z,1591653773.030 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:03:28.178Z,1591653808.178 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:04:03.319Z,1591653843.319 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:04:10.367Z,1591653850.367 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-06-08T22:04:38.458Z,1591653878.458 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:04:39.619Z,1591653879.619 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 72
2020-06-08T22:04:39.619Z,1591653879.619 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T22:04:39.628Z,1591653879.628 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T22:04:39.738Z,1591653879.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T22:04:39.738Z,1591653879.738 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 72
2020-06-08T22:04:55.357Z,1591653895.357 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-06-08T22:05:13.598Z,1591653913.598 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:05:48.738Z,1591653948.738 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:06:23.886Z,1591653983.886 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:06:25.247Z,1591653985.247 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T22:06:25.247Z,1591653985.247 [NAL9602] Data Fault, FailCount= 5
2020-06-08T22:06:25.247Z,1591653985.247 [NAL9602](ERROR): Data Fault
2020-06-08T22:06:25.311Z,1591653985.311 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T22:06:25.312Z,1591653985.312 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T22:06:25.651Z,1591653985.651 [NAL9602](INFO): Powering down
2020-06-08T22:06:25.716Z,1591653985.716 [CBIT](INFO): Critical error at 20200608T220625
2020-06-08T22:06:59.034Z,1591654019.034 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:07:34.174Z,1591654054.174 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:07:40.411Z,1591654060.411 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 73
2020-06-08T22:07:40.411Z,1591654060.411 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T22:07:40.429Z,1591654060.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T22:07:40.830Z,1591654060.830 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T22:07:40.830Z,1591654060.830 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 73
2020-06-08T22:08:09.315Z,1591654089.315 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-06-08T22:08:25.271Z,1591654105.271 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T22:08:25.271Z,1591654105.271 [NAL9602] No Fault, FailCount= 5
2020-06-08T22:08:25.639Z,1591654105.639 [NAL9602](INFO): Powering up NAL9602
2020-06-08T22:08:29.875Z,1591654109.875 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004082
2020-06-08T22:08:33.732Z,1591654113.732 [CommandLine](IMPORTANT): got command quit
2020-06-08T22:08:34.738Z,1591654114.738 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:34.738Z,1591654114.738 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:34.786Z,1591654114.786 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-06-08T22:08:34.786Z,1591654114.786 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:34.787Z,1591654114.787 [CommandLine](INFO): Join timeout helper Thread ID is 3123
2020-06-08T22:08:34.794Z,1591654114.794 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-06-08T22:08:34.794Z,1591654114.794 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:34.794Z,1591654114.794 [NavChartDb](INFO): Join timeout helper Thread ID is 3124
2020-06-08T22:08:35.086Z,1591654115.086 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:35.086Z,1591654115.086 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.094Z,1591654115.094 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-06-08T22:08:35.094Z,1591654115.094 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.094Z,1591654115.094 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3125
2020-06-08T22:08:35.170Z,1591654115.170 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:35.171Z,1591654115.171 [WetLabsBB2FL](INFO): Powering down
2020-06-08T22:08:35.171Z,1591654115.171 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.182Z,1591654115.182 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-06-08T22:08:35.182Z,1591654115.182 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.182Z,1591654115.182 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3126
2020-06-08T22:08:35.382Z,1591654115.382 [CTD_Seabird](INFO): Powering down
2020-06-08T22:08:35.394Z,1591654115.394 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:35.394Z,1591654115.394 [CTD_Seabird](INFO): Powering down
2020-06-08T22:08:35.406Z,1591654115.406 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.418Z,1591654115.418 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler
2020-06-08T22:08:35.418Z,1591654115.418 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.418Z,1591654115.418 [BackSeatDriver](INFO): Join timeout helper Thread ID is 3127
2020-06-08T22:08:35.482Z,1591654115.482 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:35.482Z,1591654115.482 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.487Z,1591654115.487 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-06-08T22:08:35.487Z,1591654115.487 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.487Z,1591654115.487 [Radio_Surface](INFO): Join timeout helper Thread ID is 3128
2020-06-08T22:08:35.614Z,1591654115.614 [Radio_Surface](INFO): Powering down
2020-06-08T22:08:35.615Z,1591654115.615 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:35.615Z,1591654115.615 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.635Z,1591654115.635 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-06-08T22:08:35.635Z,1591654115.635 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:35.636Z,1591654115.636 [DataOverHttps](INFO): Join timeout helper Thread ID is 3129
2020-06-08T22:08:36.421Z,1591654116.421 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:36.427Z,1591654116.427 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.447Z,1591654116.447 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-06-08T22:08:36.447Z,1591654116.447 [logger ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.447Z,1591654116.447 [logger](INFO): Join timeout helper Thread ID is 3130
2020-06-08T22:08:36.470Z,1591654116.470 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:36.470Z,1591654116.470 [logger ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.487Z,1591654116.487 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-06-08T22:08:36.487Z,1591654116.487 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.487Z,1591654116.487 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-06-08T22:08:36.487Z,1591654116.487 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.487Z,1591654116.487 [controlThread](INFO): Join timeout helper Thread ID is 3131
2020-06-08T22:08:36.534Z,1591654116.534 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T22:08:36.534Z,1591654116.534 [controlThread](DEBUG): Uninitializing ControlThread
2020-06-08T22:08:36.535Z,1591654116.535 [AHRS_M2](INFO): Powering down
2020-06-08T22:08:36.606Z,1591654116.606 [NAL9602](INFO): Powering down
2020-06-08T22:08:36.678Z,1591654116.678 [RDI_Pathfinder](INFO): Powering down
2020-06-08T22:08:36.679Z,1591654116.679 [DAT](INFO): Powering down
2020-06-08T22:08:36.799Z,1591654116.799 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-06-08T22:08:36.799Z,1591654116.799 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-06-08T22:08:36.800Z,1591654116.800 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-06-08T22:08:36.800Z,1591654116.800 [MissionManager](INFO): Uninitializing Mission Default
2020-06-08T22:08:36.800Z,1591654116.800 [Default] Stopped
2020-06-08T22:08:36.801Z,1591654116.801 [Default](DEBUG): Aggregate::uninitialize Default
2020-06-08T22:08:36.801Z,1591654116.801 [Default:B.GoToSurface] Stopped
2020-06-08T22:08:36.801Z,1591654116.801 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-06-08T22:08:36.801Z,1591654116.801 [Default:CheckIn] Stopped
2020-06-08T22:08:36.801Z,1591654116.801 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T22:08:36.801Z,1591654116.801 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T22:08:36.803Z,1591654116.803 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-06-08T22:08:36.804Z,1591654116.804 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-06-08T22:08:36.804Z,1591654116.804 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-06-08T22:08:36.804Z,1591654116.804 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-06-08T22:08:36.804Z,1591654116.804 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-06-08T22:08:36.804Z,1591654116.804 [ElevatorServo](INFO): Powering down
2020-06-08T22:08:36.805Z,1591654116.805 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-06-08T22:08:36.805Z,1591654116.805 [MassServo](INFO): Powering down
2020-06-08T22:08:36.806Z,1591654116.806 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-06-08T22:08:36.807Z,1591654116.807 [RudderServo](INFO): Powering down
2020-06-08T22:08:36.807Z,1591654116.807 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-06-08T22:08:36.807Z,1591654116.807 [ThrusterServo](INFO): Powering down
2020-06-08T22:08:36.808Z,1591654116.808 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-06-08T22:08:36.809Z,1591654116.809 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-06-08T22:08:36.809Z,1591654116.809 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-06-08T22:08:36.809Z,1591654116.809 [CBIT](DEBUG): Powering off loads.
2020-06-08T22:08:36.822Z,1591654116.822 [CBIT](DEBUG): Disabling WDT.
2020-06-08T22:08:36.834Z,1591654116.834 [CBIT](DEBUG): Opening all GF detection circuits.
2020-06-08T22:08:36.835Z,1591654116.835 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.978Z,1591654116.978 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:36.985Z,1591654116.985 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:37.051Z,1591654117.051 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:37.055Z,1591654117.055 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:37.058Z,1591654117.058 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:37.072Z,1591654117.072 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-08T22:08:37.133Z,1591654117.133 [logger ThreadHandler](INFO): Thread cancelled.