2020-06-08T17:47:06.387Z,1591638426.387 [Supervisor](DEBUG): Initializing supervisor.
2020-06-08T17:47:06.390Z,1591638426.390 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-06-08T17:47:06.391Z,1591638426.391 [SyncHandler](INFO): Protected caller Thread ID is 2372
2020-06-08T17:47:06.392Z,1591638426.392 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-06-08T17:47:06.392Z,1591638426.392 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-06-08T17:47:06.393Z,1591638426.393 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2373
2020-06-08T17:47:06.396Z,1591638426.396 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-06-08T17:47:06.409Z,1591638426.409 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-06-08T17:47:06.410Z,1591638426.410 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-06-08T17:47:06.410Z,1591638426.410 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2374
2020-06-08T17:47:06.411Z,1591638426.411 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-06-08T17:47:06.412Z,1591638426.412 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-06-08T17:47:06.413Z,1591638426.413 [logger ThreadHandler](INFO): Protected caller Thread ID is 2375
2020-06-08T17:47:06.415Z,1591638426.415 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-06-08T17:47:06.415Z,1591638426.415 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-06-08T17:47:06.417Z,1591638426.417 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-06-08T17:47:06.618Z,1591638426.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-06-08T17:47:06.619Z,1591638426.619 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-06-08T17:47:06.696Z,1591638426.696 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-06-08T17:47:07.106Z,1591638427.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-06-08T17:47:07.107Z,1591638427.107 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-06-08T17:47:07.407Z,1591638427.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-06-08T17:47:07.408Z,1591638427.408 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-06-08T17:47:07.501Z,1591638427.501 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-06-08T17:47:07.501Z,1591638427.501 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-06-08T17:47:07.780Z,1591638427.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-06-08T17:47:07.781Z,1591638427.781 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-06-08T17:47:07.964Z,1591638427.964 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-06-08T17:47:07.965Z,1591638427.965 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-06-08T17:47:08.409Z,1591638428.409 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-06-08T17:47:08.409Z,1591638428.409 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-06-08T17:47:08.509Z,1591638428.509 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-06-08T17:47:08.509Z,1591638428.509 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-06-08T17:47:08.607Z,1591638428.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-06-08T17:47:08.608Z,1591638428.608 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-06-08T17:47:09.232Z,1591638429.232 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-06-08T17:47:09.232Z,1591638429.232 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-06-08T17:47:09.643Z,1591638429.643 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-06-08T17:47:09.643Z,1591638429.643 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-06-08T17:47:09.823Z,1591638429.823 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-06-08T17:47:09.824Z,1591638429.824 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-06-08T17:47:09.966Z,1591638429.966 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-06-08T17:47:09.967Z,1591638429.967 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-06-08T17:47:10.109Z,1591638430.109 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-06-08T17:47:10.109Z,1591638430.109 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-06-08T17:47:10.310Z,1591638430.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-06-08T17:47:10.312Z,1591638430.312 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2020-06-08T17:47:10.313Z,1591638430.313 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2020-06-08T17:47:10.400Z,1591638430.400 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2020-06-08T17:47:10.497Z,1591638430.497 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2020-06-08T17:47:10.641Z,1591638430.641 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2020-06-08T17:47:10.884Z,1591638430.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2020-06-08T17:47:11.038Z,1591638431.038 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2020-06-08T17:47:11.140Z,1591638431.140 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2020-06-08T17:47:11.393Z,1591638431.393 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2020-06-08T17:47:11.468Z,1591638431.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2020-06-08T17:47:11.626Z,1591638431.626 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2020-06-08T17:47:11.767Z,1591638431.767 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2020-06-08T17:47:11.880Z,1591638431.880 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2020-06-08T17:47:12.108Z,1591638432.108 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-06-08T17:47:12.110Z,1591638432.110 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2020-06-08T17:47:12.110Z,1591638432.110 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-06-08T17:47:12.115Z,1591638432.115 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-06-08T17:47:12.166Z,1591638432.166 [VerticalControl](DEBUG): Construct VerticalControl.
2020-06-08T17:47:12.279Z,1591638432.279 [VerticalControl] Loaded
2020-06-08T17:47:12.279Z,1591638432.279 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-06-08T17:47:12.280Z,1591638432.280 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-06-08T17:47:12.360Z,1591638432.360 [HorizontalControl] Loaded
2020-06-08T17:47:12.361Z,1591638432.361 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-06-08T17:47:12.361Z,1591638432.361 [SpeedControl](DEBUG): Construct SpeedControl.
2020-06-08T17:47:12.367Z,1591638432.367 [SpeedControl] Loaded
2020-06-08T17:47:12.367Z,1591638432.367 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-06-08T17:47:12.368Z,1591638432.368 [LoopControl](DEBUG): Construct LoopControl.
2020-06-08T17:47:12.368Z,1591638432.368 [LoopControl] Loaded
2020-06-08T17:47:12.369Z,1591638432.369 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-06-08T17:47:12.369Z,1591638432.369 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-06-08T17:47:12.369Z,1591638432.369 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-06-08T17:47:12.388Z,1591638432.388 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-06-08T17:47:12.389Z,1591638432.389 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-06-08T17:47:12.488Z,1591638432.488 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-06-08T17:47:12.489Z,1591638432.489 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-06-08T17:47:12.617Z,1591638432.617 [BuoyancyServo] Loaded
2020-06-08T17:47:12.617Z,1591638432.617 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-06-08T17:47:12.628Z,1591638432.628 [ElevatorServo] Loaded
2020-06-08T17:47:12.628Z,1591638432.628 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-06-08T17:47:12.639Z,1591638432.639 [MassServo] Loaded
2020-06-08T17:47:12.639Z,1591638432.639 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-06-08T17:47:12.650Z,1591638432.650 [RudderServo] Loaded
2020-06-08T17:47:12.650Z,1591638432.650 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-06-08T17:47:12.661Z,1591638432.661 [ThrusterServo] Loaded
2020-06-08T17:47:12.661Z,1591638432.661 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-06-08T17:47:12.662Z,1591638432.662 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-06-08T17:47:12.662Z,1591638432.662 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-06-08T17:47:12.768Z,1591638432.768 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-06-08T17:47:12.768Z,1591638432.768 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-06-08T17:47:12.789Z,1591638432.789 [NavChart] Loaded
2020-06-08T17:47:12.789Z,1591638432.789 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-06-08T17:47:12.793Z,1591638432.793 [UniversalFixResidualReporter] Loaded
2020-06-08T17:47:12.793Z,1591638432.793 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-06-08T17:47:12.794Z,1591638432.794 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-06-08T17:47:12.794Z,1591638432.794 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-06-08T17:47:12.876Z,1591638432.876 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-06-08T17:47:12.877Z,1591638432.877 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-06-08T17:47:13.162Z,1591638433.162 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-06-08T17:47:13.167Z,1591638433.167 [AHRS_M2](INFO): created writer for : platform_orientation
2020-06-08T17:47:13.168Z,1591638433.168 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-06-08T17:47:13.174Z,1591638433.174 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-06-08T17:47:13.174Z,1591638433.174 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-06-08T17:47:13.179Z,1591638433.179 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-06-08T17:47:13.180Z,1591638433.180 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-06-08T17:47:13.185Z,1591638433.185 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-06-08T17:47:13.258Z,1591638433.258 [AHRS_M2] Loaded
2020-06-08T17:47:13.259Z,1591638433.259 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-06-08T17:47:13.338Z,1591638433.338 [DataOverHttps] Loaded
2020-06-08T17:47:13.338Z,1591638433.338 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-06-08T17:47:13.339Z,1591638433.339 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408924E0
2020-06-08T17:47:13.339Z,1591638433.339 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2460
2020-06-08T17:47:13.353Z,1591638433.353 [Depth_Keller] Loaded
2020-06-08T17:47:13.353Z,1591638433.353 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-06-08T17:47:13.358Z,1591638433.358 [DropWeight] Loaded
2020-06-08T17:47:13.358Z,1591638433.358 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-06-08T17:47:13.457Z,1591638433.457 [NAL9602] Loaded
2020-06-08T17:47:13.457Z,1591638433.457 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-06-08T17:47:13.504Z,1591638433.504 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now
2020-06-08T17:47:13.505Z,1591638433.505 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now
2020-06-08T17:47:13.505Z,1591638433.505 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now
2020-06-08T17:47:13.506Z,1591638433.506 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full
2020-06-08T17:47:13.506Z,1591638433.506 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now
2020-06-08T17:47:13.507Z,1591638433.507 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now
2020-06-08T17:47:13.507Z,1591638433.507 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now
2020-06-08T17:47:13.508Z,1591638433.508 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full
2020-06-08T17:47:13.508Z,1591638433.508 [Onboard] Loaded
2020-06-08T17:47:13.508Z,1591638433.508 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-06-08T17:47:13.509Z,1591638433.509 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408C24E0
2020-06-08T17:47:13.510Z,1591638433.510 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2461
2020-06-08T17:47:13.513Z,1591638433.513 [Radio_Surface] Loaded
2020-06-08T17:47:13.513Z,1591638433.513 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-06-08T17:47:13.514Z,1591638433.514 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408F24E0
2020-06-08T17:47:13.515Z,1591638433.515 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2462
2020-06-08T17:47:13.650Z,1591638433.650 [DAT] Loaded
2020-06-08T17:47:13.650Z,1591638433.650 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-06-08T17:47:15.189Z,1591638435.189 [BPC1] Loaded
2020-06-08T17:47:15.189Z,1591638435.189 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-06-08T17:47:15.190Z,1591638435.190 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-06-08T17:47:15.190Z,1591638435.190 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-06-08T17:47:15.230Z,1591638435.230 [DepthRateCalculator] Loaded
2020-06-08T17:47:15.231Z,1591638435.231 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-06-08T17:47:15.236Z,1591638435.236 [PitchRateCalculator] Loaded
2020-06-08T17:47:15.236Z,1591638435.236 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-06-08T17:47:15.248Z,1591638435.248 [SpeedCalculator] Loaded
2020-06-08T17:47:15.248Z,1591638435.248 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-06-08T17:47:15.269Z,1591638435.269 [TempGradientCalculator] Loaded
2020-06-08T17:47:15.269Z,1591638435.269 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-06-08T17:47:15.274Z,1591638435.274 [YawRateCalculator] Loaded
2020-06-08T17:47:15.275Z,1591638435.275 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-06-08T17:47:15.305Z,1591638435.305 [ElevatorOffsetCalculator] Loaded
2020-06-08T17:47:15.305Z,1591638435.305 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-06-08T17:47:15.305Z,1591638435.305 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-06-08T17:47:15.306Z,1591638435.306 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-06-08T17:47:15.499Z,1591638435.499 [CANONSampler] Loaded
2020-06-08T17:47:15.499Z,1591638435.499 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2020-06-08T17:47:15.508Z,1591638435.508 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-06-08T17:47:15.513Z,1591638435.513 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-06-08T17:47:15.514Z,1591638435.514 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-06-08T17:47:15.519Z,1591638435.519 [CTD_Seabird](INFO): created writer for : depth
2020-06-08T17:47:15.519Z,1591638435.519 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-06-08T17:47:15.524Z,1591638435.524 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-06-08T17:47:15.525Z,1591638435.525 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-06-08T17:47:15.530Z,1591638435.530 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-06-08T17:47:15.531Z,1591638435.531 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-06-08T17:47:15.536Z,1591638435.536 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-06-08T17:47:15.536Z,1591638435.536 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-06-08T17:47:15.542Z,1591638435.542 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-06-08T17:47:15.542Z,1591638435.542 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-06-08T17:47:15.548Z,1591638435.548 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-06-08T17:47:15.548Z,1591638435.548 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): mass_concentration_of_oxygen_in_sea_water
2020-06-08T17:47:15.553Z,1591638435.553 [CTD_Seabird](INFO): created writer for : mass_concentration_of_oxygen_in_sea_water
2020-06-08T17:47:15.554Z,1591638435.554 [CTD_Seabird](DEBUG): LcmSlateWriter::add(DAtaURI): CTD_Seabird.sea_water_dissolved_oxygen_freq
2020-06-08T17:47:15.554Z,1591638435.554 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): dataName: sea_water_dissolved_oxygen_freq
2020-06-08T17:47:15.587Z,1591638435.587 [CTD_Seabird] Loaded
2020-06-08T17:47:15.587Z,1591638435.587 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-06-08T17:47:15.588Z,1591638435.588 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409FE4E0
2020-06-08T17:47:15.589Z,1591638435.589 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2463
2020-06-08T17:47:15.604Z,1591638435.604 [PAR_Licor] Loaded
2020-06-08T17:47:15.604Z,1591638435.604 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-06-08T17:47:15.610Z,1591638435.610 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-06-08T17:47:15.610Z,1591638435.610 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-06-08T17:47:15.615Z,1591638435.615 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-06-08T17:47:15.615Z,1591638435.615 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-06-08T17:47:15.619Z,1591638435.619 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-06-08T17:47:15.619Z,1591638435.619 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-06-08T17:47:15.624Z,1591638435.624 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-06-08T17:47:15.624Z,1591638435.624 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-06-08T17:47:15.628Z,1591638435.628 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-06-08T17:47:15.628Z,1591638435.628 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-06-08T17:47:15.633Z,1591638435.633 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-06-08T17:47:15.633Z,1591638435.633 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-06-08T17:47:15.637Z,1591638435.637 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-06-08T17:47:15.638Z,1591638435.638 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-06-08T17:47:15.642Z,1591638435.642 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.647Z,1591638435.647 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.647Z,1591638435.647 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.647Z,1591638435.647 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.652Z,1591638435.652 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.652Z,1591638435.652 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.656Z,1591638435.656 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.656Z,1591638435.656 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-06-08T17:47:15.661Z,1591638435.661 [WetLabsBB2FL] Loaded
2020-06-08T17:47:15.661Z,1591638435.661 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-06-08T17:47:15.662Z,1591638435.662 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A2E4E0
2020-06-08T17:47:15.662Z,1591638435.662 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2464
2020-06-08T17:47:15.663Z,1591638435.663 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-06-08T17:47:15.664Z,1591638435.664 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-06-08T17:47:15.847Z,1591638435.847 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-06-08T17:47:15.847Z,1591638435.847 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-06-08T17:47:16.212Z,1591638436.212 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-06-08T17:47:16.212Z,1591638436.212 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-06-08T17:47:16.347Z,1591638436.347 [SBIT](DEBUG): Construct Startup Built In Test.
2020-06-08T17:47:16.358Z,1591638436.358 [SBIT] Loaded
2020-06-08T17:47:16.358Z,1591638436.358 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-06-08T17:47:16.359Z,1591638436.359 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-06-08T17:47:16.371Z,1591638436.371 [IBIT] Loaded
2020-06-08T17:47:16.371Z,1591638436.371 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-06-08T17:47:16.374Z,1591638436.374 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-06-08T17:47:16.514Z,1591638436.514 [CBIT] Loaded
2020-06-08T17:47:16.514Z,1591638436.514 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-06-08T17:47:16.514Z,1591638436.514 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-06-08T17:47:16.515Z,1591638436.515 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-06-08T17:47:16.591Z,1591638436.591 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-06-08T17:47:16.595Z,1591638436.595 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-06-08T17:47:16.596Z,1591638436.596 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-06-08T17:47:16.602Z,1591638436.602 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-06-08T17:47:16.603Z,1591638436.603 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B5F4E0
2020-06-08T17:47:16.604Z,1591638436.604 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2465
2020-06-08T17:47:16.608Z,1591638436.608 [Supervisor](INFO): Main Thread ID is 2104
2020-06-08T17:47:16.608Z,1591638436.608 [Supervisor](DEBUG): Running supervisor.
2020-06-08T17:47:16.609Z,1591638436.609 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2466
2020-06-08T17:47:16.611Z,1591638436.611 [controlThread ThreadHandler](INFO): Handler Thread ID is 2467
2020-06-08T17:47:16.612Z,1591638436.612 [controlThread](DEBUG): Initializing ControlThread
2020-06-08T17:47:16.613Z,1591638436.613 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-06-08T17:47:16.614Z,1591638436.614 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-06-08T17:47:16.615Z,1591638436.615 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-06-08T17:47:16.615Z,1591638436.615 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-06-08T17:47:16.617Z,1591638436.617 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-06-08T17:47:16.618Z,1591638436.618 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-06-08T17:47:16.621Z,1591638436.621 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-06-08T17:47:16.621Z,1591638436.621 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-06-08T17:47:16.621Z,1591638436.621 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-06-08T17:47:16.622Z,1591638436.622 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-06-08T17:47:16.622Z,1591638436.622 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-06-08T17:47:16.622Z,1591638436.622 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-06-08T17:47:16.627Z,1591638436.627 [SBIT](INFO): Initialize SBIT Component.
2020-06-08T17:47:16.628Z,1591638436.628 [SBIT](IMPORTANT): git: 2020-06-05
2020-06-08T17:47:16.628Z,1591638436.628 [SBIT](INFO): git hash: c12bfff2bdf9b929af60ba43c4eb841aed31d072
2020-06-08T17:47:16.628Z,1591638436.628 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-06-08T17:47:16.629Z,1591638436.629 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2020-06-08T17:47:16.630Z,1591638436.630 [SBIT](INFO): Beginning SBIT in 76.000000 seconds.
2020-06-08T17:47:16.631Z,1591638436.631 [IBIT](INFO): Initialize IBIT Component.
2020-06-08T17:47:16.632Z,1591638436.632 [CBIT](DEBUG): Initialize CBIT Component.
2020-06-08T17:47:16.633Z,1591638436.633 [logger ThreadHandler](INFO): Handler Thread ID is 2468
2020-06-08T17:47:16.643Z,1591638436.643 [CBIT](DEBUG): Initialized mux pins.
2020-06-08T17:47:16.643Z,1591638436.643 [CBIT](DEBUG): Initializing the watchdog timer.
2020-06-08T17:47:16.651Z,1591638436.651 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2469
2020-06-08T17:47:16.652Z,1591638436.652 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-06-08T17:47:16.663Z,1591638436.663 [Onboard ThreadHandler](INFO): Handler Thread ID is 2470
2020-06-08T17:47:16.667Z,1591638436.667 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-06-08T17:47:16.668Z,1591638436.668 [CBIT](DEBUG): Initializing heartbeat.
2020-06-08T17:47:16.680Z,1591638436.680 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2471
2020-06-08T17:47:16.691Z,1591638436.691 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2472
2020-06-08T17:47:16.692Z,1591638436.692 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-06-08T17:47:16.695Z,1591638436.695 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2020-06-08T17:47:16.696Z,1591638436.696 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2474
2020-06-08T17:47:16.697Z,1591638436.697 [WetLabsBB2FL](INFO): Powering down
2020-06-08T17:47:16.727Z,1591638436.727 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2475
2020-06-08T17:47:16.730Z,1591638436.730 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-06-08T17:47:16.731Z,1591638436.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-06-08T17:47:16.731Z,1591638436.731 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-06-08T17:47:16.731Z,1591638436.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-06-08T17:47:16.731Z,1591638436.731 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-06-08T17:47:16.731Z,1591638436.731 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-06-08T17:47:16.732Z,1591638436.732 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-06-08T17:47:16.732Z,1591638436.732 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-06-08T17:47:16.732Z,1591638436.732 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-06-08T17:47:16.732Z,1591638436.732 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-06-08T17:47:16.732Z,1591638436.732 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-06-08T17:47:16.733Z,1591638436.733 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-06-08T17:47:16.733Z,1591638436.733 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-06-08T17:47:16.733Z,1591638436.733 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-06-08T17:47:16.733Z,1591638436.733 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-06-08T17:47:16.733Z,1591638436.733 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-06-08T17:47:16.739Z,1591638436.739 [CBIT](DEBUG): Deactivating GF circuits.
2020-06-08T17:47:16.739Z,1591638436.739 [CBIT](DEBUG): Deactivating emergency mode.
2020-06-08T17:47:16.775Z,1591638436.775 [CBIT](DEBUG): Backplane powered.
2020-06-08T17:47:16.776Z,1591638436.776 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-06-08T17:47:16.786Z,1591638436.786 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-06-08T17:47:16.797Z,1591638436.797 [MissionManager](DEBUG):
2020-06-08T17:47:16.797Z,1591638436.797 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-06-08T17:47:16.881Z,1591638436.881 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-06-08T17:47:16.882Z,1591638436.882 [Default:A.Wait](DEBUG): Construct Wait.
2020-06-08T17:47:16.884Z,1591638436.884 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-06-08T17:47:16.923Z,1591638436.923 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-06-08T17:47:16.926Z,1591638436.926 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-06-08T17:47:16.947Z,1591638436.947 [Default:E.Execute](DEBUG): Construct Execute.
2020-06-08T17:47:16.964Z,1591638436.964 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2020-06-08T17:47:16.968Z,1591638436.968 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,DAT,BPC1,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-06-08T17:47:16.983Z,1591638436.983 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-06-08T17:47:17.020Z,1591638437.020 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2020-06-08T17:47:17.023Z,1591638437.023 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-06-08T17:47:17.023Z,1591638437.023 [DAT](INFO): Powering up
2020-06-08T17:47:17.024Z,1591638437.024 [DAT](DEBUG): Initializing DAT.
2020-06-08T17:47:17.083Z,1591638437.083 [Radio_Surface](INFO): Powering up
2020-06-08T17:47:17.084Z,1591638437.084 [CANONSampler](INFO): Powering down
2020-06-08T17:47:17.111Z,1591638437.111 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-06-08T17:47:17.241Z,1591638437.241 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-06-08T17:47:17.264Z,1591638437.264 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-06-08T17:47:17.271Z,1591638437.271 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-06-08T17:47:17.272Z,1591638437.272 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-06-08T17:47:17.279Z,1591638437.279 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-06-08T17:47:17.280Z,1591638437.280 [MassServo](DEBUG): Initializing EZServoServo.
2020-06-08T17:47:17.287Z,1591638437.287 [MassServo](DEBUG): Initializing MassServo.
2020-06-08T17:47:17.288Z,1591638437.288 [RudderServo](DEBUG): Initializing EZServoServo.
2020-06-08T17:47:17.295Z,1591638437.295 [RudderServo](DEBUG): Initializing RudderServo.
2020-06-08T17:47:17.296Z,1591638437.296 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-06-08T17:47:17.303Z,1591638437.303 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-06-08T17:47:17.489Z,1591638437.489 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2020-06-08T17:47:17.489Z,1591638437.489 [DropWeight] Hardware Fault, FailCount= 1
2020-06-08T17:47:17.489Z,1591638437.489 [DropWeight](ERROR): Hardware Fault
2020-06-08T17:47:17.574Z,1591638437.574 [CommandLine](FAULT): Scheduling is paused
2020-06-08T17:47:17.574Z,1591638437.574 [CBIT](INFO): Critical error at 20200608T174717
2020-06-08T17:47:17.575Z,1591638437.575 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-06-08T17:47:17.577Z,1591638437.577 [CBIT](ERROR): Hardware Fault in component: DropWeight
2020-06-08T17:47:17.578Z,1591638437.578 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2020-06-08T17:47:18.115Z,1591638438.115 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-06-08T17:47:18.115Z,1591638438.115 [RudderServo](FAULT): Rudder failed to initialize
2020-06-08T17:47:18.115Z,1591638438.115 [RudderServo] Communications Fault, FailCount= 1
2020-06-08T17:47:18.115Z,1591638438.115 [RudderServo](ERROR): Communications Fault
2020-06-08T17:47:18.252Z,1591638438.252 [CBIT](INFO): Critical error at 20200608T174717
2020-06-08T17:47:18.254Z,1591638438.254 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-06-08T17:47:18.452Z,1591638438.452 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-06-08T17:47:18.452Z,1591638438.452 [RudderServo](INFO): Powering down
2020-06-08T17:47:19.090Z,1591638439.090 [RudderServo](DEBUG): Initializing EZServoServo.
2020-06-08T17:47:19.208Z,1591638439.208 [RudderServo](DEBUG): Initializing RudderServo.
2020-06-08T17:47:19.212Z,1591638439.212 [CBIT](INFO): Clearing failed state for component RudderServo
2020-06-08T17:47:19.212Z,1591638439.212 [RudderServo] No Fault, FailCount= 1
2020-06-08T17:47:27.584Z,1591638447.584 [DAT](DEBUG):
2020-06-08T17:47:27.585Z,1591638447.585 [DAT](DEBUG): Teledyne Benthos DAT-900 Series
2020-06-08T17:47:28.785Z,1591638448.785 [DAT](DEBUG): MF Frequency Band
2020-06-08T17:47:28.786Z,1591638448.786 [DAT](DEBUG): Directional Acoustic Transponder version 8.12.21
2020-06-08T17:47:28.786Z,1591638448.786 [DAT](DEBUG): Jan 3 2000 23:15:42
2020-06-08T17:47:29.593Z,1591638449.593 [DAT](DEBUG): Features enabled [Bearing]
2020-06-08T17:47:29.594Z,1591638449.594 [DAT](DEBUG): CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2020-06-08T17:47:29.594Z,1591638449.594 [DAT](INFO): commRate: 800
2020-06-08T17:47:29.996Z,1591638449.996 [DAT](INFO): entering command mode
2020-06-08T17:47:30.400Z,1591638450.400 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T17:47:30.401Z,1591638450.401 [DAT](INFO): command mode acknowledged
2020-06-08T17:47:30.401Z,1591638450.401 [DAT](INFO): setting verbose to 3
2020-06-08T17:47:30.804Z,1591638450.804 [DAT](DEBUG): checking for verbose setting acknowledgment
2020-06-08T17:47:30.805Z,1591638450.805 [DAT](INFO): set verbose to 3
2020-06-08T17:47:31.216Z,1591638451.216 [DAT](INFO): setting transmit power to 8
2020-06-08T17:47:31.612Z,1591638451.612 [DAT](DEBUG): checking for transmit power setting acknowledgment
2020-06-08T17:47:32.016Z,1591638452.016 [DAT](DEBUG): checking for transmit power setting acknowledgment
2020-06-08T17:47:32.017Z,1591638452.017 [DAT](INFO): set transmit power to 8
2020-06-08T17:47:32.420Z,1591638452.420 [DAT](INFO): setting local address to 7
2020-06-08T17:47:32.825Z,1591638452.825 [DAT](DEBUG): checking for local address setting acknowledgment
2020-06-08T17:47:33.228Z,1591638453.228 [DAT](DEBUG): checking for local address setting acknowledgment
2020-06-08T17:47:33.229Z,1591638453.229 [DAT](INFO): set local address to 7
2020-06-08T17:47:43.732Z,1591638463.732 [NAL9602](INFO): Powering up NAL9602
2020-06-08T17:47:54.640Z,1591638474.640 [NAL9602](INFO): NAL9602 initialized
2020-06-08T17:48:31.060Z,1591638511.060 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T17:48:33.034Z,1591638513.034 [SBIT](IMPORTANT): Beginning Startup BIT
2020-06-08T17:48:33.038Z,1591638513.038 [CBIT](IMPORTANT): Beginning ground fault scan
2020-06-08T17:48:44.468Z,1591638524.468 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): -0.003330
CHAN A1 (24V): 0.000378
CHAN A2 (12V): -0.001988
CHAN A3 (5V): -0.001484
CHAN B0 (3.3V): 4.766929
CHAN B1 (3.15aV): -0.000120
CHAN B2 (3.15bV): -0.000055
CHAN B3 (GND): 0.000053
OPEN: -0.000612
Full Scale Calc: 4.765 mA, -1.589 mA
2020-06-08T17:49:26.662Z,1591638566.662 [SBIT](IMPORTANT): SBIT PASSED
2020-06-08T17:49:26.663Z,1591638566.663 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-06-08T17:49:26.664Z,1591638566.664 [SBIT](IMPORTANT): CBIT.gf24Offset=154 microampere;
2020-06-08T17:49:26.664Z,1591638566.664 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;
2020-06-08T17:49:26.664Z,1591638566.664 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=264.728883 cubic_centimeter;
2020-06-08T17:49:26.664Z,1591638566.664 [SBIT](IMPORTANT): VerticalControl.massDefault=-14.226688 millimeter;
2020-06-08T17:49:27.053Z,1591638567.053 [MissionManager](IMPORTANT): Started mission Startup
2020-06-08T17:49:27.053Z,1591638567.053 [Startup] Running Loop=1
2020-06-08T17:49:27.053Z,1591638567.053 [Startup](DEBUG): Aggregate::initialize Startup
2020-06-08T17:49:27.053Z,1591638567.053 [Startup:A.GoToSurface] Running Loop=1
2020-06-08T17:49:27.053Z,1591638567.053 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-06-08T17:49:27.054Z,1591638567.054 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-06-08T17:49:27.054Z,1591638567.054 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-06-08T17:49:27.055Z,1591638567.055 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-06-08T17:49:27.055Z,1591638567.055 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-06-08T17:49:27.056Z,1591638567.056 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-06-08T17:49:27.057Z,1591638567.057 [Startup:StartupSatComms] Running Loop=1
2020-06-08T17:49:27.057Z,1591638567.057 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-06-08T17:49:27.057Z,1591638567.057 [Startup:StartupSatComms:A] Running Loop=1
2020-06-08T17:49:27.449Z,1591638567.449 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-06-08T17:49:37.998Z,1591638577.998 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T17:49:59.474Z,1591638599.474 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005077
2020-06-08T17:50:16.728Z,1591638616.728 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-06-08T17:50:16.728Z,1591638616.728 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T17:50:16.761Z,1591638616.761 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T17:50:17.180Z,1591638617.180 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T17:50:17.195Z,1591638617.195 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T17:50:17.195Z,1591638617.195 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-06-08T17:50:27.246Z,1591638627.246 [Startup:StartupSatComms:A](INFO): Timed out from 2020-06-08T17:49:27.1Z
2020-06-08T17:50:27.246Z,1591638627.246 [Startup:StartupSatComms:A] Stopped
2020-06-08T17:50:27.246Z,1591638627.246 [Startup:StartupSatComms:B] Running Loop=1
2020-06-08T17:50:27.664Z,1591638627.664 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-06-08T17:50:27.979Z,1591638627.979 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20200608T173803/Courier0004.lzma
2020-06-08T17:50:28.837Z,1591638628.837 [DataOverHttps](INFO): Moved sent file to Logs/20200608T173803/Courier0004.lzma.bak
2020-06-08T17:50:28.837Z,1591638628.837 [DataOverHttps](INFO): SBD MOMSN=12372384
2020-06-08T17:50:44.299Z,1591638644.299 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20200608T174706/Courier0000.lzma
2020-06-08T17:50:45.300Z,1591638645.300 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0000.lzma.bak
2020-06-08T17:50:45.301Z,1591638645.301 [DataOverHttps](INFO): SBD MOMSN=12372386
2020-06-08T17:51:00.720Z,1591638660.720 [DataOverHttps](INFO): Sending 571 bytes from file Logs/20200608T173803/Express0005.lzma
2020-06-08T17:51:01.724Z,1591638661.724 [DataOverHttps](INFO): Moved sent file to Logs/20200608T173803/Express0005.lzma.bak
2020-06-08T17:51:01.724Z,1591638661.724 [DataOverHttps](INFO): SBD MOMSN=12372391
2020-06-08T17:51:17.272Z,1591638677.272 [DataOverHttps](INFO): Sending 752 bytes from file Logs/20200608T174706/Express0001.lzma
2020-06-08T17:51:18.272Z,1591638678.272 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0001.lzma.bak
2020-06-08T17:51:18.273Z,1591638678.273 [DataOverHttps](INFO): SBD MOMSN=12372414
2020-06-08T17:51:19.809Z,1591638679.809 [Startup:StartupSatComms:B] Stopped
2020-06-08T17:51:19.809Z,1591638679.809 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-06-08T17:51:19.809Z,1591638679.809 [Startup:StartupSatComms] Stopped
2020-06-08T17:51:19.809Z,1591638679.809 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-06-08T17:51:19.810Z,1591638679.810 [Startup](INFO): Completed Startup
2020-06-08T17:51:19.810Z,1591638679.810 [MissionManager](INFO): Startup is completed.
2020-06-08T17:51:19.810Z,1591638679.810 [MissionManager](INFO): Uninitializing Mission Startup
2020-06-08T17:51:19.810Z,1591638679.810 [Startup] Stopped
2020-06-08T17:51:19.810Z,1591638679.810 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-06-08T17:51:19.810Z,1591638679.810 [Startup:A.GoToSurface] Stopped
2020-06-08T17:51:19.810Z,1591638679.810 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-06-08T17:51:20.196Z,1591638680.196 [MissionManager](IMPORTANT): Started mission Default
2020-06-08T17:51:20.197Z,1591638680.197 [Default] Running Loop=1
2020-06-08T17:51:20.197Z,1591638680.197 [Default](DEBUG): Aggregate::initialize Default
2020-06-08T17:51:20.197Z,1591638680.197 [Default:B.GoToSurface] Running Loop=1
2020-06-08T17:51:20.197Z,1591638680.197 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-06-08T17:51:20.197Z,1591638680.197 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-06-08T17:51:20.197Z,1591638680.197 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-06-08T17:51:20.198Z,1591638680.198 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-06-08T17:51:20.198Z,1591638680.198 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-06-08T17:51:20.198Z,1591638680.198 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-06-08T17:51:20.199Z,1591638680.199 [Default:A.Wait] Running Loop=1
2020-06-08T17:51:20.199Z,1591638680.199 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-06-08T17:51:26.733Z,1591638686.733 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T17:51:33.545Z,1591638693.545 [Default:A.Wait](INFO): Done Waiting.
2020-06-08T17:51:33.545Z,1591638693.545 [Default:A.Wait] Stopped
2020-06-08T17:51:33.545Z,1591638693.545 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T17:51:33.952Z,1591638693.952 [Default:CheckIn] Running Loop=1
2020-06-08T17:51:33.952Z,1591638693.952 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T17:51:33.953Z,1591638693.953 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T17:51:34.329Z,1591638694.329 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-06-08T17:51:41.196Z,1591638701.196 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2020-06-08T17:52:54.820Z,1591638774.820 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T17:52:57.945Z,1591638777.945 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-06-08T17:53:06.096Z,1591638786.096 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T17:53:17.772Z,1591638797.772 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-06-08T17:53:17.772Z,1591638797.772 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T17:53:17.781Z,1591638797.781 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T17:53:18.179Z,1591638798.179 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T17:53:18.179Z,1591638798.179 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-06-08T17:54:20.835Z,1591638860.835 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T17:54:36.190Z,1591638876.190 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T17:54:50.346Z,1591638890.346 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T17:55:20.594Z,1591638920.594 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T17:55:20.597Z,1591638920.597 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T17:56:18.768Z,1591638978.768 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-06-08T17:56:18.768Z,1591638978.768 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T17:56:18.778Z,1591638978.778 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T17:56:19.183Z,1591638979.183 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T17:56:19.184Z,1591638979.184 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-06-08T17:56:34.122Z,1591638994.122 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T17:51:33.0Z
2020-06-08T17:56:34.122Z,1591638994.122 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T17:56:34.122Z,1591638994.122 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T17:56:34.521Z,1591638994.521 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-06-08T17:56:41.287Z,1591639001.287 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20200608T174706/Courier0004.lzma
2020-06-08T17:56:42.288Z,1591639002.288 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0004.lzma.bak
2020-06-08T17:56:42.289Z,1591639002.289 [DataOverHttps](INFO): SBD MOMSN=12372445
2020-06-08T17:56:57.619Z,1591639017.619 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20200608T174706/Express0005.lzma
2020-06-08T17:56:58.621Z,1591639018.621 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0005.lzma.bak
2020-06-08T17:56:58.621Z,1591639018.621 [DataOverHttps](INFO): SBD MOMSN=12372447
2020-06-08T17:56:59.968Z,1591639019.968 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T17:56:59.968Z,1591639019.968 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T17:56:59.968Z,1591639019.968 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T17:57:55.696Z,1591639075.696 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T17:57:55.696Z,1591639075.696 [NAL9602] Data Fault, FailCount= 1
2020-06-08T17:57:55.696Z,1591639075.696 [NAL9602](ERROR): Data Fault
2020-06-08T17:57:55.714Z,1591639075.714 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T17:57:56.100Z,1591639076.100 [NAL9602](INFO): Powering down
2020-06-08T17:57:56.942Z,1591639076.942 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T17:57:56.942Z,1591639076.942 [NAL9602] No Fault, FailCount= 1
2020-06-08T17:58:26.400Z,1591639106.400 [NAL9602](INFO): Powering up NAL9602
2020-06-08T17:58:37.315Z,1591639117.315 [NAL9602](INFO): NAL9602 initialized
2020-06-08T17:59:19.735Z,1591639159.735 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-06-08T17:59:19.735Z,1591639159.735 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T17:59:19.769Z,1591639159.769 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T17:59:20.148Z,1591639160.148 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T17:59:20.148Z,1591639160.148 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-06-08T18:02:00.552Z,1591639320.552 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:02:00.552Z,1591639320.552 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:02:00.552Z,1591639320.552 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:02:00.552Z,1591639320.552 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:02:00.965Z,1591639320.965 [Default:CheckIn:D] Stopped
2020-06-08T18:02:00.965Z,1591639320.965 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:02:01.357Z,1591639321.357 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.679468 min
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn:E] Stopped
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn] Stopped
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn](INFO): Running loop #2
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn] Running Loop=2
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:02:01.358Z,1591639321.358 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:02:17.537Z,1591639337.537 [CBIT](INFO): Clearing failed state for component DropWeight
2020-06-08T18:02:17.537Z,1591639337.537 [DropWeight] No Fault, FailCount= 1
2020-06-08T18:02:20.769Z,1591639340.769 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-06-08T18:02:20.769Z,1591639340.769 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:02:20.779Z,1591639340.779 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:02:21.185Z,1591639341.185 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:02:21.185Z,1591639341.185 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-06-08T18:05:21.757Z,1591639521.757 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-06-08T18:05:21.757Z,1591639521.757 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:05:21.766Z,1591639521.766 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:05:22.173Z,1591639522.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:05:22.173Z,1591639522.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-06-08T18:07:01.549Z,1591639621.549 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:02:01.4Z
2020-06-08T18:07:01.549Z,1591639621.549 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:07:01.549Z,1591639621.549 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:07:08.426Z,1591639628.426 [DataOverHttps](INFO): Sending 171 bytes from file Logs/20200608T174706/Express0008.lzma
2020-06-08T18:07:09.428Z,1591639629.428 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0008.lzma.bak
2020-06-08T18:07:09.429Z,1591639629.429 [DataOverHttps](INFO): SBD MOMSN=12372477
2020-06-08T18:07:10.844Z,1591639630.844 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:07:10.844Z,1591639630.844 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:07:10.844Z,1591639630.844 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:08:22.764Z,1591639702.764 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-06-08T18:08:22.764Z,1591639702.764 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:08:22.774Z,1591639702.774 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:08:23.176Z,1591639703.176 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:08:23.176Z,1591639703.176 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-06-08T18:08:39.304Z,1591639719.304 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:08:39.304Z,1591639719.304 [NAL9602] Data Fault, FailCount= 2
2020-06-08T18:08:39.304Z,1591639719.304 [NAL9602](ERROR): Data Fault
2020-06-08T18:08:39.351Z,1591639719.351 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:08:39.704Z,1591639719.704 [NAL9602](INFO): Powering down
2020-06-08T18:08:40.536Z,1591639720.536 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:08:40.536Z,1591639720.536 [NAL9602] No Fault, FailCount= 2
2020-06-08T18:09:10.004Z,1591639750.004 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:09:20.917Z,1591639760.917 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:11:23.740Z,1591639883.740 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-06-08T18:11:23.740Z,1591639883.740 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:11:23.750Z,1591639883.750 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:11:24.156Z,1591639884.156 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:11:24.156Z,1591639884.156 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-06-08T18:12:11.437Z,1591639931.437 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:12:11.437Z,1591639931.437 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:12:11.437Z,1591639931.437 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:12:11.438Z,1591639931.438 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:12:11.824Z,1591639931.824 [Default:CheckIn:D] Stopped
2020-06-08T18:12:11.824Z,1591639931.824 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:12:12.216Z,1591639932.216 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.860457 min
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn:E] Stopped
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn] Stopped
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn](INFO): Running loop #3
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn] Running Loop=3
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:12:12.217Z,1591639932.217 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:14:24.742Z,1591640064.742 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2020-06-08T18:14:24.742Z,1591640064.742 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:14:24.752Z,1591640064.752 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:14:25.171Z,1591640065.171 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:14:25.172Z,1591640065.172 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2020-06-08T18:17:12.394Z,1591640232.394 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:12:12.2Z
2020-06-08T18:17:12.394Z,1591640232.394 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:17:12.394Z,1591640232.394 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:17:20.547Z,1591640240.547 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0011.lzma
2020-06-08T18:17:21.549Z,1591640241.549 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0011.lzma.bak
2020-06-08T18:17:21.549Z,1591640241.549 [DataOverHttps](INFO): SBD MOMSN=12372595
2020-06-08T18:17:22.918Z,1591640242.918 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:17:22.918Z,1591640242.918 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:17:22.918Z,1591640242.918 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:17:25.751Z,1591640245.751 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2020-06-08T18:17:25.751Z,1591640245.751 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:17:25.769Z,1591640245.769 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:17:26.167Z,1591640246.167 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:17:26.167Z,1591640246.167 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2020-06-08T18:19:22.064Z,1591640362.064 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:19:22.064Z,1591640362.064 [NAL9602] Data Fault, FailCount= 3
2020-06-08T18:19:22.064Z,1591640362.064 [NAL9602](ERROR): Data Fault
2020-06-08T18:19:22.081Z,1591640362.081 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:19:22.472Z,1591640362.472 [NAL9602](INFO): Powering down
2020-06-08T18:19:23.321Z,1591640363.321 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:19:23.321Z,1591640363.321 [NAL9602] No Fault, FailCount= 3
2020-06-08T18:19:52.768Z,1591640392.768 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:20:03.672Z,1591640403.672 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:20:26.737Z,1591640426.737 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2020-06-08T18:20:26.737Z,1591640426.737 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:20:26.751Z,1591640426.751 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:20:27.163Z,1591640427.163 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:20:27.163Z,1591640427.163 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2020-06-08T18:22:23.481Z,1591640543.481 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:22:23.481Z,1591640543.481 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:22:23.481Z,1591640543.481 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:22:23.481Z,1591640543.481 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:22:23.877Z,1591640543.877 [Default:CheckIn:D] Stopped
2020-06-08T18:22:23.877Z,1591640543.877 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:22:24.294Z,1591640544.294 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.061344 min
2020-06-08T18:22:24.294Z,1591640544.294 [Default:CheckIn:E] Stopped
2020-06-08T18:22:24.294Z,1591640544.294 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:22:24.294Z,1591640544.294 [Default:CheckIn] Stopped
2020-06-08T18:22:24.295Z,1591640544.295 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:22:24.295Z,1591640544.295 [Default:CheckIn](INFO): Running loop #4
2020-06-08T18:22:24.295Z,1591640544.295 [Default:CheckIn] Running Loop=4
2020-06-08T18:22:24.295Z,1591640544.295 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:22:24.295Z,1591640544.295 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:23:27.726Z,1591640607.726 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2020-06-08T18:23:27.726Z,1591640607.726 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:23:27.735Z,1591640607.735 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:23:28.156Z,1591640608.156 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:23:28.156Z,1591640608.156 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2020-06-08T18:26:28.722Z,1591640788.722 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2020-06-08T18:26:28.722Z,1591640788.722 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:26:28.733Z,1591640788.733 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:26:29.133Z,1591640789.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:26:29.133Z,1591640789.133 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2020-06-08T18:27:24.449Z,1591640844.449 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:22:24.3Z
2020-06-08T18:27:24.449Z,1591640844.449 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:27:24.449Z,1591640844.449 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:27:31.371Z,1591640851.371 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0014.lzma
2020-06-08T18:27:32.373Z,1591640852.373 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0014.lzma.bak
2020-06-08T18:27:32.373Z,1591640852.373 [DataOverHttps](INFO): SBD MOMSN=12372711
2020-06-08T18:27:33.766Z,1591640853.766 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:27:33.766Z,1591640853.766 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:27:33.766Z,1591640853.766 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:29:29.702Z,1591640969.702 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2020-06-08T18:29:29.702Z,1591640969.702 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:29:29.712Z,1591640969.712 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:29:30.125Z,1591640970.125 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:29:30.125Z,1591640970.125 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2020-06-08T18:30:04.824Z,1591641004.824 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:30:04.824Z,1591641004.824 [NAL9602] Data Fault, FailCount= 4
2020-06-08T18:30:04.824Z,1591641004.824 [NAL9602](ERROR): Data Fault
2020-06-08T18:30:04.861Z,1591641004.861 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:30:05.232Z,1591641005.232 [NAL9602](INFO): Powering down
2020-06-08T18:30:06.065Z,1591641006.065 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:30:06.065Z,1591641006.065 [NAL9602] No Fault, FailCount= 4
2020-06-08T18:30:35.533Z,1591641035.533 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:30:46.444Z,1591641046.444 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:32:30.684Z,1591641150.684 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2020-06-08T18:32:30.684Z,1591641150.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:32:30.694Z,1591641150.694 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:32:31.132Z,1591641151.132 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:32:31.132Z,1591641151.132 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2020-06-08T18:32:34.333Z,1591641154.333 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:32:34.333Z,1591641154.333 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:32:34.333Z,1591641154.333 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:32:34.333Z,1591641154.333 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:32:34.745Z,1591641154.745 [Default:CheckIn:D] Stopped
2020-06-08T18:32:34.745Z,1591641154.745 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:32:35.145Z,1591641155.145 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.242476 min
2020-06-08T18:32:35.145Z,1591641155.145 [Default:CheckIn:E] Stopped
2020-06-08T18:32:35.145Z,1591641155.145 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:32:35.145Z,1591641155.145 [Default:CheckIn] Stopped
2020-06-08T18:32:35.145Z,1591641155.145 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:32:35.146Z,1591641155.146 [Default:CheckIn](INFO): Running loop #5
2020-06-08T18:32:35.146Z,1591641155.146 [Default:CheckIn] Running Loop=5
2020-06-08T18:32:35.146Z,1591641155.146 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:32:35.146Z,1591641155.146 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:35:31.684Z,1591641331.684 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2020-06-08T18:35:31.684Z,1591641331.684 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:35:31.694Z,1591641331.694 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:35:32.104Z,1591641332.104 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:35:32.104Z,1591641332.104 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2020-06-08T18:37:35.304Z,1591641455.304 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:32:35.1Z
2020-06-08T18:37:35.304Z,1591641455.304 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:37:35.304Z,1591641455.304 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:37:42.410Z,1591641462.410 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0017.lzma
2020-06-08T18:37:43.413Z,1591641463.413 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0017.lzma.bak
2020-06-08T18:37:43.413Z,1591641463.413 [DataOverHttps](INFO): SBD MOMSN=12372747
2020-06-08T18:37:44.589Z,1591641464.589 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:37:44.589Z,1591641464.589 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:37:44.589Z,1591641464.589 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:38:32.663Z,1591641512.663 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2020-06-08T18:38:32.663Z,1591641512.663 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:38:32.703Z,1591641512.703 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:38:33.106Z,1591641513.106 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:38:33.106Z,1591641513.106 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2020-06-08T18:40:47.597Z,1591641647.597 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:40:47.597Z,1591641647.597 [NAL9602] Data Fault, FailCount= 5
2020-06-08T18:40:47.597Z,1591641647.597 [NAL9602](ERROR): Data Fault
2020-06-08T18:40:47.614Z,1591641647.614 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:40:47.614Z,1591641647.614 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T18:40:47.992Z,1591641647.992 [NAL9602](INFO): Powering down
2020-06-08T18:40:48.039Z,1591641648.039 [CBIT](INFO): Critical error at 20200608T184047
2020-06-08T18:41:33.663Z,1591641693.663 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2020-06-08T18:41:33.663Z,1591641693.663 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:41:33.697Z,1591641693.697 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:41:34.072Z,1591641694.072 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:41:34.072Z,1591641694.072 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2020-06-08T18:42:45.171Z,1591641765.171 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:42:45.172Z,1591641765.172 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:42:45.172Z,1591641765.172 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:42:45.172Z,1591641765.172 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:42:45.581Z,1591641765.581 [Default:CheckIn:D] Stopped
2020-06-08T18:42:45.581Z,1591641765.581 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.423067 min
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn:E] Stopped
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn] Stopped
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn](INFO): Running loop #6
2020-06-08T18:42:45.973Z,1591641765.973 [Default:CheckIn] Running Loop=6
2020-06-08T18:42:45.974Z,1591641765.974 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:42:45.974Z,1591641765.974 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:42:48.001Z,1591641768.001 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:42:48.001Z,1591641768.001 [NAL9602] No Fault, FailCount= 5
2020-06-08T18:42:48.388Z,1591641768.388 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:42:59.296Z,1591641779.296 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:44:34.657Z,1591641874.657 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2020-06-08T18:44:34.657Z,1591641874.657 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:44:34.666Z,1591641874.666 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:44:35.084Z,1591641875.084 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T18:44:35.084Z,1591641875.084 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2020-06-08T18:47:35.668Z,1591642055.668 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2020-06-08T18:47:35.668Z,1591642055.668 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T18:47:35.678Z,1591642055.678 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:47:35.678Z,1591642055.678 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T18:47:46.144Z,1591642066.144 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:42:45.0Z
2020-06-08T18:47:46.144Z,1591642066.144 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:47:46.144Z,1591642066.144 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:47:53.686Z,1591642073.686 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20200608T174706/Courier0019.lzma
2020-06-08T18:47:54.689Z,1591642074.689 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0019.lzma.bak
2020-06-08T18:47:54.689Z,1591642074.689 [DataOverHttps](INFO): SBD MOMSN=12372796
2020-06-08T18:48:09.999Z,1591642089.999 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20200608T174706/Express0020.lzma
2020-06-08T18:48:11.001Z,1591642091.001 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0020.lzma.bak
2020-06-08T18:48:11.001Z,1591642091.001 [DataOverHttps](INFO): SBD MOMSN=12372803
2020-06-08T18:48:12.424Z,1591642092.424 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:48:12.424Z,1591642092.424 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:48:12.424Z,1591642092.424 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T18:53:00.448Z,1591642380.448 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T18:53:00.448Z,1591642380.448 [NAL9602] Data Fault, FailCount= 1
2020-06-08T18:53:00.448Z,1591642380.448 [NAL9602](ERROR): Data Fault
2020-06-08T18:53:00.464Z,1591642380.464 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T18:53:00.858Z,1591642380.858 [NAL9602](INFO): Powering down
2020-06-08T18:53:01.676Z,1591642381.676 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T18:53:01.676Z,1591642381.676 [NAL9602] No Fault, FailCount= 1
2020-06-08T18:53:12.979Z,1591642392.979 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T18:53:12.979Z,1591642392.979 [Default:CheckIn:C.Wait] Stopped
2020-06-08T18:53:12.979Z,1591642392.979 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T18:53:12.979Z,1591642392.979 [Default:CheckIn:D] Running Loop=1
2020-06-08T18:53:13.384Z,1591642393.384 [Default:CheckIn:D] Stopped
2020-06-08T18:53:13.384Z,1591642393.384 [Default:CheckIn:E] Running Loop=1
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.886454 min
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn:E] Stopped
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn] Stopped
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn](INFO): Running loop #7
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn] Running Loop=7
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T18:53:13.792Z,1591642393.792 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T18:53:31.156Z,1591642411.156 [NAL9602](INFO): Powering up NAL9602
2020-06-08T18:53:42.060Z,1591642422.060 [NAL9602](INFO): NAL9602 initialized
2020-06-08T18:56:43.073Z,1591642603.073 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2020-06-08T18:56:54.018Z,1591642614.018 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T18:57:06.948Z,1591642626.948 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T18:57:32.756Z,1591642652.756 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2020-06-08T18:57:32.757Z,1591642652.757 [BPC1](ERROR): BPC1B failed to parse battery stick message.
2020-06-08T18:57:47.758Z,1591642667.758 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T18:58:13.965Z,1591642693.965 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T18:53:13.8Z
2020-06-08T18:58:13.965Z,1591642693.965 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T18:58:13.965Z,1591642693.965 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T18:58:21.562Z,1591642701.562 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0023.lzma
2020-06-08T18:58:22.565Z,1591642702.565 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0023.lzma.bak
2020-06-08T18:58:22.565Z,1591642702.565 [DataOverHttps](INFO): SBD MOMSN=12372823
2020-06-08T18:58:24.076Z,1591642704.076 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T18:58:24.076Z,1591642704.076 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T18:58:24.076Z,1591642704.076 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:00:03.908Z,1591642803.908 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T19:00:48.349Z,1591642848.349 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T19:02:05.519Z,1591642925.519 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T19:02:20.487Z,1591642940.487 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T19:02:35.360Z,1591642955.360 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T19:02:35.362Z,1591642955.362 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T19:02:35.781Z,1591642955.781 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:02:35.781Z,1591642955.781 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2020-06-08T19:03:24.653Z,1591643004.653 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:03:24.653Z,1591643004.653 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:03:24.653Z,1591643004.653 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:03:24.653Z,1591643004.653 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:03:25.046Z,1591643005.046 [Default:CheckIn:D] Stopped
2020-06-08T19:03:25.046Z,1591643005.046 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:03:25.445Z,1591643005.445 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.080827 min
2020-06-08T19:03:25.445Z,1591643005.445 [Default:CheckIn:E] Stopped
2020-06-08T19:03:25.445Z,1591643005.445 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:03:25.445Z,1591643005.445 [Default:CheckIn] Stopped
2020-06-08T19:03:25.445Z,1591643005.445 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:03:25.446Z,1591643005.446 [Default:CheckIn](INFO): Running loop #8
2020-06-08T19:03:25.446Z,1591643005.446 [Default:CheckIn] Running Loop=8
2020-06-08T19:03:25.446Z,1591643005.446 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:03:25.446Z,1591643005.446 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:03:43.216Z,1591643023.216 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:03:43.216Z,1591643023.216 [NAL9602] Data Fault, FailCount= 2
2020-06-08T19:03:43.216Z,1591643023.216 [NAL9602](ERROR): Data Fault
2020-06-08T19:03:43.233Z,1591643023.233 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:03:43.622Z,1591643023.622 [NAL9602](INFO): Powering down
2020-06-08T19:03:44.440Z,1591643024.440 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:03:44.440Z,1591643024.440 [NAL9602] No Fault, FailCount= 2
2020-06-08T19:04:13.912Z,1591643053.912 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:04:24.824Z,1591643064.824 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:05:36.356Z,1591643136.356 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-06-08T19:05:36.356Z,1591643136.356 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:05:36.366Z,1591643136.366 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:05:36.782Z,1591643136.782 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:05:36.782Z,1591643136.782 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-06-08T19:08:25.631Z,1591643305.631 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:03:25.4Z
2020-06-08T19:08:25.631Z,1591643305.631 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:08:25.631Z,1591643305.631 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:08:32.778Z,1591643312.778 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20200608T174706/Courier0025.lzma
2020-06-08T19:08:33.781Z,1591643313.781 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0025.lzma.bak
2020-06-08T19:08:33.781Z,1591643313.781 [DataOverHttps](INFO): SBD MOMSN=12372840
2020-06-08T19:08:37.355Z,1591643317.355 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-06-08T19:08:37.355Z,1591643317.355 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:08:37.373Z,1591643317.373 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:08:37.773Z,1591643317.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:08:37.773Z,1591643317.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-06-08T19:08:49.127Z,1591643329.127 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20200608T174706/Express0026.lzma
2020-06-08T19:08:50.128Z,1591643330.128 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0026.lzma.bak
2020-06-08T19:08:50.129Z,1591643330.129 [DataOverHttps](INFO): SBD MOMSN=12372842
2020-06-08T19:08:51.482Z,1591643331.482 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:08:51.482Z,1591643331.482 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:08:51.482Z,1591643331.482 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:11:38.338Z,1591643498.338 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-06-08T19:11:38.338Z,1591643498.338 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:11:38.347Z,1591643498.347 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:11:38.736Z,1591643498.736 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:11:38.736Z,1591643498.736 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-06-08T19:13:52.061Z,1591643632.061 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:13:52.061Z,1591643632.061 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:13:52.061Z,1591643632.061 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:13:52.061Z,1591643632.061 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:13:52.476Z,1591643632.476 [Default:CheckIn:D] Stopped
2020-06-08T19:13:52.476Z,1591643632.476 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:13:52.871Z,1591643632.871 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.537988 min
2020-06-08T19:13:52.871Z,1591643632.871 [Default:CheckIn:E] Stopped
2020-06-08T19:13:52.871Z,1591643632.871 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:13:52.871Z,1591643632.871 [Default:CheckIn] Stopped
2020-06-08T19:13:52.871Z,1591643632.871 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:13:52.872Z,1591643632.872 [Default:CheckIn](INFO): Running loop #9
2020-06-08T19:13:52.872Z,1591643632.872 [Default:CheckIn] Running Loop=9
2020-06-08T19:13:52.872Z,1591643632.872 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:13:52.872Z,1591643632.872 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:14:25.980Z,1591643665.980 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:14:25.980Z,1591643665.980 [NAL9602] Data Fault, FailCount= 3
2020-06-08T19:14:25.980Z,1591643665.980 [NAL9602](ERROR): Data Fault
2020-06-08T19:14:26.046Z,1591643666.046 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:14:26.376Z,1591643666.376 [NAL9602](INFO): Powering down
2020-06-08T19:14:27.269Z,1591643667.269 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:14:27.269Z,1591643667.269 [NAL9602] No Fault, FailCount= 3
2020-06-08T19:14:39.327Z,1591643679.327 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-06-08T19:14:39.327Z,1591643679.327 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:14:39.337Z,1591643679.337 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:14:39.749Z,1591643679.749 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:14:39.749Z,1591643679.749 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-06-08T19:14:56.680Z,1591643696.680 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:15:07.588Z,1591643707.588 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:17:40.307Z,1591643860.307 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-06-08T19:17:40.307Z,1591643860.307 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:17:40.316Z,1591643860.316 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:17:40.727Z,1591643860.727 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:17:40.727Z,1591643860.727 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-06-08T19:18:53.052Z,1591643933.052 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:13:52.9Z
2020-06-08T19:18:53.052Z,1591643933.052 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:18:53.053Z,1591643933.053 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:18:59.615Z,1591643939.615 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20200608T174706/Express0029.lzma
2020-06-08T19:19:00.617Z,1591643940.617 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0029.lzma.bak
2020-06-08T19:19:00.617Z,1591643940.617 [DataOverHttps](INFO): SBD MOMSN=12372857
2020-06-08T19:19:01.973Z,1591643941.973 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:19:01.973Z,1591643941.973 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:19:01.973Z,1591643941.973 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:20:41.346Z,1591644041.346 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-06-08T19:20:41.346Z,1591644041.346 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:20:41.384Z,1591644041.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:20:41.741Z,1591644041.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:20:41.741Z,1591644041.741 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-06-08T19:23:42.325Z,1591644222.325 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-06-08T19:23:42.325Z,1591644222.325 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:23:42.335Z,1591644222.335 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:23:42.748Z,1591644222.748 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:23:42.748Z,1591644222.748 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-06-08T19:24:02.536Z,1591644242.536 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:24:02.536Z,1591644242.536 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:24:02.536Z,1591644242.536 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:24:02.536Z,1591644242.536 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:24:02.949Z,1591644242.949 [Default:CheckIn:D] Stopped
2020-06-08T19:24:02.949Z,1591644242.949 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:24:03.335Z,1591644243.335 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 92.712533 min
2020-06-08T19:24:03.335Z,1591644243.335 [Default:CheckIn:E] Stopped
2020-06-08T19:24:03.335Z,1591644243.335 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:24:03.335Z,1591644243.335 [Default:CheckIn] Stopped
2020-06-08T19:24:03.335Z,1591644243.335 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:24:03.335Z,1591644243.335 [Default:CheckIn](INFO): Running loop #10
2020-06-08T19:24:03.336Z,1591644243.336 [Default:CheckIn] Running Loop=10
2020-06-08T19:24:03.336Z,1591644243.336 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:24:03.336Z,1591644243.336 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:25:09.569Z,1591644309.569 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:25:09.569Z,1591644309.569 [NAL9602] Data Fault, FailCount= 4
2020-06-08T19:25:09.569Z,1591644309.569 [NAL9602](ERROR): Data Fault
2020-06-08T19:25:09.630Z,1591644309.630 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:25:09.972Z,1591644309.972 [NAL9602](INFO): Powering down
2020-06-08T19:25:10.813Z,1591644310.813 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:25:10.813Z,1591644310.813 [NAL9602] No Fault, FailCount= 4
2020-06-08T19:25:40.276Z,1591644340.276 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:25:51.192Z,1591644351.192 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:26:43.316Z,1591644403.316 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-06-08T19:26:43.316Z,1591644403.316 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:26:43.326Z,1591644403.326 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:26:43.732Z,1591644403.732 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:26:43.732Z,1591644403.732 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-06-08T19:29:03.509Z,1591644543.509 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:24:03.3Z
2020-06-08T19:29:03.509Z,1591644543.509 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:29:03.509Z,1591644543.509 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:29:10.423Z,1591644550.423 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0032.lzma
2020-06-08T19:29:11.425Z,1591644551.425 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0032.lzma.bak
2020-06-08T19:29:11.425Z,1591644551.425 [DataOverHttps](INFO): SBD MOMSN=12372892
2020-06-08T19:29:12.821Z,1591644552.821 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:29:12.821Z,1591644552.821 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:29:12.821Z,1591644552.821 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:29:44.323Z,1591644584.323 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2020-06-08T19:29:44.323Z,1591644584.323 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:29:44.333Z,1591644584.333 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:29:44.756Z,1591644584.756 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:29:44.756Z,1591644584.756 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2020-06-08T19:32:45.304Z,1591644765.304 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2020-06-08T19:32:45.304Z,1591644765.304 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:32:45.314Z,1591644765.314 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:32:45.721Z,1591644765.721 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:32:45.721Z,1591644765.721 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2020-06-08T19:34:13.372Z,1591644853.372 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:34:13.373Z,1591644853.373 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:34:13.373Z,1591644853.373 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:34:13.373Z,1591644853.373 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:34:13.797Z,1591644853.797 [Default:CheckIn:D] Stopped
2020-06-08T19:34:13.797Z,1591644853.797 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:34:14.201Z,1591644854.201 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 102.893335 min
2020-06-08T19:34:14.201Z,1591644854.201 [Default:CheckIn:E] Stopped
2020-06-08T19:34:14.201Z,1591644854.201 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:34:14.201Z,1591644854.201 [Default:CheckIn] Stopped
2020-06-08T19:34:14.202Z,1591644854.202 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:34:14.202Z,1591644854.202 [Default:CheckIn](INFO): Running loop #11
2020-06-08T19:34:14.202Z,1591644854.202 [Default:CheckIn] Running Loop=11
2020-06-08T19:34:14.202Z,1591644854.202 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:34:14.202Z,1591644854.202 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:35:46.312Z,1591644946.312 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2020-06-08T19:35:46.312Z,1591644946.312 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:35:46.322Z,1591644946.322 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:35:46.728Z,1591644946.728 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:35:46.729Z,1591644946.729 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2020-06-08T19:35:52.348Z,1591644952.348 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:35:52.348Z,1591644952.348 [NAL9602] Data Fault, FailCount= 5
2020-06-08T19:35:52.348Z,1591644952.348 [NAL9602](ERROR): Data Fault
2020-06-08T19:35:52.365Z,1591644952.365 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:35:52.366Z,1591644952.366 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T19:35:52.748Z,1591644952.748 [NAL9602](INFO): Powering down
2020-06-08T19:35:52.784Z,1591644952.784 [CBIT](INFO): Critical error at 20200608T193552
2020-06-08T19:37:52.752Z,1591645072.752 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:37:52.752Z,1591645072.752 [NAL9602] No Fault, FailCount= 5
2020-06-08T19:37:53.140Z,1591645073.140 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:38:04.048Z,1591645084.048 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:38:47.301Z,1591645127.301 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2020-06-08T19:38:47.301Z,1591645127.301 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:38:47.311Z,1591645127.311 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:38:47.726Z,1591645127.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:38:47.726Z,1591645127.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2020-06-08T19:39:14.357Z,1591645154.357 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:34:14.2Z
2020-06-08T19:39:14.357Z,1591645154.357 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:39:14.357Z,1591645154.357 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:39:21.378Z,1591645161.378 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20200608T174706/Courier0034.lzma
2020-06-08T19:39:22.381Z,1591645162.381 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0034.lzma.bak
2020-06-08T19:39:22.381Z,1591645162.381 [DataOverHttps](INFO): SBD MOMSN=12372909
2020-06-08T19:39:37.711Z,1591645177.711 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20200608T174706/Express0035.lzma
2020-06-08T19:39:38.713Z,1591645178.713 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0035.lzma.bak
2020-06-08T19:39:38.713Z,1591645178.713 [DataOverHttps](INFO): SBD MOMSN=12372912
2020-06-08T19:39:40.245Z,1591645180.245 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:39:40.245Z,1591645180.245 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:39:40.245Z,1591645180.245 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:41:48.295Z,1591645308.295 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2020-06-08T19:41:48.295Z,1591645308.295 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:41:48.305Z,1591645308.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:41:48.719Z,1591645308.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:41:48.719Z,1591645308.719 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2020-06-08T19:44:40.793Z,1591645480.793 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:44:40.793Z,1591645480.793 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:44:40.793Z,1591645480.793 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:44:40.793Z,1591645480.793 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:44:41.200Z,1591645481.200 [Default:CheckIn:D] Stopped
2020-06-08T19:44:41.200Z,1591645481.200 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:44:41.593Z,1591645481.593 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 113.350065 min
2020-06-08T19:44:41.593Z,1591645481.593 [Default:CheckIn:E] Stopped
2020-06-08T19:44:41.593Z,1591645481.593 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:44:41.593Z,1591645481.593 [Default:CheckIn] Stopped
2020-06-08T19:44:41.593Z,1591645481.593 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:44:41.594Z,1591645481.594 [Default:CheckIn](INFO): Running loop #12
2020-06-08T19:44:41.594Z,1591645481.594 [Default:CheckIn] Running Loop=12
2020-06-08T19:44:41.594Z,1591645481.594 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:44:41.594Z,1591645481.594 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:44:49.280Z,1591645489.280 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2020-06-08T19:44:49.280Z,1591645489.280 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:44:49.290Z,1591645489.290 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:44:49.704Z,1591645489.704 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:44:49.704Z,1591645489.704 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2020-06-08T19:47:50.277Z,1591645670.277 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2020-06-08T19:47:50.278Z,1591645670.278 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:47:50.287Z,1591645670.287 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:47:50.688Z,1591645670.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:47:50.688Z,1591645670.688 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2020-06-08T19:48:05.201Z,1591645685.201 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:48:05.201Z,1591645685.201 [NAL9602] Data Fault, FailCount= 1
2020-06-08T19:48:05.201Z,1591645685.201 [NAL9602](ERROR): Data Fault
2020-06-08T19:48:05.253Z,1591645685.253 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:48:05.600Z,1591645685.600 [NAL9602](INFO): Powering down
2020-06-08T19:48:06.428Z,1591645686.428 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:48:06.428Z,1591645686.428 [NAL9602] No Fault, FailCount= 1
2020-06-08T19:48:35.905Z,1591645715.905 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:48:46.812Z,1591645726.812 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:49:41.777Z,1591645781.777 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:44:41.6Z
2020-06-08T19:49:41.777Z,1591645781.777 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:49:41.777Z,1591645781.777 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:49:49.071Z,1591645789.071 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20200608T174706/Express0038.lzma
2020-06-08T19:49:50.073Z,1591645790.073 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0038.lzma.bak
2020-06-08T19:49:50.073Z,1591645790.073 [DataOverHttps](INFO): SBD MOMSN=12372935
2020-06-08T19:49:51.469Z,1591645791.469 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T19:49:51.469Z,1591645791.469 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T19:49:51.469Z,1591645791.469 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T19:50:51.264Z,1591645851.264 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2020-06-08T19:50:51.264Z,1591645851.264 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:50:51.274Z,1591645851.274 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:50:51.664Z,1591645851.664 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:50:51.664Z,1591645851.664 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2020-06-08T19:53:52.269Z,1591646032.269 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2020-06-08T19:53:52.269Z,1591646032.269 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:53:52.278Z,1591646032.278 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:53:52.661Z,1591646032.661 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:53:52.661Z,1591646032.661 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2020-06-08T19:54:52.055Z,1591646092.055 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T19:54:52.055Z,1591646092.055 [Default:CheckIn:C.Wait] Stopped
2020-06-08T19:54:52.055Z,1591646092.055 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T19:54:52.055Z,1591646092.055 [Default:CheckIn:D] Running Loop=1
2020-06-08T19:54:52.464Z,1591646092.464 [Default:CheckIn:D] Stopped
2020-06-08T19:54:52.464Z,1591646092.464 [Default:CheckIn:E] Running Loop=1
2020-06-08T19:54:52.848Z,1591646092.848 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 123.537793 min
2020-06-08T19:54:52.848Z,1591646092.848 [Default:CheckIn:E] Stopped
2020-06-08T19:54:52.848Z,1591646092.848 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T19:54:52.848Z,1591646092.848 [Default:CheckIn] Stopped
2020-06-08T19:54:52.849Z,1591646092.849 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T19:54:52.849Z,1591646092.849 [Default:CheckIn](INFO): Running loop #13
2020-06-08T19:54:52.849Z,1591646092.849 [Default:CheckIn] Running Loop=13
2020-06-08T19:54:52.849Z,1591646092.849 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T19:54:52.849Z,1591646092.849 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T19:56:53.256Z,1591646213.256 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2020-06-08T19:56:53.256Z,1591646213.256 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:56:53.293Z,1591646213.293 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:56:53.655Z,1591646213.655 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:56:53.655Z,1591646213.655 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2020-06-08T19:58:47.964Z,1591646327.964 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T19:58:47.965Z,1591646327.965 [NAL9602] Data Fault, FailCount= 2
2020-06-08T19:58:47.965Z,1591646327.965 [NAL9602](ERROR): Data Fault
2020-06-08T19:58:48.013Z,1591646328.013 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T19:58:48.368Z,1591646328.368 [NAL9602](INFO): Powering down
2020-06-08T19:58:49.197Z,1591646329.197 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T19:58:49.197Z,1591646329.197 [NAL9602] No Fault, FailCount= 2
2020-06-08T19:59:18.674Z,1591646358.674 [NAL9602](INFO): Powering up NAL9602
2020-06-08T19:59:29.576Z,1591646369.576 [NAL9602](INFO): NAL9602 initialized
2020-06-08T19:59:53.037Z,1591646393.037 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T19:54:52.8Z
2020-06-08T19:59:53.037Z,1591646393.037 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T19:59:53.037Z,1591646393.037 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T19:59:54.248Z,1591646394.248 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2020-06-08T19:59:54.248Z,1591646394.248 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T19:59:54.287Z,1591646394.287 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T19:59:54.658Z,1591646394.658 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T19:59:54.658Z,1591646394.658 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2020-06-08T20:00:00.139Z,1591646400.139 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20200608T174706/Express0041.lzma
2020-06-08T20:00:01.141Z,1591646401.141 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0041.lzma.bak
2020-06-08T20:00:01.141Z,1591646401.141 [DataOverHttps](INFO): SBD MOMSN=12372946
2020-06-08T20:00:02.734Z,1591646402.734 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:00:02.734Z,1591646402.734 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:00:02.734Z,1591646402.734 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:02:55.239Z,1591646575.239 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2020-06-08T20:02:55.239Z,1591646575.239 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:02:55.249Z,1591646575.249 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:02:55.249Z,1591646575.249 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:05:03.316Z,1591646703.316 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:05:03.316Z,1591646703.316 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:05:03.316Z,1591646703.316 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:05:03.316Z,1591646703.316 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:05:03.705Z,1591646703.705 [Default:CheckIn:D] Stopped
2020-06-08T20:05:03.705Z,1591646703.705 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.725138 min
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn:E] Stopped
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn] Stopped
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn](INFO): Running loop #14
2020-06-08T20:05:04.113Z,1591646704.113 [Default:CheckIn] Running Loop=14
2020-06-08T20:05:04.114Z,1591646704.114 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:05:04.114Z,1591646704.114 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:07:42.944Z,1591646862.944 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T20:09:08.589Z,1591646948.589 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T20:09:30.748Z,1591646970.748 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:09:30.748Z,1591646970.748 [NAL9602] Data Fault, FailCount= 3
2020-06-08T20:09:30.748Z,1591646970.748 [NAL9602](ERROR): Data Fault
2020-06-08T20:09:30.802Z,1591646970.802 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:09:31.148Z,1591646971.148 [NAL9602](INFO): Powering down
2020-06-08T20:09:31.976Z,1591646971.976 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:09:31.976Z,1591646971.976 [NAL9602] No Fault, FailCount= 3
2020-06-08T20:09:44.085Z,1591646984.085 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T20:09:44.099Z,1591646984.099 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T20:10:01.452Z,1591647001.452 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:10:04.319Z,1591647004.319 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:05:04.1Z
2020-06-08T20:10:04.319Z,1591647004.319 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:10:04.319Z,1591647004.319 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:10:11.654Z,1591647011.654 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20200608T174706/Courier0043.lzma
2020-06-08T20:10:12.540Z,1591647012.540 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:10:12.657Z,1591647012.657 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0043.lzma.bak
2020-06-08T20:10:12.657Z,1591647012.657 [DataOverHttps](INFO): SBD MOMSN=12372959
2020-06-08T20:10:27.951Z,1591647027.951 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20200608T174706/Express0044.lzma
2020-06-08T20:10:28.953Z,1591647028.953 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0044.lzma.bak
2020-06-08T20:10:28.953Z,1591647028.953 [DataOverHttps](INFO): SBD MOMSN=12372964
2020-06-08T20:10:30.341Z,1591647030.341 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:10:30.341Z,1591647030.341 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:10:30.341Z,1591647030.341 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:15:30.911Z,1591647330.911 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:15:30.912Z,1591647330.912 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:15:30.912Z,1591647330.912 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:15:30.912Z,1591647330.912 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:15:31.328Z,1591647331.328 [Default:CheckIn:D] Stopped
2020-06-08T20:15:31.328Z,1591647331.328 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:15:31.724Z,1591647331.724 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.185531 min
2020-06-08T20:15:31.724Z,1591647331.724 [Default:CheckIn:E] Stopped
2020-06-08T20:15:31.724Z,1591647331.724 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:15:31.725Z,1591647331.725 [Default:CheckIn] Stopped
2020-06-08T20:15:31.725Z,1591647331.725 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:15:31.725Z,1591647331.725 [Default:CheckIn](INFO): Running loop #15
2020-06-08T20:15:31.725Z,1591647331.725 [Default:CheckIn] Running Loop=15
2020-06-08T20:15:31.725Z,1591647331.725 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:15:31.725Z,1591647331.725 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:17:55.564Z,1591647475.564 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:17:55.564Z,1591647475.564 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2020-06-08T20:20:13.696Z,1591647613.696 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:20:13.697Z,1591647613.697 [NAL9602] Data Fault, FailCount= 4
2020-06-08T20:20:13.697Z,1591647613.697 [NAL9602](ERROR): Data Fault
2020-06-08T20:20:13.734Z,1591647613.734 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:20:14.092Z,1591647614.092 [NAL9602](INFO): Powering down
2020-06-08T20:20:14.916Z,1591647614.916 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:20:14.916Z,1591647614.916 [NAL9602] No Fault, FailCount= 4
2020-06-08T20:20:31.876Z,1591647631.876 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:15:31.7Z
2020-06-08T20:20:31.876Z,1591647631.876 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:20:31.876Z,1591647631.876 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:20:38.559Z,1591647638.559 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0047.lzma
2020-06-08T20:20:39.560Z,1591647639.560 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0047.lzma.bak
2020-06-08T20:20:39.561Z,1591647639.561 [DataOverHttps](INFO): SBD MOMSN=12372981
2020-06-08T20:20:40.765Z,1591647640.765 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:20:40.765Z,1591647640.765 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:20:40.765Z,1591647640.765 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:20:44.396Z,1591647644.396 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:20:55.304Z,1591647655.304 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:20:56.148Z,1591647656.148 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-06-08T20:20:56.148Z,1591647656.148 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:20:56.158Z,1591647656.158 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:20:56.549Z,1591647656.549 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:20:56.549Z,1591647656.549 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-06-08T20:23:57.128Z,1591647837.128 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-06-08T20:23:57.128Z,1591647837.128 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:23:57.162Z,1591647837.162 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:23:57.546Z,1591647837.546 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:23:57.546Z,1591647837.546 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-06-08T20:25:41.373Z,1591647941.373 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:25:41.373Z,1591647941.373 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:25:41.373Z,1591647941.373 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:25:41.373Z,1591647941.373 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:25:41.781Z,1591647941.781 [Default:CheckIn:D] Stopped
2020-06-08T20:25:41.781Z,1591647941.781 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 154.359733 min
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn:E] Stopped
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn] Stopped
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn](INFO): Running loop #16
2020-06-08T20:25:42.157Z,1591647942.157 [Default:CheckIn] Running Loop=16
2020-06-08T20:25:42.158Z,1591647942.158 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:25:42.158Z,1591647942.158 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:26:58.126Z,1591648018.126 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-06-08T20:26:58.126Z,1591648018.126 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:26:58.136Z,1591648018.136 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:26:58.520Z,1591648018.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:26:58.520Z,1591648018.520 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-06-08T20:29:59.118Z,1591648199.118 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-06-08T20:29:59.118Z,1591648199.118 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:29:59.128Z,1591648199.128 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:29:59.512Z,1591648199.512 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:29:59.512Z,1591648199.512 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-06-08T20:30:42.329Z,1591648242.329 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:25:42.2Z
2020-06-08T20:30:42.329Z,1591648242.329 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:30:42.329Z,1591648242.329 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:30:49.750Z,1591648249.750 [DataOverHttps](INFO): Sending 98 bytes from file Logs/20200608T174706/Express0050.lzma
2020-06-08T20:30:50.753Z,1591648250.753 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0050.lzma.bak
2020-06-08T20:30:50.753Z,1591648250.753 [DataOverHttps](INFO): SBD MOMSN=12372999
2020-06-08T20:30:52.040Z,1591648252.040 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:30:52.040Z,1591648252.040 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:30:52.040Z,1591648252.040 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:30:56.456Z,1591648256.456 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:30:56.456Z,1591648256.456 [NAL9602] Data Fault, FailCount= 5
2020-06-08T20:30:56.456Z,1591648256.456 [NAL9602](ERROR): Data Fault
2020-06-08T20:30:56.489Z,1591648256.489 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:30:56.490Z,1591648256.490 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T20:30:56.872Z,1591648256.872 [NAL9602](INFO): Powering down
2020-06-08T20:30:56.906Z,1591648256.906 [CBIT](INFO): Critical error at 20200608T203056
2020-06-08T20:32:56.508Z,1591648376.508 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:32:56.508Z,1591648376.508 [NAL9602] No Fault, FailCount= 5
2020-06-08T20:32:56.856Z,1591648376.856 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:33:00.096Z,1591648380.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-06-08T20:33:00.096Z,1591648380.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:33:00.106Z,1591648380.106 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:33:00.520Z,1591648380.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:33:00.520Z,1591648380.520 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-06-08T20:33:07.768Z,1591648387.768 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:35:52.622Z,1591648552.622 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:35:52.622Z,1591648552.622 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:35:52.622Z,1591648552.622 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:35:52.622Z,1591648552.622 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:35:53.029Z,1591648553.029 [Default:CheckIn:D] Stopped
2020-06-08T20:35:53.029Z,1591648553.029 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:35:53.437Z,1591648553.437 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 164.547201 min
2020-06-08T20:35:53.437Z,1591648553.437 [Default:CheckIn:E] Stopped
2020-06-08T20:35:53.437Z,1591648553.437 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:35:53.437Z,1591648553.437 [Default:CheckIn] Stopped
2020-06-08T20:35:53.438Z,1591648553.438 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:35:53.438Z,1591648553.438 [Default:CheckIn](INFO): Running loop #17
2020-06-08T20:35:53.438Z,1591648553.438 [Default:CheckIn] Running Loop=17
2020-06-08T20:35:53.438Z,1591648553.438 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:35:53.438Z,1591648553.438 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:36:01.096Z,1591648561.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-06-08T20:36:01.096Z,1591648561.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:36:01.105Z,1591648561.105 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:36:01.524Z,1591648561.524 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:36:01.524Z,1591648561.524 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-06-08T20:39:02.076Z,1591648742.076 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-06-08T20:39:02.076Z,1591648742.076 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:39:02.085Z,1591648742.085 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:39:02.496Z,1591648742.496 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:39:02.496Z,1591648742.496 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-06-08T20:40:53.585Z,1591648853.585 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:35:53.4Z
2020-06-08T20:40:53.585Z,1591648853.585 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:40:53.585Z,1591648853.585 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:41:00.734Z,1591648860.734 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20200608T174706/Courier0052.lzma
2020-06-08T20:41:01.737Z,1591648861.737 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0052.lzma.bak
2020-06-08T20:41:01.737Z,1591648861.737 [DataOverHttps](INFO): SBD MOMSN=12373015
2020-06-08T20:41:17.063Z,1591648877.063 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20200608T174706/Express0053.lzma
2020-06-08T20:41:18.065Z,1591648878.065 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0053.lzma.bak
2020-06-08T20:41:18.065Z,1591648878.065 [DataOverHttps](INFO): SBD MOMSN=12373018
2020-06-08T20:41:19.453Z,1591648879.453 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:41:19.453Z,1591648879.453 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:41:19.453Z,1591648879.453 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:42:03.079Z,1591648923.079 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-06-08T20:42:03.079Z,1591648923.079 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:42:03.089Z,1591648923.089 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:42:03.496Z,1591648923.496 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:42:03.496Z,1591648923.496 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-06-08T20:43:10.532Z,1591648990.532 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:43:10.533Z,1591648990.533 [NAL9602] Data Fault, FailCount= 1
2020-06-08T20:43:10.533Z,1591648990.533 [NAL9602](ERROR): Data Fault
2020-06-08T20:43:10.549Z,1591648990.549 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:43:10.932Z,1591648990.932 [NAL9602](INFO): Powering down
2020-06-08T20:43:11.756Z,1591648991.756 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:43:11.756Z,1591648991.756 [NAL9602] No Fault, FailCount= 1
2020-06-08T20:43:41.232Z,1591649021.232 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:43:52.152Z,1591649032.152 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:45:04.096Z,1591649104.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2020-06-08T20:45:04.096Z,1591649104.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:45:04.114Z,1591649104.114 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:45:04.512Z,1591649104.512 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:45:04.512Z,1591649104.512 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2020-06-08T20:46:20.041Z,1591649180.041 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:46:20.041Z,1591649180.041 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:46:20.041Z,1591649180.041 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:46:20.041Z,1591649180.041 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:46:20.445Z,1591649180.445 [Default:CheckIn:D] Stopped
2020-06-08T20:46:20.445Z,1591649180.445 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:46:20.837Z,1591649180.837 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 175.004134 min
2020-06-08T20:46:20.837Z,1591649180.837 [Default:CheckIn:E] Stopped
2020-06-08T20:46:20.837Z,1591649180.837 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:46:20.837Z,1591649180.837 [Default:CheckIn] Stopped
2020-06-08T20:46:20.838Z,1591649180.838 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:46:20.838Z,1591649180.838 [Default:CheckIn](INFO): Running loop #18
2020-06-08T20:46:20.838Z,1591649180.838 [Default:CheckIn] Running Loop=18
2020-06-08T20:46:20.838Z,1591649180.838 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:46:20.838Z,1591649180.838 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:48:05.080Z,1591649285.080 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2020-06-08T20:48:05.080Z,1591649285.080 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:48:05.116Z,1591649285.116 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:48:05.486Z,1591649285.486 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:48:05.487Z,1591649285.487 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2020-06-08T20:51:06.059Z,1591649466.059 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2020-06-08T20:51:06.060Z,1591649466.060 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:51:06.106Z,1591649466.106 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:51:06.513Z,1591649466.513 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:51:06.513Z,1591649466.513 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2020-06-08T20:51:21.001Z,1591649481.001 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:46:20.8Z
2020-06-08T20:51:21.001Z,1591649481.001 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T20:51:21.001Z,1591649481.001 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T20:51:28.026Z,1591649488.026 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20200608T174706/Express0056.lzma
2020-06-08T20:51:29.029Z,1591649489.029 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0056.lzma.bak
2020-06-08T20:51:29.029Z,1591649489.029 [DataOverHttps](INFO): SBD MOMSN=12373079
2020-06-08T20:51:30.296Z,1591649490.296 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T20:51:30.296Z,1591649490.296 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T20:51:30.296Z,1591649490.296 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T20:53:54.509Z,1591649634.509 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T20:53:54.510Z,1591649634.510 [NAL9602] Data Fault, FailCount= 2
2020-06-08T20:53:54.510Z,1591649634.510 [NAL9602](ERROR): Data Fault
2020-06-08T20:53:54.537Z,1591649634.537 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T20:53:54.912Z,1591649634.912 [NAL9602](INFO): Powering down
2020-06-08T20:53:55.741Z,1591649635.741 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T20:53:55.741Z,1591649635.741 [NAL9602] No Fault, FailCount= 2
2020-06-08T20:54:07.038Z,1591649647.038 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2020-06-08T20:54:07.039Z,1591649647.039 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:54:07.048Z,1591649647.048 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:54:07.448Z,1591649647.448 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:54:07.448Z,1591649647.448 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2020-06-08T20:54:25.212Z,1591649665.212 [NAL9602](INFO): Powering up NAL9602
2020-06-08T20:54:36.120Z,1591649676.120 [NAL9602](INFO): NAL9602 initialized
2020-06-08T20:56:30.911Z,1591649790.911 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T20:56:30.911Z,1591649790.911 [Default:CheckIn:C.Wait] Stopped
2020-06-08T20:56:30.911Z,1591649790.911 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T20:56:30.912Z,1591649790.912 [Default:CheckIn:D] Running Loop=1
2020-06-08T20:56:31.328Z,1591649791.328 [Default:CheckIn:D] Stopped
2020-06-08T20:56:31.328Z,1591649791.328 [Default:CheckIn:E] Running Loop=1
2020-06-08T20:56:31.717Z,1591649791.717 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 185.185531 min
2020-06-08T20:56:31.717Z,1591649791.717 [Default:CheckIn:E] Stopped
2020-06-08T20:56:31.717Z,1591649791.717 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T20:56:31.717Z,1591649791.717 [Default:CheckIn] Stopped
2020-06-08T20:56:31.718Z,1591649791.718 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T20:56:31.718Z,1591649791.718 [Default:CheckIn](INFO): Running loop #19
2020-06-08T20:56:31.718Z,1591649791.718 [Default:CheckIn] Running Loop=19
2020-06-08T20:56:31.718Z,1591649791.718 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T20:56:31.718Z,1591649791.718 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T20:57:08.079Z,1591649828.079 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2020-06-08T20:57:08.079Z,1591649828.079 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T20:57:08.097Z,1591649828.097 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T20:57:08.492Z,1591649828.492 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T20:57:08.492Z,1591649828.492 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2020-06-08T21:00:09.067Z,1591650009.067 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2020-06-08T21:00:09.067Z,1591650009.067 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:00:09.085Z,1591650009.085 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:00:09.495Z,1591650009.495 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:00:09.495Z,1591650009.495 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2020-06-08T21:01:31.889Z,1591650091.889 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T20:56:31.7Z
2020-06-08T21:01:31.889Z,1591650091.889 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:01:31.889Z,1591650091.889 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:01:38.452Z,1591650098.452 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20200608T174706/Express0059.lzma
2020-06-08T21:01:39.453Z,1591650099.453 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0059.lzma.bak
2020-06-08T21:01:39.453Z,1591650099.453 [DataOverHttps](INFO): SBD MOMSN=12373096
2020-06-08T21:01:40.777Z,1591650100.777 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:01:40.777Z,1591650100.777 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:01:40.777Z,1591650100.777 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:03:10.064Z,1591650190.064 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2020-06-08T21:03:10.064Z,1591650190.064 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:03:10.074Z,1591650190.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:03:10.472Z,1591650190.472 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:03:10.472Z,1591650190.472 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2020-06-08T21:04:37.700Z,1591650277.700 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:04:37.701Z,1591650277.701 [NAL9602] Data Fault, FailCount= 3
2020-06-08T21:04:37.701Z,1591650277.701 [NAL9602](ERROR): Data Fault
2020-06-08T21:04:37.718Z,1591650277.718 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:04:38.108Z,1591650278.108 [NAL9602](INFO): Powering down
2020-06-08T21:04:38.928Z,1591650278.928 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:04:38.928Z,1591650278.928 [NAL9602] No Fault, FailCount= 3
2020-06-08T21:05:08.404Z,1591650308.404 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:05:19.312Z,1591650319.312 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:06:11.036Z,1591650371.036 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2020-06-08T21:06:11.036Z,1591650371.036 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:06:11.058Z,1591650371.058 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:06:11.448Z,1591650371.448 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:06:11.448Z,1591650371.448 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2020-06-08T21:06:41.341Z,1591650401.341 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:06:41.341Z,1591650401.341 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:06:41.341Z,1591650401.341 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:06:41.341Z,1591650401.341 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:06:41.753Z,1591650401.753 [Default:CheckIn:D] Stopped
2020-06-08T21:06:41.753Z,1591650401.753 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:06:42.161Z,1591650402.161 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 195.359261 min
2020-06-08T21:06:42.161Z,1591650402.161 [Default:CheckIn:E] Stopped
2020-06-08T21:06:42.161Z,1591650402.161 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:06:42.161Z,1591650402.161 [Default:CheckIn] Stopped
2020-06-08T21:06:42.162Z,1591650402.162 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:06:42.162Z,1591650402.162 [Default:CheckIn](INFO): Running loop #20
2020-06-08T21:06:42.162Z,1591650402.162 [Default:CheckIn] Running Loop=20
2020-06-08T21:06:42.162Z,1591650402.162 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:06:42.162Z,1591650402.162 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:09:12.031Z,1591650552.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2020-06-08T21:09:12.031Z,1591650552.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:09:12.060Z,1591650552.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:09:12.436Z,1591650552.436 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:09:12.436Z,1591650552.436 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2020-06-08T21:11:42.320Z,1591650702.320 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:06:42.2Z
2020-06-08T21:11:42.321Z,1591650702.321 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:11:42.321Z,1591650702.321 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:11:49.587Z,1591650709.587 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20200608T174706/Express0062.lzma
2020-06-08T21:11:50.589Z,1591650710.589 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0062.lzma.bak
2020-06-08T21:11:50.589Z,1591650710.589 [DataOverHttps](INFO): SBD MOMSN=12373122
2020-06-08T21:11:52.032Z,1591650712.032 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:11:52.032Z,1591650712.032 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:11:52.032Z,1591650712.032 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:12:13.021Z,1591650733.021 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2020-06-08T21:12:13.021Z,1591650733.021 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:12:13.031Z,1591650733.031 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:12:13.441Z,1591650733.441 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:12:13.441Z,1591650733.441 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2020-06-08T21:13:10.061Z,1591650790.061 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T21:13:53.278Z,1591650833.278 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T21:14:22.358Z,1591650862.358 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T21:14:49.844Z,1591650889.844 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T21:15:03.975Z,1591650903.975 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T21:15:14.012Z,1591650914.012 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2020-06-08T21:15:14.012Z,1591650914.012 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:15:14.022Z,1591650914.022 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:15:14.430Z,1591650914.430 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:15:14.430Z,1591650914.430 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2020-06-08T21:15:21.682Z,1591650921.682 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:15:21.682Z,1591650921.682 [NAL9602] Data Fault, FailCount= 4
2020-06-08T21:15:21.682Z,1591650921.682 [NAL9602](ERROR): Data Fault
2020-06-08T21:15:21.705Z,1591650921.705 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:15:22.084Z,1591650922.084 [NAL9602](INFO): Powering down
2020-06-08T21:15:22.909Z,1591650922.909 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:15:22.909Z,1591650922.909 [NAL9602] No Fault, FailCount= 4
2020-06-08T21:15:52.392Z,1591650952.392 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:15:53.670Z,1591650953.670 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-06-08T21:16:03.296Z,1591650963.296 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:16:17.901Z,1591650977.901 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-06-08T21:16:52.591Z,1591651012.591 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:16:52.592Z,1591651012.592 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:16:52.592Z,1591651012.592 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:16:52.592Z,1591651012.592 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:16:53.016Z,1591651013.016 [Default:CheckIn:D] Stopped
2020-06-08T21:16:53.016Z,1591651013.016 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:16:53.421Z,1591651013.421 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 205.546989 min
2020-06-08T21:16:53.421Z,1591651013.421 [Default:CheckIn:E] Stopped
2020-06-08T21:16:53.421Z,1591651013.421 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:16:53.421Z,1591651013.421 [Default:CheckIn] Stopped
2020-06-08T21:16:53.422Z,1591651013.422 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:16:53.422Z,1591651013.422 [Default:CheckIn](INFO): Running loop #21
2020-06-08T21:16:53.422Z,1591651013.422 [Default:CheckIn] Running Loop=21
2020-06-08T21:16:53.422Z,1591651013.422 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:16:53.422Z,1591651013.422 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:17:24.512Z,1591651044.512 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-06-08T21:17:24.514Z,1591651044.514 [BPC1](INFO): Received data from all battery sticks.
2020-06-08T21:18:15.028Z,1591651095.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2020-06-08T21:18:15.028Z,1591651095.028 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:18:15.038Z,1591651095.038 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:18:15.038Z,1591651095.038 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:21:53.580Z,1591651313.580 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:16:53.4Z
2020-06-08T21:21:53.580Z,1591651313.580 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:21:53.580Z,1591651313.580 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:22:00.146Z,1591651320.146 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20200608T174706/Courier0064.lzma
2020-06-08T21:22:01.149Z,1591651321.149 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0064.lzma.bak
2020-06-08T21:22:01.149Z,1591651321.149 [DataOverHttps](INFO): SBD MOMSN=12373149
2020-06-08T21:22:16.431Z,1591651336.431 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20200608T174706/Express0065.lzma
2020-06-08T21:22:17.433Z,1591651337.433 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0065.lzma.bak
2020-06-08T21:22:17.433Z,1591651337.433 [DataOverHttps](INFO): SBD MOMSN=12373151
2020-06-08T21:22:18.616Z,1591651338.616 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:22:18.616Z,1591651338.616 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:22:18.616Z,1591651338.616 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:26:04.453Z,1591651564.453 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:26:04.453Z,1591651564.453 [NAL9602] Data Fault, FailCount= 5
2020-06-08T21:26:04.453Z,1591651564.453 [NAL9602](ERROR): Data Fault
2020-06-08T21:26:04.468Z,1591651564.468 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:26:04.468Z,1591651564.468 [CBIT](CRITICAL): Data Fault in component: NAL9602
2020-06-08T21:26:04.852Z,1591651564.852 [NAL9602](INFO): Powering down
2020-06-08T21:26:04.874Z,1591651564.874 [CBIT](INFO): Critical error at 20200608T212604
2020-06-08T21:27:19.211Z,1591651639.211 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:27:19.212Z,1591651639.212 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:27:19.212Z,1591651639.212 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:27:19.212Z,1591651639.212 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:27:19.603Z,1591651639.603 [Default:CheckIn:D] Stopped
2020-06-08T21:27:19.603Z,1591651639.603 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:27:20.007Z,1591651640.007 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 215.990104 min
2020-06-08T21:27:20.007Z,1591651640.007 [Default:CheckIn:E] Stopped
2020-06-08T21:27:20.007Z,1591651640.007 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:27:20.008Z,1591651640.008 [Default:CheckIn] Stopped
2020-06-08T21:27:20.008Z,1591651640.008 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:27:20.008Z,1591651640.008 [Default:CheckIn](INFO): Running loop #22
2020-06-08T21:27:20.008Z,1591651640.008 [Default:CheckIn] Running Loop=22
2020-06-08T21:27:20.008Z,1591651640.008 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:27:20.008Z,1591651640.008 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:28:04.461Z,1591651684.461 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:28:04.461Z,1591651684.461 [NAL9602] No Fault, FailCount= 5
2020-06-08T21:28:04.844Z,1591651684.844 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:28:15.758Z,1591651695.758 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:32:20.198Z,1591651940.198 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-06-08T21:27:20.0Z
2020-06-08T21:32:20.198Z,1591651940.198 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:32:20.198Z,1591651940.198 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-06-08T21:32:27.586Z,1591651947.586 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20200608T174706/Courier0067.lzma
2020-06-08T21:32:28.589Z,1591651948.589 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Courier0067.lzma.bak
2020-06-08T21:32:28.589Z,1591651948.589 [DataOverHttps](INFO): SBD MOMSN=12373434
2020-06-08T21:32:42.801Z,1591651962.801 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20200608T174706/Express0068.lzma
2020-06-08T21:32:43.785Z,1591651963.785 [DataOverHttps](INFO): Moved sent file to Logs/20200608T174706/Express0068.lzma.bak
2020-06-08T21:32:43.785Z,1591651963.785 [DataOverHttps](INFO): SBD MOMSN=12373437
2020-06-08T21:32:45.238Z,1591651965.238 [Default:CheckIn:Read_Iridium] Stopped
2020-06-08T21:32:45.238Z,1591651965.238 [Default:CheckIn:C.Wait] Running Loop=1
2020-06-08T21:32:45.238Z,1591651965.238 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-06-08T21:33:15.137Z,1591651995.137 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:33:15.137Z,1591651995.137 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2020-06-08T21:36:15.728Z,1591652175.728 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-06-08T21:36:15.728Z,1591652175.728 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:36:15.738Z,1591652175.738 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:36:16.144Z,1591652176.144 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:36:16.144Z,1591652176.144 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-06-08T21:37:45.818Z,1591652265.818 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2020-06-08T21:37:45.818Z,1591652265.818 [Default:CheckIn:C.Wait] Stopped
2020-06-08T21:37:45.835Z,1591652265.835 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-06-08T21:37:45.836Z,1591652265.836 [Default:CheckIn:D] Running Loop=1
2020-06-08T21:37:46.229Z,1591652266.229 [Default:CheckIn:D] Stopped
2020-06-08T21:37:46.229Z,1591652266.229 [Default:CheckIn:E] Running Loop=1
2020-06-08T21:37:46.617Z,1591652266.617 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 226.433870 min
2020-06-08T21:37:46.617Z,1591652266.617 [Default:CheckIn:E] Stopped
2020-06-08T21:37:46.617Z,1591652266.617 [Default:CheckIn](INFO): Completed Default:CheckIn
2020-06-08T21:37:46.617Z,1591652266.617 [Default:CheckIn] Stopped
2020-06-08T21:37:46.617Z,1591652266.617 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:37:46.618Z,1591652266.618 [Default:CheckIn](INFO): Running loop #23
2020-06-08T21:37:46.618Z,1591652266.618 [Default:CheckIn] Running Loop=23
2020-06-08T21:37:46.618Z,1591652266.618 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-06-08T21:37:46.618Z,1591652266.618 [Default:CheckIn:Read_GPS] Running Loop=1
2020-06-08T21:38:17.304Z,1591652297.304 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-06-08T21:38:17.304Z,1591652297.304 [NAL9602] Data Fault, FailCount= 1
2020-06-08T21:38:17.304Z,1591652297.304 [NAL9602](ERROR): Data Fault
2020-06-08T21:38:17.328Z,1591652297.328 [CBIT](ERROR): Data Fault in component: NAL9602
2020-06-08T21:38:17.718Z,1591652297.718 [NAL9602](INFO): Powering down
2020-06-08T21:38:18.536Z,1591652298.536 [CBIT](INFO): Clearing failed state for component NAL9602
2020-06-08T21:38:18.536Z,1591652298.536 [NAL9602] No Fault, FailCount= 1
2020-06-08T21:38:48.020Z,1591652328.020 [NAL9602](INFO): Powering up NAL9602
2020-06-08T21:38:58.051Z,1591652338.051 [CommandLine](IMPORTANT): got command failComponent
2020-06-08T21:38:58.052Z,1591652338.052 [CommandLine](IMPORTANT): Failed components:
2020-06-08T21:38:58.052Z,1591652338.052 [CommandLine](IMPORTANT): No failed Components.
2020-06-08T21:38:58.921Z,1591652338.921 [NAL9602](INFO): NAL9602 initialized
2020-06-08T21:39:00.204Z,1591652340.204 [CommandLine](IMPORTANT): got command show stack
2020-06-08T21:39:00.204Z,1591652340.204 [CommandLine](IMPORTANT): Behavior Stack:
2020-06-08T21:39:00.204Z,1591652340.204 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface
2020-06-08T21:39:00.204Z,1591652340.204 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS
2020-06-08T21:39:16.722Z,1591652356.722 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-06-08T21:39:16.722Z,1591652356.722 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:39:16.732Z,1591652356.732 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:39:17.136Z,1591652357.136 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:39:17.136Z,1591652357.136 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-06-08T21:39:51.684Z,1591652391.684 [CommandLine](IMPORTANT): got command show variable address
2020-06-08T21:39:51.686Z,1591652391.686 [CommandLine](IMPORTANT): acoustic_contact_address (unknown)
2020-06-08T21:39:51.798Z,1591652391.798 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.localAddress (count)
2020-06-08T21:39:51.807Z,1591652391.807 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.sbdAddress (enum)
2020-06-08T21:39:51.807Z,1591652391.807 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900.transponderAddress (enum)
2020-06-08T21:39:51.810Z,1591652391.810 [CommandLine](IMPORTANT): DAT.localAddress (count)
2020-06-08T21:39:51.810Z,1591652391.810 [CommandLine](IMPORTANT): DAT.sbdAddress (enum)
2020-06-08T21:39:51.815Z,1591652391.815 [CommandLine](IMPORTANT): DAT.transponderAddress (enum)
2020-06-08T21:39:51.818Z,1591652391.818 [CommandLine](IMPORTANT): Micromodem.localAddress (enum)
2020-06-08T21:39:51.818Z,1591652391.818 [CommandLine](IMPORTANT): Micromodem.destinationAddress (enum)
2020-06-08T21:39:52.030Z,1591652392.030 [CommandLine](IMPORTANT): DAT.remoteAddress (enum)
2020-06-08T21:39:52.035Z,1591652392.035 [CommandLine](IMPORTANT): DAT.localAddressReading (enum)
2020-06-08T21:39:56.705Z,1591652396.705 [CommandLine](IMPORTANT): got command get DAT.localAddress
2020-06-08T21:39:56.705Z,1591652396.705 [CommandLine](IMPORTANT): DAT.localAddress 7 count
2020-06-08T21:41:42.101Z,1591652502.101 [CommandLine](IMPORTANT): got command failComponent
2020-06-08T21:41:42.101Z,1591652502.101 [CommandLine](IMPORTANT): Failed components:
2020-06-08T21:41:42.101Z,1591652502.101 [CommandLine](IMPORTANT): No failed Components.
2020-06-08T21:41:44.508Z,1591652504.508 [CommandLine](IMPORTANT): got command failComponent hardware DAT
2020-06-08T21:41:44.508Z,1591652504.508 [DAT] Hardware Fault, FailCount= 1
2020-06-08T21:41:44.508Z,1591652504.508 [DAT](ERROR): Hardware Fault
2020-06-08T21:41:44.508Z,1591652504.508 [CommandLine](IMPORTANT): DAT failureMode is Hardware Fault
2020-06-08T21:41:44.587Z,1591652504.587 [DAT](INFO): Powering down
2020-06-08T21:41:44.732Z,1591652504.732 [CBIT](ERROR): Hardware Fault in component: DAT
2020-06-08T21:41:45.409Z,1591652505.409 [CBIT](INFO): Clearing failed state for component DAT
2020-06-08T21:41:45.409Z,1591652505.409 [DAT] No Fault, FailCount= 1
2020-06-08T21:41:47.809Z,1591652507.809 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-06-08T21:41:47.809Z,1591652507.809 [DAT](INFO): Powering up
2020-06-08T21:41:47.809Z,1591652507.809 [DAT](DEBUG): Initializing DAT.
2020-06-08T21:41:47.907Z,1591652507.907 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-06-08T21:41:49.661Z,1591652509.661 [CommandLine](IMPORTANT): got command failComponent
2020-06-08T21:41:49.661Z,1591652509.661 [CommandLine](IMPORTANT): Failed components:
2020-06-08T21:41:49.661Z,1591652509.661 [CommandLine](IMPORTANT): No failed Components.
2020-06-08T21:41:57.901Z,1591652517.901 [DAT](DEBUG):
2020-06-08T21:41:58.312Z,1591652518.312 [DAT](DEBUG): Teledyne Benthos DAT-900 Series
2020-06-08T21:41:59.114Z,1591652519.114 [DAT](DEBUG): MF Frequency Band
2020-06-08T21:41:59.528Z,1591652519.528 [DAT](DEBUG): Directional Acoustic Transponder version 8.12.21
2020-06-08T21:41:59.529Z,1591652519.529 [DAT](DEBUG): Jan 4 2000 03:10:12
2020-06-08T21:42:00.339Z,1591652520.339 [DAT](DEBUG): Features enabled [Bearing]
2020-06-08T21:42:00.340Z,1591652520.340 [DAT](DEBUG): CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2020-06-08T21:42:00.340Z,1591652520.340 [DAT](INFO): commRate: 800
2020-06-08T21:42:00.726Z,1591652520.726 [DAT](INFO): entering command mode
2020-06-08T21:42:01.125Z,1591652521.125 [DAT](DEBUG): checking for command mode acknowledgment
2020-06-08T21:42:01.125Z,1591652521.125 [DAT](INFO): command mode acknowledged
2020-06-08T21:42:01.125Z,1591652521.125 [DAT](INFO): setting verbose to 3
2020-06-08T21:42:01.547Z,1591652521.547 [DAT](DEBUG): checking for verbose setting acknowledgment
2020-06-08T21:42:01.548Z,1591652521.548 [DAT](INFO): set verbose to 3
2020-06-08T21:42:01.955Z,1591652521.955 [DAT](INFO): setting transmit power to 8
2020-06-08T21:42:02.347Z,1591652522.347 [DAT](DEBUG): checking for transmit power setting acknowledgment
2020-06-08T21:42:02.742Z,1591652522.742 [DAT](DEBUG): checking for transmit power setting acknowledgment
2020-06-08T21:42:02.742Z,1591652522.742 [DAT](INFO): set transmit power to 8
2020-06-08T21:42:03.153Z,1591652523.153 [DAT](INFO): setting local address to 7
2020-06-08T21:42:03.559Z,1591652523.559 [DAT](DEBUG): checking for local address setting acknowledgment
2020-06-08T21:42:03.967Z,1591652523.967 [DAT](DEBUG): checking for local address setting acknowledgment
2020-06-08T21:42:03.968Z,1591652523.968 [DAT](INFO): set local address to 7
2020-06-08T21:42:17.724Z,1591652537.724 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-06-08T21:42:17.724Z,1591652537.724 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-06-08T21:42:17.734Z,1591652537.734 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-06-08T21:42:18.136Z,1591652538.136 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-06-08T21:42:18.136Z,1591652538.136 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-06-08T21:42:33.827Z,1591652553.827 [CommandLine](IMPORTANT): got command
2020-06-08T21:42:33.828Z,1591652553.828 [CommandLine](FAULT): Incomplete syntax. Try: help
2020-06-08T21:42:37.043Z,1591652557.043 [CommandLine](IMPORTANT): got command failComponent
2020-06-08T21:42:37.044Z,1591652557.044 [CommandLine](IMPORTANT): Failed components:
2020-06-08T21:42:37.044Z,1591652557.044 [CommandLine](IMPORTANT): No failed Components.
2020-06-08T21:42:38.196Z,1591652558.196 [CommandLine](IMPORTANT): got command quit
2020-06-08T21:42:39.203Z,1591652559.203 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:39.203Z,1591652559.203 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.359Z,1591652559.359 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2020-06-08T21:42:39.359Z,1591652559.359 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.360Z,1591652559.360 [CommandLine](INFO): Join timeout helper Thread ID is 2721
2020-06-08T21:42:39.360Z,1591652559.360 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-06-08T21:42:39.360Z,1591652559.360 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.361Z,1591652559.361 [NavChartDb](INFO): Join timeout helper Thread ID is 2722
2020-06-08T21:42:39.627Z,1591652559.627 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:39.627Z,1591652559.627 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.647Z,1591652559.647 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-06-08T21:42:39.647Z,1591652559.647 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.647Z,1591652559.647 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2723
2020-06-08T21:42:39.739Z,1591652559.739 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:39.739Z,1591652559.739 [WetLabsBB2FL](INFO): Powering down
2020-06-08T21:42:39.740Z,1591652559.740 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.751Z,1591652559.751 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-06-08T21:42:39.751Z,1591652559.751 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:39.751Z,1591652559.751 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2724
2020-06-08T21:42:40.035Z,1591652560.035 [CTD_Seabird](INFO): Powering down
2020-06-08T21:42:40.047Z,1591652560.047 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:40.047Z,1591652560.047 [CTD_Seabird](INFO): Powering down
2020-06-08T21:42:40.059Z,1591652560.059 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:40.079Z,1591652560.079 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-06-08T21:42:40.079Z,1591652560.079 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:40.079Z,1591652560.079 [Radio_Surface](INFO): Join timeout helper Thread ID is 2725
2020-06-08T21:42:40.419Z,1591652560.419 [Radio_Surface](INFO): Powering down
2020-06-08T21:42:40.420Z,1591652560.420 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:40.420Z,1591652560.420 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:40.424Z,1591652560.424 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-06-08T21:42:40.424Z,1591652560.424 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:40.424Z,1591652560.424 [Onboard](INFO): Join timeout helper Thread ID is 2726
2020-06-08T21:42:41.099Z,1591652561.099 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-06-08T21:42:43.479Z,1591652563.479 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:43.479Z,1591652563.479 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:43.499Z,1591652563.499 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-06-08T21:42:43.500Z,1591652563.500 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:43.500Z,1591652563.500 [DataOverHttps](INFO): Join timeout helper Thread ID is 2727
2020-06-08T21:42:43.584Z,1591652563.584 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2305760 %. Average:283984.625000
2020-06-08T21:42:44.111Z,1591652564.111 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:44.111Z,1591652564.111 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.135Z,1591652564.135 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-06-08T21:42:44.135Z,1591652564.135 [logger ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.135Z,1591652564.135 [logger](INFO): Join timeout helper Thread ID is 2728
2020-06-08T21:42:44.135Z,1591652564.135 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:44.136Z,1591652564.136 [logger ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.137Z,1591652564.137 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-06-08T21:42:44.137Z,1591652564.137 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.137Z,1591652564.137 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-06-08T21:42:44.137Z,1591652564.137 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.137Z,1591652564.137 [controlThread](INFO): Join timeout helper Thread ID is 2729
2020-06-08T21:42:44.343Z,1591652564.343 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-06-08T21:42:44.343Z,1591652564.343 [controlThread](DEBUG): Uninitializing ControlThread
2020-06-08T21:42:44.343Z,1591652564.343 [AHRS_M2](INFO): Powering down
2020-06-08T21:42:44.415Z,1591652564.415 [NAL9602](INFO): Powering down
2020-06-08T21:42:44.416Z,1591652564.416 [DAT](INFO): Powering down
2020-06-08T21:42:44.537Z,1591652564.537 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-06-08T21:42:44.537Z,1591652564.537 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-06-08T21:42:44.538Z,1591652564.538 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-06-08T21:42:44.538Z,1591652564.538 [MissionManager](INFO): Uninitializing Mission Default
2020-06-08T21:42:44.538Z,1591652564.538 [Default] Stopped
2020-06-08T21:42:44.539Z,1591652564.539 [Default](DEBUG): Aggregate::uninitialize Default
2020-06-08T21:42:44.539Z,1591652564.539 [Default:B.GoToSurface] Stopped
2020-06-08T21:42:44.539Z,1591652564.539 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-06-08T21:42:44.539Z,1591652564.539 [Default:CheckIn] Stopped
2020-06-08T21:42:44.539Z,1591652564.539 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-06-08T21:42:44.539Z,1591652564.539 [Default:CheckIn:Read_GPS] Stopped
2020-06-08T21:42:44.542Z,1591652564.542 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-06-08T21:42:44.542Z,1591652564.542 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-06-08T21:42:44.542Z,1591652564.542 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-06-08T21:42:44.542Z,1591652564.542 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-06-08T21:42:44.543Z,1591652564.543 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-06-08T21:42:44.543Z,1591652564.543 [BuoyancyServo](INFO): Powering down
2020-06-08T21:42:44.555Z,1591652564.555 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-06-08T21:42:44.555Z,1591652564.555 [ElevatorServo](INFO): Powering down
2020-06-08T21:42:44.556Z,1591652564.556 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-06-08T21:42:44.556Z,1591652564.556 [MassServo](INFO): Powering down
2020-06-08T21:42:44.557Z,1591652564.557 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-06-08T21:42:44.557Z,1591652564.557 [RudderServo](INFO): Powering down
2020-06-08T21:42:44.557Z,1591652564.557 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-06-08T21:42:44.558Z,1591652564.558 [ThrusterServo](INFO): Powering down
2020-06-08T21:42:44.558Z,1591652564.558 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-06-08T21:42:44.559Z,1591652564.559 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-06-08T21:42:44.559Z,1591652564.559 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-06-08T21:42:44.559Z,1591652564.559 [CBIT](DEBUG): Powering off loads.
2020-06-08T21:42:44.571Z,1591652564.571 [CBIT](DEBUG): Disabling WDT.
2020-06-08T21:42:44.583Z,1591652564.583 [CBIT](DEBUG): Opening all GF detection circuits.
2020-06-08T21:42:44.583Z,1591652564.583 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.674Z,1591652564.674 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.676Z,1591652564.676 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.681Z,1591652564.681 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.713Z,1591652564.713 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.717Z,1591652564.717 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.760Z,1591652564.760 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-06-08T21:42:44.822Z,1591652564.822 [logger ThreadHandler](INFO): Thread cancelled.