2023-03-27T18:06:50.696Z,1679940410.696 [Supervisor](DEBUG): Initializing supervisor.
2023-03-27T18:06:50.701Z,1679940410.701 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-03-27T18:06:50.701Z,1679940410.701 [SyncHandler](INFO): Protected caller Thread ID is 4332
2023-03-27T18:06:50.702Z,1679940410.702 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-03-27T18:06:50.703Z,1679940410.703 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-03-27T18:06:50.703Z,1679940410.703 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4333
2023-03-27T18:06:50.707Z,1679940410.707 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-03-27T18:06:50.724Z,1679940410.724 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-03-27T18:06:50.725Z,1679940410.725 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-03-27T18:06:50.725Z,1679940410.725 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4334
2023-03-27T18:06:50.729Z,1679940410.729 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-03-27T18:06:50.730Z,1679940410.730 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-03-27T18:06:50.731Z,1679940410.731 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4335
2023-03-27T18:06:50.732Z,1679940410.732 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-03-27T18:06:50.733Z,1679940410.733 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-03-27T18:06:50.734Z,1679940410.734 [logger ThreadHandler](INFO): Protected caller Thread ID is 4336
2023-03-27T18:06:50.737Z,1679940410.737 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-03-27T18:06:50.738Z,1679940410.738 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-03-27T18:06:50.743Z,1679940410.743 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-03-27T18:06:51.066Z,1679940411.066 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-03-27T18:06:51.068Z,1679940411.068 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-03-27T18:06:51.151Z,1679940411.151 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-03-27T18:06:51.602Z,1679940411.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-03-27T18:06:51.604Z,1679940411.604 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-03-27T18:06:51.915Z,1679940411.915 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-03-27T18:06:51.915Z,1679940411.915 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-03-27T18:06:52.013Z,1679940412.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-03-27T18:06:52.015Z,1679940412.015 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-03-27T18:06:52.391Z,1679940412.391 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-03-27T18:06:52.393Z,1679940412.393 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-03-27T18:06:52.594Z,1679940412.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-03-27T18:06:52.595Z,1679940412.595 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-03-27T18:06:53.078Z,1679940413.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-03-27T18:06:53.080Z,1679940413.080 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-03-27T18:06:53.215Z,1679940413.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-03-27T18:06:53.216Z,1679940413.216 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-03-27T18:06:53.297Z,1679940413.297 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-03-27T18:06:54.102Z,1679940414.102 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-03-27T18:06:54.219Z,1679940414.219 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-03-27T18:06:54.639Z,1679940414.639 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-03-27T18:06:54.641Z,1679940414.641 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-03-27T18:06:54.820Z,1679940414.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-03-27T18:06:54.821Z,1679940414.821 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-03-27T18:06:54.931Z,1679940414.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-03-27T18:06:54.932Z,1679940414.932 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-03-27T18:06:55.148Z,1679940415.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-03-27T18:06:55.149Z,1679940415.149 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-03-27T18:06:55.379Z,1679940415.379 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-03-27T18:06:55.381Z,1679940415.381 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2023-03-27T18:06:55.384Z,1679940415.384 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2023-03-27T18:06:55.475Z,1679940415.475 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2023-03-27T18:06:55.562Z,1679940415.562 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2023-03-27T18:06:55.662Z,1679940415.662 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2023-03-27T18:06:55.747Z,1679940415.747 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2023-03-27T18:06:55.847Z,1679940415.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2023-03-27T18:06:55.947Z,1679940415.947 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2023-03-27T18:06:56.121Z,1679940416.121 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2023-03-27T18:06:56.200Z,1679940416.200 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2023-03-27T18:06:56.343Z,1679940416.343 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2023-03-27T18:06:56.477Z,1679940416.477 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2023-03-27T18:06:56.591Z,1679940416.591 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2023-03-27T18:06:56.849Z,1679940416.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-03-27T18:06:56.850Z,1679940416.850 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-03-27T18:06:56.885Z,1679940416.885 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-03-27T18:06:56.950Z,1679940416.950 [VerticalControl](DEBUG): Construct VerticalControl.
2023-03-27T18:06:57.007Z,1679940417.007 [VerticalControl] Loaded
2023-03-27T18:06:57.008Z,1679940417.008 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-03-27T18:06:57.011Z,1679940417.011 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-03-27T18:06:57.051Z,1679940417.051 [HorizontalControl] Loaded
2023-03-27T18:06:57.051Z,1679940417.051 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-03-27T18:06:57.053Z,1679940417.053 [SpeedControl](DEBUG): Construct SpeedControl.
2023-03-27T18:06:57.056Z,1679940417.056 [SpeedControl] Loaded
2023-03-27T18:06:57.056Z,1679940417.056 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-03-27T18:06:57.059Z,1679940417.059 [LoopControl](DEBUG): Construct LoopControl.
2023-03-27T18:06:57.059Z,1679940417.059 [LoopControl] Loaded
2023-03-27T18:06:57.059Z,1679940417.059 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-03-27T18:06:57.060Z,1679940417.060 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-03-27T18:06:57.062Z,1679940417.062 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-03-27T18:06:57.081Z,1679940417.081 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-03-27T18:06:57.082Z,1679940417.082 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-03-27T18:06:57.259Z,1679940417.259 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-03-27T18:06:57.260Z,1679940417.260 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-03-27T18:06:57.414Z,1679940417.414 [BuoyancyServo] Loaded
2023-03-27T18:06:57.414Z,1679940417.414 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-03-27T18:06:57.433Z,1679940417.433 [ElevatorServo] Loaded
2023-03-27T18:06:57.434Z,1679940417.434 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-03-27T18:06:57.452Z,1679940417.452 [MassServo] Loaded
2023-03-27T18:06:57.452Z,1679940417.452 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-03-27T18:06:57.470Z,1679940417.470 [RudderServo] Loaded
2023-03-27T18:06:57.470Z,1679940417.470 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-03-27T18:06:57.487Z,1679940417.487 [ThrusterServo] Loaded
2023-03-27T18:06:57.487Z,1679940417.487 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2023-03-27T18:06:57.488Z,1679940417.488 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-03-27T18:06:57.488Z,1679940417.488 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-03-27T18:06:57.621Z,1679940417.621 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-03-27T18:06:57.622Z,1679940417.622 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-03-27T18:06:57.635Z,1679940417.635 [NavChart] Loaded
2023-03-27T18:06:57.635Z,1679940417.635 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-03-27T18:06:57.641Z,1679940417.641 [UniversalFixResidualReporter] Loaded
2023-03-27T18:06:57.641Z,1679940417.641 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-03-27T18:06:57.641Z,1679940417.641 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-03-27T18:06:57.642Z,1679940417.642 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-03-27T18:06:57.722Z,1679940417.722 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-03-27T18:06:57.723Z,1679940417.723 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-03-27T18:06:58.495Z,1679940418.495 [AHRS_M2] Loaded
2023-03-27T18:06:58.496Z,1679940418.496 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-03-27T18:06:59.294Z,1679940419.294 [BPC1] Loaded
2023-03-27T18:06:59.295Z,1679940419.295 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-03-27T18:06:59.904Z,1679940419.904 [DataOverHttps] Loaded
2023-03-27T18:06:59.904Z,1679940419.904 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-03-27T18:06:59.905Z,1679940419.905 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0
2023-03-27T18:06:59.905Z,1679940419.905 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4421
2023-03-27T18:06:59.953Z,1679940419.953 [Depth_Keller] Loaded
2023-03-27T18:06:59.953Z,1679940419.953 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-03-27T18:06:59.985Z,1679940419.985 [DropWeight] Loaded
2023-03-27T18:06:59.986Z,1679940419.986 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-03-27T18:07:00.004Z,1679940420.004 [MultiRay] Loaded
2023-03-27T18:07:00.004Z,1679940420.004 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-03-27T18:07:00.068Z,1679940420.068 [NAL9602] Loaded
2023-03-27T18:07:00.068Z,1679940420.068 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-03-27T18:07:00.097Z,1679940420.097 [Onboard] Loaded
2023-03-27T18:07:00.098Z,1679940420.098 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-03-27T18:07:00.099Z,1679940420.099 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0
2023-03-27T18:07:00.099Z,1679940420.099 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4422
2023-03-27T18:07:00.113Z,1679940420.113 [Power24vConverter] Loaded
2023-03-27T18:07:00.113Z,1679940420.113 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-03-27T18:07:00.127Z,1679940420.127 [Radio_Surface] Loaded
2023-03-27T18:07:00.127Z,1679940420.127 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-03-27T18:07:00.128Z,1679940420.128 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0
2023-03-27T18:07:00.128Z,1679940420.128 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4423
2023-03-27T18:07:00.129Z,1679940420.129 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-03-27T18:07:00.130Z,1679940420.130 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-03-27T18:07:00.200Z,1679940420.200 [DepthRateCalculator] Loaded
2023-03-27T18:07:00.201Z,1679940420.201 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-03-27T18:07:00.205Z,1679940420.205 [PitchRateCalculator] Loaded
2023-03-27T18:07:00.206Z,1679940420.206 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-03-27T18:07:00.215Z,1679940420.215 [SpeedCalculator] Loaded
2023-03-27T18:07:00.215Z,1679940420.215 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-03-27T18:07:00.230Z,1679940420.230 [VerticalHomogeneityIndexCalculator] Loaded
2023-03-27T18:07:00.230Z,1679940420.230 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2023-03-27T18:07:00.234Z,1679940420.234 [YawRateCalculator] Loaded
2023-03-27T18:07:00.236Z,1679940420.236 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-03-27T18:07:00.254Z,1679940420.254 [ElevatorOffsetCalculator] Loaded
2023-03-27T18:07:00.254Z,1679940420.254 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-03-27T18:07:00.270Z,1679940420.270 [ShortestDistanceToPolygonSidesCalculator] Loaded
2023-03-27T18:07:00.271Z,1679940420.271 [ComponentRegistry](DEBUG): SyncComponent "ShortestDistanceToPolygonSidesCalculator" handled in the control thread.
2023-03-27T18:07:00.271Z,1679940420.271 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-03-27T18:07:00.272Z,1679940420.272 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-03-27T18:07:00.447Z,1679940420.447 [CANONSampler] Loaded
2023-03-27T18:07:00.448Z,1679940420.448 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2023-03-27T18:07:00.506Z,1679940420.506 [CTD_Seabird] Loaded
2023-03-27T18:07:00.506Z,1679940420.506 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-03-27T18:07:00.507Z,1679940420.507 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2023-03-27T18:07:00.508Z,1679940420.508 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4424
2023-03-27T18:07:00.527Z,1679940420.527 [PAR_Licor] Loaded
2023-03-27T18:07:00.528Z,1679940420.528 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-03-27T18:07:00.558Z,1679940420.558 [WetLabsBB2FL] Loaded
2023-03-27T18:07:00.558Z,1679940420.558 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-03-27T18:07:00.559Z,1679940420.559 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0
2023-03-27T18:07:00.559Z,1679940420.559 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4425
2023-03-27T18:07:00.560Z,1679940420.560 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-03-27T18:07:00.560Z,1679940420.560 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-03-27T18:07:00.602Z,1679940420.602 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-03-27T18:07:00.603Z,1679940420.603 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-03-27T18:07:00.953Z,1679940420.953 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-03-27T18:07:00.954Z,1679940420.954 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-03-27T18:07:01.114Z,1679940421.114 [SBIT](DEBUG): Construct Startup Built In Test.
2023-03-27T18:07:01.125Z,1679940421.125 [SBIT] Loaded
2023-03-27T18:07:01.125Z,1679940421.125 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-03-27T18:07:01.128Z,1679940421.128 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-03-27T18:07:01.141Z,1679940421.141 [IBIT] Loaded
2023-03-27T18:07:01.142Z,1679940421.142 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-03-27T18:07:01.147Z,1679940421.147 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-03-27T18:07:01.252Z,1679940421.252 [CBIT] Loaded
2023-03-27T18:07:01.253Z,1679940421.253 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-03-27T18:07:01.253Z,1679940421.253 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-03-27T18:07:01.254Z,1679940421.254 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-03-27T18:07:01.375Z,1679940421.375 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-03-27T18:07:01.381Z,1679940421.381 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-03-27T18:07:01.384Z,1679940421.384 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-03-27T18:07:01.395Z,1679940421.395 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-03-27T18:07:01.396Z,1679940421.396 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B7E4E0
2023-03-27T18:07:01.396Z,1679940421.396 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4426
2023-03-27T18:07:01.400Z,1679940421.400 [Supervisor](INFO): Main Thread ID is 4331
2023-03-27T18:07:01.400Z,1679940421.400 [Supervisor](DEBUG): Running supervisor.
2023-03-27T18:07:01.401Z,1679940421.401 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4427
2023-03-27T18:07:01.402Z,1679940421.402 [CommandExec](INFO): Initializing the command executive.
2023-03-27T18:07:01.403Z,1679940421.403 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4428
2023-03-27T18:07:01.405Z,1679940421.405 [controlThread ThreadHandler](INFO): Handler Thread ID is 4429
2023-03-27T18:07:01.406Z,1679940421.406 [controlThread](DEBUG): Initializing ControlThread
2023-03-27T18:07:01.407Z,1679940421.407 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-03-27T18:07:01.408Z,1679940421.408 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-03-27T18:07:01.409Z,1679940421.409 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-03-27T18:07:01.409Z,1679940421.409 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-03-27T18:07:01.411Z,1679940421.411 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-03-27T18:07:01.412Z,1679940421.412 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-03-27T18:07:01.417Z,1679940421.417 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-03-27T18:07:01.417Z,1679940421.417 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-03-27T18:07:01.417Z,1679940421.417 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-03-27T18:07:01.417Z,1679940421.417 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2023-03-27T18:07:01.418Z,1679940421.418 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-03-27T18:07:01.419Z,1679940421.419 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-03-27T18:07:01.419Z,1679940421.419 [ShortestDistanceToPolygonSidesCalculator](DEBUG): Initializing.
2023-03-27T18:07:01.423Z,1679940421.423 [SBIT](INFO): Initialize SBIT Component.
2023-03-27T18:07:01.423Z,1679940421.423 [SBIT](IMPORTANT): git: 2023-03-17
2023-03-27T18:07:01.424Z,1679940421.424 [SBIT](INFO): git hash: 11ed9ebecafe2be57985d0df7ef5106c11760b30
2023-03-27T18:07:01.424Z,1679940421.424 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-03-27T18:07:01.425Z,1679940421.425 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-03-27T18:07:01.426Z,1679940421.426 [SBIT](INFO): Beginning SBIT in 76.000000 seconds.
2023-03-27T18:07:01.427Z,1679940421.427 [IBIT](INFO): Initialize IBIT Component.
2023-03-27T18:07:01.428Z,1679940421.428 [CBIT](DEBUG): Initialize CBIT Component.
2023-03-27T18:07:01.429Z,1679940421.429 [logger ThreadHandler](INFO): Handler Thread ID is 4430
2023-03-27T18:07:01.439Z,1679940421.439 [CBIT](DEBUG): Initialized mux pins.
2023-03-27T18:07:01.439Z,1679940421.439 [CBIT](DEBUG): Initializing the watchdog timer.
2023-03-27T18:07:01.447Z,1679940421.447 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4431
2023-03-27T18:07:01.448Z,1679940421.448 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-03-27T18:07:01.459Z,1679940421.459 [Onboard ThreadHandler](INFO): Handler Thread ID is 4432
2023-03-27T18:07:01.463Z,1679940421.463 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-03-27T18:07:01.464Z,1679940421.464 [CBIT](DEBUG): Initializing heartbeat.
2023-03-27T18:07:01.480Z,1679940421.480 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4433
2023-03-27T18:07:01.499Z,1679940421.499 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4434
2023-03-27T18:07:01.500Z,1679940421.500 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-03-27T18:07:01.505Z,1679940421.505 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4436
2023-03-27T18:07:01.507Z,1679940421.507 [WetLabsBB2FL](INFO): Powering up
2023-03-27T18:07:01.508Z,1679940421.508 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4438
2023-03-27T18:07:01.516Z,1679940421.516 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-03-27T18:07:01.516Z,1679940421.516 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-03-27T18:07:01.516Z,1679940421.516 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-03-27T18:07:01.517Z,1679940421.517 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-03-27T18:07:01.517Z,1679940421.517 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-03-27T18:07:01.517Z,1679940421.517 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-03-27T18:07:01.517Z,1679940421.517 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-03-27T18:07:01.517Z,1679940421.517 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-03-27T18:07:01.535Z,1679940421.535 [CBIT](DEBUG): Deactivating GF circuits.
2023-03-27T18:07:01.535Z,1679940421.535 [CBIT](DEBUG): Deactivating emergency mode.
2023-03-27T18:07:01.575Z,1679940421.575 [CBIT](DEBUG): Backplane powered.
2023-03-27T18:07:01.576Z,1679940421.576 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-03-27T18:07:01.616Z,1679940421.616 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-27T18:07:01.643Z,1679940421.643 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2023-03-27T18:07:01.644Z,1679940421.644 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-03-27T18:07:01.748Z,1679940421.748 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-03-27T18:07:01.749Z,1679940421.749 [Default:A.Wait](DEBUG): Construct Wait.
2023-03-27T18:07:01.768Z,1679940421.768 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-27T18:07:01.795Z,1679940421.795 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-03-27T18:07:01.797Z,1679940421.797 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-03-27T18:07:01.821Z,1679940421.821 [Default:E.Execute](DEBUG): Construct Execute.
2023-03-27T18:07:01.844Z,1679940421.844 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2023-03-27T18:07:01.849Z,1679940421.849 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2023-03-27T18:07:01.871Z,1679940421.871 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-03-27T18:07:01.883Z,1679940421.883 [Radio_Surface](INFO): Powering up
2023-03-27T18:07:01.940Z,1679940421.940 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2023-03-27T18:07:01.941Z,1679940421.941 [MultiRay](INFO): Powering up MultiRay Lights
2023-03-27T18:07:01.975Z,1679940421.975 [Power24vConverter](INFO): Powering up.
2023-03-27T18:07:01.976Z,1679940421.976 [CANONSampler](INFO): Powering down
2023-03-27T18:07:01.999Z,1679940421.999 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-03-27T18:07:02.059Z,1679940422.059 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-03-27T18:07:02.067Z,1679940422.067 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-03-27T18:07:02.068Z,1679940422.068 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-03-27T18:07:02.075Z,1679940422.075 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-03-27T18:07:02.076Z,1679940422.076 [MassServo](DEBUG): Initializing EZServoServo.
2023-03-27T18:07:02.083Z,1679940422.083 [MassServo](DEBUG): Initializing MassServo.
2023-03-27T18:07:02.084Z,1679940422.084 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-27T18:07:02.091Z,1679940422.091 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-27T18:07:02.092Z,1679940422.092 [ThrusterServo](DEBUG): Initializing EZServoServo.
2023-03-27T18:07:02.099Z,1679940422.099 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2023-03-27T18:07:02.305Z,1679940422.305 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T18:07:02.305Z,1679940422.305 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T18:07:02.305Z,1679940422.305 [DropWeight](ERROR): Hardware Fault
2023-03-27T18:07:02.380Z,1679940422.380 [CommandExec](FAULT): Scheduling is paused
2023-03-27T18:07:02.380Z,1679940422.380 [CBIT](INFO): Critical error at 20230327T180702
2023-03-27T18:07:02.381Z,1679940422.381 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-03-27T18:07:02.391Z,1679940422.391 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T18:07:02.392Z,1679940422.392 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T18:07:02.995Z,1679940422.995 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-03-27T18:07:02.995Z,1679940422.995 [RudderServo](FAULT): Rudder failed to initialize
2023-03-27T18:07:02.995Z,1679940422.995 [RudderServo] Communications Fault, FailCount= 1
2023-03-27T18:07:02.995Z,1679940422.995 [RudderServo](ERROR): Communications Fault
2023-03-27T18:07:03.093Z,1679940423.093 [CBIT](INFO): Critical error at 20230327T180702
2023-03-27T18:07:03.095Z,1679940423.095 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-03-27T18:07:03.512Z,1679940423.512 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-27T18:07:03.512Z,1679940423.512 [RudderServo](INFO): Powering down
2023-03-27T18:07:03.952Z,1679940423.952 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-27T18:07:04.072Z,1679940424.072 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-27T18:07:04.076Z,1679940424.076 [CBIT](INFO): Clearing failed state for component RudderServo
2023-03-27T18:07:04.076Z,1679940424.076 [RudderServo] No Fault, FailCount= 1
2023-03-27T18:07:04.119Z,1679940424.119 [WetLabsBB2FL](INFO): Powering down
2023-03-27T18:07:15.365Z,1679940435.365 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004666
2023-03-27T18:07:30.192Z,1679940450.192 [NAL9602](INFO): Powering up NAL9602
2023-03-27T18:07:41.112Z,1679940461.112 [NAL9602](INFO): NAL9602 initialized
2023-03-27T18:08:17.885Z,1679940497.885 [SBIT](IMPORTANT): Beginning Startup BIT
2023-03-27T18:08:17.889Z,1679940497.889 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-27T18:08:28.794Z,1679940508.794 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2023-03-27T18:08:29.204Z,1679940509.204 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-27T18:08:40.181Z,1679940520.181 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2023-03-27T18:08:40.595Z,1679940520.595 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-27T18:08:51.499Z,1679940531.499 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2023-03-27T18:08:51.500Z,1679940531.500 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2023-03-27T18:09:12.018Z,1679940552.018 [SBIT](IMPORTANT): SBIT PASSED
2023-03-27T18:09:12.018Z,1679940552.018 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-03-27T18:09:12.019Z,1679940552.019 [SBIT](IMPORTANT): AHRS_M2.readAccelerations=0 bool;

2023-03-27T18:09:12.019Z,1679940552.019 [SBIT](IMPORTANT): AHRS_M2.readAngularVelocities=0 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): AHRS_M2.readMagnetics=0 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=10 count;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): CANONSampler.loadAtStartup=1 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): CANONSampler.sampleTimeout=10 minute;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): CBIT.runElevOffsetCalc=1 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): DropWeight.loadAtStartup=1 bool;

2023-03-27T18:09:12.020Z,1679940552.020 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=0 bool;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_mean_sea_water_temperature;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.100000 celsius;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-27T18:09:12.021Z,1679940552.021 [SBIT](IMPORTANT): Express linearApproximation depth 5.000000 meter;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): Express linearApproximation latitude 0.005000 degree;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): Express linearApproximation longitude 0.005000 degree;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex1=36.81 degree;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex2=36.81 degree;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex3=36.78 degree;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex4=36.78 degree;

2023-03-27T18:09:12.022Z,1679940552.022 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.loadAtStartup=1 bool;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex1=-121.87 degree;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex2=-121.83 degree;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex3=-121.83 degree;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex4=-121.87 degree;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): ThrusterServo.currLimit=50 percent;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=336.456139 cubic_centimeter;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): VerticalControl.massDefault=-14.157167 millimeter;

2023-03-27T18:09:12.023Z,1679940552.023 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=15 meter;

2023-03-27T18:09:12.024Z,1679940552.024 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=20 meter;

2023-03-27T18:09:12.024Z,1679940552.024 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool;

2023-03-27T18:09:12.425Z,1679940552.425 [MissionManager](IMPORTANT): Started mission Startup
2023-03-27T18:09:12.426Z,1679940552.426 [Startup] Running Loop=1
2023-03-27T18:09:12.426Z,1679940552.426 [Startup](DEBUG): Aggregate::initialize Startup
2023-03-27T18:09:12.426Z,1679940552.426 [Startup:A.GoToSurface] Running Loop=1
2023-03-27T18:09:12.426Z,1679940552.426 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-27T18:09:12.427Z,1679940552.427 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-27T18:09:12.427Z,1679940552.427 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-27T18:09:12.428Z,1679940552.428 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-27T18:09:12.428Z,1679940552.428 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-27T18:09:12.428Z,1679940552.428 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-27T18:09:12.430Z,1679940552.430 [Startup:StartupSatComms] Running Loop=1
2023-03-27T18:09:12.430Z,1679940552.430 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-03-27T18:09:12.430Z,1679940552.430 [Startup:StartupSatComms:A] Running Loop=1
2023-03-27T18:09:12.826Z,1679940552.826 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-03-27T18:09:30.600Z,1679940570.600 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T18:10:01.729Z,1679940601.729 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-27T18:10:01.729Z,1679940601.729 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:10:01.739Z,1679940601.739 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:10:02.133Z,1679940602.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:10:02.133Z,1679940602.133 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-27T18:10:12.613Z,1679940612.613 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-27T18:09:12.4Z
2023-03-27T18:10:12.613Z,1679940612.613 [Startup:StartupSatComms:A] Stopped
2023-03-27T18:10:12.613Z,1679940612.613 [Startup:StartupSatComms:B] Running Loop=1
2023-03-27T18:10:13.017Z,1679940613.017 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-27T18:10:19.631Z,1679940619.631 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230320T200622/Courier0054.lzma
2023-03-27T18:10:20.633Z,1679940620.633 [DataOverHttps](INFO): Moved sent file to Logs/20230320T200622/Courier0054.lzma.bak
2023-03-27T18:10:20.633Z,1679940620.633 [DataOverHttps](INFO): SBD MOMSN=17683642
2023-03-27T18:10:39.499Z,1679940639.499 [DataOverHttps](INFO): Sending 244 bytes from file Logs/20230327T180650/Courier0000.lzma
2023-03-27T18:10:40.501Z,1679940640.501 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0000.lzma.bak
2023-03-27T18:10:40.501Z,1679940640.501 [DataOverHttps](INFO): SBD MOMSN=17683644
2023-03-27T18:10:56.831Z,1679940656.831 [DataOverHttps](INFO): Sending 97 bytes from file Logs/20230320T200622/Express0055.lzma
2023-03-27T18:10:57.833Z,1679940657.833 [DataOverHttps](INFO): Moved sent file to Logs/20230320T200622/Express0055.lzma.bak
2023-03-27T18:10:57.833Z,1679940657.833 [DataOverHttps](INFO): SBD MOMSN=17683649
2023-03-27T18:11:12.893Z,1679940672.893 [Startup:StartupSatComms:B](INFO): Timed out from 2023-03-27T18:10:12.6Z
2023-03-27T18:11:12.893Z,1679940672.893 [Startup:StartupSatComms:B] Stopped
2023-03-27T18:11:12.893Z,1679940672.893 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-03-27T18:11:12.893Z,1679940672.893 [Startup:StartupSatComms] Stopped
2023-03-27T18:11:12.893Z,1679940672.893 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-03-27T18:11:12.894Z,1679940672.894 [Startup](INFO): Completed Startup
2023-03-27T18:11:12.894Z,1679940672.894 [MissionManager](INFO): Startup is completed.
2023-03-27T18:11:12.899Z,1679940672.899 [MissionManager](INFO): Uninitializing Mission Startup
2023-03-27T18:11:12.899Z,1679940672.899 [Startup] Stopped
2023-03-27T18:11:12.899Z,1679940672.899 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-03-27T18:11:12.899Z,1679940672.899 [Startup:A.GoToSurface] Stopped
2023-03-27T18:11:12.899Z,1679940672.899 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-27T18:11:13.277Z,1679940673.277 [MissionManager](IMPORTANT): Started mission Default
2023-03-27T18:11:13.277Z,1679940673.277 [Default] Running Loop=1
2023-03-27T18:11:13.277Z,1679940673.277 [Default](DEBUG): Aggregate::initialize Default
2023-03-27T18:11:13.277Z,1679940673.277 [Default:B.GoToSurface] Running Loop=1
2023-03-27T18:11:13.277Z,1679940673.277 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-27T18:11:13.277Z,1679940673.277 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-27T18:11:13.278Z,1679940673.278 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-27T18:11:13.278Z,1679940673.278 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-27T18:11:13.278Z,1679940673.278 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-27T18:11:13.279Z,1679940673.279 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-27T18:11:13.279Z,1679940673.279 [Default:A.Wait] Running Loop=1
2023-03-27T18:11:13.279Z,1679940673.279 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-03-27T18:11:14.189Z,1679940674.189 [DataOverHttps](INFO): Sending 1235 bytes from file Logs/20230327T180650/Express0001.lzma
2023-03-27T18:11:15.188Z,1679940675.188 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0001.lzma.bak
2023-03-27T18:11:15.189Z,1679940675.189 [DataOverHttps](INFO): SBD MOMSN=17683652
2023-03-27T18:11:26.629Z,1679940686.629 [Default:A.Wait](INFO): Done Waiting.
2023-03-27T18:11:26.629Z,1679940686.629 [Default:A.Wait] Stopped
2023-03-27T18:11:26.629Z,1679940686.629 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T18:11:27.030Z,1679940687.030 [Default:CheckIn] Running Loop=1
2023-03-27T18:11:27.030Z,1679940687.030 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T18:11:27.031Z,1679940687.031 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T18:11:27.437Z,1679940687.437 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-03-27T18:11:57.291Z,1679940717.291 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:11:57.707Z,1679940717.707 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2023-03-27T18:12:12.643Z,1679940732.643 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:12:27.591Z,1679940747.591 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:12:42.943Z,1679940762.943 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:12:44.571Z,1679940764.571 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-03-27T18:12:58.295Z,1679940778.295 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:13:02.777Z,1679940782.777 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-27T18:13:02.777Z,1679940782.777 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:13:02.787Z,1679940782.787 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:13:03.187Z,1679940783.187 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:13:03.187Z,1679940783.187 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-27T18:13:13.243Z,1679940793.243 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:13:28.595Z,1679940808.595 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:13:44.355Z,1679940824.355 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:13:59.704Z,1679940839.704 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T18:14:15.055Z,1679940855.055 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-03-27T18:14:31.235Z,1679940871.235 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2023-03-27T18:14:31.243Z,1679940871.243 [BPC1](INFO): Received data from all battery sticks.
2023-03-27T18:16:03.748Z,1679940963.748 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-03-27T18:16:03.748Z,1679940963.748 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:16:03.758Z,1679940963.758 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:16:04.199Z,1679940964.199 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:16:04.199Z,1679940964.199 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-03-27T18:16:27.198Z,1679940987.198 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T18:11:27.0Z
2023-03-27T18:16:27.198Z,1679940987.198 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T18:16:27.198Z,1679940987.198 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T18:16:27.610Z,1679940987.610 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-27T18:16:34.826Z,1679940994.826 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20230327T180650/Courier0004.lzma
2023-03-27T18:16:35.828Z,1679940995.828 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0004.lzma.bak
2023-03-27T18:16:35.828Z,1679940995.828 [DataOverHttps](INFO): SBD MOMSN=17683706
2023-03-27T18:16:51.418Z,1679941011.418 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20230327T180650/Express0005.lzma
2023-03-27T18:16:52.420Z,1679941012.420 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0005.lzma.bak
2023-03-27T18:16:52.421Z,1679941012.421 [DataOverHttps](INFO): SBD MOMSN=17683709
2023-03-27T18:16:53.857Z,1679941013.857 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T18:16:53.857Z,1679941013.857 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T18:16:53.857Z,1679941013.857 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T18:17:03.143Z,1679941023.143 [Power24vConverter](INFO): Powering down.
2023-03-27T18:17:43.532Z,1679941063.532 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T18:17:43.532Z,1679941063.532 [NAL9602] Data Fault, FailCount= 1
2023-03-27T18:17:43.532Z,1679941063.532 [NAL9602](ERROR): Data Fault
2023-03-27T18:17:43.579Z,1679941063.579 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T18:17:43.929Z,1679941063.929 [NAL9602](INFO): Powering down
2023-03-27T18:17:44.765Z,1679941064.765 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T18:17:44.765Z,1679941064.765 [NAL9602] No Fault, FailCount= 1
2023-03-27T18:18:14.229Z,1679941094.229 [NAL9602](INFO): Powering up NAL9602
2023-03-27T18:18:25.144Z,1679941105.144 [NAL9602](INFO): NAL9602 initialized
2023-03-27T18:19:04.764Z,1679941144.764 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-03-27T18:19:04.764Z,1679941144.764 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:19:04.775Z,1679941144.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:19:05.175Z,1679941145.175 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:19:05.175Z,1679941145.175 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-03-27T18:21:54.421Z,1679941314.421 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T18:21:54.421Z,1679941314.421 [Default:CheckIn:C.Wait] Stopped
2023-03-27T18:21:54.422Z,1679941314.422 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T18:21:54.422Z,1679941314.422 [Default:CheckIn:D] Running Loop=1
2023-03-27T18:21:54.854Z,1679941314.854 [Default:CheckIn:D] Stopped
2023-03-27T18:21:54.855Z,1679941314.855 [Default:CheckIn:E] Running Loop=1
2023-03-27T18:21:55.250Z,1679941315.250 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.692957 min 
2023-03-27T18:21:55.250Z,1679941315.250 [Default:CheckIn:E] Stopped
2023-03-27T18:21:55.250Z,1679941315.250 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T18:21:55.250Z,1679941315.250 [Default:CheckIn] Stopped
2023-03-27T18:21:55.250Z,1679941315.250 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T18:21:55.251Z,1679941315.251 [Default:CheckIn](INFO): Running loop #2
2023-03-27T18:21:55.251Z,1679941315.251 [Default:CheckIn] Running Loop=2
2023-03-27T18:21:55.251Z,1679941315.251 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T18:21:55.251Z,1679941315.251 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T18:22:02.526Z,1679941322.526 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T18:22:02.526Z,1679941322.526 [DropWeight] No Fault, FailCount= 1
2023-03-27T18:22:05.757Z,1679941325.757 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-03-27T18:22:05.757Z,1679941325.757 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:22:05.768Z,1679941325.768 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:22:06.174Z,1679941326.174 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:22:06.174Z,1679941326.174 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-03-27T18:25:06.740Z,1679941506.740 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-03-27T18:25:06.740Z,1679941506.740 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:25:06.751Z,1679941506.751 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:25:07.141Z,1679941507.141 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:25:07.141Z,1679941507.141 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-03-27T18:26:55.414Z,1679941615.414 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T18:21:55.3Z
2023-03-27T18:26:55.414Z,1679941615.414 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T18:26:55.414Z,1679941615.414 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T18:27:02.410Z,1679941622.410 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0007.lzma
2023-03-27T18:27:03.412Z,1679941623.412 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0007.lzma.bak
2023-03-27T18:27:03.412Z,1679941623.412 [DataOverHttps](INFO): SBD MOMSN=17684074
2023-03-27T18:27:18.846Z,1679941638.846 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20230327T180650/Express0008.lzma
2023-03-27T18:27:19.848Z,1679941639.848 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0008.lzma.bak
2023-03-27T18:27:19.849Z,1679941639.849 [DataOverHttps](INFO): SBD MOMSN=17684076
2023-03-27T18:27:21.274Z,1679941641.274 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T18:27:21.274Z,1679941641.274 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T18:27:21.274Z,1679941641.274 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T18:28:07.721Z,1679941687.721 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-03-27T18:28:07.721Z,1679941687.721 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:28:07.733Z,1679941687.733 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:28:08.155Z,1679941688.155 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:28:08.155Z,1679941688.155 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-03-27T18:28:28.316Z,1679941708.316 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T18:28:28.317Z,1679941708.317 [NAL9602] Data Fault, FailCount= 2
2023-03-27T18:28:28.317Z,1679941708.317 [NAL9602](ERROR): Data Fault
2023-03-27T18:28:28.360Z,1679941708.360 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T18:28:28.720Z,1679941708.720 [NAL9602](INFO): Powering down
2023-03-27T18:28:29.550Z,1679941709.550 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T18:28:29.550Z,1679941709.550 [NAL9602] No Fault, FailCount= 2
2023-03-27T18:28:59.013Z,1679941739.013 [NAL9602](INFO): Powering up NAL9602
2023-03-27T18:29:09.928Z,1679941749.928 [NAL9602](INFO): NAL9602 initialized
2023-03-27T18:31:08.733Z,1679941868.733 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-03-27T18:31:08.733Z,1679941868.733 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:31:08.759Z,1679941868.759 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:31:09.143Z,1679941869.143 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:31:09.143Z,1679941869.143 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-03-27T18:32:21.857Z,1679941941.857 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T18:32:21.857Z,1679941941.857 [Default:CheckIn:C.Wait] Stopped
2023-03-27T18:32:21.857Z,1679941941.857 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T18:32:21.857Z,1679941941.857 [Default:CheckIn:D] Running Loop=1
2023-03-27T18:32:22.257Z,1679941942.257 [Default:CheckIn:D] Stopped
2023-03-27T18:32:22.257Z,1679941942.257 [Default:CheckIn:E] Running Loop=1
2023-03-27T18:32:22.663Z,1679941942.663 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.149677 min 
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn:E] Stopped
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn] Stopped
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn](INFO): Running loop #3
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn] Running Loop=3
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T18:32:22.664Z,1679941942.664 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T18:34:09.704Z,1679942049.704 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-03-27T18:34:09.704Z,1679942049.704 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:34:09.731Z,1679942049.731 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:34:10.118Z,1679942050.118 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:34:10.118Z,1679942050.118 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-03-27T18:37:10.740Z,1679942230.740 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-03-27T18:37:10.740Z,1679942230.740 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:37:10.750Z,1679942230.750 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:37:11.134Z,1679942231.134 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:37:11.134Z,1679942231.134 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-03-27T18:37:22.862Z,1679942242.862 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T18:32:22.7Z
2023-03-27T18:37:22.862Z,1679942242.862 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T18:37:22.862Z,1679942242.862 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T18:37:30.058Z,1679942250.058 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0010.lzma
2023-03-27T18:37:31.060Z,1679942251.060 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0010.lzma.bak
2023-03-27T18:37:31.061Z,1679942251.061 [DataOverHttps](INFO): SBD MOMSN=17684427
2023-03-27T18:37:46.395Z,1679942266.395 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230327T180650/Express0011.lzma
2023-03-27T18:37:47.396Z,1679942267.396 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0011.lzma.bak
2023-03-27T18:37:47.396Z,1679942267.396 [DataOverHttps](INFO): SBD MOMSN=17684429
2023-03-27T18:37:48.721Z,1679942268.721 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T18:37:48.722Z,1679942268.722 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T18:37:48.722Z,1679942268.722 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T18:39:11.517Z,1679942351.517 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T18:39:11.517Z,1679942351.517 [NAL9602] Data Fault, FailCount= 3
2023-03-27T18:39:11.517Z,1679942351.517 [NAL9602](ERROR): Data Fault
2023-03-27T18:39:11.559Z,1679942351.559 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T18:39:11.920Z,1679942351.920 [NAL9602](INFO): Powering down
2023-03-27T18:39:12.751Z,1679942352.751 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T18:39:12.751Z,1679942352.751 [NAL9602] No Fault, FailCount= 3
2023-03-27T18:39:42.220Z,1679942382.220 [NAL9602](INFO): Powering up NAL9602
2023-03-27T18:39:53.128Z,1679942393.128 [NAL9602](INFO): NAL9602 initialized
2023-03-27T18:40:11.733Z,1679942411.733 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-03-27T18:40:11.733Z,1679942411.733 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:40:11.744Z,1679942411.744 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:40:12.158Z,1679942412.158 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:40:12.158Z,1679942412.158 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-03-27T18:42:49.288Z,1679942569.288 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T18:42:49.288Z,1679942569.288 [Default:CheckIn:C.Wait] Stopped
2023-03-27T18:42:49.288Z,1679942569.288 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T18:42:49.289Z,1679942569.289 [Default:CheckIn:D] Running Loop=1
2023-03-27T18:42:49.688Z,1679942569.688 [Default:CheckIn:D] Stopped
2023-03-27T18:42:49.688Z,1679942569.688 [Default:CheckIn:E] Running Loop=1
2023-03-27T18:42:50.097Z,1679942570.097 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.606854 min 
2023-03-27T18:42:50.097Z,1679942570.097 [Default:CheckIn:E] Stopped
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn] Stopped
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn](INFO): Running loop #4
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn] Running Loop=4
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T18:42:50.098Z,1679942570.098 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T18:43:12.737Z,1679942592.737 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-03-27T18:43:12.737Z,1679942592.737 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:43:12.747Z,1679942592.747 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:43:13.146Z,1679942593.146 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:43:13.146Z,1679942593.146 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-03-27T18:46:13.714Z,1679942773.714 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-03-27T18:46:13.714Z,1679942773.714 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:46:13.744Z,1679942773.744 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:46:14.123Z,1679942774.123 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:46:14.123Z,1679942774.123 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-03-27T18:47:50.261Z,1679942870.261 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T18:42:50.1Z
2023-03-27T18:47:50.261Z,1679942870.261 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T18:47:50.261Z,1679942870.261 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T18:47:57.626Z,1679942877.626 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0013.lzma
2023-03-27T18:47:58.631Z,1679942878.631 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0013.lzma.bak
2023-03-27T18:47:58.632Z,1679942878.632 [DataOverHttps](INFO): SBD MOMSN=17684787
2023-03-27T18:48:14.470Z,1679942894.470 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230327T180650/Express0014.lzma
2023-03-27T18:48:15.472Z,1679942895.472 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0014.lzma.bak
2023-03-27T18:48:15.473Z,1679942895.473 [DataOverHttps](INFO): SBD MOMSN=17684789
2023-03-27T18:48:16.945Z,1679942896.945 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T18:48:16.945Z,1679942896.945 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T18:48:16.945Z,1679942896.945 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T18:49:14.696Z,1679942954.696 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-03-27T18:49:14.696Z,1679942954.696 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:49:14.733Z,1679942954.733 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:49:15.113Z,1679942955.113 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:49:15.113Z,1679942955.113 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-03-27T18:49:54.276Z,1679942994.276 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T18:49:54.277Z,1679942994.277 [NAL9602] Data Fault, FailCount= 4
2023-03-27T18:49:54.277Z,1679942994.277 [NAL9602](ERROR): Data Fault
2023-03-27T18:49:54.324Z,1679942994.324 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T18:49:54.684Z,1679942994.684 [NAL9602](INFO): Powering down
2023-03-27T18:49:55.505Z,1679942995.505 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T18:49:55.505Z,1679942995.505 [NAL9602] No Fault, FailCount= 4
2023-03-27T18:50:24.988Z,1679943024.988 [NAL9602](INFO): Powering up NAL9602
2023-03-27T18:50:35.892Z,1679943035.892 [NAL9602](INFO): NAL9602 initialized
2023-03-27T18:52:03.973Z,1679943123.973 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T18:52:03.973Z,1679943123.973 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T18:52:03.973Z,1679943123.973 [DropWeight](ERROR): Hardware Fault
2023-03-27T18:52:04.001Z,1679943124.001 [CBIT](INFO): Critical error at 20230327T185203
2023-03-27T18:52:04.003Z,1679943124.003 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T18:52:04.004Z,1679943124.004 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T18:52:04.409Z,1679943124.409 [CBIT](INFO): Critical error at 20230327T185204
2023-03-27T18:52:15.713Z,1679943135.713 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-03-27T18:52:15.713Z,1679943135.713 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:52:15.743Z,1679943135.743 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:52:16.122Z,1679943136.122 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:52:16.122Z,1679943136.122 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-03-27T18:53:17.530Z,1679943197.530 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T18:53:17.530Z,1679943197.530 [Default:CheckIn:C.Wait] Stopped
2023-03-27T18:53:17.530Z,1679943197.530 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T18:53:17.530Z,1679943197.530 [Default:CheckIn:D] Running Loop=1
2023-03-27T18:53:17.933Z,1679943197.933 [Default:CheckIn:D] Stopped
2023-03-27T18:53:17.933Z,1679943197.933 [Default:CheckIn:E] Running Loop=1
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.077600 min 
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn:E] Stopped
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn] Stopped
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn](INFO): Running loop #5
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn] Running Loop=5
2023-03-27T18:53:18.323Z,1679943198.323 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T18:53:18.324Z,1679943198.324 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T18:55:16.694Z,1679943316.694 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-03-27T18:55:16.694Z,1679943316.694 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:55:16.704Z,1679943316.704 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:55:17.093Z,1679943317.093 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:55:17.093Z,1679943317.093 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-03-27T18:58:17.678Z,1679943497.678 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2023-03-27T18:58:17.678Z,1679943497.678 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T18:58:17.688Z,1679943497.688 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T18:58:18.102Z,1679943498.102 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T18:58:18.102Z,1679943498.102 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2023-03-27T18:58:18.509Z,1679943498.509 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T18:53:18.3Z
2023-03-27T18:58:18.509Z,1679943498.509 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T18:58:18.509Z,1679943498.509 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T18:58:25.342Z,1679943505.342 [DataOverHttps](INFO): Sending 117 bytes from file Logs/20230327T180650/Courier0016.lzma
2023-03-27T18:58:26.344Z,1679943506.344 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0016.lzma.bak
2023-03-27T18:58:26.345Z,1679943506.345 [DataOverHttps](INFO): SBD MOMSN=17685149
2023-03-27T18:58:41.887Z,1679943521.887 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20230327T180650/Express0017.lzma
2023-03-27T18:58:42.804Z,1679943522.804 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0017.lzma.bak
2023-03-27T18:58:42.804Z,1679943522.804 [DataOverHttps](INFO): SBD MOMSN=17685153
2023-03-27T18:58:44.002Z,1679943524.002 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T18:58:44.002Z,1679943524.002 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T18:58:44.002Z,1679943524.002 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T19:00:37.080Z,1679943637.080 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T19:00:37.080Z,1679943637.080 [NAL9602] Data Fault, FailCount= 5
2023-03-27T19:00:37.080Z,1679943637.080 [NAL9602](ERROR): Data Fault
2023-03-27T19:00:37.098Z,1679943637.098 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T19:00:37.123Z,1679943637.123 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-03-27T19:00:37.484Z,1679943637.484 [NAL9602](INFO): Powering down
2023-03-27T19:00:37.501Z,1679943637.501 [CBIT](INFO): Critical error at 20230327T190037
2023-03-27T19:01:18.716Z,1679943678.716 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2023-03-27T19:01:18.716Z,1679943678.716 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:01:18.739Z,1679943678.739 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:01:19.140Z,1679943679.140 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:01:19.140Z,1679943679.140 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2023-03-27T19:02:37.104Z,1679943757.104 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T19:02:37.104Z,1679943757.104 [NAL9602] No Fault, FailCount= 5
2023-03-27T19:02:37.472Z,1679943757.472 [NAL9602](INFO): Powering up NAL9602
2023-03-27T19:02:48.382Z,1679943768.382 [NAL9602](INFO): NAL9602 initialized
2023-03-27T19:03:44.553Z,1679943824.553 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T19:03:44.553Z,1679943824.553 [Default:CheckIn:C.Wait] Stopped
2023-03-27T19:03:44.553Z,1679943824.553 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T19:03:44.553Z,1679943824.553 [Default:CheckIn:D] Running Loop=1
2023-03-27T19:03:44.965Z,1679943824.965 [Default:CheckIn:D] Stopped
2023-03-27T19:03:44.965Z,1679943824.965 [Default:CheckIn:E] Running Loop=1
2023-03-27T19:03:45.383Z,1679943825.383 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.528141 min 
2023-03-27T19:03:45.383Z,1679943825.383 [Default:CheckIn:E] Stopped
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn] Stopped
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn](INFO): Running loop #6
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn] Running Loop=6
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T19:03:45.384Z,1679943825.384 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T19:04:19.724Z,1679943859.724 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2023-03-27T19:04:19.724Z,1679943859.724 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:04:19.763Z,1679943859.763 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:04:20.171Z,1679943860.171 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:04:20.171Z,1679943860.171 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2023-03-27T19:07:04.164Z,1679944024.164 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T19:07:04.164Z,1679944024.164 [DropWeight] No Fault, FailCount= 1
2023-03-27T19:07:20.734Z,1679944040.734 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2023-03-27T19:07:20.734Z,1679944040.734 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:07:20.756Z,1679944040.756 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:07:20.756Z,1679944040.756 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:08:45.522Z,1679944125.522 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T19:03:45.4Z
2023-03-27T19:08:45.522Z,1679944125.522 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T19:08:45.522Z,1679944125.522 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T19:08:52.526Z,1679944132.526 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20230327T180650/Courier0019.lzma
2023-03-27T19:08:53.528Z,1679944133.528 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0019.lzma.bak
2023-03-27T19:08:53.529Z,1679944133.529 [DataOverHttps](INFO): SBD MOMSN=17685502
2023-03-27T19:09:09.414Z,1679944149.414 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20230327T180650/Express0020.lzma
2023-03-27T19:09:10.416Z,1679944150.416 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0020.lzma.bak
2023-03-27T19:09:10.417Z,1679944150.417 [DataOverHttps](INFO): SBD MOMSN=17685505
2023-03-27T19:09:11.796Z,1679944151.796 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T19:09:11.796Z,1679944151.796 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T19:09:11.797Z,1679944151.797 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T19:12:50.341Z,1679944370.341 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T19:12:50.341Z,1679944370.341 [NAL9602] Data Fault, FailCount= 1
2023-03-27T19:12:50.341Z,1679944370.341 [NAL9602](ERROR): Data Fault
2023-03-27T19:12:50.362Z,1679944370.362 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T19:12:50.748Z,1679944370.748 [NAL9602](INFO): Powering down
2023-03-27T19:12:51.565Z,1679944371.565 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T19:12:51.565Z,1679944371.565 [NAL9602] No Fault, FailCount= 1
2023-03-27T19:13:21.049Z,1679944401.049 [NAL9602](INFO): Powering up NAL9602
2023-03-27T19:13:31.956Z,1679944411.956 [NAL9602](INFO): NAL9602 initialized
2023-03-27T19:14:12.373Z,1679944452.373 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T19:14:12.374Z,1679944452.374 [Default:CheckIn:C.Wait] Stopped
2023-03-27T19:14:12.374Z,1679944452.374 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T19:14:12.374Z,1679944452.374 [Default:CheckIn:D] Running Loop=1
2023-03-27T19:14:12.769Z,1679944452.769 [Default:CheckIn:D] Stopped
2023-03-27T19:14:12.769Z,1679944452.769 [Default:CheckIn:E] Running Loop=1
2023-03-27T19:14:13.178Z,1679944453.178 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.991532 min 
2023-03-27T19:14:13.178Z,1679944453.178 [Default:CheckIn:E] Stopped
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn] Stopped
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn](INFO): Running loop #7
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn] Running Loop=7
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T19:14:13.179Z,1679944453.179 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T19:19:13.435Z,1679944753.435 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T19:14:13.2Z
2023-03-27T19:19:13.435Z,1679944753.435 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T19:19:13.435Z,1679944753.435 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T19:19:20.514Z,1679944760.514 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0022.lzma
2023-03-27T19:19:21.516Z,1679944761.516 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0022.lzma.bak
2023-03-27T19:19:21.516Z,1679944761.516 [DataOverHttps](INFO): SBD MOMSN=17685861
2023-03-27T19:19:30.307Z,1679944770.307 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:19:36.898Z,1679944776.898 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0023.lzma
2023-03-27T19:19:37.900Z,1679944777.900 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0023.lzma.bak
2023-03-27T19:19:37.901Z,1679944777.901 [DataOverHttps](INFO): SBD MOMSN=17685863
2023-03-27T19:19:39.217Z,1679944779.217 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T19:19:39.217Z,1679944779.217 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T19:19:39.217Z,1679944779.217 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T19:19:45.263Z,1679944785.263 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:20:00.224Z,1679944800.224 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:20:15.159Z,1679944815.159 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:20:30.514Z,1679944830.514 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:20:45.864Z,1679944845.864 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:21:00.811Z,1679944860.811 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:21:15.759Z,1679944875.759 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:21:30.717Z,1679944890.717 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T19:21:44.851Z,1679944904.851 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-03-27T19:21:58.192Z,1679944918.192 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2023-03-27T19:21:58.195Z,1679944918.195 [BPC1](INFO): Received data from all battery sticks.
2023-03-27T19:22:20.844Z,1679944940.844 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:22:20.844Z,1679944940.844 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2023-03-27T19:23:34.345Z,1679945014.345 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T19:23:34.345Z,1679945014.345 [NAL9602] Data Fault, FailCount= 2
2023-03-27T19:23:34.345Z,1679945014.345 [NAL9602](ERROR): Data Fault
2023-03-27T19:23:34.391Z,1679945014.391 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T19:23:34.748Z,1679945014.748 [NAL9602](INFO): Powering down
2023-03-27T19:23:35.574Z,1679945015.574 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T19:23:35.574Z,1679945015.574 [NAL9602] No Fault, FailCount= 2
2023-03-27T19:24:05.048Z,1679945045.048 [NAL9602](INFO): Powering up NAL9602
2023-03-27T19:24:15.952Z,1679945055.952 [NAL9602](INFO): NAL9602 initialized
2023-03-27T19:24:39.822Z,1679945079.822 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T19:24:39.822Z,1679945079.822 [Default:CheckIn:C.Wait] Stopped
2023-03-27T19:24:39.822Z,1679945079.822 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T19:24:39.822Z,1679945079.822 [Default:CheckIn:D] Running Loop=1
2023-03-27T19:24:40.230Z,1679945080.230 [Default:CheckIn:D] Stopped
2023-03-27T19:24:40.230Z,1679945080.230 [Default:CheckIn:E] Running Loop=1
2023-03-27T19:24:40.634Z,1679945080.634 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.449219 min 
2023-03-27T19:24:40.634Z,1679945080.634 [Default:CheckIn:E] Stopped
2023-03-27T19:24:40.634Z,1679945080.634 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T19:24:40.634Z,1679945080.634 [Default:CheckIn] Stopped
2023-03-27T19:24:40.634Z,1679945080.634 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T19:24:40.634Z,1679945080.634 [Default:CheckIn](INFO): Running loop #8
2023-03-27T19:24:40.635Z,1679945080.635 [Default:CheckIn] Running Loop=8
2023-03-27T19:24:40.635Z,1679945080.635 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T19:24:40.635Z,1679945080.635 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T19:25:21.426Z,1679945121.426 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-27T19:25:21.426Z,1679945121.426 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:25:21.437Z,1679945121.437 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:25:21.851Z,1679945121.851 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:25:21.852Z,1679945121.852 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-27T19:28:22.407Z,1679945302.407 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-27T19:28:22.407Z,1679945302.407 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:28:22.417Z,1679945302.417 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:28:22.835Z,1679945302.835 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:28:22.835Z,1679945302.835 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-27T19:29:40.790Z,1679945380.790 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T19:24:40.6Z
2023-03-27T19:29:40.790Z,1679945380.790 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T19:29:40.790Z,1679945380.790 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T19:29:47.997Z,1679945387.997 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20230327T180650/Courier0025.lzma
2023-03-27T19:29:48.996Z,1679945388.996 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0025.lzma.bak
2023-03-27T19:29:48.997Z,1679945388.997 [DataOverHttps](INFO): SBD MOMSN=17686221
2023-03-27T19:30:04.350Z,1679945404.350 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0026.lzma
2023-03-27T19:30:05.352Z,1679945405.352 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0026.lzma.bak
2023-03-27T19:30:05.352Z,1679945405.352 [DataOverHttps](INFO): SBD MOMSN=17686223
2023-03-27T19:30:07.046Z,1679945407.046 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T19:30:07.046Z,1679945407.046 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T19:30:07.046Z,1679945407.046 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T19:31:23.424Z,1679945483.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-03-27T19:31:23.424Z,1679945483.424 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:31:23.457Z,1679945483.457 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:31:23.837Z,1679945483.837 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:31:23.837Z,1679945483.837 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-03-27T19:34:17.136Z,1679945657.136 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T19:34:17.137Z,1679945657.137 [NAL9602] Data Fault, FailCount= 3
2023-03-27T19:34:17.137Z,1679945657.137 [NAL9602](ERROR): Data Fault
2023-03-27T19:34:17.154Z,1679945657.154 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T19:34:17.540Z,1679945657.540 [NAL9602](INFO): Powering down
2023-03-27T19:34:18.383Z,1679945658.383 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T19:34:18.383Z,1679945658.383 [NAL9602] No Fault, FailCount= 3
2023-03-27T19:34:24.419Z,1679945664.419 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-03-27T19:34:24.419Z,1679945664.419 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:34:24.429Z,1679945664.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:34:24.832Z,1679945664.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:34:24.832Z,1679945664.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-03-27T19:34:47.833Z,1679945687.833 [NAL9602](INFO): Powering up NAL9602
2023-03-27T19:34:58.753Z,1679945698.753 [NAL9602](INFO): NAL9602 initialized
2023-03-27T19:35:07.669Z,1679945707.669 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T19:35:07.669Z,1679945707.669 [Default:CheckIn:C.Wait] Stopped
2023-03-27T19:35:07.669Z,1679945707.669 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T19:35:07.669Z,1679945707.669 [Default:CheckIn:D] Running Loop=1
2023-03-27T19:35:08.073Z,1679945708.073 [Default:CheckIn:D] Stopped
2023-03-27T19:35:08.073Z,1679945708.073 [Default:CheckIn:E] Running Loop=1
2023-03-27T19:35:08.470Z,1679945708.470 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.913265 min 
2023-03-27T19:35:08.470Z,1679945708.470 [Default:CheckIn:E] Stopped
2023-03-27T19:35:08.470Z,1679945708.470 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T19:35:08.470Z,1679945708.470 [Default:CheckIn] Stopped
2023-03-27T19:35:08.470Z,1679945708.470 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T19:35:08.471Z,1679945708.471 [Default:CheckIn](INFO): Running loop #9
2023-03-27T19:35:08.471Z,1679945708.471 [Default:CheckIn] Running Loop=9
2023-03-27T19:35:08.471Z,1679945708.471 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T19:35:08.471Z,1679945708.471 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T19:37:05.608Z,1679945825.608 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T19:37:05.608Z,1679945825.608 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T19:37:05.608Z,1679945825.608 [DropWeight](ERROR): Hardware Fault
2023-03-27T19:37:05.624Z,1679945825.624 [CBIT](INFO): Critical error at 20230327T193705
2023-03-27T19:37:05.627Z,1679945825.627 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T19:37:05.627Z,1679945825.627 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T19:37:06.055Z,1679945826.055 [CBIT](INFO): Critical error at 20230327T193705
2023-03-27T19:37:25.413Z,1679945845.413 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-03-27T19:37:25.413Z,1679945845.413 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:37:25.436Z,1679945845.436 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:37:25.821Z,1679945845.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:37:25.821Z,1679945845.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-03-27T19:40:08.624Z,1679946008.624 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T19:35:08.5Z
2023-03-27T19:40:08.624Z,1679946008.624 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T19:40:08.624Z,1679946008.624 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T19:40:15.986Z,1679946015.986 [DataOverHttps](INFO): Sending 116 bytes from file Logs/20230327T180650/Courier0028.lzma
2023-03-27T19:40:16.988Z,1679946016.988 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0028.lzma.bak
2023-03-27T19:40:16.989Z,1679946016.989 [DataOverHttps](INFO): SBD MOMSN=17686582
2023-03-27T19:40:26.417Z,1679946026.417 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-03-27T19:40:26.417Z,1679946026.417 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:40:26.427Z,1679946026.427 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:40:26.832Z,1679946026.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:40:26.832Z,1679946026.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-03-27T19:40:33.306Z,1679946033.306 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230327T180650/Express0029.lzma
2023-03-27T19:40:34.308Z,1679946034.308 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0029.lzma.bak
2023-03-27T19:40:34.309Z,1679946034.309 [DataOverHttps](INFO): SBD MOMSN=17686586
2023-03-27T19:40:35.724Z,1679946035.724 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T19:40:35.724Z,1679946035.724 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T19:40:35.724Z,1679946035.724 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T19:43:27.444Z,1679946207.444 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-03-27T19:43:27.444Z,1679946207.444 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:43:27.455Z,1679946207.455 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:43:27.854Z,1679946207.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:43:27.854Z,1679946207.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-03-27T19:44:59.936Z,1679946299.936 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T19:44:59.936Z,1679946299.936 [NAL9602] Data Fault, FailCount= 4
2023-03-27T19:44:59.936Z,1679946299.936 [NAL9602](ERROR): Data Fault
2023-03-27T19:44:59.953Z,1679946299.953 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T19:45:00.336Z,1679946300.336 [NAL9602](INFO): Powering down
2023-03-27T19:45:01.154Z,1679946301.154 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T19:45:01.154Z,1679946301.154 [NAL9602] No Fault, FailCount= 4
2023-03-27T19:45:30.640Z,1679946330.640 [NAL9602](INFO): Powering up NAL9602
2023-03-27T19:45:36.292Z,1679946336.292 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T19:45:36.293Z,1679946336.293 [Default:CheckIn:C.Wait] Stopped
2023-03-27T19:45:36.293Z,1679946336.293 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T19:45:36.293Z,1679946336.293 [Default:CheckIn:D] Running Loop=1
2023-03-27T19:45:36.706Z,1679946336.706 [Default:CheckIn:D] Stopped
2023-03-27T19:45:36.706Z,1679946336.706 [Default:CheckIn:E] Running Loop=1
2023-03-27T19:45:37.108Z,1679946337.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.390479 min 
2023-03-27T19:45:37.108Z,1679946337.108 [Default:CheckIn:E] Stopped
2023-03-27T19:45:37.108Z,1679946337.108 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T19:45:37.108Z,1679946337.108 [Default:CheckIn] Stopped
2023-03-27T19:45:37.108Z,1679946337.108 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T19:45:37.109Z,1679946337.109 [Default:CheckIn](INFO): Running loop #10
2023-03-27T19:45:37.109Z,1679946337.109 [Default:CheckIn] Running Loop=10
2023-03-27T19:45:37.109Z,1679946337.109 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T19:45:37.109Z,1679946337.109 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T19:45:41.540Z,1679946341.540 [NAL9602](INFO): NAL9602 initialized
2023-03-27T19:46:28.424Z,1679946388.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-03-27T19:46:28.424Z,1679946388.424 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:46:28.435Z,1679946388.435 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:46:28.842Z,1679946388.842 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:46:28.843Z,1679946388.843 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-03-27T19:49:29.408Z,1679946569.408 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-03-27T19:49:29.408Z,1679946569.408 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:49:29.419Z,1679946569.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:49:29.825Z,1679946569.825 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:49:29.825Z,1679946569.825 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-03-27T19:50:37.299Z,1679946637.299 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T19:45:37.1Z
2023-03-27T19:50:37.299Z,1679946637.299 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T19:50:37.299Z,1679946637.299 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T19:50:47.802Z,1679946647.802 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0031.lzma
2023-03-27T19:50:48.804Z,1679946648.804 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0031.lzma.bak
2023-03-27T19:50:48.804Z,1679946648.804 [DataOverHttps](INFO): SBD MOMSN=17686935
2023-03-27T19:51:04.138Z,1679946664.138 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230327T180650/Express0032.lzma
2023-03-27T19:51:05.140Z,1679946665.140 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0032.lzma.bak
2023-03-27T19:51:05.141Z,1679946665.141 [DataOverHttps](INFO): SBD MOMSN=17686937
2023-03-27T19:51:06.422Z,1679946666.422 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T19:51:06.422Z,1679946666.422 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T19:51:06.422Z,1679946666.422 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T19:52:05.832Z,1679946725.832 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T19:52:05.832Z,1679946725.832 [DropWeight] No Fault, FailCount= 1
2023-03-27T19:52:30.437Z,1679946750.437 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-03-27T19:52:30.437Z,1679946750.437 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:52:30.447Z,1679946750.447 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:52:30.857Z,1679946750.857 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:52:30.857Z,1679946750.857 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-03-27T19:55:31.423Z,1679946931.423 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-03-27T19:55:31.423Z,1679946931.423 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:55:31.433Z,1679946931.433 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:55:31.842Z,1679946931.842 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:55:31.842Z,1679946931.842 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-03-27T19:55:42.725Z,1679946942.725 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T19:55:42.725Z,1679946942.725 [NAL9602] Data Fault, FailCount= 5
2023-03-27T19:55:42.725Z,1679946942.725 [NAL9602](ERROR): Data Fault
2023-03-27T19:55:42.781Z,1679946942.781 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T19:55:42.781Z,1679946942.781 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-03-27T19:55:43.132Z,1679946943.132 [NAL9602](INFO): Powering down
2023-03-27T19:55:43.165Z,1679946943.165 [CBIT](INFO): Critical error at 20230327T195542
2023-03-27T19:56:06.976Z,1679946966.976 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T19:56:06.976Z,1679946966.976 [Default:CheckIn:C.Wait] Stopped
2023-03-27T19:56:06.976Z,1679946966.976 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T19:56:06.977Z,1679946966.977 [Default:CheckIn:D] Running Loop=1
2023-03-27T19:56:07.389Z,1679946967.389 [Default:CheckIn:D] Stopped
2023-03-27T19:56:07.389Z,1679946967.389 [Default:CheckIn:E] Running Loop=1
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.901864 min 
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn:E] Stopped
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn] Stopped
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn](INFO): Running loop #11
2023-03-27T19:56:07.777Z,1679946967.777 [Default:CheckIn] Running Loop=11
2023-03-27T19:56:07.778Z,1679946967.778 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T19:56:07.778Z,1679946967.778 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T19:57:42.763Z,1679947062.763 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T19:57:42.763Z,1679947062.763 [NAL9602] No Fault, FailCount= 5
2023-03-27T19:57:43.116Z,1679947063.116 [NAL9602](INFO): Powering up NAL9602
2023-03-27T19:57:54.024Z,1679947074.024 [NAL9602](INFO): NAL9602 initialized
2023-03-27T19:58:32.437Z,1679947112.437 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-03-27T19:58:32.437Z,1679947112.437 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T19:58:32.467Z,1679947112.467 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T19:58:32.833Z,1679947112.833 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T19:58:32.833Z,1679947112.833 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-03-27T20:01:07.957Z,1679947267.957 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T19:56:07.8Z
2023-03-27T20:01:07.957Z,1679947267.957 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T20:01:07.957Z,1679947267.957 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T20:01:14.978Z,1679947274.978 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20230327T180650/Courier0034.lzma
2023-03-27T20:01:15.980Z,1679947275.980 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0034.lzma.bak
2023-03-27T20:01:15.980Z,1679947275.980 [DataOverHttps](INFO): SBD MOMSN=17687287
2023-03-27T20:01:31.342Z,1679947291.342 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230327T180650/Express0035.lzma
2023-03-27T20:01:32.345Z,1679947292.345 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0035.lzma.bak
2023-03-27T20:01:32.345Z,1679947292.345 [DataOverHttps](INFO): SBD MOMSN=17687290
2023-03-27T20:01:33.437Z,1679947293.437 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-03-27T20:01:33.437Z,1679947293.437 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:01:33.476Z,1679947293.476 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:01:33.836Z,1679947293.836 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T20:01:33.836Z,1679947293.836 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T20:01:33.836Z,1679947293.836 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T20:01:33.845Z,1679947293.845 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:01:33.845Z,1679947293.845 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-03-27T20:04:34.409Z,1679947474.409 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-03-27T20:04:34.409Z,1679947474.409 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:04:34.445Z,1679947474.445 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:04:34.814Z,1679947474.814 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:04:34.814Z,1679947474.814 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-03-27T20:06:34.385Z,1679947594.385 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T20:06:34.385Z,1679947594.385 [Default:CheckIn:C.Wait] Stopped
2023-03-27T20:06:34.385Z,1679947594.385 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T20:06:34.385Z,1679947594.385 [Default:CheckIn:D] Running Loop=1
2023-03-27T20:06:34.795Z,1679947594.795 [Default:CheckIn:D] Stopped
2023-03-27T20:06:34.796Z,1679947594.796 [Default:CheckIn:E] Running Loop=1
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.358643 min 
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn:E] Stopped
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn] Stopped
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn](INFO): Running loop #12
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn] Running Loop=12
2023-03-27T20:06:35.210Z,1679947595.210 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T20:06:35.211Z,1679947595.211 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T20:07:35.429Z,1679947655.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-03-27T20:07:35.429Z,1679947655.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:07:35.440Z,1679947655.440 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:07:35.817Z,1679947655.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:07:35.817Z,1679947655.817 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-03-27T20:07:55.584Z,1679947675.584 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T20:07:55.584Z,1679947675.584 [NAL9602] Data Fault, FailCount= 1
2023-03-27T20:07:55.585Z,1679947675.585 [NAL9602](ERROR): Data Fault
2023-03-27T20:07:55.601Z,1679947675.601 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T20:07:55.995Z,1679947675.995 [NAL9602](INFO): Powering down
2023-03-27T20:07:56.810Z,1679947676.810 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T20:07:56.810Z,1679947676.810 [NAL9602] No Fault, FailCount= 1
2023-03-27T20:08:26.293Z,1679947706.293 [NAL9602](INFO): Powering up NAL9602
2023-03-27T20:08:37.206Z,1679947717.206 [NAL9602](INFO): NAL9602 initialized
2023-03-27T20:10:36.489Z,1679947836.489 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-03-27T20:10:36.489Z,1679947836.489 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:10:36.542Z,1679947836.542 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:10:36.884Z,1679947836.884 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:10:36.884Z,1679947836.884 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-03-27T20:11:35.525Z,1679947895.525 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T20:06:35.2Z
2023-03-27T20:11:35.525Z,1679947895.525 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T20:11:35.526Z,1679947895.526 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T20:11:42.770Z,1679947902.770 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0037.lzma
2023-03-27T20:11:43.772Z,1679947903.772 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0037.lzma.bak
2023-03-27T20:11:43.773Z,1679947903.773 [DataOverHttps](INFO): SBD MOMSN=17687714
2023-03-27T20:11:59.230Z,1679947919.230 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20230327T180650/Express0038.lzma
2023-03-27T20:12:00.232Z,1679947920.232 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0038.lzma.bak
2023-03-27T20:12:00.233Z,1679947920.233 [DataOverHttps](INFO): SBD MOMSN=17687716
2023-03-27T20:12:01.806Z,1679947921.806 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T20:12:01.806Z,1679947921.806 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T20:12:01.806Z,1679947921.806 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T20:13:37.534Z,1679948017.534 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2023-03-27T20:13:37.534Z,1679948017.534 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:13:37.545Z,1679948017.545 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:13:37.966Z,1679948017.966 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:13:37.966Z,1679948017.966 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2023-03-27T20:16:38.537Z,1679948198.537 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2023-03-27T20:16:38.537Z,1679948198.537 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:16:38.580Z,1679948198.580 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:16:38.947Z,1679948198.947 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:16:38.947Z,1679948198.947 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2023-03-27T20:17:02.354Z,1679948222.354 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T20:17:02.354Z,1679948222.354 [Default:CheckIn:C.Wait] Stopped
2023-03-27T20:17:02.355Z,1679948222.355 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T20:17:02.355Z,1679948222.355 [Default:CheckIn:D] Running Loop=1
2023-03-27T20:17:02.782Z,1679948222.782 [Default:CheckIn:D] Stopped
2023-03-27T20:17:02.782Z,1679948222.782 [Default:CheckIn:E] Running Loop=1
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 125.825081 min 
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn:E] Stopped
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn] Stopped
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn](INFO): Running loop #13
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn] Running Loop=13
2023-03-27T20:17:03.187Z,1679948223.187 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T20:17:03.188Z,1679948223.188 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T20:18:38.096Z,1679948318.096 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T20:18:38.096Z,1679948318.096 [NAL9602] Data Fault, FailCount= 2
2023-03-27T20:18:38.096Z,1679948318.096 [NAL9602](ERROR): Data Fault
2023-03-27T20:18:38.180Z,1679948318.180 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T20:18:38.505Z,1679948318.505 [NAL9602](INFO): Powering down
2023-03-27T20:18:39.368Z,1679948319.368 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T20:18:39.368Z,1679948319.368 [NAL9602] No Fault, FailCount= 2
2023-03-27T20:19:08.800Z,1679948348.800 [NAL9602](INFO): Powering up NAL9602
2023-03-27T20:19:19.714Z,1679948359.714 [NAL9602](INFO): NAL9602 initialized
2023-03-27T20:19:39.524Z,1679948379.524 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2023-03-27T20:19:39.524Z,1679948379.524 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:19:39.556Z,1679948379.556 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:19:39.964Z,1679948379.964 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:19:39.964Z,1679948379.964 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2023-03-27T20:22:03.406Z,1679948523.406 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T20:17:03.2Z
2023-03-27T20:22:03.406Z,1679948523.406 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T20:22:03.406Z,1679948523.406 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T20:22:07.004Z,1679948527.004 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T20:22:07.004Z,1679948527.004 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T20:22:07.004Z,1679948527.004 [DropWeight](ERROR): Hardware Fault
2023-03-27T20:22:07.061Z,1679948527.061 [CBIT](INFO): Critical error at 20230327T202207
2023-03-27T20:22:07.072Z,1679948527.072 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T20:22:07.072Z,1679948527.072 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T20:22:07.451Z,1679948527.451 [CBIT](INFO): Critical error at 20230327T202207
2023-03-27T20:22:10.522Z,1679948530.522 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20230327T180650/Courier0040.lzma
2023-03-27T20:22:11.524Z,1679948531.524 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0040.lzma.bak
2023-03-27T20:22:11.524Z,1679948531.524 [DataOverHttps](INFO): SBD MOMSN=17688165
2023-03-27T20:22:26.906Z,1679948546.906 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230327T180650/Express0041.lzma
2023-03-27T20:22:27.908Z,1679948547.908 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0041.lzma.bak
2023-03-27T20:22:27.909Z,1679948547.909 [DataOverHttps](INFO): SBD MOMSN=17688167
2023-03-27T20:22:29.249Z,1679948549.249 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T20:22:29.250Z,1679948549.250 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T20:22:29.250Z,1679948549.250 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T20:22:40.547Z,1679948560.547 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2023-03-27T20:22:40.547Z,1679948560.547 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:22:40.558Z,1679948560.558 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:22:40.558Z,1679948560.558 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:26:55.859Z,1679948815.859 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:27:11.211Z,1679948831.211 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:27:26.563Z,1679948846.563 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:27:29.825Z,1679948849.825 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T20:27:29.825Z,1679948849.825 [Default:CheckIn:C.Wait] Stopped
2023-03-27T20:27:29.825Z,1679948849.825 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T20:27:29.825Z,1679948849.825 [Default:CheckIn:D] Running Loop=1
2023-03-27T20:27:30.215Z,1679948850.215 [Default:CheckIn:D] Stopped
2023-03-27T20:27:30.216Z,1679948850.216 [Default:CheckIn:E] Running Loop=1
2023-03-27T20:27:30.634Z,1679948850.634 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 136.282308 min 
2023-03-27T20:27:30.634Z,1679948850.634 [Default:CheckIn:E] Stopped
2023-03-27T20:27:30.634Z,1679948850.634 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T20:27:30.634Z,1679948850.634 [Default:CheckIn] Stopped
2023-03-27T20:27:30.634Z,1679948850.634 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T20:27:30.635Z,1679948850.635 [Default:CheckIn](INFO): Running loop #14
2023-03-27T20:27:30.635Z,1679948850.635 [Default:CheckIn] Running Loop=14
2023-03-27T20:27:30.635Z,1679948850.635 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T20:27:30.635Z,1679948850.635 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T20:27:41.915Z,1679948861.915 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:27:56.863Z,1679948876.863 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:28:12.215Z,1679948892.215 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:28:27.569Z,1679948907.569 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:28:42.515Z,1679948922.515 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:28:57.463Z,1679948937.463 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T20:29:12.413Z,1679948952.413 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-03-27T20:29:21.304Z,1679948961.304 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T20:29:21.304Z,1679948961.304 [NAL9602] Data Fault, FailCount= 3
2023-03-27T20:29:21.304Z,1679948961.304 [NAL9602](ERROR): Data Fault
2023-03-27T20:29:21.346Z,1679948961.346 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T20:29:21.712Z,1679948961.712 [NAL9602](INFO): Powering down
2023-03-27T20:29:22.538Z,1679948962.538 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T20:29:22.538Z,1679948962.538 [NAL9602] No Fault, FailCount= 3
2023-03-27T20:29:25.752Z,1679948965.752 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 5.
2023-03-27T20:29:25.755Z,1679948965.755 [BPC1](INFO): Received data from all battery sticks.
2023-03-27T20:29:52.012Z,1679948992.012 [NAL9602](INFO): Powering up NAL9602
2023-03-27T20:30:02.923Z,1679949002.923 [NAL9602](INFO): NAL9602 initialized
2023-03-27T20:32:30.806Z,1679949150.806 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T20:27:30.6Z
2023-03-27T20:32:30.806Z,1679949150.806 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T20:32:30.806Z,1679949150.806 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T20:32:38.078Z,1679949158.078 [DataOverHttps](INFO): Sending 126 bytes from file Logs/20230327T180650/Courier0043.lzma
2023-03-27T20:32:39.080Z,1679949159.080 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0043.lzma.bak
2023-03-27T20:32:39.081Z,1679949159.081 [DataOverHttps](INFO): SBD MOMSN=17688541
2023-03-27T20:32:54.358Z,1679949174.358 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20230327T180650/Express0044.lzma
2023-03-27T20:32:55.361Z,1679949175.361 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0044.lzma.bak
2023-03-27T20:32:55.361Z,1679949175.361 [DataOverHttps](INFO): SBD MOMSN=17688545
2023-03-27T20:32:57.048Z,1679949177.048 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T20:32:57.048Z,1679949177.048 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T20:32:57.049Z,1679949177.049 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T20:37:07.133Z,1679949427.133 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T20:37:07.134Z,1679949427.134 [DropWeight] No Fault, FailCount= 1
2023-03-27T20:37:40.679Z,1679949460.679 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:37:40.679Z,1679949460.679 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2023-03-27T20:37:57.647Z,1679949477.647 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T20:37:57.647Z,1679949477.647 [Default:CheckIn:C.Wait] Stopped
2023-03-27T20:37:57.647Z,1679949477.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T20:37:57.647Z,1679949477.647 [Default:CheckIn:D] Running Loop=1
2023-03-27T20:37:58.034Z,1679949478.034 [Default:CheckIn:D] Stopped
2023-03-27T20:37:58.034Z,1679949478.034 [Default:CheckIn:E] Running Loop=1
2023-03-27T20:37:58.437Z,1679949478.437 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 146.745947 min 
2023-03-27T20:37:58.437Z,1679949478.437 [Default:CheckIn:E] Stopped
2023-03-27T20:37:58.437Z,1679949478.437 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T20:37:58.438Z,1679949478.438 [Default:CheckIn] Stopped
2023-03-27T20:37:58.438Z,1679949478.438 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T20:37:58.438Z,1679949478.438 [Default:CheckIn](INFO): Running loop #15
2023-03-27T20:37:58.438Z,1679949478.438 [Default:CheckIn] Running Loop=15
2023-03-27T20:37:58.438Z,1679949478.438 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T20:37:58.438Z,1679949478.438 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T20:40:04.880Z,1679949604.880 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T20:40:04.880Z,1679949604.880 [NAL9602] Data Fault, FailCount= 4
2023-03-27T20:40:04.880Z,1679949604.880 [NAL9602](ERROR): Data Fault
2023-03-27T20:40:04.948Z,1679949604.948 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T20:40:05.280Z,1679949605.280 [NAL9602](INFO): Powering down
2023-03-27T20:40:06.118Z,1679949606.118 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T20:40:06.118Z,1679949606.118 [NAL9602] No Fault, FailCount= 4
2023-03-27T20:40:35.613Z,1679949635.613 [NAL9602](INFO): Powering up NAL9602
2023-03-27T20:40:41.323Z,1679949641.323 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-27T20:40:41.324Z,1679949641.324 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:40:41.334Z,1679949641.334 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:40:41.717Z,1679949641.717 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:40:41.718Z,1679949641.718 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-27T20:40:46.540Z,1679949646.540 [NAL9602](INFO): NAL9602 initialized
2023-03-27T20:42:58.678Z,1679949778.678 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T20:37:58.4Z
2023-03-27T20:42:58.678Z,1679949778.678 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T20:42:58.678Z,1679949778.678 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T20:43:05.598Z,1679949785.598 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0046.lzma
2023-03-27T20:43:06.737Z,1679949786.737 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0046.lzma.bak
2023-03-27T20:43:06.737Z,1679949786.737 [DataOverHttps](INFO): SBD MOMSN=17688894
2023-03-27T20:43:22.054Z,1679949802.054 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0047.lzma
2023-03-27T20:43:23.057Z,1679949803.057 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0047.lzma.bak
2023-03-27T20:43:23.057Z,1679949803.057 [DataOverHttps](INFO): SBD MOMSN=17688896
2023-03-27T20:43:24.537Z,1679949804.537 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T20:43:24.537Z,1679949804.537 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T20:43:24.537Z,1679949804.537 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T20:43:42.294Z,1679949822.294 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-27T20:43:42.294Z,1679949822.294 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:43:42.305Z,1679949822.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:43:42.714Z,1679949822.714 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:43:42.714Z,1679949822.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-27T20:46:43.280Z,1679950003.280 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-03-27T20:46:43.280Z,1679950003.280 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:46:43.307Z,1679950003.307 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:46:43.693Z,1679950003.693 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:46:43.693Z,1679950003.693 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-03-27T20:48:25.114Z,1679950105.114 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T20:48:25.114Z,1679950105.114 [Default:CheckIn:C.Wait] Stopped
2023-03-27T20:48:25.114Z,1679950105.114 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T20:48:25.114Z,1679950105.114 [Default:CheckIn:D] Running Loop=1
2023-03-27T20:48:25.502Z,1679950105.502 [Default:CheckIn:D] Stopped
2023-03-27T20:48:25.502Z,1679950105.502 [Default:CheckIn:E] Running Loop=1
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 157.203760 min 
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn:E] Stopped
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn] Stopped
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn](INFO): Running loop #16
2023-03-27T20:48:25.903Z,1679950105.903 [Default:CheckIn] Running Loop=16
2023-03-27T20:48:25.904Z,1679950105.904 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T20:48:25.904Z,1679950105.904 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T20:49:44.285Z,1679950184.285 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-03-27T20:49:44.285Z,1679950184.285 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:49:44.295Z,1679950184.295 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:49:44.713Z,1679950184.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:49:44.714Z,1679950184.714 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-03-27T20:50:48.132Z,1679950248.132 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T20:50:48.132Z,1679950248.132 [NAL9602] Data Fault, FailCount= 5
2023-03-27T20:50:48.133Z,1679950248.133 [NAL9602](ERROR): Data Fault
2023-03-27T20:50:48.151Z,1679950248.151 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T20:50:48.151Z,1679950248.151 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-03-27T20:50:48.542Z,1679950248.542 [NAL9602](INFO): Powering down
2023-03-27T20:50:48.558Z,1679950248.558 [CBIT](INFO): Critical error at 20230327T205048
2023-03-27T20:52:45.306Z,1679950365.306 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-03-27T20:52:45.306Z,1679950365.306 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:52:45.335Z,1679950365.335 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:52:45.713Z,1679950365.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:52:45.713Z,1679950365.713 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-03-27T20:52:48.145Z,1679950368.145 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T20:52:48.145Z,1679950368.145 [NAL9602] No Fault, FailCount= 5
2023-03-27T20:52:48.521Z,1679950368.521 [NAL9602](INFO): Powering up NAL9602
2023-03-27T20:52:59.434Z,1679950379.434 [NAL9602](INFO): NAL9602 initialized
2023-03-27T20:53:26.122Z,1679950406.122 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T20:48:25.9Z
2023-03-27T20:53:26.122Z,1679950406.122 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T20:53:26.122Z,1679950406.122 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T20:53:32.930Z,1679950412.930 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20230327T180650/Courier0049.lzma
2023-03-27T20:53:33.932Z,1679950413.932 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0049.lzma.bak
2023-03-27T20:53:33.933Z,1679950413.933 [DataOverHttps](INFO): SBD MOMSN=17689276
2023-03-27T20:53:49.262Z,1679950429.262 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0050.lzma
2023-03-27T20:53:50.264Z,1679950430.264 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0050.lzma.bak
2023-03-27T20:53:50.265Z,1679950430.265 [DataOverHttps](INFO): SBD MOMSN=17689279
2023-03-27T20:53:51.560Z,1679950431.560 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T20:53:51.560Z,1679950431.560 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T20:53:51.561Z,1679950431.561 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T20:55:46.313Z,1679950546.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-03-27T20:55:46.313Z,1679950546.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:55:46.323Z,1679950546.323 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:55:46.725Z,1679950546.725 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:55:46.725Z,1679950546.725 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-03-27T20:58:47.304Z,1679950727.304 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-03-27T20:58:47.304Z,1679950727.304 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T20:58:47.315Z,1679950727.315 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T20:58:47.729Z,1679950727.729 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T20:58:47.729Z,1679950727.729 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-03-27T20:58:52.138Z,1679950732.138 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T20:58:52.138Z,1679950732.138 [Default:CheckIn:C.Wait] Stopped
2023-03-27T20:58:52.138Z,1679950732.138 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T20:58:52.138Z,1679950732.138 [Default:CheckIn:D] Running Loop=1
2023-03-27T20:58:52.537Z,1679950732.537 [Default:CheckIn:D] Stopped
2023-03-27T20:58:52.538Z,1679950732.538 [Default:CheckIn:E] Running Loop=1
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 167.654346 min 
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn:E] Stopped
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn] Stopped
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn](INFO): Running loop #17
2023-03-27T20:58:52.941Z,1679950732.941 [Default:CheckIn] Running Loop=17
2023-03-27T20:58:52.942Z,1679950732.942 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T20:58:52.942Z,1679950732.942 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T21:01:48.310Z,1679950908.310 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-03-27T21:01:48.310Z,1679950908.310 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:01:48.321Z,1679950908.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:01:48.711Z,1679950908.711 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:01:48.711Z,1679950908.711 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-03-27T21:03:01.392Z,1679950981.392 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T21:03:01.393Z,1679950981.393 [NAL9602] Data Fault, FailCount= 1
2023-03-27T21:03:01.393Z,1679950981.393 [NAL9602](ERROR): Data Fault
2023-03-27T21:03:01.471Z,1679950981.471 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T21:03:01.792Z,1679950981.792 [NAL9602](INFO): Powering down
2023-03-27T21:03:02.629Z,1679950982.629 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T21:03:02.629Z,1679950982.629 [NAL9602] No Fault, FailCount= 1
2023-03-27T21:03:32.092Z,1679951012.092 [NAL9602](INFO): Powering up NAL9602
2023-03-27T21:03:43.004Z,1679951023.004 [NAL9602](INFO): NAL9602 initialized
2023-03-27T21:03:53.119Z,1679951033.119 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T20:58:52.9Z
2023-03-27T21:03:53.119Z,1679951033.119 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T21:03:53.119Z,1679951033.119 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T21:03:59.814Z,1679951039.814 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0052.lzma
2023-03-27T21:04:00.817Z,1679951040.817 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0052.lzma.bak
2023-03-27T21:04:00.817Z,1679951040.817 [DataOverHttps](INFO): SBD MOMSN=17689647
2023-03-27T21:04:16.226Z,1679951056.226 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0053.lzma
2023-03-27T21:04:17.228Z,1679951057.228 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0053.lzma.bak
2023-03-27T21:04:17.229Z,1679951057.229 [DataOverHttps](INFO): SBD MOMSN=17689649
2023-03-27T21:04:18.582Z,1679951058.582 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T21:04:18.582Z,1679951058.582 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T21:04:18.582Z,1679951058.582 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T21:04:49.268Z,1679951089.268 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-03-27T21:04:49.268Z,1679951089.268 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:04:49.303Z,1679951089.303 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:04:49.709Z,1679951089.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:04:49.709Z,1679951089.709 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-03-27T21:07:08.640Z,1679951228.640 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T21:07:08.640Z,1679951228.640 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T21:07:08.640Z,1679951228.640 [DropWeight](ERROR): Hardware Fault
2023-03-27T21:07:08.656Z,1679951228.656 [CBIT](INFO): Critical error at 20230327T210708
2023-03-27T21:07:08.659Z,1679951228.659 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T21:07:08.659Z,1679951228.659 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T21:07:09.063Z,1679951229.063 [CBIT](INFO): Critical error at 20230327T210708
2023-03-27T21:07:50.285Z,1679951270.285 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-03-27T21:07:50.285Z,1679951270.285 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:07:50.295Z,1679951270.295 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:07:50.679Z,1679951270.679 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:07:50.679Z,1679951270.679 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-03-27T21:09:19.175Z,1679951359.175 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T21:09:19.176Z,1679951359.176 [Default:CheckIn:C.Wait] Stopped
2023-03-27T21:09:19.176Z,1679951359.176 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T21:09:19.176Z,1679951359.176 [Default:CheckIn:D] Running Loop=1
2023-03-27T21:09:19.566Z,1679951359.566 [Default:CheckIn:D] Stopped
2023-03-27T21:09:19.566Z,1679951359.566 [Default:CheckIn:E] Running Loop=1
2023-03-27T21:09:19.959Z,1679951359.959 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 178.104818 min 
2023-03-27T21:09:19.959Z,1679951359.959 [Default:CheckIn:E] Stopped
2023-03-27T21:09:19.959Z,1679951359.959 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T21:09:19.960Z,1679951359.960 [Default:CheckIn] Stopped
2023-03-27T21:09:19.960Z,1679951359.960 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T21:09:19.960Z,1679951359.960 [Default:CheckIn](INFO): Running loop #18
2023-03-27T21:09:19.960Z,1679951359.960 [Default:CheckIn] Running Loop=18
2023-03-27T21:09:19.960Z,1679951359.960 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T21:09:19.960Z,1679951359.960 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T21:10:51.261Z,1679951451.261 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-03-27T21:10:51.261Z,1679951451.261 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:10:51.271Z,1679951451.271 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:10:51.690Z,1679951451.690 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:10:51.690Z,1679951451.690 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-03-27T21:13:44.567Z,1679951624.567 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T21:13:44.567Z,1679951624.567 [NAL9602] Data Fault, FailCount= 2
2023-03-27T21:13:44.567Z,1679951624.567 [NAL9602](ERROR): Data Fault
2023-03-27T21:13:44.584Z,1679951624.584 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T21:13:44.960Z,1679951624.960 [NAL9602](INFO): Powering down
2023-03-27T21:13:45.782Z,1679951625.782 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T21:13:45.782Z,1679951625.782 [NAL9602] No Fault, FailCount= 2
2023-03-27T21:13:52.243Z,1679951632.243 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-03-27T21:13:52.243Z,1679951632.243 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:13:52.253Z,1679951632.253 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:13:52.661Z,1679951632.661 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:13:52.661Z,1679951632.661 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-03-27T21:14:15.260Z,1679951655.260 [NAL9602](INFO): Powering up NAL9602
2023-03-27T21:14:20.133Z,1679951660.133 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T21:09:19.0Z
2023-03-27T21:14:20.133Z,1679951660.133 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T21:14:20.133Z,1679951660.133 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T21:14:26.174Z,1679951666.174 [NAL9602](INFO): NAL9602 initialized
2023-03-27T21:14:26.712Z,1679951666.712 [DataOverHttps](INFO): Sending 116 bytes from file Logs/20230327T180650/Courier0055.lzma
2023-03-27T21:14:27.432Z,1679951667.432 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0055.lzma.bak
2023-03-27T21:14:27.433Z,1679951667.433 [DataOverHttps](INFO): SBD MOMSN=17690012
2023-03-27T21:14:42.826Z,1679951682.826 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0056.lzma
2023-03-27T21:14:43.828Z,1679951683.828 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0056.lzma.bak
2023-03-27T21:14:43.829Z,1679951683.829 [DataOverHttps](INFO): SBD MOMSN=17690016
2023-03-27T21:14:45.182Z,1679951685.182 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T21:14:45.182Z,1679951685.182 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T21:14:45.182Z,1679951685.182 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T21:16:53.237Z,1679951813.237 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-03-27T21:16:53.237Z,1679951813.237 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:16:53.248Z,1679951813.248 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:16:53.650Z,1679951813.650 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:16:53.652Z,1679951813.652 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-03-27T21:19:45.737Z,1679951985.737 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T21:19:45.737Z,1679951985.737 [Default:CheckIn:C.Wait] Stopped
2023-03-27T21:19:45.737Z,1679951985.737 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T21:19:45.737Z,1679951985.737 [Default:CheckIn:D] Running Loop=1
2023-03-27T21:19:46.150Z,1679951986.150 [Default:CheckIn:D] Stopped
2023-03-27T21:19:46.150Z,1679951986.150 [Default:CheckIn:E] Running Loop=1
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 188.547884 min 
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn:E] Stopped
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn] Stopped
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn](INFO): Running loop #19
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn] Running Loop=19
2023-03-27T21:19:46.554Z,1679951986.554 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T21:19:46.555Z,1679951986.555 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T21:19:54.220Z,1679951994.220 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-03-27T21:19:54.220Z,1679951994.220 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:19:54.231Z,1679951994.231 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:19:54.642Z,1679951994.642 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:19:54.642Z,1679951994.642 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-03-27T21:22:08.852Z,1679952128.852 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T21:22:08.852Z,1679952128.852 [DropWeight] No Fault, FailCount= 1
2023-03-27T21:22:55.284Z,1679952175.284 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-03-27T21:22:55.284Z,1679952175.284 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:22:55.295Z,1679952175.295 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:22:55.702Z,1679952175.702 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:22:55.702Z,1679952175.702 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-03-27T21:24:27.792Z,1679952267.792 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T21:24:27.792Z,1679952267.792 [NAL9602] Data Fault, FailCount= 3
2023-03-27T21:24:27.792Z,1679952267.792 [NAL9602](ERROR): Data Fault
2023-03-27T21:24:27.827Z,1679952267.827 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T21:24:28.189Z,1679952268.189 [NAL9602](INFO): Powering down
2023-03-27T21:24:29.024Z,1679952269.024 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T21:24:29.025Z,1679952269.025 [NAL9602] No Fault, FailCount= 3
2023-03-27T21:24:46.788Z,1679952286.788 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T21:19:46.6Z
2023-03-27T21:24:46.788Z,1679952286.788 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T21:24:46.789Z,1679952286.789 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T21:24:53.750Z,1679952293.750 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0058.lzma
2023-03-27T21:24:54.752Z,1679952294.752 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0058.lzma.bak
2023-03-27T21:24:54.753Z,1679952294.753 [DataOverHttps](INFO): SBD MOMSN=17690057
2023-03-27T21:24:58.497Z,1679952298.497 [NAL9602](INFO): Powering up NAL9602
2023-03-27T21:25:09.404Z,1679952309.404 [NAL9602](INFO): NAL9602 initialized
2023-03-27T21:25:09.958Z,1679952309.958 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0059.lzma
2023-03-27T21:25:10.961Z,1679952310.961 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0059.lzma.bak
2023-03-27T21:25:10.961Z,1679952310.961 [DataOverHttps](INFO): SBD MOMSN=17690059
2023-03-27T21:25:12.246Z,1679952312.246 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T21:25:12.246Z,1679952312.246 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T21:25:12.246Z,1679952312.246 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T21:25:56.283Z,1679952356.283 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-03-27T21:25:56.283Z,1679952356.283 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:25:56.294Z,1679952356.294 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:25:56.709Z,1679952356.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:25:56.709Z,1679952356.709 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-03-27T21:28:57.288Z,1679952537.288 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2023-03-27T21:28:57.288Z,1679952537.288 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:28:57.299Z,1679952537.299 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:28:57.681Z,1679952537.681 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:28:57.681Z,1679952537.681 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2023-03-27T21:30:12.838Z,1679952612.838 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T21:30:12.838Z,1679952612.838 [Default:CheckIn:C.Wait] Stopped
2023-03-27T21:30:12.838Z,1679952612.838 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T21:30:12.838Z,1679952612.838 [Default:CheckIn:D] Running Loop=1
2023-03-27T21:30:13.224Z,1679952613.224 [Default:CheckIn:D] Stopped
2023-03-27T21:30:13.224Z,1679952613.224 [Default:CheckIn:E] Running Loop=1
2023-03-27T21:30:13.624Z,1679952613.624 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 198.999121 min 
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn:E] Stopped
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn] Stopped
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn](INFO): Running loop #20
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn] Running Loop=20
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T21:30:13.625Z,1679952613.625 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T21:31:58.274Z,1679952718.274 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2023-03-27T21:31:58.274Z,1679952718.274 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:31:58.285Z,1679952718.285 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:31:58.696Z,1679952718.696 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:31:58.697Z,1679952718.697 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2023-03-27T21:34:22.887Z,1679952862.887 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:34:38.643Z,1679952878.643 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:34:53.996Z,1679952893.996 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:34:59.270Z,1679952899.270 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2023-03-27T21:34:59.270Z,1679952899.270 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:34:59.280Z,1679952899.280 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:34:59.696Z,1679952899.696 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:34:59.696Z,1679952899.696 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2023-03-27T21:35:10.155Z,1679952910.155 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:35:12.184Z,1679952912.184 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T21:35:12.184Z,1679952912.184 [NAL9602] Data Fault, FailCount= 4
2023-03-27T21:35:12.184Z,1679952912.184 [NAL9602](ERROR): Data Fault
2023-03-27T21:35:12.202Z,1679952912.202 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T21:35:12.589Z,1679952912.589 [NAL9602](INFO): Powering down
2023-03-27T21:35:13.427Z,1679952913.427 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T21:35:13.427Z,1679952913.427 [NAL9602] No Fault, FailCount= 4
2023-03-27T21:35:13.805Z,1679952913.805 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T21:30:13.6Z
2023-03-27T21:35:13.805Z,1679952913.805 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T21:35:13.805Z,1679952913.805 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T21:35:21.390Z,1679952921.390 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0061.lzma
2023-03-27T21:35:22.392Z,1679952922.392 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0061.lzma.bak
2023-03-27T21:35:22.393Z,1679952922.393 [DataOverHttps](INFO): SBD MOMSN=17690402
2023-03-27T21:35:25.508Z,1679952925.508 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:35:37.778Z,1679952937.778 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20230327T180650/Express0062.lzma
2023-03-27T21:35:38.781Z,1679952938.781 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0062.lzma.bak
2023-03-27T21:35:38.781Z,1679952938.781 [DataOverHttps](INFO): SBD MOMSN=17690405
2023-03-27T21:35:40.081Z,1679952940.081 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T21:35:40.081Z,1679952940.081 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T21:35:40.082Z,1679952940.082 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T21:35:40.859Z,1679952940.859 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:35:42.888Z,1679952942.888 [NAL9602](INFO): Powering up NAL9602
2023-03-27T21:35:53.797Z,1679952953.797 [NAL9602](INFO): NAL9602 initialized
2023-03-27T21:35:55.407Z,1679952955.407 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:36:10.351Z,1679952970.351 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:36:25.299Z,1679952985.299 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T21:36:39.440Z,1679952999.440 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-03-27T21:36:53.187Z,1679953013.187 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 5.
2023-03-27T21:36:53.190Z,1679953013.190 [BPC1](INFO): Received data from all battery sticks.
2023-03-27T21:38:00.248Z,1679953080.248 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2023-03-27T21:38:00.248Z,1679953080.248 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:38:00.281Z,1679953080.281 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:38:00.281Z,1679953080.281 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:40:40.657Z,1679953240.657 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T21:40:40.657Z,1679953240.657 [Default:CheckIn:C.Wait] Stopped
2023-03-27T21:40:40.657Z,1679953240.657 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T21:40:40.657Z,1679953240.657 [Default:CheckIn:D] Running Loop=1
2023-03-27T21:40:41.061Z,1679953241.061 [Default:CheckIn:D] Stopped
2023-03-27T21:40:41.061Z,1679953241.061 [Default:CheckIn:E] Running Loop=1
2023-03-27T21:40:41.470Z,1679953241.470 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 209.463070 min 
2023-03-27T21:40:41.470Z,1679953241.470 [Default:CheckIn:E] Stopped
2023-03-27T21:40:41.470Z,1679953241.470 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T21:40:41.470Z,1679953241.470 [Default:CheckIn] Stopped
2023-03-27T21:40:41.470Z,1679953241.470 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T21:40:41.471Z,1679953241.471 [Default:CheckIn](INFO): Running loop #21
2023-03-27T21:40:41.471Z,1679953241.471 [Default:CheckIn] Running Loop=21
2023-03-27T21:40:41.471Z,1679953241.471 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T21:40:41.471Z,1679953241.471 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T21:45:41.666Z,1679953541.666 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T21:40:41.5Z
2023-03-27T21:45:41.666Z,1679953541.666 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T21:45:41.666Z,1679953541.666 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T21:45:48.494Z,1679953548.494 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20230327T180650/Courier0064.lzma
2023-03-27T21:45:49.497Z,1679953549.497 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0064.lzma.bak
2023-03-27T21:45:49.497Z,1679953549.497 [DataOverHttps](INFO): SBD MOMSN=17690769
2023-03-27T21:45:55.380Z,1679953555.380 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T21:45:55.381Z,1679953555.381 [NAL9602] Data Fault, FailCount= 5
2023-03-27T21:45:55.381Z,1679953555.381 [NAL9602](ERROR): Data Fault
2023-03-27T21:45:55.442Z,1679953555.442 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T21:45:55.442Z,1679953555.442 [CBIT](CRITICAL): Data Fault in component: NAL9602
2023-03-27T21:45:55.788Z,1679953555.788 [NAL9602](INFO): Powering down
2023-03-27T21:45:55.827Z,1679953555.827 [CBIT](INFO): Critical error at 20230327T214555
2023-03-27T21:46:04.822Z,1679953564.822 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20230327T180650/Express0065.lzma
2023-03-27T21:46:05.824Z,1679953565.824 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0065.lzma.bak
2023-03-27T21:46:05.825Z,1679953565.825 [DataOverHttps](INFO): SBD MOMSN=17690772
2023-03-27T21:46:07.120Z,1679953567.120 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T21:46:07.120Z,1679953567.120 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T21:46:07.121Z,1679953567.121 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T21:47:55.397Z,1679953675.397 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T21:47:55.397Z,1679953675.397 [NAL9602] No Fault, FailCount= 5
2023-03-27T21:47:55.793Z,1679953675.793 [NAL9602](INFO): Powering up NAL9602
2023-03-27T21:48:06.701Z,1679953686.701 [NAL9602](INFO): NAL9602 initialized
2023-03-27T21:51:07.725Z,1679953867.725 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T21:51:07.725Z,1679953867.725 [Default:CheckIn:C.Wait] Stopped
2023-03-27T21:51:07.725Z,1679953867.725 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T21:51:07.725Z,1679953867.725 [Default:CheckIn:D] Running Loop=1
2023-03-27T21:51:08.121Z,1679953868.121 [Default:CheckIn:D] Stopped
2023-03-27T21:51:08.121Z,1679953868.121 [Default:CheckIn:E] Running Loop=1
2023-03-27T21:51:08.552Z,1679953868.552 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 219.914062 min 
2023-03-27T21:51:08.552Z,1679953868.552 [Default:CheckIn:E] Stopped
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn] Stopped
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn](INFO): Running loop #22
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn] Running Loop=22
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T21:51:08.553Z,1679953868.553 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T21:52:10.336Z,1679953930.336 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T21:52:10.336Z,1679953930.336 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T21:52:10.336Z,1679953930.336 [DropWeight](ERROR): Hardware Fault
2023-03-27T21:52:10.371Z,1679953930.371 [CBIT](INFO): Critical error at 20230327T215210
2023-03-27T21:52:10.374Z,1679953930.374 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T21:52:10.375Z,1679953930.375 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T21:52:10.771Z,1679953930.771 [CBIT](INFO): Critical error at 20230327T215210
2023-03-27T21:53:00.470Z,1679953980.470 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:53:00.471Z,1679953980.471 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2023-03-27T21:56:01.031Z,1679954161.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-27T21:56:01.031Z,1679954161.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:56:01.042Z,1679954161.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:56:01.451Z,1679954161.451 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:56:01.451Z,1679954161.451 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-27T21:56:08.718Z,1679954168.718 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T21:51:08.6Z
2023-03-27T21:56:08.718Z,1679954168.718 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T21:56:08.718Z,1679954168.718 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T21:56:16.078Z,1679954176.078 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20230327T180650/Courier0067.lzma
2023-03-27T21:56:17.081Z,1679954177.081 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0067.lzma.bak
2023-03-27T21:56:17.081Z,1679954177.081 [DataOverHttps](INFO): SBD MOMSN=17691136
2023-03-27T21:56:32.398Z,1679954192.398 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0068.lzma
2023-03-27T21:56:33.401Z,1679954193.401 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0068.lzma.bak
2023-03-27T21:56:33.401Z,1679954193.401 [DataOverHttps](INFO): SBD MOMSN=17691141
2023-03-27T21:56:34.985Z,1679954194.985 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T21:56:34.986Z,1679954194.986 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T21:56:34.986Z,1679954194.986 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T21:58:08.280Z,1679954288.280 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T21:58:08.280Z,1679954288.280 [NAL9602] Data Fault, FailCount= 1
2023-03-27T21:58:08.280Z,1679954288.280 [NAL9602](ERROR): Data Fault
2023-03-27T21:58:08.348Z,1679954288.348 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T21:58:08.680Z,1679954288.680 [NAL9602](INFO): Powering down
2023-03-27T21:58:09.539Z,1679954289.539 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T21:58:09.539Z,1679954289.539 [NAL9602] No Fault, FailCount= 1
2023-03-27T21:58:38.980Z,1679954318.980 [NAL9602](INFO): Powering up NAL9602
2023-03-27T21:58:49.889Z,1679954329.889 [NAL9602](INFO): NAL9602 initialized
2023-03-27T21:59:02.021Z,1679954342.021 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-27T21:59:02.021Z,1679954342.021 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T21:59:02.031Z,1679954342.031 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T21:59:02.437Z,1679954342.437 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T21:59:02.437Z,1679954342.437 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-27T22:01:35.558Z,1679954495.558 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:01:35.558Z,1679954495.558 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:01:35.559Z,1679954495.559 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:01:35.559Z,1679954495.559 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:01:35.957Z,1679954495.957 [Default:CheckIn:D] Stopped
2023-03-27T22:01:35.957Z,1679954495.957 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:01:36.393Z,1679954496.393 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 230.377995 min 
2023-03-27T22:01:36.393Z,1679954496.393 [Default:CheckIn:E] Stopped
2023-03-27T22:01:36.393Z,1679954496.393 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:01:36.393Z,1679954496.393 [Default:CheckIn] Stopped
2023-03-27T22:01:36.393Z,1679954496.393 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:01:36.393Z,1679954496.393 [Default:CheckIn](INFO): Running loop #23
2023-03-27T22:01:36.394Z,1679954496.394 [Default:CheckIn] Running Loop=23
2023-03-27T22:01:36.394Z,1679954496.394 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:01:36.394Z,1679954496.394 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:02:03.016Z,1679954523.016 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-03-27T22:02:03.016Z,1679954523.016 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:02:03.027Z,1679954523.027 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:02:03.440Z,1679954523.440 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:02:03.440Z,1679954523.440 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-03-27T22:05:04.003Z,1679954704.003 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-03-27T22:05:04.003Z,1679954704.003 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:05:04.039Z,1679954704.039 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:05:04.417Z,1679954704.417 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:05:04.417Z,1679954704.417 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-03-27T22:06:36.534Z,1679954796.534 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T22:01:36.4Z
2023-03-27T22:06:36.534Z,1679954796.534 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:06:36.535Z,1679954796.535 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:06:43.130Z,1679954803.130 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0070.lzma
2023-03-27T22:06:44.133Z,1679954804.133 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0070.lzma.bak
2023-03-27T22:06:44.133Z,1679954804.133 [DataOverHttps](INFO): SBD MOMSN=17691507
2023-03-27T22:06:59.510Z,1679954819.510 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Express0071.lzma
2023-03-27T22:07:00.513Z,1679954820.513 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0071.lzma.bak
2023-03-27T22:07:00.513Z,1679954820.513 [DataOverHttps](INFO): SBD MOMSN=17691509
2023-03-27T22:07:02.005Z,1679954822.005 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:07:02.005Z,1679954822.005 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:07:02.005Z,1679954822.005 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:07:10.615Z,1679954830.615 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T22:07:10.615Z,1679954830.615 [DropWeight] No Fault, FailCount= 1
2023-03-27T22:08:05.056Z,1679954885.056 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-03-27T22:08:05.056Z,1679954885.056 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:08:05.075Z,1679954885.075 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:08:05.481Z,1679954885.481 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:08:05.481Z,1679954885.481 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-03-27T22:08:51.076Z,1679954931.076 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T22:08:51.077Z,1679954931.077 [NAL9602] Data Fault, FailCount= 2
2023-03-27T22:08:51.077Z,1679954931.077 [NAL9602](ERROR): Data Fault
2023-03-27T22:08:51.098Z,1679954931.098 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T22:08:51.480Z,1679954931.480 [NAL9602](INFO): Powering down
2023-03-27T22:08:52.313Z,1679954932.313 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T22:08:52.314Z,1679954932.314 [NAL9602] No Fault, FailCount= 2
2023-03-27T22:09:21.780Z,1679954961.780 [NAL9602](INFO): Powering up NAL9602
2023-03-27T22:09:32.685Z,1679954972.685 [NAL9602](INFO): NAL9602 initialized
2023-03-27T22:11:06.019Z,1679955066.019 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-03-27T22:11:06.019Z,1679955066.019 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:11:06.030Z,1679955066.030 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:11:06.485Z,1679955066.485 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:11:06.485Z,1679955066.485 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-03-27T22:12:02.585Z,1679955122.585 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:12:02.585Z,1679955122.585 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:12:02.585Z,1679955122.585 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:12:02.585Z,1679955122.585 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:12:02.994Z,1679955122.994 [Default:CheckIn:D] Stopped
2023-03-27T22:12:02.994Z,1679955122.994 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:12:03.389Z,1679955123.389 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 240.828613 min 
2023-03-27T22:12:03.389Z,1679955123.389 [Default:CheckIn:E] Stopped
2023-03-27T22:12:03.389Z,1679955123.389 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:12:03.389Z,1679955123.389 [Default:CheckIn] Stopped
2023-03-27T22:12:03.389Z,1679955123.389 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:12:03.390Z,1679955123.390 [Default:CheckIn](INFO): Running loop #24
2023-03-27T22:12:03.390Z,1679955123.390 [Default:CheckIn] Running Loop=24
2023-03-27T22:12:03.390Z,1679955123.390 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:12:03.390Z,1679955123.390 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:14:07.011Z,1679955247.011 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-03-27T22:14:07.011Z,1679955247.011 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:14:07.021Z,1679955247.021 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:14:07.431Z,1679955247.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:14:07.431Z,1679955247.431 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-03-27T22:17:03.566Z,1679955423.566 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T22:12:03.4Z
2023-03-27T22:17:03.566Z,1679955423.566 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:17:03.566Z,1679955423.566 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:17:08.036Z,1679955428.036 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-03-27T22:17:08.036Z,1679955428.036 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:17:08.072Z,1679955428.072 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:17:08.457Z,1679955428.457 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:17:08.457Z,1679955428.457 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-03-27T22:17:10.794Z,1679955430.794 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T180650/Courier0073.lzma
2023-03-27T22:17:11.797Z,1679955431.797 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0073.lzma.bak
2023-03-27T22:17:11.797Z,1679955431.797 [DataOverHttps](INFO): SBD MOMSN=17691875
2023-03-27T22:17:27.554Z,1679955447.554 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20230327T180650/Express0074.lzma
2023-03-27T22:17:28.557Z,1679955448.557 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0074.lzma.bak
2023-03-27T22:17:28.557Z,1679955448.557 [DataOverHttps](INFO): SBD MOMSN=17691877
2023-03-27T22:17:29.834Z,1679955449.834 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:17:29.834Z,1679955449.834 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:17:29.834Z,1679955449.834 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:18:56.960Z,1679955536.960 [CommandExec](IMPORTANT): got command strobe off
2023-03-27T22:18:56.960Z,1679955536.960 [CommandExec](IMPORTANT): Deactivating strobe
2023-03-27T22:19:34.256Z,1679955574.256 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T22:19:34.258Z,1679955574.258 [NAL9602] Data Fault, FailCount= 3
2023-03-27T22:19:34.258Z,1679955574.258 [NAL9602](ERROR): Data Fault
2023-03-27T22:19:34.365Z,1679955574.365 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T22:19:34.648Z,1679955574.648 [NAL9602](INFO): Powering down
2023-03-27T22:19:35.494Z,1679955575.494 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T22:19:35.495Z,1679955575.495 [NAL9602] No Fault, FailCount= 3
2023-03-27T22:20:04.952Z,1679955604.952 [NAL9602](INFO): Powering up NAL9602
2023-03-27T22:20:08.999Z,1679955608.999 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-03-27T22:20:08.999Z,1679955608.999 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:20:09.010Z,1679955609.010 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:20:09.420Z,1679955609.420 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:20:09.420Z,1679955609.420 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-03-27T22:20:15.864Z,1679955615.864 [NAL9602](INFO): NAL9602 initialized
2023-03-27T22:20:31.043Z,1679955631.043 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T22:21:02.167Z,1679955662.167 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T22:21:33.291Z,1679955693.291 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T22:22:30.422Z,1679955750.422 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:22:30.422Z,1679955750.422 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:22:30.422Z,1679955750.422 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:22:30.422Z,1679955750.422 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:22:30.805Z,1679955750.805 [Default:CheckIn:D] Stopped
2023-03-27T22:22:30.805Z,1679955750.805 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 251.292139 min 
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn:E] Stopped
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn] Stopped
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn](INFO): Running loop #25
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn] Running Loop=25
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:22:31.211Z,1679955751.211 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:23:10.047Z,1679955790.047 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-03-27T22:23:10.047Z,1679955790.047 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T22:23:10.057Z,1679955790.057 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T22:23:10.442Z,1679955790.442 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T22:23:10.442Z,1679955790.442 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-03-27T22:26:02.098Z,1679955962.098 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222600.00,A,3648.17884,N,12147.28920,W,0.019,0.00,270323,,,A*7C
2023-03-27T22:26:02.124Z,1679955962.124 [NAL9602](INFO): GPS fix at 20230327T222600: (36.802981, -121.788153)
2023-03-27T22:26:02.136Z,1679955962.136 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:26:02.136Z,1679955962.136 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:26:02.537Z,1679955962.537 [DeadReckonUsingMultipleVelocitySources](INFO): Failure count cleared after critical for DeadReckonUsingMultipleVelocitySources
2023-03-27T22:26:10.982Z,1679955970.982 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20230327T180650/Courier0076.lzma
2023-03-27T22:26:11.984Z,1679955971.984 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0076.lzma.bak
2023-03-27T22:26:11.985Z,1679955971.985 [DataOverHttps](INFO): SBD MOMSN=17692243
2023-03-27T22:26:32.586Z,1679955992.586 [DataOverHttps](INFO): Sending 328 bytes from file Logs/20230327T180650/Express0077.lzma
2023-03-27T22:26:33.589Z,1679955993.589 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0077.lzma.bak
2023-03-27T22:26:33.589Z,1679955993.589 [DataOverHttps](INFO): SBD MOMSN=17692246
2023-03-27T22:26:34.467Z,1679955994.467 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T22:26:34.920Z,1679955994.920 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:26:34.920Z,1679955994.920 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:26:34.920Z,1679955994.920 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:31:35.471Z,1679956295.471 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:31:35.471Z,1679956295.471 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:31:35.471Z,1679956295.471 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:31:35.471Z,1679956295.471 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:31:35.876Z,1679956295.876 [Default:CheckIn:D] Stopped
2023-03-27T22:31:35.876Z,1679956295.876 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:31:36.289Z,1679956296.289 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 260.376644 min 
2023-03-27T22:31:36.289Z,1679956296.289 [Default:CheckIn:E] Stopped
2023-03-27T22:31:36.289Z,1679956296.289 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:31:36.289Z,1679956296.289 [Default:CheckIn] Stopped
2023-03-27T22:31:36.289Z,1679956296.289 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:31:36.290Z,1679956296.290 [Default:CheckIn](INFO): Running loop #26
2023-03-27T22:31:36.290Z,1679956296.290 [Default:CheckIn] Running Loop=26
2023-03-27T22:31:36.290Z,1679956296.290 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:31:36.290Z,1679956296.290 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:31:38.286Z,1679956298.286 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223136.00,A,3648.17733,N,12147.28635,W,0.058,0.00,270323,,,A*72
2023-03-27T22:31:38.288Z,1679956298.288 [NAL9602](INFO): GPS fix at 20230327T223136: (36.802956, -121.788106)
2023-03-27T22:31:38.300Z,1679956298.300 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:31:38.300Z,1679956298.300 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:31:45.258Z,1679956305.258 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230327T180650/Courier0079.lzma
2023-03-27T22:31:46.261Z,1679956306.261 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0079.lzma.bak
2023-03-27T22:31:46.261Z,1679956306.261 [DataOverHttps](INFO): SBD MOMSN=17692289
2023-03-27T22:31:50.414Z,1679956310.414 [NAL9602](INFO): SBD MO Status=0, MOMSN=39522, MT Status=0, MTMSN=0
2023-03-27T22:31:50.414Z,1679956310.414 [NAL9602](INFO): No messages in MT queue
2023-03-27T22:32:02.134Z,1679956322.134 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20230327T180650/Express0080.lzma
2023-03-27T22:32:03.137Z,1679956323.137 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0080.lzma.bak
2023-03-27T22:32:03.137Z,1679956323.137 [DataOverHttps](INFO): SBD MOMSN=17692293
2023-03-27T22:32:04.567Z,1679956324.567 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:32:04.567Z,1679956324.567 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:32:04.567Z,1679956324.567 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:32:21.111Z,1679956341.111 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T22:37:05.153Z,1679956625.153 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:37:05.153Z,1679956625.153 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:37:05.153Z,1679956625.153 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:37:05.153Z,1679956625.153 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:37:05.537Z,1679956625.537 [Default:CheckIn:D] Stopped
2023-03-27T22:37:05.537Z,1679956625.537 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:37:05.957Z,1679956625.957 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 265.871012 min 
2023-03-27T22:37:05.957Z,1679956625.957 [Default:CheckIn:E] Stopped
2023-03-27T22:37:05.957Z,1679956625.957 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:37:05.957Z,1679956625.957 [Default:CheckIn] Stopped
2023-03-27T22:37:05.958Z,1679956625.958 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:37:05.958Z,1679956625.958 [Default:CheckIn](INFO): Running loop #27
2023-03-27T22:37:05.958Z,1679956625.958 [Default:CheckIn] Running Loop=27
2023-03-27T22:37:05.958Z,1679956625.958 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:37:05.958Z,1679956625.958 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:37:07.962Z,1679956627.962 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223707.00,A,3648.17762,N,12147.28594,W,0.000,0.00,270323,,,A*77
2023-03-27T22:37:07.964Z,1679956627.964 [NAL9602](INFO): GPS fix at 20230327T223707: (36.802960, -121.788099)
2023-03-27T22:37:07.976Z,1679956627.976 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:37:07.976Z,1679956627.976 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:37:11.992Z,1679956631.992 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T22:37:11.992Z,1679956631.992 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T22:37:11.992Z,1679956631.992 [DropWeight](ERROR): Hardware Fault
2023-03-27T22:37:12.082Z,1679956632.082 [CBIT](INFO): Critical error at 20230327T223711
2023-03-27T22:37:12.092Z,1679956632.092 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T22:37:12.093Z,1679956632.093 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T22:37:12.485Z,1679956632.485 [CBIT](INFO): Critical error at 20230327T223712
2023-03-27T22:37:15.570Z,1679956635.570 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230327T180650/Courier0082.lzma
2023-03-27T22:37:16.753Z,1679956636.753 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0082.lzma.bak
2023-03-27T22:37:16.753Z,1679956636.753 [DataOverHttps](INFO): SBD MOMSN=17692626
2023-03-27T22:37:32.630Z,1679956652.630 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20230327T180650/Express0083.lzma
2023-03-27T22:37:33.633Z,1679956653.633 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0083.lzma.bak
2023-03-27T22:37:33.633Z,1679956653.633 [DataOverHttps](INFO): SBD MOMSN=17692629
2023-03-27T22:37:35.056Z,1679956655.056 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:37:35.056Z,1679956655.056 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:37:35.056Z,1679956655.056 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:38:17.441Z,1679956697.441 [NAL9602](INFO): SBD MO Status=0, MOMSN=39523, MT Status=0, MTMSN=0
2023-03-27T22:38:17.441Z,1679956697.441 [NAL9602](INFO): No messages in MT queue
2023-03-27T22:38:17.441Z,1679956697.441 [NAL9602](INFO): Failure count cleared after critical for NAL9602
2023-03-27T22:38:48.156Z,1679956728.156 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T22:41:49.555Z,1679956909.555 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:42:04.501Z,1679956924.501 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:42:19.861Z,1679956939.861 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:42:35.213Z,1679956955.213 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:42:35.647Z,1679956955.647 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:42:35.647Z,1679956955.647 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:42:35.647Z,1679956955.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:42:35.647Z,1679956955.647 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:42:36.056Z,1679956956.056 [Default:CheckIn:D] Stopped
2023-03-27T22:42:36.057Z,1679956956.057 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 271.379655 min 
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn:E] Stopped
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn] Stopped
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn](INFO): Running loop #28
2023-03-27T22:42:36.443Z,1679956956.443 [Default:CheckIn] Running Loop=28
2023-03-27T22:42:36.444Z,1679956956.444 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:42:36.444Z,1679956956.444 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:42:38.458Z,1679956958.458 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224237.00,A,3648.17738,N,12147.28602,W,0.000,0.00,270323,,,A*75
2023-03-27T22:42:38.460Z,1679956958.460 [NAL9602](INFO): GPS fix at 20230327T224237: (36.802956, -121.788100)
2023-03-27T22:42:38.471Z,1679956958.471 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:42:38.472Z,1679956958.471 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:42:45.894Z,1679956965.894 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230327T180650/Courier0085.lzma
2023-03-27T22:42:46.897Z,1679956966.897 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0085.lzma.bak
2023-03-27T22:42:46.897Z,1679956966.897 [DataOverHttps](INFO): SBD MOMSN=17692664
2023-03-27T22:42:50.573Z,1679956970.573 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:43:05.978Z,1679956985.978 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20230327T180650/Express0086.lzma
2023-03-27T22:43:06.390Z,1679956986.390 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:43:06.981Z,1679956986.981 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0086.lzma.bak
2023-03-27T22:43:06.981Z,1679956986.981 [DataOverHttps](INFO): SBD MOMSN=17692670
2023-03-27T22:43:08.445Z,1679956988.445 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:43:08.445Z,1679956988.445 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:43:08.445Z,1679956988.445 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:43:20.947Z,1679957000.947 [NAL9602](INFO): SBD MO Status=0, MOMSN=39524, MT Status=0, MTMSN=0
2023-03-27T22:43:20.947Z,1679957000.947 [NAL9602](INFO): No messages in MT queue
2023-03-27T22:43:21.742Z,1679957001.742 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:43:21.745Z,1679957001.745 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2023-03-27T22:43:36.692Z,1679957016.692 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:43:51.686Z,1679957031.686 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T22:43:52.042Z,1679957032.042 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-03-27T22:44:06.988Z,1679957046.988 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2023-03-27T22:44:19.118Z,1679957059.118 [BPC1](INFO): Calculating totals. Valid battery stick count: 47. Valid reserve battery stick count: 6.
2023-03-27T22:44:19.120Z,1679957059.120 [BPC1](INFO): Received data from all battery sticks.
2023-03-27T22:48:09.031Z,1679957289.031 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:48:09.031Z,1679957289.031 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:48:09.031Z,1679957289.031 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:48:09.031Z,1679957289.031 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:48:09.431Z,1679957289.431 [Default:CheckIn:D] Stopped
2023-03-27T22:48:09.431Z,1679957289.431 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 276.935905 min 
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn:E] Stopped
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn] Stopped
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn](INFO): Running loop #29
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn] Running Loop=29
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:48:09.853Z,1679957289.853 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:48:11.850Z,1679957291.850 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224811.00,A,3648.17629,N,12147.28440,W,0.019,0.00,270323,,,A*76
2023-03-27T22:48:11.852Z,1679957291.852 [NAL9602](INFO): GPS fix at 20230327T224811: (36.802938, -121.788073)
2023-03-27T22:48:11.889Z,1679957291.889 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:48:11.889Z,1679957291.889 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:48:21.138Z,1679957301.138 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20230327T180650/Courier0088.lzma
2023-03-27T22:48:22.141Z,1679957302.141 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0088.lzma.bak
2023-03-27T22:48:22.141Z,1679957302.141 [DataOverHttps](INFO): SBD MOMSN=17693008
2023-03-27T22:48:33.297Z,1679957313.297 [NAL9602](INFO): SBD MO Status=0, MOMSN=39525, MT Status=0, MTMSN=0
2023-03-27T22:48:33.297Z,1679957313.297 [NAL9602](INFO): No messages in MT queue
2023-03-27T22:48:40.146Z,1679957320.146 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20230327T180650/Express0089.lzma
2023-03-27T22:48:41.149Z,1679957321.149 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0089.lzma.bak
2023-03-27T22:48:41.149Z,1679957321.149 [DataOverHttps](INFO): SBD MOMSN=17693011
2023-03-27T22:48:42.599Z,1679957322.599 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:48:42.599Z,1679957322.599 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:48:42.599Z,1679957322.599 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:49:04.012Z,1679957344.012 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T22:52:12.370Z,1679957532.370 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T22:52:12.370Z,1679957532.370 [DropWeight] No Fault, FailCount= 1
2023-03-27T22:53:43.353Z,1679957623.353 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:53:43.354Z,1679957623.354 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:53:43.354Z,1679957623.354 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:53:43.354Z,1679957623.354 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:53:43.767Z,1679957623.767 [Default:CheckIn:D] Stopped
2023-03-27T22:53:43.767Z,1679957623.767 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:53:44.176Z,1679957624.176 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 282.508171 min 
2023-03-27T22:53:44.176Z,1679957624.176 [Default:CheckIn:E] Stopped
2023-03-27T22:53:44.176Z,1679957624.176 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:53:44.176Z,1679957624.176 [Default:CheckIn] Stopped
2023-03-27T22:53:44.176Z,1679957624.176 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:53:44.176Z,1679957624.176 [Default:CheckIn](INFO): Running loop #30
2023-03-27T22:53:44.177Z,1679957624.177 [Default:CheckIn] Running Loop=30
2023-03-27T22:53:44.177Z,1679957624.177 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:53:44.177Z,1679957624.177 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:53:46.178Z,1679957626.178 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225345.00,A,3648.17615,N,12147.28577,W,0.019,0.00,270323,,,A*77
2023-03-27T22:53:46.180Z,1679957626.180 [NAL9602](INFO): GPS fix at 20230327T225345: (36.802936, -121.788096)
2023-03-27T22:53:46.216Z,1679957626.216 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:53:46.216Z,1679957626.216 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:53:53.094Z,1679957633.094 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230327T180650/Courier0091.lzma
2023-03-27T22:53:54.097Z,1679957634.097 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0091.lzma.bak
2023-03-27T22:53:54.097Z,1679957634.097 [DataOverHttps](INFO): SBD MOMSN=17693051
2023-03-27T22:54:09.926Z,1679957649.926 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20230327T180650/Express0092.lzma
2023-03-27T22:54:10.930Z,1679957650.930 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0092.lzma.bak
2023-03-27T22:54:10.931Z,1679957650.931 [DataOverHttps](INFO): SBD MOMSN=17693054
2023-03-27T22:54:12.468Z,1679957652.468 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:54:12.468Z,1679957652.468 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:54:12.468Z,1679957652.468 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T22:54:36.702Z,1679957676.702 [NAL9602](INFO): SBD MO Status=0, MOMSN=39526, MT Status=0, MTMSN=0
2023-03-27T22:54:36.702Z,1679957676.702 [NAL9602](INFO): No messages in MT queue
2023-03-27T22:55:07.420Z,1679957707.420 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T22:59:12.892Z,1679957952.892 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T22:59:12.892Z,1679957952.892 [Default:CheckIn:C.Wait] Stopped
2023-03-27T22:59:12.892Z,1679957952.892 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T22:59:12.892Z,1679957952.892 [Default:CheckIn:D] Running Loop=1
2023-03-27T22:59:13.285Z,1679957953.285 [Default:CheckIn:D] Stopped
2023-03-27T22:59:13.286Z,1679957953.286 [Default:CheckIn:E] Running Loop=1
2023-03-27T22:59:13.695Z,1679957953.695 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 288.000130 min 
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn:E] Stopped
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn] Stopped
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn](INFO): Running loop #31
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn] Running Loop=31
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T22:59:13.696Z,1679957953.696 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T22:59:15.707Z,1679957955.707 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225914.00,A,3648.17498,N,12147.28544,W,0.019,0.00,270323,,,A*7E
2023-03-27T22:59:15.709Z,1679957955.709 [NAL9602](INFO): GPS fix at 20230327T225914: (36.802916, -121.788091)
2023-03-27T22:59:15.721Z,1679957955.721 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T22:59:15.721Z,1679957955.721 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T22:59:23.138Z,1679957963.138 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230327T180650/Courier0094.lzma
2023-03-27T22:59:24.141Z,1679957964.141 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0094.lzma.bak
2023-03-27T22:59:24.141Z,1679957964.141 [DataOverHttps](INFO): SBD MOMSN=17693388
2023-03-27T22:59:29.841Z,1679957969.841 [NAL9602](INFO): SBD MO Status=0, MOMSN=39527, MT Status=0, MTMSN=0
2023-03-27T22:59:29.842Z,1679957969.842 [NAL9602](INFO): No messages in MT queue
2023-03-27T22:59:39.990Z,1679957979.990 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20230327T180650/Express0095.lzma
2023-03-27T22:59:40.993Z,1679957980.993 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0095.lzma.bak
2023-03-27T22:59:40.993Z,1679957980.993 [DataOverHttps](INFO): SBD MOMSN=17693391
2023-03-27T22:59:42.391Z,1679957982.391 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T22:59:42.392Z,1679957982.392 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T22:59:42.392Z,1679957982.392 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:00:00.544Z,1679958000.544 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T23:04:43.142Z,1679958283.142 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T23:04:43.142Z,1679958283.142 [Default:CheckIn:C.Wait] Stopped
2023-03-27T23:04:43.142Z,1679958283.142 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T23:04:43.142Z,1679958283.142 [Default:CheckIn:D] Running Loop=1
2023-03-27T23:04:43.535Z,1679958283.535 [Default:CheckIn:D] Stopped
2023-03-27T23:04:43.535Z,1679958283.535 [Default:CheckIn:E] Running Loop=1
2023-03-27T23:04:43.939Z,1679958283.939 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 293.504297 min 
2023-03-27T23:04:43.939Z,1679958283.939 [Default:CheckIn:E] Stopped
2023-03-27T23:04:43.939Z,1679958283.939 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T23:04:43.939Z,1679958283.939 [Default:CheckIn] Stopped
2023-03-27T23:04:43.940Z,1679958283.940 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T23:04:43.940Z,1679958283.940 [Default:CheckIn](INFO): Running loop #32
2023-03-27T23:04:43.940Z,1679958283.940 [Default:CheckIn] Running Loop=32
2023-03-27T23:04:43.940Z,1679958283.940 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T23:04:43.940Z,1679958283.940 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T23:04:45.950Z,1679958285.950 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230445.00,A,3648.17503,N,12147.28640,W,0.039,0.00,270323,,,A*75
2023-03-27T23:04:45.953Z,1679958285.953 [NAL9602](INFO): GPS fix at 20230327T230445: (36.802917, -121.788107)
2023-03-27T23:04:45.965Z,1679958285.965 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T23:04:45.965Z,1679958285.965 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T23:04:56.170Z,1679958296.170 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230327T180650/Courier0097.lzma
2023-03-27T23:04:57.173Z,1679958297.173 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0097.lzma.bak
2023-03-27T23:04:57.173Z,1679958297.173 [DataOverHttps](INFO): SBD MOMSN=17693425
2023-03-27T23:05:13.406Z,1679958313.406 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20230327T180650/Express0098.lzma
2023-03-27T23:05:14.409Z,1679958314.409 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0098.lzma.bak
2023-03-27T23:05:14.409Z,1679958314.409 [DataOverHttps](INFO): SBD MOMSN=17693428
2023-03-27T23:05:15.908Z,1679958315.908 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T23:05:15.908Z,1679958315.908 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T23:05:15.908Z,1679958315.908 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:05:31.255Z,1679958331.255 [NAL9602](INFO): SBD MO Status=0, MOMSN=39528, MT Status=0, MTMSN=0
2023-03-27T23:05:31.255Z,1679958331.255 [NAL9602](INFO): No messages in MT queue
2023-03-27T23:06:01.953Z,1679958361.953 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T23:06:20.727Z,1679958380.727 [CommandExec](IMPORTANT): got command report touch NAL9602.sigQuality
2023-03-27T23:06:50.712Z,1679958410.712 [CommandExec](IMPORTANT): got command get NAL9602.sigQuality
2023-03-27T23:06:50.713Z,1679958410.713 [CommandExec](IMPORTANT): NAL9602.sigQuality 0 count
2023-03-27T23:07:02.155Z,1679958422.155 [CommandExec](IMPORTANT): got command ibit
2023-03-27T23:07:02.327Z,1679958422.327 [IBIT](IMPORTANT): Beginning Initiated BIT
2023-03-27T23:07:02.327Z,1679958422.327 [IBIT](IMPORTANT): Beginning control surface checks.
2023-03-27T23:07:02.331Z,1679958422.331 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-27T23:07:03.906Z,1679958423.906 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230703.00,A,3648.17628,N,12147.28530,W,0.078,0.00,270323,,,A*7F
2023-03-27T23:07:03.908Z,1679958423.908 [NAL9602](INFO): GPS fix at 20230327T230703: (36.802938, -121.788088)
2023-03-27T23:07:05.215Z,1679958425.215 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2023-03-27T23:07:12.034Z,1679958432.034 [Reporter](INFO): NAL9602.sigQuality 2 count
2023-03-27T23:07:13.228Z,1679958433.228 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002669
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.002092
CHAN A3 (5V): -0.001601
CHAN B0 (3.3V): -0.000186
CHAN B1 (3.15aV): -0.000641
CHAN B2 (3.15bV): -0.000643
CHAN B3 (GND): 0.000143
OPEN: -0.000686
Full Scale: +/- 1 mA
2023-03-27T23:07:15.625Z,1679958435.625 [NAL9602](INFO): SBD MO Status=0, MOMSN=39529, MT Status=0, MTMSN=0
2023-03-27T23:07:15.626Z,1679958435.626 [NAL9602](INFO): No messages in MT queue
2023-03-27T23:07:16.834Z,1679958436.834 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230716.00,A,3648.17616,N,12147.28533,W,0.078,0.00,270323,,,A*75
2023-03-27T23:07:16.836Z,1679958436.836 [NAL9602](INFO): GPS fix at 20230327T230716: (36.802936, -121.788089)
2023-03-27T23:07:20.062Z,1679958440.062 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230719.00,A,3648.17614,N,12147.28535,W,0.039,0.00,270323,,,A*7B
2023-03-27T23:07:20.064Z,1679958440.064 [NAL9602](INFO): GPS fix at 20230327T230719: (36.802936, -121.788089)
2023-03-27T23:07:22.890Z,1679958442.890 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230722.00,A,3648.17614,N,12147.28538,W,0.019,0.00,270323,,,A*7C
2023-03-27T23:07:22.892Z,1679958442.892 [NAL9602](INFO): GPS fix at 20230327T230722: (36.802936, -121.788090)
2023-03-27T23:07:26.121Z,1679958446.121 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230725.00,A,3648.17612,N,12147.28540,W,0.019,0.00,270323,,,A*72
2023-03-27T23:07:26.123Z,1679958446.123 [NAL9602](INFO): GPS fix at 20230327T230725: (36.802935, -121.788090)
2023-03-27T23:07:28.954Z,1679958448.954 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230728.00,A,3648.17608,N,12147.28542,W,0.039,0.00,270323,,,A*74
2023-03-27T23:07:28.969Z,1679958448.969 [NAL9602](INFO): GPS fix at 20230327T230728: (36.802935, -121.788090)
2023-03-27T23:07:32.192Z,1679958452.192 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230731.00,A,3648.17602,N,12147.28542,W,0.039,0.00,270323,,,A*76
2023-03-27T23:07:32.194Z,1679958452.194 [NAL9602](INFO): GPS fix at 20230327T230731: (36.802934, -121.788090)
2023-03-27T23:07:35.008Z,1679958455.008 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230734.00,A,3648.17595,N,12147.28548,W,0.019,0.00,270323,,,A*76
2023-03-27T23:07:35.011Z,1679958455.011 [NAL9602](INFO): GPS fix at 20230327T230734: (36.802932, -121.788091)
2023-03-27T23:07:37.842Z,1679958457.842 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230737.00,A,3648.17587,N,12147.28551,W,0.058,0.00,270323,,,A*7B
2023-03-27T23:07:37.854Z,1679958457.854 [NAL9602](INFO): GPS fix at 20230327T230737: (36.802931, -121.788092)
2023-03-27T23:07:41.074Z,1679958461.074 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230740.00,A,3648.17574,N,12147.28557,W,0.039,0.00,270323,,,A*76
2023-03-27T23:07:41.085Z,1679958461.085 [NAL9602](INFO): GPS fix at 20230327T230740: (36.802929, -121.788093)
2023-03-27T23:07:43.636Z,1679958463.636 [CommandLine](INFO): End of History
2023-03-27T23:07:43.641Z,1679958463.641 [CommandLine](INFO): End of History
2023-03-27T23:07:43.646Z,1679958463.646 [CommandLine](INFO): End of History
2023-03-27T23:07:43.651Z,1679958463.651 [CommandLine](INFO): End of History
2023-03-27T23:07:43.656Z,1679958463.656 [CommandLine](INFO): End of History
2023-03-27T23:07:43.662Z,1679958463.662 [CommandLine](INFO): End of History
2023-03-27T23:07:43.667Z,1679958463.667 [CommandLine](INFO): End of History
2023-03-27T23:07:43.672Z,1679958463.672 [CommandLine](INFO): End of History
2023-03-27T23:07:43.902Z,1679958463.902 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230743.00,A,3648.17565,N,12147.28562,W,0.019,0.00,270323,,,A*71
2023-03-27T23:07:43.909Z,1679958463.909 [NAL9602](INFO): GPS fix at 20230327T230743: (36.802928, -121.788094)
2023-03-27T23:07:47.130Z,1679958467.130 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230746.00,A,3648.17556,N,12147.28566,W,0.019,0.00,270323,,,A*70
2023-03-27T23:07:47.132Z,1679958467.132 [NAL9602](INFO): GPS fix at 20230327T230746: (36.802926, -121.788094)
2023-03-27T23:07:48.385Z,1679958468.385 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 36.802925 Longitude: -121.788094
2023-03-27T23:07:48.777Z,1679958468.777 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.620000
2023-03-27T23:07:48.777Z,1679958468.777 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2023-03-27T23:07:48.778Z,1679958468.778 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2023-03-27T23:07:49.171Z,1679958469.171 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2023-03-27T23:07:49.171Z,1679958469.171 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2023-03-27T23:07:49.172Z,1679958469.172 [IBIT](IMPORTANT): Pressure:9.854683 PSI
2023-03-27T23:07:49.172Z,1679958469.172 [IBIT](IMPORTANT): Humidity:0.781345 %
2023-03-27T23:07:49.648Z,1679958469.648 [IBIT](IMPORTANT): Vehicle Pitch:-0.597358 degrees
2023-03-27T23:07:49.649Z,1679958469.649 [IBIT](IMPORTANT): Vehicle  Roll:-6.012299 degrees
2023-03-27T23:07:49.649Z,1679958469.649 [IBIT](IMPORTANT): Vehicle  Heading:24.468651 degrees
2023-03-27T23:07:49.972Z,1679958469.972 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2023-03-27T23:07:49.972Z,1679958469.972 [IBIT](IMPORTANT): buoyancyNeutral: 336.456146 cc
2023-03-27T23:07:49.973Z,1679958469.973 [IBIT](IMPORTANT): massDefault: -1.415717 cm
2023-03-27T23:07:49.973Z,1679958469.973 [IBIT](IMPORTANT): stopDepth: 250.000000 m
2023-03-27T23:07:49.973Z,1679958469.973 [IBIT](IMPORTANT): abortDepth: 270.000000 m
2023-03-27T23:07:49.973Z,1679958469.973 [IBIT](IMPORTANT): IBIT PASSED
2023-03-27T23:08:04.410Z,1679958484.410 [CommandExec](IMPORTANT): got command get NAL9602.sigQuality
2023-03-27T23:08:04.411Z,1679958484.411 [CommandExec](IMPORTANT): NAL9602.sigQuality 2 count
2023-03-27T23:08:11.640Z,1679958491.640 [CommandExec](IMPORTANT): got command report clear
2023-03-27T23:08:16.969Z,1679958496.969 [CommandExec](IMPORTANT): got command report mod NAL9602.sigQuality
2023-03-27T23:08:17.068Z,1679958497.068 [Reporter](INFO): NAL9602.sigQuality 2 count
2023-03-27T23:08:19.448Z,1679958499.448 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T23:08:19.540Z,1679958499.540 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:10:16.347Z,1679958616.347 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T23:10:16.347Z,1679958616.347 [Default:CheckIn:C.Wait] Stopped
2023-03-27T23:10:16.347Z,1679958616.347 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T23:10:16.347Z,1679958616.347 [Default:CheckIn:D] Running Loop=1
2023-03-27T23:10:16.750Z,1679958616.750 [Default:CheckIn:D] Stopped
2023-03-27T23:10:16.751Z,1679958616.751 [Default:CheckIn:E] Running Loop=1
2023-03-27T23:10:17.186Z,1679958617.186 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 299.057878 min 
2023-03-27T23:10:17.186Z,1679958617.186 [Default:CheckIn:E] Stopped
2023-03-27T23:10:17.186Z,1679958617.186 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T23:10:17.186Z,1679958617.186 [Default:CheckIn] Stopped
2023-03-27T23:10:17.186Z,1679958617.186 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T23:10:17.187Z,1679958617.187 [Default:CheckIn](INFO): Running loop #33
2023-03-27T23:10:17.187Z,1679958617.187 [Default:CheckIn] Running Loop=33
2023-03-27T23:10:17.187Z,1679958617.187 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T23:10:17.187Z,1679958617.187 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T23:10:19.170Z,1679958619.170 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231018.00,A,3648.17491,N,12147.28574,W,0.039,0.00,270323,,,A*76
2023-03-27T23:10:19.172Z,1679958619.172 [NAL9602](INFO): GPS fix at 20230327T231018: (36.802915, -121.788096)
2023-03-27T23:10:19.184Z,1679958619.184 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T23:10:19.184Z,1679958619.184 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T23:10:25.363Z,1679958625.363 [Reporter](INFO): NAL9602.sigQuality 1 count
2023-03-27T23:10:29.046Z,1679958629.046 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230327T180650/Courier0100.lzma
2023-03-27T23:10:30.049Z,1679958630.049 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0100.lzma.bak
2023-03-27T23:10:30.049Z,1679958630.049 [DataOverHttps](INFO): SBD MOMSN=17693783
2023-03-27T23:10:46.247Z,1679958646.247 [DataOverHttps](INFO): Sending 867 bytes from file Logs/20230327T180650/Express0101.lzma
2023-03-27T23:10:47.249Z,1679958647.249 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0101.lzma.bak
2023-03-27T23:10:47.249Z,1679958647.249 [DataOverHttps](INFO): SBD MOMSN=17693786
2023-03-27T23:10:48.721Z,1679958648.721 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T23:10:48.721Z,1679958648.721 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T23:10:48.721Z,1679958648.721 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:10:51.258Z,1679958651.258 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:11:51.507Z,1679958711.507 [Reporter](INFO): NAL9602.sigQuality 1 count
2023-03-27T23:12:00.308Z,1679958720.308 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:12:08.803Z,1679958728.803 [Reporter](INFO): NAL9602.sigQuality 1 count
2023-03-27T23:12:15.271Z,1679958735.271 [Reporter](INFO): NAL9602.sigQuality 2 count
2023-03-27T23:12:22.133Z,1679958742.133 [NAL9602](INFO): SBD MO Status=0, MOMSN=39530, MT Status=0, MTMSN=0
2023-03-27T23:12:22.133Z,1679958742.133 [NAL9602](INFO): No messages in MT queue
2023-03-27T23:12:52.850Z,1679958772.850 [NAL9602](INFO): Not Powering down - fast GPS
2023-03-27T23:12:52.971Z,1679958772.971 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:15:49.408Z,1679958949.408 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T23:15:49.408Z,1679958949.408 [Default:CheckIn:C.Wait] Stopped
2023-03-27T23:15:49.408Z,1679958949.408 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T23:15:49.408Z,1679958949.408 [Default:CheckIn:D] Running Loop=1
2023-03-27T23:15:49.820Z,1679958949.820 [Default:CheckIn:D] Stopped
2023-03-27T23:15:49.820Z,1679958949.820 [Default:CheckIn:E] Running Loop=1
2023-03-27T23:15:50.214Z,1679958950.214 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 304.609049 min 
2023-03-27T23:15:50.214Z,1679958950.214 [Default:CheckIn:E] Stopped
2023-03-27T23:15:50.214Z,1679958950.214 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T23:15:50.214Z,1679958950.214 [Default:CheckIn] Stopped
2023-03-27T23:15:50.214Z,1679958950.214 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T23:15:50.214Z,1679958950.214 [Default:CheckIn](INFO): Running loop #34
2023-03-27T23:15:50.215Z,1679958950.215 [Default:CheckIn] Running Loop=34
2023-03-27T23:15:50.215Z,1679958950.215 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T23:15:50.215Z,1679958950.215 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T23:15:52.230Z,1679958952.230 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231551.00,A,3648.17568,N,12147.28513,W,0.019,0.00,270323,,,A*7A
2023-03-27T23:15:52.233Z,1679958952.233 [NAL9602](INFO): GPS fix at 20230327T231551: (36.802928, -121.788085)
2023-03-27T23:15:52.245Z,1679958952.245 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T23:15:52.245Z,1679958952.245 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T23:15:59.238Z,1679958959.238 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230327T180650/Courier0103.lzma
2023-03-27T23:16:00.241Z,1679958960.241 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Courier0103.lzma.bak
2023-03-27T23:16:00.241Z,1679958960.241 [DataOverHttps](INFO): SBD MOMSN=17693852
2023-03-27T23:16:16.086Z,1679958976.086 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20230327T180650/Express0104.lzma
2023-03-27T23:16:17.089Z,1679958977.089 [DataOverHttps](INFO): Moved sent file to Logs/20230327T180650/Express0104.lzma.bak
2023-03-27T23:16:17.089Z,1679958977.089 [DataOverHttps](INFO): SBD MOMSN=17693855
2023-03-27T23:16:18.513Z,1679958978.513 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T23:16:18.513Z,1679958978.513 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T23:16:18.513Z,1679958978.513 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:17:20.339Z,1679959040.339 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T23:17:51.463Z,1679959071.463 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T23:17:53.135Z,1679959073.135 [Reporter](INFO): NAL9602.sigQuality 4 count
2023-03-27T23:18:07.625Z,1679959087.625 [NAL9602](INFO): SBD MO Status=2, MOMSN=39531, MT Status=2, MTMSN=0
2023-03-27T23:18:07.626Z,1679959087.626 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-03-27T23:18:12.131Z,1679959092.131 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:18:22.599Z,1679959102.599 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T23:18:33.541Z,1679959113.541 [Reporter](INFO): NAL9602.sigQuality 1 count
2023-03-27T23:18:42.464Z,1679959122.464 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:18:46.487Z,1679959126.487 [Reporter](INFO): NAL9602.sigQuality 1 count
2023-03-27T23:18:53.731Z,1679959133.731 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-03-27T23:18:59.447Z,1679959139.447 [Reporter](INFO): NAL9602.sigQuality 0 count
2023-03-27T23:19:03.419Z,1679959143.419 [Reporter](INFO): NAL9602.sigQuality 1 count
2023-03-27T23:19:12.307Z,1679959152.307 [Reporter](INFO): NAL9602.sigQuality 0 count