2023-08-31T17:36:04.960Z,1693503364.960 [Supervisor](DEBUG): Initializing supervisor. 2023-08-31T17:36:04.965Z,1693503364.965 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-08-31T17:36:04.965Z,1693503364.965 [SyncHandler](INFO): Protected caller Thread ID is 836 2023-08-31T17:36:04.966Z,1693503364.966 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-08-31T17:36:04.967Z,1693503364.967 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-08-31T17:36:04.967Z,1693503364.967 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 837 2023-08-31T17:36:04.971Z,1693503364.971 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-08-31T17:36:04.988Z,1693503364.988 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-08-31T17:36:04.989Z,1693503364.989 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-08-31T17:36:04.990Z,1693503364.990 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 838 2023-08-31T17:36:04.994Z,1693503364.994 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-08-31T17:36:04.995Z,1693503364.995 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-08-31T17:36:04.995Z,1693503364.995 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839 2023-08-31T17:36:04.997Z,1693503364.997 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-08-31T17:36:04.998Z,1693503364.998 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-08-31T17:36:04.998Z,1693503364.998 [logger ThreadHandler](INFO): Protected caller Thread ID is 840 2023-08-31T17:36:05.002Z,1693503365.002 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-08-31T17:36:05.002Z,1693503365.002 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-08-31T17:36:05.007Z,1693503365.007 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-08-31T17:36:05.471Z,1693503365.471 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-08-31T17:36:05.471Z,1693503365.471 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-08-31T17:36:05.676Z,1693503365.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-08-31T17:36:05.678Z,1693503365.678 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-08-31T17:36:05.758Z,1693503365.758 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-08-31T17:36:05.972Z,1693503365.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-08-31T17:36:05.974Z,1693503365.974 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-08-31T17:36:06.053Z,1693503366.053 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-08-31T17:36:06.194Z,1693503366.194 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-08-31T17:36:06.196Z,1693503366.196 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-08-31T17:36:06.545Z,1693503366.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-08-31T17:36:06.546Z,1693503366.546 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-08-31T17:36:06.676Z,1693503366.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-08-31T17:36:06.677Z,1693503366.677 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-08-31T17:36:07.154Z,1693503367.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-08-31T17:36:07.155Z,1693503367.155 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-08-31T17:36:07.345Z,1693503367.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-08-31T17:36:07.346Z,1693503367.346 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-08-31T17:36:07.753Z,1693503367.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-08-31T17:36:07.755Z,1693503367.755 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-08-31T17:36:08.040Z,1693503368.040 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-08-31T17:36:08.042Z,1693503368.042 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-08-31T17:36:08.151Z,1693503368.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-08-31T17:36:08.152Z,1693503368.152 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-08-31T17:36:09.263Z,1693503369.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-08-31T17:36:09.265Z,1693503369.265 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-08-31T17:36:09.588Z,1693503369.588 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-08-31T17:36:09.590Z,1693503369.590 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-08-31T17:36:09.814Z,1693503369.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-08-31T17:36:09.816Z,1693503369.816 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2023-08-31T17:36:09.819Z,1693503369.819 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2023-08-31T17:36:09.944Z,1693503369.944 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2023-08-31T17:36:10.028Z,1693503370.028 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2023-08-31T17:36:10.166Z,1693503370.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2023-08-31T17:36:10.252Z,1693503370.252 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2023-08-31T17:36:10.520Z,1693503370.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-08-31T17:36:10.520Z,1693503370.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2023-08-31T17:36:10.623Z,1693503370.623 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2023-08-31T17:36:10.729Z,1693503370.729 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2023-08-31T17:36:10.847Z,1693503370.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2023-08-31T17:36:10.994Z,1693503370.994 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2023-08-31T17:36:11.092Z,1693503371.092 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2023-08-31T17:36:11.189Z,1693503371.189 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-08-31T17:36:11.206Z,1693503371.206 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-08-31T17:36:11.223Z,1693503371.223 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-08-31T17:36:11.224Z,1693503371.224 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-08-31T17:36:11.349Z,1693503371.349 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-08-31T17:36:11.349Z,1693503371.349 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-08-31T17:36:11.418Z,1693503371.418 [VerticalControl](DEBUG): Construct VerticalControl. 2023-08-31T17:36:11.478Z,1693503371.478 [VerticalControl] Loaded 2023-08-31T17:36:11.479Z,1693503371.479 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-08-31T17:36:11.481Z,1693503371.481 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-08-31T17:36:11.523Z,1693503371.523 [HorizontalControl] Loaded 2023-08-31T17:36:11.523Z,1693503371.523 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-08-31T17:36:11.526Z,1693503371.526 [SpeedControl](DEBUG): Construct SpeedControl. 2023-08-31T17:36:11.529Z,1693503371.529 [SpeedControl] Loaded 2023-08-31T17:36:11.529Z,1693503371.529 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-08-31T17:36:11.532Z,1693503371.532 [LoopControl](DEBUG): Construct LoopControl. 2023-08-31T17:36:11.532Z,1693503371.532 [LoopControl] Loaded 2023-08-31T17:36:11.532Z,1693503371.532 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-08-31T17:36:11.533Z,1693503371.533 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-08-31T17:36:11.533Z,1693503371.533 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-08-31T17:36:11.720Z,1693503371.720 [BuoyancyServo] Loaded 2023-08-31T17:36:11.720Z,1693503371.720 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-08-31T17:36:11.740Z,1693503371.740 [ElevatorServo] Loaded 2023-08-31T17:36:11.740Z,1693503371.740 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-08-31T17:36:11.759Z,1693503371.759 [MassServo] Loaded 2023-08-31T17:36:11.759Z,1693503371.759 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-08-31T17:36:11.778Z,1693503371.778 [RudderServo] Loaded 2023-08-31T17:36:11.778Z,1693503371.778 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-08-31T17:36:11.793Z,1693503371.793 [ThrusterHE] Loaded 2023-08-31T17:36:11.793Z,1693503371.793 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-08-31T17:36:11.793Z,1693503371.793 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-08-31T17:36:11.794Z,1693503371.794 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-08-31T17:36:11.863Z,1693503371.863 [DepthRateCalculator] Loaded 2023-08-31T17:36:11.863Z,1693503371.863 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-08-31T17:36:11.868Z,1693503371.868 [PitchRateCalculator] Loaded 2023-08-31T17:36:11.869Z,1693503371.869 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-08-31T17:36:11.878Z,1693503371.878 [SpeedCalculator] Loaded 2023-08-31T17:36:11.878Z,1693503371.878 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-08-31T17:36:11.883Z,1693503371.883 [YawRateCalculator] Loaded 2023-08-31T17:36:11.883Z,1693503371.883 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-08-31T17:36:11.902Z,1693503371.902 [ElevatorOffsetCalculator] Loaded 2023-08-31T17:36:11.902Z,1693503371.902 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-08-31T17:36:11.902Z,1693503371.902 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-08-31T17:36:11.903Z,1693503371.903 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-08-31T17:36:12.041Z,1693503372.041 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-08-31T17:36:12.042Z,1693503372.042 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-08-31T17:36:12.055Z,1693503372.055 [NavChart] Loaded 2023-08-31T17:36:12.056Z,1693503372.056 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-08-31T17:36:12.061Z,1693503372.061 [UniversalFixResidualReporter] Loaded 2023-08-31T17:36:12.061Z,1693503372.061 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-08-31T17:36:12.062Z,1693503372.062 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-08-31T17:36:12.063Z,1693503372.063 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-08-31T17:36:13.007Z,1693503373.007 [AHRS_M2] Loaded 2023-08-31T17:36:13.008Z,1693503373.008 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-08-31T17:36:13.257Z,1693503373.257 [BackseatComponent] Loaded 2023-08-31T17:36:13.257Z,1693503373.257 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-08-31T17:36:13.259Z,1693503373.259 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408E64E0 2023-08-31T17:36:13.259Z,1693503373.259 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2023-08-31T17:36:13.262Z,1693503373.262 [LcmUniversalReporter] Loaded 2023-08-31T17:36:13.262Z,1693503373.262 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-08-31T17:36:13.268Z,1693503373.268 [BioacousticsDataBridge] Loaded 2023-08-31T17:36:13.269Z,1693503373.269 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2023-08-31T17:36:14.104Z,1693503374.104 [BPC1] Loaded 2023-08-31T17:36:14.104Z,1693503374.104 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-08-31T17:36:14.246Z,1693503374.246 [DataOverHttps] Loaded 2023-08-31T17:36:14.246Z,1693503374.246 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-08-31T17:36:14.247Z,1693503374.247 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409164E0 2023-08-31T17:36:14.247Z,1693503374.247 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924 2023-08-31T17:36:14.268Z,1693503374.268 [Depth_Keller] Loaded 2023-08-31T17:36:14.269Z,1693503374.269 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-08-31T17:36:14.274Z,1693503374.274 [DropWeight] Loaded 2023-08-31T17:36:14.274Z,1693503374.274 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-08-31T17:36:14.337Z,1693503374.337 [NAL9602] Loaded 2023-08-31T17:36:14.337Z,1693503374.337 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-08-31T17:36:14.368Z,1693503374.368 [Onboard] Loaded 2023-08-31T17:36:14.368Z,1693503374.368 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-08-31T17:36:14.369Z,1693503374.369 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409464E0 2023-08-31T17:36:14.369Z,1693503374.369 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925 2023-08-31T17:36:14.382Z,1693503374.382 [Power24vConverter] Loaded 2023-08-31T17:36:14.382Z,1693503374.382 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-08-31T17:36:14.395Z,1693503374.395 [Radio_Surface] Loaded 2023-08-31T17:36:14.395Z,1693503374.395 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-08-31T17:36:14.397Z,1693503374.397 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409764E0 2023-08-31T17:36:14.397Z,1693503374.397 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926 2023-08-31T17:36:14.410Z,1693503374.410 [Sonardyne_Nano] Loaded 2023-08-31T17:36:14.411Z,1693503374.411 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2023-08-31T17:36:14.411Z,1693503374.411 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-08-31T17:36:14.412Z,1693503374.412 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-08-31T17:36:14.650Z,1693503374.650 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-08-31T17:36:14.650Z,1693503374.650 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-08-31T17:36:15.625Z,1693503375.625 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-08-31T17:36:15.626Z,1693503375.626 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-08-31T17:36:15.673Z,1693503375.673 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-08-31T17:36:15.673Z,1693503375.673 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-08-31T17:36:15.902Z,1693503375.902 [CTD_Seabird] Loaded 2023-08-31T17:36:15.902Z,1693503375.902 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-08-31T17:36:15.903Z,1693503375.903 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AAD4E0 2023-08-31T17:36:15.904Z,1693503375.904 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927 2023-08-31T17:36:15.924Z,1693503375.924 [PAR_Licor] Loaded 2023-08-31T17:36:15.924Z,1693503375.924 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-08-31T17:36:15.965Z,1693503375.965 [WetLabsBB2FL] Loaded 2023-08-31T17:36:15.965Z,1693503375.965 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-08-31T17:36:15.966Z,1693503375.966 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40ADD4E0 2023-08-31T17:36:15.966Z,1693503375.966 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928 2023-08-31T17:36:15.967Z,1693503375.967 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-08-31T17:36:15.968Z,1693503375.968 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-08-31T17:36:16.327Z,1693503376.327 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-08-31T17:36:16.329Z,1693503376.329 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-08-31T17:36:16.497Z,1693503376.497 [SBIT](DEBUG): Construct Startup Built In Test. 2023-08-31T17:36:16.506Z,1693503376.506 [SBIT] Loaded 2023-08-31T17:36:16.506Z,1693503376.506 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-08-31T17:36:16.509Z,1693503376.509 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-08-31T17:36:16.523Z,1693503376.523 [IBIT] Loaded 2023-08-31T17:36:16.523Z,1693503376.523 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-08-31T17:36:16.529Z,1693503376.529 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-08-31T17:36:16.634Z,1693503376.634 [CBIT] Loaded 2023-08-31T17:36:16.634Z,1693503376.634 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-08-31T17:36:16.635Z,1693503376.635 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-08-31T17:36:16.641Z,1693503376.641 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-08-31T17:36:16.644Z,1693503376.644 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-08-31T17:36:16.655Z,1693503376.655 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-08-31T17:36:16.656Z,1693503376.656 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BC94E0 2023-08-31T17:36:16.656Z,1693503376.656 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929 2023-08-31T17:36:16.661Z,1693503376.661 [Supervisor](INFO): Main Thread ID is 829 2023-08-31T17:36:16.661Z,1693503376.661 [Supervisor](DEBUG): Running supervisor. 2023-08-31T17:36:16.662Z,1693503376.662 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930 2023-08-31T17:36:16.662Z,1693503376.662 [CommandExec](INFO): Initializing the command executive. 2023-08-31T17:36:16.663Z,1693503376.663 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931 2023-08-31T17:36:16.666Z,1693503376.666 [controlThread ThreadHandler](INFO): Handler Thread ID is 932 2023-08-31T17:36:16.666Z,1693503376.666 [controlThread](DEBUG): Initializing ControlThread 2023-08-31T17:36:16.667Z,1693503376.667 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-08-31T17:36:16.683Z,1693503376.683 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-08-31T17:36:16.684Z,1693503376.684 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-08-31T17:36:16.684Z,1693503376.684 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-08-31T17:36:16.686Z,1693503376.686 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-08-31T17:36:16.686Z,1693503376.686 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-08-31T17:36:16.686Z,1693503376.686 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-08-31T17:36:16.686Z,1693503376.686 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-08-31T17:36:16.687Z,1693503376.687 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-08-31T17:36:16.688Z,1693503376.688 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-08-31T17:36:16.688Z,1693503376.688 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-08-31T17:36:16.696Z,1693503376.696 [SBIT](INFO): Initialize SBIT Component. 2023-08-31T17:36:16.697Z,1693503376.697 [SBIT](IMPORTANT): git: 2023-08-02 2023-08-31T17:36:16.697Z,1693503376.697 [SBIT](INFO): git hash: 04bff54855c04b79675eb3036915d66bd94ee3d9 2023-08-31T17:36:16.697Z,1693503376.697 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-08-31T17:36:16.698Z,1693503376.698 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-08-31T17:36:16.699Z,1693503376.699 [SBIT](INFO): Beginning SBIT in 122.000000 seconds. 2023-08-31T17:36:16.700Z,1693503376.700 [logger ThreadHandler](INFO): Handler Thread ID is 933 2023-08-31T17:36:16.716Z,1693503376.716 [IBIT](INFO): Initialize IBIT Component. 2023-08-31T17:36:16.717Z,1693503376.717 [CBIT](DEBUG): Initialize CBIT Component. 2023-08-31T17:36:16.724Z,1693503376.724 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934 2023-08-31T17:36:16.728Z,1693503376.728 [CBIT](DEBUG): Initialized mux pins. 2023-08-31T17:36:16.728Z,1693503376.728 [CBIT](DEBUG): Initializing the watchdog timer. 2023-08-31T17:36:16.736Z,1693503376.736 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935 2023-08-31T17:36:16.737Z,1693503376.737 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-08-31T17:36:16.748Z,1693503376.748 [Onboard ThreadHandler](INFO): Handler Thread ID is 936 2023-08-31T17:36:16.752Z,1693503376.752 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-08-31T17:36:16.753Z,1693503376.753 [CBIT](DEBUG): Initializing heartbeat. 2023-08-31T17:36:16.773Z,1693503376.773 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937 2023-08-31T17:36:16.784Z,1693503376.784 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938 2023-08-31T17:36:16.785Z,1693503376.785 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-08-31T17:36:16.788Z,1693503376.788 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940 2023-08-31T17:36:16.792Z,1693503376.792 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942 2023-08-31T17:36:16.793Z,1693503376.793 [WetLabsBB2FL](INFO): Powering up 2023-08-31T17:36:16.802Z,1693503376.802 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI01M.000 2023-08-31T17:36:16.802Z,1693503376.802 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000 2023-08-31T17:36:16.803Z,1693503376.803 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI80M.000 2023-08-31T17:36:16.803Z,1693503376.803 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI80M.000 2023-08-31T17:36:16.803Z,1693503376.803 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI57M.000 2023-08-31T17:36:16.803Z,1693503376.803 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI57M.000 2023-08-31T17:36:16.803Z,1693503376.803 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI56M.000 2023-08-31T17:36:16.804Z,1693503376.804 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI56M.000 2023-08-31T17:36:16.804Z,1693503376.804 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI90M.000 2023-08-31T17:36:16.804Z,1693503376.804 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI90M.000 2023-08-31T17:36:16.804Z,1693503376.804 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI89M.000 2023-08-31T17:36:16.805Z,1693503376.805 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000 2023-08-31T17:36:16.805Z,1693503376.805 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI03M.000 2023-08-31T17:36:16.805Z,1693503376.805 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI03M.000 2023-08-31T17:36:16.805Z,1693503376.805 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4WI06M.000 2023-08-31T17:36:16.805Z,1693503376.805 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4WI06M.000 2023-08-31T17:36:16.805Z,1693503376.805 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4OH01M.000 2023-08-31T17:36:16.806Z,1693503376.806 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4OH01M.000 2023-08-31T17:36:16.806Z,1693503376.806 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4OH04M.000 2023-08-31T17:36:16.806Z,1693503376.806 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4OH04M.000 2023-08-31T17:36:16.806Z,1693503376.806 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4OH02M.000 2023-08-31T17:36:16.806Z,1693503376.806 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4OH02M.000 2023-08-31T17:36:16.807Z,1693503376.806 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4PA20M.000 2023-08-31T17:36:16.807Z,1693503376.807 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4PA20M.000 2023-08-31T17:36:16.807Z,1693503376.807 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4PA21M.000 2023-08-31T17:36:16.807Z,1693503376.807 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4PA21M.000 2023-08-31T17:36:16.824Z,1693503376.824 [CBIT](DEBUG): Deactivating GF circuits. 2023-08-31T17:36:16.824Z,1693503376.824 [CBIT](DEBUG): Deactivating emergency mode. 2023-08-31T17:36:16.864Z,1693503376.864 [CBIT](DEBUG): Backplane powered. 2023-08-31T17:36:16.865Z,1693503376.865 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-08-31T17:36:16.892Z,1693503376.892 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-08-31T17:36:16.911Z,1693503376.911 [MissionManager](DEBUG): 2023-08-31T17:36:16.929Z,1693503376.929 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-08-31T17:36:17.008Z,1693503377.008 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-08-31T17:36:17.009Z,1693503377.009 [Default:A.Wait](DEBUG): Construct Wait. 2023-08-31T17:36:17.012Z,1693503377.012 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-08-31T17:36:17.059Z,1693503377.059 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-08-31T17:36:17.062Z,1693503377.062 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-08-31T17:36:17.091Z,1693503377.091 [Default:E.Execute](DEBUG): Construct Execute. 2023-08-31T17:36:17.095Z,1693503377.095 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2023-08-31T17:36:17.104Z,1693503377.104 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-08-31T17:36:17.116Z,1693503377.116 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-08-31T17:36:17.184Z,1693503377.184 [Radio_Surface](INFO): Powering up 2023-08-31T17:36:17.262Z,1693503377.262 [Power24vConverter](INFO): Powering up. 2023-08-31T17:36:17.263Z,1693503377.263 [Sonardyne_Nano](INFO): Initializing. 2023-08-31T17:36:17.318Z,1693503377.318 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-08-31T17:36:17.324Z,1693503377.324 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-08-31T17:36:17.325Z,1693503377.325 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-08-31T17:36:17.332Z,1693503377.332 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-08-31T17:36:17.333Z,1693503377.333 [MassServo](DEBUG): Initializing EZServoServo. 2023-08-31T17:36:17.341Z,1693503377.341 [MassServo](DEBUG): Initializing MassServo. 2023-08-31T17:36:17.342Z,1693503377.342 [RudderServo](DEBUG): Initializing EZServoServo. 2023-08-31T17:36:17.348Z,1693503377.348 [RudderServo](DEBUG): Initializing RudderServo. 2023-08-31T17:36:17.349Z,1693503377.349 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-08-31T17:36:17.356Z,1693503377.356 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-08-31T17:36:18.900Z,1693503378.900 [WetLabsBB2FL](INFO): Powering down 2023-08-31T17:36:19.538Z,1693503379.538 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2023-08-31T17:36:20.777Z,1693503380.777 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2201 2023-08-31T17:36:23.033Z,1693503383.033 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-08-31T17:36:44.593Z,1693503404.593 [NAL9602](INFO): Powering up NAL9602 2023-08-31T17:36:55.502Z,1693503415.502 [NAL9602](INFO): NAL9602 initialized 2023-08-31T17:37:30.729Z,1693503450.729 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T17:37:43.225Z,1693503463.225 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:37:56.156Z,1693503476.156 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:38:19.165Z,1693503499.165 [SBIT](IMPORTANT): Beginning Startup BIT 2023-08-31T17:38:19.169Z,1693503499.169 [CBIT](IMPORTANT): Beginning ground fault scan 2023-08-31T17:38:30.057Z,1693503510.057 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006812 CHAN A1 (24V): -0.007471 CHAN A2 (12V): -0.004551 CHAN A3 (5V): -0.002760 CHAN B0 (3.3V): -0.001128 CHAN B1 (3.15aV): -0.001320 CHAN B2 (3.15bV): -0.001343 CHAN B3 (GND): -0.000497 OPEN: 0.003537 Full Scale: +/- 1 mA 2023-08-31T17:38:49.891Z,1693503529.891 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:39:13.278Z,1693503553.278 [SBIT](IMPORTANT): SBIT PASSED 2023-08-31T17:39:13.279Z,1693503553.279 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-08-31T17:39:13.279Z,1693503553.279 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2023-08-31T17:39:13.280Z,1693503553.280 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=10 minute; 2023-08-31T17:39:13.280Z,1693503553.280 [SBIT](IMPORTANT): Express linearApproximation BackseatComponent.handled_message 1.000000 bool; 2023-08-31T17:39:13.280Z,1693503553.280 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_mean_sea_water_temperature 5.000000 celsius; 2023-08-31T17:39:13.280Z,1693503553.280 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 50.000000 meter; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): Express none platform_roll_angle; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): NAL9602.iridiumMTQueueTimeout=5 minute; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=391.543020 cubic_centimeter; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 angular_degree; 2023-08-31T17:39:13.281Z,1693503553.281 [SBIT](IMPORTANT): VerticalControl.massDefault=25.724938 millimeter; 2023-08-31T17:39:13.685Z,1693503553.685 [MissionManager](IMPORTANT): Started mission Startup 2023-08-31T17:39:13.685Z,1693503553.685 [Startup] Running Loop=1 2023-08-31T17:39:13.686Z,1693503553.686 [Startup](DEBUG): Aggregate::initialize Startup 2023-08-31T17:39:13.686Z,1693503553.686 [Startup:A.GoToSurface] Running Loop=1 2023-08-31T17:39:13.686Z,1693503553.686 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-08-31T17:39:13.686Z,1693503553.686 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-08-31T17:39:13.687Z,1693503553.687 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-08-31T17:39:13.687Z,1693503553.687 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-08-31T17:39:13.687Z,1693503553.687 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-08-31T17:39:13.688Z,1693503553.688 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-08-31T17:39:13.689Z,1693503553.689 [Startup:StartupSatComms] Running Loop=1 2023-08-31T17:39:13.689Z,1693503553.689 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-08-31T17:39:13.689Z,1693503553.689 [Startup:StartupSatComms:A] Running Loop=1 2023-08-31T17:39:14.083Z,1693503554.083 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-08-31T17:39:16.994Z,1693503556.994 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-08-31T17:39:16.994Z,1693503556.994 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:39:17.021Z,1693503557.021 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:39:17.364Z,1693503557.364 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:39:17.364Z,1693503557.364 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-08-31T17:40:13.910Z,1693503613.910 [Startup:StartupSatComms:A](INFO): Timed out from 2023-08-31T17:39:13.7Z 2023-08-31T17:40:13.910Z,1693503613.910 [Startup:StartupSatComms:A] Stopped 2023-08-31T17:40:13.910Z,1693503613.910 [Startup:StartupSatComms:B] Running Loop=1 2023-08-31T17:40:14.306Z,1693503614.306 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-08-31T17:40:54.307Z,1693503654.307 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:41:14.080Z,1693503674.080 [Startup:StartupSatComms:B](INFO): Timed out from 2023-08-31T17:40:13.9Z 2023-08-31T17:41:14.080Z,1693503674.080 [Startup:StartupSatComms:B] Stopped 2023-08-31T17:41:14.080Z,1693503674.080 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-08-31T17:41:14.080Z,1693503674.080 [Startup:StartupSatComms] Stopped 2023-08-31T17:41:14.080Z,1693503674.080 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-08-31T17:41:14.081Z,1693503674.081 [Startup](INFO): Completed Startup 2023-08-31T17:41:14.081Z,1693503674.081 [MissionManager](INFO): Startup is completed. 2023-08-31T17:41:14.081Z,1693503674.081 [MissionManager](INFO): Uninitializing Mission Startup 2023-08-31T17:41:14.081Z,1693503674.081 [Startup] Stopped 2023-08-31T17:41:14.082Z,1693503674.082 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-08-31T17:41:14.082Z,1693503674.082 [Startup:A.GoToSurface] Stopped 2023-08-31T17:41:14.082Z,1693503674.082 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-08-31T17:41:14.477Z,1693503674.477 [MissionManager](IMPORTANT): Started mission Default 2023-08-31T17:41:14.477Z,1693503674.477 [Default] Running Loop=1 2023-08-31T17:41:14.477Z,1693503674.477 [Default](DEBUG): Aggregate::initialize Default 2023-08-31T17:41:14.477Z,1693503674.477 [Default:B.GoToSurface] Running Loop=1 2023-08-31T17:41:14.478Z,1693503674.478 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-08-31T17:41:14.478Z,1693503674.478 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-08-31T17:41:14.478Z,1693503674.478 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-08-31T17:41:14.478Z,1693503674.478 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-08-31T17:41:14.479Z,1693503674.479 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-08-31T17:41:14.479Z,1693503674.479 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-08-31T17:41:14.479Z,1693503674.479 [Default:A.Wait] Running Loop=1 2023-08-31T17:41:14.479Z,1693503674.479 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-08-31T17:41:17.739Z,1693503677.739 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:41:27.800Z,1693503687.800 [Default:A.Wait](INFO): Done Waiting. 2023-08-31T17:41:27.800Z,1693503687.800 [Default:A.Wait] Stopped 2023-08-31T17:41:27.800Z,1693503687.800 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T17:41:28.210Z,1693503688.210 [Default:CheckIn] Running Loop=1 2023-08-31T17:41:28.210Z,1693503688.210 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T17:41:28.210Z,1693503688.210 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T17:41:28.610Z,1693503688.610 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-08-31T17:41:58.906Z,1693503718.906 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-08-31T17:42:17.925Z,1693503737.925 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-08-31T17:42:17.925Z,1693503737.925 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:42:17.935Z,1693503737.935 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:42:18.311Z,1693503738.311 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:42:18.311Z,1693503738.311 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-08-31T17:43:01.972Z,1693503781.972 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T17:43:53.290Z,1693503833.290 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:44:03.792Z,1693503843.792 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T17:44:06.221Z,1693503846.221 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T17:44:16.669Z,1693503856.669 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 5. 2023-08-31T17:44:16.672Z,1693503856.672 [BPC1](INFO): Received data from all battery sticks. 2023-08-31T17:45:18.888Z,1693503918.888 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-08-31T17:45:18.888Z,1693503918.888 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:45:18.899Z,1693503918.899 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:45:19.302Z,1693503919.302 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:45:19.302Z,1693503919.302 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-08-31T17:45:26.818Z,1693503926.818 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004367 2023-08-31T17:46:18.274Z,1693503978.274 [Power24vConverter](INFO): Powering down. 2023-08-31T17:46:28.382Z,1693503988.382 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T17:41:28.2Z 2023-08-31T17:46:28.382Z,1693503988.382 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T17:46:28.382Z,1693503988.382 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T17:46:28.786Z,1693503988.786 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-08-31T17:46:37.145Z,1693503997.145 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230830T161543/Courier0436.lzma 2023-08-31T17:46:38.146Z,1693503998.146 [DataOverHttps](INFO): Moved sent file to Logs/20230830T161543/Courier0436.lzma.bak 2023-08-31T17:46:38.146Z,1693503998.146 [DataOverHttps](INFO): SBD MOMSN=18618591 2023-08-31T17:46:56.321Z,1693504016.321 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T17:46:56.321Z,1693504016.321 [NAL9602] Data Fault, FailCount= 1 2023-08-31T17:46:56.322Z,1693504016.322 [NAL9602](ERROR): Data Fault 2023-08-31T17:46:56.351Z,1693504016.351 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T17:46:56.713Z,1693504016.713 [NAL9602](INFO): Powering down 2023-08-31T17:46:57.578Z,1693504017.578 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T17:46:57.578Z,1693504017.578 [NAL9602] No Fault, FailCount= 1 2023-08-31T17:46:59.751Z,1693504019.751 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20230831T173604/Courier0000.lzma 2023-08-31T17:47:00.754Z,1693504020.754 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0000.lzma.bak 2023-08-31T17:47:00.754Z,1693504020.754 [DataOverHttps](INFO): SBD MOMSN=18618593 2023-08-31T17:47:17.043Z,1693504037.043 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20230831T173604/Courier0004.lzma 2023-08-31T17:47:18.046Z,1693504038.046 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0004.lzma.bak 2023-08-31T17:47:18.046Z,1693504038.046 [DataOverHttps](INFO): SBD MOMSN=18618596 2023-08-31T17:47:27.017Z,1693504047.017 [NAL9602](INFO): Powering up NAL9602 2023-08-31T17:47:35.345Z,1693504055.345 [DataOverHttps](INFO): Sending 246 bytes from file Logs/20230830T161543/Express0437.lzma 2023-08-31T17:47:36.346Z,1693504056.346 [DataOverHttps](INFO): Moved sent file to Logs/20230830T161543/Express0437.lzma.bak 2023-08-31T17:47:36.346Z,1693504056.346 [DataOverHttps](INFO): SBD MOMSN=18618598 2023-08-31T17:47:37.921Z,1693504057.921 [NAL9602](INFO): NAL9602 initialized 2023-08-31T17:47:53.805Z,1693504073.805 [DataOverHttps](INFO): Sending 1039 bytes from file Logs/20230831T173604/Express0001.lzma 2023-08-31T17:47:54.805Z,1693504074.805 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0001.lzma.bak 2023-08-31T17:47:54.806Z,1693504074.806 [DataOverHttps](INFO): SBD MOMSN=18618603 2023-08-31T17:48:14.223Z,1693504094.223 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20230831T173604/Express0005.lzma 2023-08-31T17:48:15.226Z,1693504095.226 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0005.lzma.bak 2023-08-31T17:48:15.227Z,1693504095.227 [DataOverHttps](INFO): SBD MOMSN=18618629 2023-08-31T17:48:18.768Z,1693504098.768 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T17:48:18.768Z,1693504098.768 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T17:48:18.768Z,1693504098.768 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T17:48:19.966Z,1693504099.966 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-08-31T17:48:19.966Z,1693504099.966 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:48:20.009Z,1693504100.009 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:48:20.398Z,1693504100.398 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:48:20.398Z,1693504100.398 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-08-31T17:51:20.974Z,1693504280.974 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2023-08-31T17:51:20.974Z,1693504280.974 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:51:20.999Z,1693504280.999 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:51:21.370Z,1693504281.370 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:51:21.371Z,1693504281.371 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2023-08-31T17:53:19.325Z,1693504399.325 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T17:53:19.325Z,1693504399.325 [Default:CheckIn:C.Wait] Stopped 2023-08-31T17:53:19.325Z,1693504399.325 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T17:53:19.325Z,1693504399.325 [Default:CheckIn:D] Running Loop=1 2023-08-31T17:53:19.746Z,1693504399.746 [Default:CheckIn:D] Stopped 2023-08-31T17:53:19.746Z,1693504399.746 [Default:CheckIn:E] Running Loop=1 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.087814 min 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn:E] Stopped 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn] Stopped 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn](INFO): Running loop #2 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn] Running Loop=2 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T17:53:20.154Z,1693504400.154 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T17:54:21.969Z,1693504461.969 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2023-08-31T17:54:21.969Z,1693504461.969 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:54:21.979Z,1693504461.979 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:54:22.370Z,1693504462.370 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:54:22.371Z,1693504462.371 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2023-08-31T17:57:22.996Z,1693504642.996 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2023-08-31T17:57:22.996Z,1693504642.996 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T17:57:23.015Z,1693504643.015 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T17:57:23.420Z,1693504643.420 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T17:57:23.420Z,1693504643.420 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2023-08-31T17:57:39.542Z,1693504659.542 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T17:57:39.542Z,1693504659.542 [NAL9602] Data Fault, FailCount= 2 2023-08-31T17:57:39.542Z,1693504659.542 [NAL9602](ERROR): Data Fault 2023-08-31T17:57:39.579Z,1693504659.579 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T17:57:39.941Z,1693504659.941 [NAL9602](INFO): Powering down 2023-08-31T17:57:40.775Z,1693504660.775 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T17:57:40.775Z,1693504660.775 [NAL9602] No Fault, FailCount= 2 2023-08-31T17:58:10.246Z,1693504690.246 [NAL9602](INFO): Powering up NAL9602 2023-08-31T17:58:20.347Z,1693504700.347 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T17:53:20.2Z 2023-08-31T17:58:20.347Z,1693504700.347 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T17:58:20.347Z,1693504700.347 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T17:58:21.150Z,1693504701.150 [NAL9602](INFO): NAL9602 initialized 2023-08-31T17:58:28.279Z,1693504708.279 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0007.lzma 2023-08-31T17:58:29.282Z,1693504709.282 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0007.lzma.bak 2023-08-31T17:58:29.282Z,1693504709.282 [DataOverHttps](INFO): SBD MOMSN=18618633 2023-08-31T17:58:50.620Z,1693504730.620 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20230831T173604/Express0008.lzma 2023-08-31T17:58:51.622Z,1693504731.622 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0008.lzma.bak 2023-08-31T17:58:51.622Z,1693504731.622 [DataOverHttps](INFO): SBD MOMSN=18618635 2023-08-31T17:58:55.178Z,1693504735.178 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T17:58:55.178Z,1693504735.178 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T17:58:55.178Z,1693504735.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T18:00:24.055Z,1693504824.055 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2023-08-31T18:00:24.055Z,1693504824.055 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:00:24.066Z,1693504824.066 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:00:24.477Z,1693504824.477 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:00:24.477Z,1693504824.477 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2023-08-31T18:03:25.072Z,1693505005.072 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2023-08-31T18:03:25.072Z,1693505005.072 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:03:25.083Z,1693505005.083 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:03:25.503Z,1693505005.503 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:03:25.503Z,1693505005.503 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2023-08-31T18:03:55.778Z,1693505035.778 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T18:03:55.778Z,1693505035.778 [Default:CheckIn:C.Wait] Stopped 2023-08-31T18:03:55.778Z,1693505035.778 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T18:03:55.778Z,1693505035.778 [Default:CheckIn:D] Running Loop=1 2023-08-31T18:03:56.181Z,1693505036.181 [Default:CheckIn:D] Stopped 2023-08-31T18:03:56.181Z,1693505036.181 [Default:CheckIn:E] Running Loop=1 2023-08-31T18:03:56.606Z,1693505036.606 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.695058 min 2023-08-31T18:03:56.606Z,1693505036.606 [Default:CheckIn:E] Stopped 2023-08-31T18:03:56.606Z,1693505036.606 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T18:03:56.606Z,1693505036.606 [Default:CheckIn] Stopped 2023-08-31T18:03:56.607Z,1693505036.607 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T18:03:56.607Z,1693505036.607 [Default:CheckIn](INFO): Running loop #3 2023-08-31T18:03:56.607Z,1693505036.607 [Default:CheckIn] Running Loop=3 2023-08-31T18:03:56.607Z,1693505036.607 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T18:03:56.607Z,1693505036.607 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T18:06:26.064Z,1693505186.064 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2023-08-31T18:06:26.064Z,1693505186.064 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:06:26.095Z,1693505186.095 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:06:26.477Z,1693505186.477 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:06:26.477Z,1693505186.477 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2023-08-31T18:08:22.005Z,1693505302.005 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T18:08:22.005Z,1693505302.005 [NAL9602] Data Fault, FailCount= 3 2023-08-31T18:08:22.005Z,1693505302.005 [NAL9602](ERROR): Data Fault 2023-08-31T18:08:22.023Z,1693505302.023 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T18:08:22.406Z,1693505302.406 [NAL9602](INFO): Powering down 2023-08-31T18:08:23.246Z,1693505303.246 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T18:08:23.246Z,1693505303.246 [NAL9602] No Fault, FailCount= 3 2023-08-31T18:08:52.721Z,1693505332.721 [NAL9602](INFO): Powering up NAL9602 2023-08-31T18:08:56.750Z,1693505336.750 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T18:03:56.6Z 2023-08-31T18:08:56.750Z,1693505336.750 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T18:08:56.750Z,1693505336.750 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T18:09:03.626Z,1693505343.626 [NAL9602](INFO): NAL9602 initialized 2023-08-31T18:09:04.703Z,1693505344.703 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0010.lzma 2023-08-31T18:09:05.706Z,1693505345.706 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0010.lzma.bak 2023-08-31T18:09:05.706Z,1693505345.706 [DataOverHttps](INFO): SBD MOMSN=18618640 2023-08-31T18:09:25.651Z,1693505365.651 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230831T173604/Express0011.lzma 2023-08-31T18:09:26.653Z,1693505366.653 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0011.lzma.bak 2023-08-31T18:09:26.654Z,1693505366.654 [DataOverHttps](INFO): SBD MOMSN=18618642 2023-08-31T18:09:27.105Z,1693505367.105 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2023-08-31T18:09:27.105Z,1693505367.105 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:09:27.115Z,1693505367.115 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:09:27.523Z,1693505367.523 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:09:27.524Z,1693505367.524 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2023-08-31T18:09:29.937Z,1693505369.937 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T18:09:29.937Z,1693505369.937 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T18:09:29.937Z,1693505369.937 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T18:12:28.094Z,1693505548.094 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2023-08-31T18:12:28.094Z,1693505548.094 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:12:28.104Z,1693505548.104 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:12:28.516Z,1693505548.516 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:12:28.516Z,1693505548.516 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2023-08-31T18:14:30.542Z,1693505670.542 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T18:14:30.542Z,1693505670.542 [Default:CheckIn:C.Wait] Stopped 2023-08-31T18:14:30.542Z,1693505670.542 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T18:14:30.543Z,1693505670.543 [Default:CheckIn:D] Running Loop=1 2023-08-31T18:14:30.958Z,1693505670.958 [Default:CheckIn:D] Stopped 2023-08-31T18:14:30.958Z,1693505670.958 [Default:CheckIn:E] Running Loop=1 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.274677 min 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn:E] Stopped 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn] Stopped 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn](INFO): Running loop #4 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn] Running Loop=4 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T18:14:31.347Z,1693505671.347 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T18:15:29.145Z,1693505729.145 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2023-08-31T18:15:29.145Z,1693505729.145 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:15:29.156Z,1693505729.156 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:15:29.551Z,1693505729.551 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:15:29.551Z,1693505729.551 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2023-08-31T18:18:30.130Z,1693505910.130 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2023-08-31T18:18:30.130Z,1693505910.130 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:18:30.141Z,1693505910.141 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:18:30.538Z,1693505910.538 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:18:30.538Z,1693505910.538 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2023-08-31T18:19:04.449Z,1693505944.449 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T18:19:04.449Z,1693505944.449 [NAL9602] Data Fault, FailCount= 4 2023-08-31T18:19:04.449Z,1693505944.449 [NAL9602](ERROR): Data Fault 2023-08-31T18:19:04.467Z,1693505944.467 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T18:19:04.849Z,1693505944.849 [NAL9602](INFO): Powering down 2023-08-31T18:19:05.678Z,1693505945.678 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T18:19:05.678Z,1693505945.678 [NAL9602] No Fault, FailCount= 4 2023-08-31T18:19:31.525Z,1693505971.525 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T18:14:31.3Z 2023-08-31T18:19:31.525Z,1693505971.525 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T18:19:31.525Z,1693505971.525 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T18:19:35.153Z,1693505975.153 [NAL9602](INFO): Powering up NAL9602 2023-08-31T18:19:39.959Z,1693505979.959 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0013.lzma 2023-08-31T18:19:40.962Z,1693505980.962 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0013.lzma.bak 2023-08-31T18:19:40.962Z,1693505980.962 [DataOverHttps](INFO): SBD MOMSN=18618646 2023-08-31T18:19:46.057Z,1693505986.057 [NAL9602](INFO): NAL9602 initialized 2023-08-31T18:19:58.327Z,1693505998.327 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230831T173604/Express0014.lzma 2023-08-31T18:19:59.330Z,1693505999.330 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0014.lzma.bak 2023-08-31T18:19:59.330Z,1693505999.330 [DataOverHttps](INFO): SBD MOMSN=18618648 2023-08-31T18:20:02.653Z,1693506002.653 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T18:20:02.653Z,1693506002.653 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T18:20:02.654Z,1693506002.654 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T18:21:31.139Z,1693506091.139 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2023-08-31T18:21:31.139Z,1693506091.139 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:21:31.150Z,1693506091.150 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:21:31.565Z,1693506091.565 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:21:31.565Z,1693506091.565 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2023-08-31T18:24:32.133Z,1693506272.133 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2023-08-31T18:24:32.133Z,1693506272.133 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:24:32.144Z,1693506272.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:24:32.554Z,1693506272.554 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:24:32.555Z,1693506272.555 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2023-08-31T18:25:03.241Z,1693506303.241 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T18:25:03.241Z,1693506303.241 [Default:CheckIn:C.Wait] Stopped 2023-08-31T18:25:03.241Z,1693506303.241 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T18:25:03.241Z,1693506303.241 [Default:CheckIn:D] Running Loop=1 2023-08-31T18:25:03.646Z,1693506303.646 [Default:CheckIn:D] Stopped 2023-08-31T18:25:03.646Z,1693506303.646 [Default:CheckIn:E] Running Loop=1 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.819470 min 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn:E] Stopped 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn] Stopped 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn](INFO): Running loop #5 2023-08-31T18:25:04.060Z,1693506304.060 [Default:CheckIn] Running Loop=5 2023-08-31T18:25:04.061Z,1693506304.061 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T18:25:04.061Z,1693506304.061 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T18:27:33.135Z,1693506453.135 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2023-08-31T18:27:33.135Z,1693506453.135 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:27:33.145Z,1693506453.145 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:27:33.557Z,1693506453.557 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:27:33.557Z,1693506453.557 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2023-08-31T18:29:48.466Z,1693506588.466 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T18:29:48.466Z,1693506588.466 [NAL9602] Data Fault, FailCount= 5 2023-08-31T18:29:48.466Z,1693506588.466 [NAL9602](ERROR): Data Fault 2023-08-31T18:29:48.483Z,1693506588.483 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T18:29:48.483Z,1693506588.483 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-08-31T18:29:48.865Z,1693506588.865 [NAL9602](INFO): Powering down 2023-08-31T18:29:48.894Z,1693506588.894 [CommandExec](FAULT): Scheduling is paused 2023-08-31T18:29:48.895Z,1693506588.895 [CBIT](INFO): Critical error at 20230831T182948 2023-08-31T18:29:48.895Z,1693506588.895 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-08-31T18:30:04.233Z,1693506604.233 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T18:25:04.1Z 2023-08-31T18:30:04.233Z,1693506604.233 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T18:30:04.233Z,1693506604.233 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T18:30:12.699Z,1693506612.699 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20230831T173604/Courier0016.lzma 2023-08-31T18:30:13.702Z,1693506613.702 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0016.lzma.bak 2023-08-31T18:30:13.702Z,1693506613.702 [DataOverHttps](INFO): SBD MOMSN=18618652 2023-08-31T18:30:31.299Z,1693506631.299 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20230831T173604/Express0017.lzma 2023-08-31T18:30:32.302Z,1693506632.302 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0017.lzma.bak 2023-08-31T18:30:32.302Z,1693506632.302 [DataOverHttps](INFO): SBD MOMSN=18618655 2023-08-31T18:30:34.148Z,1693506634.148 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2023-08-31T18:30:34.148Z,1693506634.148 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:30:34.167Z,1693506634.167 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:30:34.569Z,1693506634.569 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:30:34.569Z,1693506634.569 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2023-08-31T18:30:35.353Z,1693506635.353 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T18:30:35.353Z,1693506635.353 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T18:30:35.354Z,1693506635.354 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T18:31:48.534Z,1693506708.534 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T18:31:48.534Z,1693506708.534 [NAL9602] No Fault, FailCount= 5 2023-08-31T18:31:48.905Z,1693506708.905 [NAL9602](INFO): Powering up NAL9602 2023-08-31T18:31:59.829Z,1693506719.829 [NAL9602](INFO): NAL9602 initialized 2023-08-31T18:33:35.173Z,1693506815.173 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2023-08-31T18:33:35.173Z,1693506815.173 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:33:35.203Z,1693506815.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:33:35.614Z,1693506815.614 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:33:35.614Z,1693506815.614 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2023-08-31T18:35:35.977Z,1693506935.977 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T18:35:35.977Z,1693506935.977 [Default:CheckIn:C.Wait] Stopped 2023-08-31T18:35:35.978Z,1693506935.978 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T18:35:35.978Z,1693506935.978 [Default:CheckIn:D] Running Loop=1 2023-08-31T18:35:36.373Z,1693506936.373 [Default:CheckIn:D] Stopped 2023-08-31T18:35:36.373Z,1693506936.373 [Default:CheckIn:E] Running Loop=1 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.364929 min 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn:E] Stopped 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn] Stopped 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn](INFO): Running loop #6 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn] Running Loop=6 2023-08-31T18:35:36.788Z,1693506936.788 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T18:35:36.789Z,1693506936.789 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T18:36:36.168Z,1693506996.168 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2023-08-31T18:36:36.168Z,1693506996.168 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:36:36.178Z,1693506996.178 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:36:36.595Z,1693506996.595 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:36:36.595Z,1693506996.595 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2023-08-31T18:39:37.189Z,1693507177.189 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2023-08-31T18:39:37.189Z,1693507177.189 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:39:37.220Z,1693507177.220 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:39:37.598Z,1693507177.598 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:39:37.598Z,1693507177.598 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2023-08-31T18:40:36.975Z,1693507236.975 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T18:35:36.8Z 2023-08-31T18:40:36.975Z,1693507236.975 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T18:40:36.975Z,1693507236.975 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T18:40:48.799Z,1693507248.799 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0019.lzma 2023-08-31T18:40:49.802Z,1693507249.802 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0019.lzma.bak 2023-08-31T18:40:49.802Z,1693507249.802 [DataOverHttps](INFO): SBD MOMSN=18618660 2023-08-31T18:41:07.383Z,1693507267.383 [DataOverHttps](INFO): Sending 109 bytes from file Logs/20230831T173604/Express0020.lzma 2023-08-31T18:41:08.386Z,1693507268.386 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0020.lzma.bak 2023-08-31T18:41:08.386Z,1693507268.386 [DataOverHttps](INFO): SBD MOMSN=18618662 2023-08-31T18:41:11.813Z,1693507271.813 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T18:41:11.813Z,1693507271.813 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T18:41:11.813Z,1693507271.813 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T18:42:00.662Z,1693507320.662 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T18:42:00.662Z,1693507320.662 [NAL9602] Data Fault, FailCount= 1 2023-08-31T18:42:00.662Z,1693507320.662 [NAL9602](ERROR): Data Fault 2023-08-31T18:42:00.727Z,1693507320.727 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T18:42:01.065Z,1693507321.065 [NAL9602](INFO): Powering down 2023-08-31T18:42:01.914Z,1693507321.914 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T18:42:01.914Z,1693507321.914 [NAL9602] No Fault, FailCount= 1 2023-08-31T18:42:31.363Z,1693507351.363 [NAL9602](INFO): Powering up NAL9602 2023-08-31T18:42:38.248Z,1693507358.248 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2023-08-31T18:42:38.248Z,1693507358.248 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:42:38.296Z,1693507358.296 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:42:38.662Z,1693507358.662 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:42:38.662Z,1693507358.662 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2023-08-31T18:42:42.279Z,1693507362.279 [NAL9602](INFO): NAL9602 initialized 2023-08-31T18:45:39.269Z,1693507539.269 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2023-08-31T18:45:39.269Z,1693507539.269 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:45:39.279Z,1693507539.279 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:45:39.683Z,1693507539.683 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:45:39.683Z,1693507539.683 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2023-08-31T18:45:52.576Z,1693507552.576 [BPC1](ERROR): BPC1B: No match for serial number FF1F in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2023-08-31T18:46:05.160Z,1693507565.160 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T18:46:12.387Z,1693507572.387 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T18:46:12.387Z,1693507572.387 [Default:CheckIn:C.Wait] Stopped 2023-08-31T18:46:12.387Z,1693507572.387 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T18:46:12.387Z,1693507572.387 [Default:CheckIn:D] Running Loop=1 2023-08-31T18:46:12.801Z,1693507572.801 [Default:CheckIn:D] Stopped 2023-08-31T18:46:12.801Z,1693507572.801 [Default:CheckIn:E] Running Loop=1 2023-08-31T18:46:13.206Z,1693507573.206 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.972062 min 2023-08-31T18:46:13.206Z,1693507573.206 [Default:CheckIn:E] Stopped 2023-08-31T18:46:13.206Z,1693507573.206 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T18:46:13.206Z,1693507573.206 [Default:CheckIn] Stopped 2023-08-31T18:46:13.206Z,1693507573.206 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T18:46:13.207Z,1693507573.207 [Default:CheckIn](INFO): Running loop #7 2023-08-31T18:46:13.207Z,1693507573.207 [Default:CheckIn] Running Loop=7 2023-08-31T18:46:13.207Z,1693507573.207 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T18:46:13.207Z,1693507573.207 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T18:46:31.827Z,1693507591.827 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T18:47:05.807Z,1693507625.807 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T18:48:40.357Z,1693507720.357 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2023-08-31T18:48:40.357Z,1693507720.357 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:48:40.381Z,1693507720.381 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:48:40.742Z,1693507720.742 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:48:40.742Z,1693507720.742 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2023-08-31T18:50:03.564Z,1693507803.564 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T18:51:13.465Z,1693507873.465 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T18:46:13.2Z 2023-08-31T18:51:13.466Z,1693507873.466 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T18:51:13.466Z,1693507873.466 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T18:51:21.767Z,1693507881.767 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0022.lzma 2023-08-31T18:51:22.770Z,1693507882.770 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0022.lzma.bak 2023-08-31T18:51:22.770Z,1693507882.770 [DataOverHttps](INFO): SBD MOMSN=18618665 2023-08-31T18:51:26.055Z,1693507886.055 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T18:51:38.548Z,1693507898.548 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T18:51:40.731Z,1693507900.731 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0023.lzma 2023-08-31T18:51:41.294Z,1693507901.294 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2023-08-31T18:51:41.294Z,1693507901.294 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:51:41.328Z,1693507901.328 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:51:41.734Z,1693507901.734 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0023.lzma.bak 2023-08-31T18:51:41.734Z,1693507901.734 [DataOverHttps](INFO): SBD MOMSN=18618667 2023-08-31T18:51:41.752Z,1693507901.752 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:51:41.752Z,1693507901.752 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2023-08-31T18:51:47.373Z,1693507907.373 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T18:51:47.373Z,1693507907.373 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T18:51:47.373Z,1693507907.373 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T18:52:05.926Z,1693507925.926 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-08-31T18:52:05.928Z,1693507925.928 [BPC1](INFO): Received data from all battery sticks. 2023-08-31T18:52:43.089Z,1693507963.089 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T18:52:43.089Z,1693507963.089 [NAL9602] Data Fault, FailCount= 2 2023-08-31T18:52:43.089Z,1693507963.089 [NAL9602](ERROR): Data Fault 2023-08-31T18:52:43.106Z,1693507963.106 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T18:52:43.491Z,1693507963.491 [NAL9602](INFO): Powering down 2023-08-31T18:52:44.351Z,1693507964.351 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T18:52:44.351Z,1693507964.351 [NAL9602] No Fault, FailCount= 2 2023-08-31T18:53:13.791Z,1693507993.791 [NAL9602](INFO): Powering up NAL9602 2023-08-31T18:53:24.705Z,1693508004.705 [NAL9602](INFO): NAL9602 initialized 2023-08-31T18:54:42.297Z,1693508082.297 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2023-08-31T18:54:42.297Z,1693508082.297 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:54:42.317Z,1693508082.317 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:54:42.726Z,1693508082.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:54:42.726Z,1693508082.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2023-08-31T18:56:47.973Z,1693508207.973 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T18:56:47.973Z,1693508207.973 [Default:CheckIn:C.Wait] Stopped 2023-08-31T18:56:47.973Z,1693508207.973 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T18:56:47.973Z,1693508207.973 [Default:CheckIn:D] Running Loop=1 2023-08-31T18:56:48.388Z,1693508208.388 [Default:CheckIn:D] Stopped 2023-08-31T18:56:48.388Z,1693508208.388 [Default:CheckIn:E] Running Loop=1 2023-08-31T18:56:48.814Z,1693508208.814 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 75.565169 min 2023-08-31T18:56:48.814Z,1693508208.814 [Default:CheckIn:E] Stopped 2023-08-31T18:56:48.814Z,1693508208.814 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T18:56:48.815Z,1693508208.815 [Default:CheckIn] Stopped 2023-08-31T18:56:48.815Z,1693508208.815 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T18:56:48.815Z,1693508208.815 [Default:CheckIn](INFO): Running loop #8 2023-08-31T18:56:48.815Z,1693508208.815 [Default:CheckIn] Running Loop=8 2023-08-31T18:56:48.815Z,1693508208.815 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T18:56:48.815Z,1693508208.815 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T18:57:43.346Z,1693508263.346 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2023-08-31T18:57:43.346Z,1693508263.346 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T18:57:43.380Z,1693508263.380 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T18:57:43.748Z,1693508263.748 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T18:57:43.748Z,1693508263.748 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2023-08-31T19:00:44.325Z,1693508444.325 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2023-08-31T19:00:44.325Z,1693508444.325 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:00:44.335Z,1693508444.335 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:00:44.741Z,1693508444.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:00:44.741Z,1693508444.741 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2023-08-31T19:01:48.978Z,1693508508.978 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T18:56:48.8Z 2023-08-31T19:01:48.978Z,1693508508.978 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T19:01:48.978Z,1693508508.978 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T19:01:57.323Z,1693508517.323 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20230831T173604/Courier0025.lzma 2023-08-31T19:02:00.175Z,1693508520.175 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0025.lzma.bak 2023-08-31T19:02:00.175Z,1693508520.175 [DataOverHttps](INFO): SBD MOMSN=18618671 2023-08-31T19:02:16.847Z,1693508536.847 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0026.lzma 2023-08-31T19:02:17.850Z,1693508537.850 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0026.lzma.bak 2023-08-31T19:02:17.850Z,1693508537.850 [DataOverHttps](INFO): SBD MOMSN=18618673 2023-08-31T19:02:20.886Z,1693508540.886 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T19:02:20.886Z,1693508540.886 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T19:02:20.886Z,1693508540.886 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T19:03:26.315Z,1693508606.315 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T19:03:26.315Z,1693508606.315 [NAL9602] Data Fault, FailCount= 3 2023-08-31T19:03:26.315Z,1693508606.315 [NAL9602](ERROR): Data Fault 2023-08-31T19:03:26.332Z,1693508606.332 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T19:03:26.714Z,1693508606.714 [NAL9602](INFO): Powering down 2023-08-31T19:03:27.542Z,1693508607.542 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T19:03:27.542Z,1693508607.542 [NAL9602] No Fault, FailCount= 3 2023-08-31T19:03:45.355Z,1693508625.355 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2023-08-31T19:03:45.355Z,1693508625.355 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:03:45.378Z,1693508625.378 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:03:45.741Z,1693508625.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:03:45.742Z,1693508625.742 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2023-08-31T19:03:57.019Z,1693508637.019 [NAL9602](INFO): Powering up NAL9602 2023-08-31T19:04:07.921Z,1693508647.921 [NAL9602](INFO): NAL9602 initialized 2023-08-31T19:06:46.363Z,1693508806.363 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2023-08-31T19:06:46.363Z,1693508806.363 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:06:46.382Z,1693508806.382 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:06:46.774Z,1693508806.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:06:46.774Z,1693508806.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2023-08-31T19:07:21.530Z,1693508841.530 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T19:07:21.530Z,1693508841.530 [Default:CheckIn:C.Wait] Stopped 2023-08-31T19:07:21.530Z,1693508841.530 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T19:07:21.530Z,1693508841.530 [Default:CheckIn:D] Running Loop=1 2023-08-31T19:07:21.922Z,1693508841.922 [Default:CheckIn:D] Stopped 2023-08-31T19:07:21.922Z,1693508841.922 [Default:CheckIn:E] Running Loop=1 2023-08-31T19:07:22.319Z,1693508842.319 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 86.124080 min 2023-08-31T19:07:22.319Z,1693508842.319 [Default:CheckIn:E] Stopped 2023-08-31T19:07:22.319Z,1693508842.319 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T19:07:22.320Z,1693508842.320 [Default:CheckIn] Stopped 2023-08-31T19:07:22.320Z,1693508842.320 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T19:07:22.320Z,1693508842.320 [Default:CheckIn](INFO): Running loop #9 2023-08-31T19:07:22.320Z,1693508842.320 [Default:CheckIn] Running Loop=9 2023-08-31T19:07:22.320Z,1693508842.320 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T19:07:22.320Z,1693508842.320 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T19:09:47.344Z,1693508987.344 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2023-08-31T19:09:47.344Z,1693508987.344 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:09:47.355Z,1693508987.355 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:09:47.771Z,1693508987.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:09:47.771Z,1693508987.771 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2023-08-31T19:12:22.502Z,1693509142.502 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T19:07:22.3Z 2023-08-31T19:12:22.502Z,1693509142.502 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T19:12:22.502Z,1693509142.502 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T19:12:30.447Z,1693509150.447 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0028.lzma 2023-08-31T19:12:31.450Z,1693509151.450 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0028.lzma.bak 2023-08-31T19:12:31.450Z,1693509151.450 [DataOverHttps](INFO): SBD MOMSN=18618677 2023-08-31T19:12:48.411Z,1693509168.411 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2023-08-31T19:12:48.411Z,1693509168.411 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:12:48.422Z,1693509168.422 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:12:48.822Z,1693509168.822 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:12:48.822Z,1693509168.822 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2023-08-31T19:12:51.671Z,1693509171.671 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230831T173604/Express0029.lzma 2023-08-31T19:12:52.674Z,1693509172.674 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0029.lzma.bak 2023-08-31T19:12:52.674Z,1693509172.674 [DataOverHttps](INFO): SBD MOMSN=18618679 2023-08-31T19:12:56.061Z,1693509176.061 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T19:12:56.061Z,1693509176.061 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T19:12:56.061Z,1693509176.061 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T19:14:08.757Z,1693509248.757 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T19:14:08.757Z,1693509248.757 [NAL9602] Data Fault, FailCount= 4 2023-08-31T19:14:08.758Z,1693509248.758 [NAL9602](ERROR): Data Fault 2023-08-31T19:14:08.775Z,1693509248.775 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T19:14:09.165Z,1693509249.165 [NAL9602](INFO): Powering down 2023-08-31T19:14:09.986Z,1693509249.986 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T19:14:09.986Z,1693509249.986 [NAL9602] No Fault, FailCount= 4 2023-08-31T19:14:39.463Z,1693509279.463 [NAL9602](INFO): Powering up NAL9602 2023-08-31T19:14:50.369Z,1693509290.369 [NAL9602](INFO): NAL9602 initialized 2023-08-31T19:15:49.358Z,1693509349.358 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2023-08-31T19:15:49.358Z,1693509349.358 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:15:49.369Z,1693509349.369 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:15:49.775Z,1693509349.775 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:15:49.775Z,1693509349.775 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2023-08-31T19:17:56.671Z,1693509476.671 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T19:17:56.671Z,1693509476.671 [Default:CheckIn:C.Wait] Stopped 2023-08-31T19:17:56.671Z,1693509476.671 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T19:17:56.671Z,1693509476.671 [Default:CheckIn:D] Running Loop=1 2023-08-31T19:17:57.085Z,1693509477.085 [Default:CheckIn:D] Stopped 2023-08-31T19:17:57.085Z,1693509477.085 [Default:CheckIn:E] Running Loop=1 2023-08-31T19:17:57.482Z,1693509477.482 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 96.710124 min 2023-08-31T19:17:57.482Z,1693509477.482 [Default:CheckIn:E] Stopped 2023-08-31T19:17:57.482Z,1693509477.482 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T19:17:57.482Z,1693509477.482 [Default:CheckIn] Stopped 2023-08-31T19:17:57.482Z,1693509477.482 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T19:17:57.483Z,1693509477.483 [Default:CheckIn](INFO): Running loop #10 2023-08-31T19:17:57.483Z,1693509477.483 [Default:CheckIn] Running Loop=10 2023-08-31T19:17:57.483Z,1693509477.483 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T19:17:57.483Z,1693509477.483 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T19:18:50.404Z,1693509530.404 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34 2023-08-31T19:18:50.404Z,1693509530.404 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:18:50.414Z,1693509530.414 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:18:50.830Z,1693509530.830 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:18:50.830Z,1693509530.830 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34 2023-08-31T19:21:51.413Z,1693509711.413 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35 2023-08-31T19:21:51.413Z,1693509711.413 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:21:51.424Z,1693509711.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:21:51.810Z,1693509711.810 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:21:51.810Z,1693509711.810 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35 2023-08-31T19:22:57.667Z,1693509777.667 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T19:17:57.5Z 2023-08-31T19:22:57.667Z,1693509777.667 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T19:22:57.667Z,1693509777.667 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T19:23:05.687Z,1693509785.687 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0031.lzma 2023-08-31T19:23:06.690Z,1693509786.690 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0031.lzma.bak 2023-08-31T19:23:06.690Z,1693509786.690 [DataOverHttps](INFO): SBD MOMSN=18618683 2023-08-31T19:23:24.203Z,1693509804.203 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230831T173604/Express0032.lzma 2023-08-31T19:23:25.206Z,1693509805.206 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0032.lzma.bak 2023-08-31T19:23:25.206Z,1693509805.206 [DataOverHttps](INFO): SBD MOMSN=18618685 2023-08-31T19:23:28.407Z,1693509808.407 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T19:23:28.407Z,1693509808.407 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T19:23:28.407Z,1693509808.407 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T19:24:51.569Z,1693509891.569 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T19:24:51.570Z,1693509891.570 [NAL9602] Data Fault, FailCount= 5 2023-08-31T19:24:51.570Z,1693509891.570 [NAL9602](ERROR): Data Fault 2023-08-31T19:24:51.604Z,1693509891.604 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T19:24:51.604Z,1693509891.604 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-08-31T19:24:51.973Z,1693509891.973 [NAL9602](INFO): Powering down 2023-08-31T19:24:52.012Z,1693509892.012 [CBIT](INFO): Critical error at 20230831T192451 2023-08-31T19:24:52.407Z,1693509892.407 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36 2023-08-31T19:24:52.407Z,1693509892.407 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:24:52.425Z,1693509892.425 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:24:52.838Z,1693509892.838 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:24:52.838Z,1693509892.838 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36 2023-08-31T19:26:51.606Z,1693510011.606 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T19:26:51.606Z,1693510011.606 [NAL9602] No Fault, FailCount= 5 2023-08-31T19:26:51.983Z,1693510011.983 [NAL9602](INFO): Powering up NAL9602 2023-08-31T19:27:02.897Z,1693510022.897 [NAL9602](INFO): NAL9602 initialized 2023-08-31T19:27:53.422Z,1693510073.422 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37 2023-08-31T19:27:53.422Z,1693510073.422 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:27:53.432Z,1693510073.432 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:27:53.848Z,1693510073.848 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:27:53.848Z,1693510073.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37 2023-08-31T19:28:28.971Z,1693510108.971 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T19:28:28.971Z,1693510108.971 [Default:CheckIn:C.Wait] Stopped 2023-08-31T19:28:28.971Z,1693510108.971 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T19:28:28.972Z,1693510108.972 [Default:CheckIn:D] Running Loop=1 2023-08-31T19:28:29.361Z,1693510109.361 [Default:CheckIn:D] Stopped 2023-08-31T19:28:29.361Z,1693510109.361 [Default:CheckIn:E] Running Loop=1 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 107.248063 min 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn:E] Stopped 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn] Stopped 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn](INFO): Running loop #11 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn] Running Loop=11 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T19:28:29.767Z,1693510109.767 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T19:30:54.465Z,1693510254.465 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38 2023-08-31T19:30:54.465Z,1693510254.465 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:30:54.497Z,1693510254.497 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:30:54.867Z,1693510254.867 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:30:54.867Z,1693510254.867 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38 2023-08-31T19:33:29.993Z,1693510409.993 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T19:28:29.8Z 2023-08-31T19:33:29.994Z,1693510409.994 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T19:33:29.994Z,1693510409.994 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T19:33:38.163Z,1693510418.163 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20230831T173604/Courier0034.lzma 2023-08-31T19:33:39.168Z,1693510419.168 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0034.lzma.bak 2023-08-31T19:33:39.169Z,1693510419.169 [DataOverHttps](INFO): SBD MOMSN=18618689 2023-08-31T19:33:55.461Z,1693510435.461 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 39 2023-08-31T19:33:55.461Z,1693510435.461 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:33:55.499Z,1693510435.499 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:33:55.924Z,1693510435.924 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:33:55.924Z,1693510435.924 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 39 2023-08-31T19:33:57.501Z,1693510437.501 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0035.lzma 2023-08-31T19:33:58.498Z,1693510438.498 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0035.lzma.bak 2023-08-31T19:33:58.498Z,1693510438.498 [DataOverHttps](INFO): SBD MOMSN=18618692 2023-08-31T19:34:01.529Z,1693510441.529 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T19:34:01.529Z,1693510441.529 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T19:34:01.529Z,1693510441.529 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T19:36:56.486Z,1693510616.486 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 40 2023-08-31T19:36:56.486Z,1693510616.486 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:36:56.496Z,1693510616.496 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:36:56.875Z,1693510616.875 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:36:56.875Z,1693510616.875 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 40 2023-08-31T19:37:03.734Z,1693510623.734 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T19:37:03.734Z,1693510623.734 [NAL9602] Data Fault, FailCount= 1 2023-08-31T19:37:03.734Z,1693510623.734 [NAL9602](ERROR): Data Fault 2023-08-31T19:37:03.779Z,1693510623.779 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T19:37:04.130Z,1693510624.130 [NAL9602](INFO): Powering down 2023-08-31T19:37:04.981Z,1693510624.981 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T19:37:04.981Z,1693510624.981 [NAL9602] No Fault, FailCount= 1 2023-08-31T19:37:34.430Z,1693510654.430 [NAL9602](INFO): Powering up NAL9602 2023-08-31T19:37:45.342Z,1693510665.342 [NAL9602](INFO): NAL9602 initialized 2023-08-31T19:39:02.119Z,1693510742.119 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T19:39:02.119Z,1693510742.119 [Default:CheckIn:C.Wait] Stopped 2023-08-31T19:39:02.119Z,1693510742.119 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T19:39:02.119Z,1693510742.119 [Default:CheckIn:D] Running Loop=1 2023-08-31T19:39:02.518Z,1693510742.518 [Default:CheckIn:D] Stopped 2023-08-31T19:39:02.518Z,1693510742.518 [Default:CheckIn:E] Running Loop=1 2023-08-31T19:39:02.952Z,1693510742.952 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 117.800675 min 2023-08-31T19:39:02.952Z,1693510742.952 [Default:CheckIn:E] Stopped 2023-08-31T19:39:02.952Z,1693510742.952 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T19:39:02.952Z,1693510742.952 [Default:CheckIn] Stopped 2023-08-31T19:39:02.952Z,1693510742.952 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T19:39:02.953Z,1693510742.953 [Default:CheckIn](INFO): Running loop #12 2023-08-31T19:39:02.953Z,1693510742.953 [Default:CheckIn] Running Loop=12 2023-08-31T19:39:02.953Z,1693510742.953 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T19:39:02.953Z,1693510742.953 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T19:39:57.460Z,1693510797.460 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41 2023-08-31T19:39:57.460Z,1693510797.460 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:39:57.470Z,1693510797.470 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:39:57.875Z,1693510797.875 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:39:57.875Z,1693510797.875 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41 2023-08-31T19:42:58.497Z,1693510978.497 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 42 2023-08-31T19:42:58.497Z,1693510978.497 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:42:58.532Z,1693510978.532 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:42:58.911Z,1693510978.911 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:42:58.911Z,1693510978.911 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 42 2023-08-31T19:44:03.139Z,1693511043.139 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T19:39:02.0Z 2023-08-31T19:44:03.139Z,1693511043.139 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T19:44:03.140Z,1693511043.140 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T19:44:10.947Z,1693511050.947 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0037.lzma 2023-08-31T19:44:11.950Z,1693511051.950 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0037.lzma.bak 2023-08-31T19:44:11.950Z,1693511051.950 [DataOverHttps](INFO): SBD MOMSN=18618696 2023-08-31T19:44:29.419Z,1693511069.419 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0038.lzma 2023-08-31T19:44:30.422Z,1693511070.422 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0038.lzma.bak 2023-08-31T19:44:30.422Z,1693511070.422 [DataOverHttps](INFO): SBD MOMSN=18618698 2023-08-31T19:44:33.845Z,1693511073.845 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T19:44:33.845Z,1693511073.845 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T19:44:33.846Z,1693511073.846 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T19:45:59.503Z,1693511159.503 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 43 2023-08-31T19:45:59.503Z,1693511159.503 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:45:59.513Z,1693511159.513 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:45:59.954Z,1693511159.954 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:45:59.954Z,1693511159.954 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 43 2023-08-31T19:47:46.294Z,1693511266.294 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T19:47:46.294Z,1693511266.294 [NAL9602] Data Fault, FailCount= 2 2023-08-31T19:47:46.294Z,1693511266.294 [NAL9602](ERROR): Data Fault 2023-08-31T19:47:46.361Z,1693511266.361 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T19:47:46.697Z,1693511266.697 [NAL9602](INFO): Powering down 2023-08-31T19:47:47.550Z,1693511267.550 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T19:47:47.550Z,1693511267.550 [NAL9602] No Fault, FailCount= 2 2023-08-31T19:48:17.001Z,1693511297.001 [NAL9602](INFO): Powering up NAL9602 2023-08-31T19:48:27.909Z,1693511307.909 [NAL9602](INFO): NAL9602 initialized 2023-08-31T19:49:00.641Z,1693511340.641 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 44 2023-08-31T19:49:00.641Z,1693511340.641 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:49:00.651Z,1693511340.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:49:01.054Z,1693511341.054 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:49:01.054Z,1693511341.054 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 44 2023-08-31T19:49:34.608Z,1693511374.608 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T19:49:34.608Z,1693511374.608 [Default:CheckIn:C.Wait] Stopped 2023-08-31T19:49:34.608Z,1693511374.608 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T19:49:34.608Z,1693511374.608 [Default:CheckIn:D] Running Loop=1 2023-08-31T19:49:34.994Z,1693511374.994 [Default:CheckIn:D] Stopped 2023-08-31T19:49:34.994Z,1693511374.994 [Default:CheckIn:E] Running Loop=1 2023-08-31T19:49:35.398Z,1693511375.398 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 128.341951 min 2023-08-31T19:49:35.398Z,1693511375.398 [Default:CheckIn:E] Stopped 2023-08-31T19:49:35.398Z,1693511375.398 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T19:49:35.398Z,1693511375.398 [Default:CheckIn] Stopped 2023-08-31T19:49:35.399Z,1693511375.399 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T19:49:35.399Z,1693511375.399 [Default:CheckIn](INFO): Running loop #13 2023-08-31T19:49:35.399Z,1693511375.399 [Default:CheckIn] Running Loop=13 2023-08-31T19:49:35.399Z,1693511375.399 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T19:49:35.399Z,1693511375.399 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T19:52:01.680Z,1693511521.680 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 45 2023-08-31T19:52:01.680Z,1693511521.680 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:52:01.691Z,1693511521.691 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:52:02.102Z,1693511522.102 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:52:02.102Z,1693511522.102 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 45 2023-08-31T19:53:33.021Z,1693511613.021 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T19:54:35.619Z,1693511675.619 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T19:49:35.4Z 2023-08-31T19:54:35.619Z,1693511675.619 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T19:54:35.619Z,1693511675.619 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T19:54:46.531Z,1693511686.531 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0040.lzma 2023-08-31T19:54:47.530Z,1693511687.530 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0040.lzma.bak 2023-08-31T19:54:47.530Z,1693511687.530 [DataOverHttps](INFO): SBD MOMSN=18618702 2023-08-31T19:55:02.748Z,1693511702.748 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 46 2023-08-31T19:55:02.748Z,1693511702.748 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:55:02.787Z,1693511702.787 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:55:03.170Z,1693511703.170 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:55:03.170Z,1693511703.170 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 46 2023-08-31T19:55:06.619Z,1693511706.619 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0041.lzma 2023-08-31T19:55:07.622Z,1693511707.622 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0041.lzma.bak 2023-08-31T19:55:07.622Z,1693511707.622 [DataOverHttps](INFO): SBD MOMSN=18618704 2023-08-31T19:55:10.850Z,1693511710.850 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T19:55:10.850Z,1693511710.850 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T19:55:10.850Z,1693511710.850 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T19:58:02.995Z,1693511882.995 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T19:58:03.764Z,1693511883.764 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 47 2023-08-31T19:58:03.765Z,1693511883.765 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T19:58:03.775Z,1693511883.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T19:58:04.173Z,1693511884.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T19:58:04.173Z,1693511884.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 47 2023-08-31T19:58:29.602Z,1693511909.602 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T19:58:29.602Z,1693511909.602 [NAL9602] Data Fault, FailCount= 3 2023-08-31T19:58:29.602Z,1693511909.602 [NAL9602](ERROR): Data Fault 2023-08-31T19:58:29.648Z,1693511909.648 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T19:58:30.066Z,1693511910.066 [NAL9602](INFO): Powering down 2023-08-31T19:58:30.848Z,1693511910.848 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T19:58:30.848Z,1693511910.848 [NAL9602] No Fault, FailCount= 3 2023-08-31T19:59:00.301Z,1693511940.301 [NAL9602](INFO): Powering up NAL9602 2023-08-31T19:59:10.865Z,1693511950.865 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T19:59:11.233Z,1693511951.233 [NAL9602](INFO): NAL9602 initialized 2023-08-31T19:59:20.909Z,1693511960.909 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-08-31T19:59:20.911Z,1693511960.911 [BPC1](INFO): Received data from all battery sticks. 2023-08-31T20:00:11.445Z,1693512011.445 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T20:00:11.445Z,1693512011.445 [Default:CheckIn:C.Wait] Stopped 2023-08-31T20:00:11.445Z,1693512011.445 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T20:00:11.445Z,1693512011.445 [Default:CheckIn:D] Running Loop=1 2023-08-31T20:00:11.819Z,1693512011.819 [Default:CheckIn:D] Stopped 2023-08-31T20:00:11.819Z,1693512011.819 [Default:CheckIn:E] Running Loop=1 2023-08-31T20:00:12.230Z,1693512012.230 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 138.955697 min 2023-08-31T20:00:12.230Z,1693512012.230 [Default:CheckIn:E] Stopped 2023-08-31T20:00:12.230Z,1693512012.230 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T20:00:12.230Z,1693512012.230 [Default:CheckIn] Stopped 2023-08-31T20:00:12.231Z,1693512012.231 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T20:00:12.231Z,1693512012.231 [Default:CheckIn](INFO): Running loop #14 2023-08-31T20:00:12.231Z,1693512012.231 [Default:CheckIn] Running Loop=14 2023-08-31T20:00:12.231Z,1693512012.231 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T20:00:12.231Z,1693512012.231 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T20:01:04.831Z,1693512064.831 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 48 2023-08-31T20:01:04.831Z,1693512064.831 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:01:04.841Z,1693512064.841 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:01:05.257Z,1693512065.257 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:01:05.257Z,1693512065.257 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 48 2023-08-31T20:04:05.821Z,1693512245.821 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 49 2023-08-31T20:04:05.821Z,1693512245.821 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:04:05.832Z,1693512245.832 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:04:06.242Z,1693512246.242 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:04:06.242Z,1693512246.242 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 49 2023-08-31T20:05:12.481Z,1693512312.481 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T20:00:12.2Z 2023-08-31T20:05:12.481Z,1693512312.481 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T20:05:12.481Z,1693512312.481 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T20:05:20.623Z,1693512320.623 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20230831T173604/Courier0043.lzma 2023-08-31T20:05:21.626Z,1693512321.626 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0043.lzma.bak 2023-08-31T20:05:21.626Z,1693512321.626 [DataOverHttps](INFO): SBD MOMSN=18618708 2023-08-31T20:05:39.055Z,1693512339.055 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20230831T173604/Express0044.lzma 2023-08-31T20:05:40.058Z,1693512340.058 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0044.lzma.bak 2023-08-31T20:05:40.058Z,1693512340.058 [DataOverHttps](INFO): SBD MOMSN=18618710 2023-08-31T20:05:43.225Z,1693512343.225 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T20:05:43.225Z,1693512343.225 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T20:05:43.225Z,1693512343.225 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T20:07:06.841Z,1693512426.841 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 50 2023-08-31T20:07:06.841Z,1693512426.841 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:07:06.860Z,1693512426.860 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:07:07.263Z,1693512427.263 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:07:07.263Z,1693512427.263 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 50 2023-08-31T20:09:12.042Z,1693512552.042 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T20:09:12.042Z,1693512552.042 [NAL9602] Data Fault, FailCount= 4 2023-08-31T20:09:12.042Z,1693512552.042 [NAL9602](ERROR): Data Fault 2023-08-31T20:09:12.059Z,1693512552.059 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T20:09:12.446Z,1693512552.446 [NAL9602](INFO): Powering down 2023-08-31T20:09:13.287Z,1693512553.287 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T20:09:13.287Z,1693512553.287 [NAL9602] No Fault, FailCount= 4 2023-08-31T20:09:42.749Z,1693512582.749 [NAL9602](INFO): Powering up NAL9602 2023-08-31T20:09:53.657Z,1693512593.657 [NAL9602](INFO): NAL9602 initialized 2023-08-31T20:10:07.817Z,1693512607.817 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 51 2023-08-31T20:10:07.817Z,1693512607.817 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:10:07.828Z,1693512607.828 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:10:08.234Z,1693512608.234 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:10:08.234Z,1693512608.234 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 51 2023-08-31T20:10:43.782Z,1693512643.782 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T20:10:43.783Z,1693512643.783 [Default:CheckIn:C.Wait] Stopped 2023-08-31T20:10:43.783Z,1693512643.783 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T20:10:43.783Z,1693512643.783 [Default:CheckIn:D] Running Loop=1 2023-08-31T20:10:44.203Z,1693512644.203 [Default:CheckIn:D] Stopped 2023-08-31T20:10:44.203Z,1693512644.203 [Default:CheckIn:E] Running Loop=1 2023-08-31T20:10:44.612Z,1693512644.612 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 149.495426 min 2023-08-31T20:10:44.612Z,1693512644.612 [Default:CheckIn:E] Stopped 2023-08-31T20:10:44.612Z,1693512644.612 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T20:10:44.612Z,1693512644.612 [Default:CheckIn] Stopped 2023-08-31T20:10:44.612Z,1693512644.612 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T20:10:44.613Z,1693512644.613 [Default:CheckIn](INFO): Running loop #15 2023-08-31T20:10:44.613Z,1693512644.613 [Default:CheckIn] Running Loop=15 2023-08-31T20:10:44.613Z,1693512644.613 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T20:10:44.613Z,1693512644.613 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T20:13:08.829Z,1693512788.829 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 52 2023-08-31T20:13:08.829Z,1693512788.829 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:13:08.839Z,1693512788.839 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:13:09.256Z,1693512789.256 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:13:09.256Z,1693512789.256 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 52 2023-08-31T20:15:44.822Z,1693512944.822 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T20:10:44.6Z 2023-08-31T20:15:44.822Z,1693512944.822 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T20:15:44.823Z,1693512944.823 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T20:15:53.687Z,1693512953.687 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0046.lzma 2023-08-31T20:15:54.690Z,1693512954.690 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0046.lzma.bak 2023-08-31T20:15:54.690Z,1693512954.690 [DataOverHttps](INFO): SBD MOMSN=18618714 2023-08-31T20:16:09.861Z,1693512969.861 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 53 2023-08-31T20:16:09.861Z,1693512969.861 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:16:09.909Z,1693512969.909 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:16:10.278Z,1693512970.278 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:16:10.278Z,1693512970.278 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 53 2023-08-31T20:16:12.587Z,1693512972.587 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0047.lzma 2023-08-31T20:16:13.590Z,1693512973.590 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0047.lzma.bak 2023-08-31T20:16:13.590Z,1693512973.590 [DataOverHttps](INFO): SBD MOMSN=18618716 2023-08-31T20:16:16.734Z,1693512976.734 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T20:16:16.734Z,1693512976.734 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T20:16:16.735Z,1693512976.735 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T20:19:10.882Z,1693513150.882 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 54 2023-08-31T20:19:10.882Z,1693513150.882 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:19:10.893Z,1693513150.893 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:19:11.294Z,1693513151.294 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:19:11.295Z,1693513151.295 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 54 2023-08-31T20:19:54.490Z,1693513194.490 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T20:19:54.490Z,1693513194.490 [NAL9602] Data Fault, FailCount= 5 2023-08-31T20:19:54.490Z,1693513194.490 [NAL9602](ERROR): Data Fault 2023-08-31T20:19:54.507Z,1693513194.507 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T20:19:54.508Z,1693513194.508 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-08-31T20:19:54.902Z,1693513194.902 [NAL9602](INFO): Powering down 2023-08-31T20:19:54.919Z,1693513194.919 [CBIT](INFO): Critical error at 20230831T201954 2023-08-31T20:21:17.328Z,1693513277.328 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T20:21:17.328Z,1693513277.328 [Default:CheckIn:C.Wait] Stopped 2023-08-31T20:21:17.328Z,1693513277.328 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T20:21:17.328Z,1693513277.328 [Default:CheckIn:D] Running Loop=1 2023-08-31T20:21:17.731Z,1693513277.731 [Default:CheckIn:D] Stopped 2023-08-31T20:21:17.731Z,1693513277.731 [Default:CheckIn:E] Running Loop=1 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 160.054232 min 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn:E] Stopped 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn] Stopped 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn](INFO): Running loop #16 2023-08-31T20:21:18.149Z,1693513278.149 [Default:CheckIn] Running Loop=16 2023-08-31T20:21:18.150Z,1693513278.150 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T20:21:18.150Z,1693513278.150 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T20:21:54.507Z,1693513314.507 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T20:21:54.507Z,1693513314.507 [NAL9602] No Fault, FailCount= 5 2023-08-31T20:21:54.889Z,1693513314.889 [NAL9602](INFO): Powering up NAL9602 2023-08-31T20:22:05.798Z,1693513325.798 [NAL9602](INFO): NAL9602 initialized 2023-08-31T20:22:11.868Z,1693513331.868 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 55 2023-08-31T20:22:11.868Z,1693513331.868 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:22:11.899Z,1693513331.899 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:22:12.277Z,1693513332.277 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:22:12.277Z,1693513332.277 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 55 2023-08-31T20:25:12.904Z,1693513512.904 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 56 2023-08-31T20:25:12.904Z,1693513512.904 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:25:12.914Z,1693513512.914 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:25:13.333Z,1693513513.333 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:25:13.334Z,1693513513.334 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 56 2023-08-31T20:26:18.367Z,1693513578.367 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T20:21:18.1Z 2023-08-31T20:26:18.367Z,1693513578.367 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T20:26:18.367Z,1693513578.367 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T20:26:26.279Z,1693513586.279 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20230831T173604/Courier0049.lzma 2023-08-31T20:26:27.282Z,1693513587.282 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0049.lzma.bak 2023-08-31T20:26:27.282Z,1693513587.282 [DataOverHttps](INFO): SBD MOMSN=18618720 2023-08-31T20:26:47.183Z,1693513607.183 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0050.lzma 2023-08-31T20:26:48.186Z,1693513608.186 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0050.lzma.bak 2023-08-31T20:26:48.186Z,1693513608.186 [DataOverHttps](INFO): SBD MOMSN=18618723 2023-08-31T20:26:52.741Z,1693513612.741 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T20:26:52.741Z,1693513612.741 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T20:26:52.741Z,1693513612.741 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T20:28:13.947Z,1693513693.947 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 57 2023-08-31T20:28:13.947Z,1693513693.947 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:28:13.957Z,1693513693.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:28:14.370Z,1693513694.370 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:28:14.370Z,1693513694.370 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 57 2023-08-31T20:31:14.936Z,1693513874.936 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 58 2023-08-31T20:31:14.937Z,1693513874.937 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:31:14.947Z,1693513874.947 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:31:15.337Z,1693513875.337 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:31:15.337Z,1693513875.337 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 58 2023-08-31T20:31:53.322Z,1693513913.322 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T20:31:53.322Z,1693513913.322 [Default:CheckIn:C.Wait] Stopped 2023-08-31T20:31:53.322Z,1693513913.322 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T20:31:53.322Z,1693513913.322 [Default:CheckIn:D] Running Loop=1 2023-08-31T20:31:53.729Z,1693513913.729 [Default:CheckIn:D] Stopped 2023-08-31T20:31:53.730Z,1693513913.730 [Default:CheckIn:E] Running Loop=1 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 170.654199 min 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn:E] Stopped 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn] Stopped 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn](INFO): Running loop #17 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn] Running Loop=17 2023-08-31T20:31:54.127Z,1693513914.127 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T20:31:54.128Z,1693513914.128 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T20:32:06.630Z,1693513926.630 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T20:32:06.630Z,1693513926.630 [NAL9602] Data Fault, FailCount= 1 2023-08-31T20:32:06.630Z,1693513926.630 [NAL9602](ERROR): Data Fault 2023-08-31T20:32:06.661Z,1693513926.661 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T20:32:07.029Z,1693513927.029 [NAL9602](INFO): Powering down 2023-08-31T20:32:07.860Z,1693513927.860 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T20:32:07.860Z,1693513927.860 [NAL9602] No Fault, FailCount= 1 2023-08-31T20:32:37.329Z,1693513957.329 [NAL9602](INFO): Powering up NAL9602 2023-08-31T20:32:48.241Z,1693513968.241 [NAL9602](INFO): NAL9602 initialized 2023-08-31T20:34:15.929Z,1693514055.929 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 59 2023-08-31T20:34:15.929Z,1693514055.929 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:34:15.959Z,1693514055.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:34:16.351Z,1693514056.351 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:34:16.351Z,1693514056.351 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 59 2023-08-31T20:36:54.347Z,1693514214.347 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T20:31:54.1Z 2023-08-31T20:36:54.347Z,1693514214.347 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T20:36:54.347Z,1693514214.347 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T20:37:02.523Z,1693514222.523 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0052.lzma 2023-08-31T20:37:03.526Z,1693514223.526 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0052.lzma.bak 2023-08-31T20:37:03.526Z,1693514223.526 [DataOverHttps](INFO): SBD MOMSN=18618727 2023-08-31T20:37:16.957Z,1693514236.957 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 60 2023-08-31T20:37:16.957Z,1693514236.957 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:37:17.004Z,1693514237.004 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:37:17.378Z,1693514237.378 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:37:17.378Z,1693514237.378 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 60 2023-08-31T20:37:21.043Z,1693514241.043 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0053.lzma 2023-08-31T20:37:22.046Z,1693514242.046 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0053.lzma.bak 2023-08-31T20:37:22.046Z,1693514242.046 [DataOverHttps](INFO): SBD MOMSN=18618729 2023-08-31T20:37:25.445Z,1693514245.445 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T20:37:25.445Z,1693514245.445 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T20:37:25.445Z,1693514245.445 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T20:40:17.941Z,1693514417.941 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 61 2023-08-31T20:40:17.941Z,1693514417.941 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:40:17.972Z,1693514417.972 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:40:18.348Z,1693514418.348 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:40:18.348Z,1693514418.348 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 61 2023-08-31T20:42:26.010Z,1693514546.010 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T20:42:26.010Z,1693514546.010 [Default:CheckIn:C.Wait] Stopped 2023-08-31T20:42:26.010Z,1693514546.010 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T20:42:26.011Z,1693514546.011 [Default:CheckIn:D] Running Loop=1 2023-08-31T20:42:26.427Z,1693514546.427 [Default:CheckIn:D] Stopped 2023-08-31T20:42:26.427Z,1693514546.427 [Default:CheckIn:E] Running Loop=1 2023-08-31T20:42:26.818Z,1693514546.818 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 181.199154 min 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn:E] Stopped 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn] Stopped 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn](INFO): Running loop #18 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn] Running Loop=18 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T20:42:26.819Z,1693514546.819 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T20:42:50.645Z,1693514570.645 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T20:42:50.646Z,1693514570.646 [NAL9602] Data Fault, FailCount= 2 2023-08-31T20:42:50.646Z,1693514570.646 [NAL9602](ERROR): Data Fault 2023-08-31T20:42:50.687Z,1693514570.687 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T20:42:51.045Z,1693514571.045 [NAL9602](INFO): Powering down 2023-08-31T20:42:51.887Z,1693514571.887 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T20:42:51.887Z,1693514571.887 [NAL9602] No Fault, FailCount= 2 2023-08-31T20:43:18.937Z,1693514598.937 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 62 2023-08-31T20:43:18.937Z,1693514598.937 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:43:18.948Z,1693514598.948 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:43:19.362Z,1693514599.362 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:43:19.363Z,1693514599.363 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 62 2023-08-31T20:43:21.345Z,1693514601.345 [NAL9602](INFO): Powering up NAL9602 2023-08-31T20:43:32.258Z,1693514612.258 [NAL9602](INFO): NAL9602 initialized 2023-08-31T20:46:20.025Z,1693514780.025 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 63 2023-08-31T20:46:20.025Z,1693514780.025 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:46:20.035Z,1693514780.035 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:46:20.424Z,1693514780.424 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:46:20.424Z,1693514780.424 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 63 2023-08-31T20:47:27.065Z,1693514847.065 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T20:42:26.8Z 2023-08-31T20:47:27.065Z,1693514847.065 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T20:47:27.065Z,1693514847.065 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T20:47:35.579Z,1693514855.579 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0055.lzma 2023-08-31T20:47:36.582Z,1693514856.582 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0055.lzma.bak 2023-08-31T20:47:36.582Z,1693514856.582 [DataOverHttps](INFO): SBD MOMSN=18618733 2023-08-31T20:47:54.271Z,1693514874.271 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0056.lzma 2023-08-31T20:47:55.274Z,1693514875.274 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0056.lzma.bak 2023-08-31T20:47:55.274Z,1693514875.274 [DataOverHttps](INFO): SBD MOMSN=18618735 2023-08-31T20:47:58.587Z,1693514878.587 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T20:47:58.587Z,1693514878.587 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T20:47:58.587Z,1693514878.587 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T20:49:21.047Z,1693514961.047 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 64 2023-08-31T20:49:21.047Z,1693514961.047 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:49:21.070Z,1693514961.070 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:49:21.498Z,1693514961.498 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:49:21.498Z,1693514961.498 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 64 2023-08-31T20:52:22.049Z,1693515142.049 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 65 2023-08-31T20:52:22.049Z,1693515142.049 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:52:22.060Z,1693515142.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:52:22.430Z,1693515142.430 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:52:22.430Z,1693515142.430 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 65 2023-08-31T20:52:59.189Z,1693515179.189 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T20:52:59.189Z,1693515179.189 [Default:CheckIn:C.Wait] Stopped 2023-08-31T20:52:59.189Z,1693515179.189 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T20:52:59.190Z,1693515179.190 [Default:CheckIn:D] Running Loop=1 2023-08-31T20:52:59.599Z,1693515179.599 [Default:CheckIn:D] Stopped 2023-08-31T20:52:59.599Z,1693515179.599 [Default:CheckIn:E] Running Loop=1 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 191.752018 min 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn:E] Stopped 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn] Stopped 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn](INFO): Running loop #19 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn] Running Loop=19 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T20:53:00.006Z,1693515180.006 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T20:53:33.514Z,1693515213.514 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T20:53:33.514Z,1693515213.514 [NAL9602] Data Fault, FailCount= 3 2023-08-31T20:53:33.515Z,1693515213.515 [NAL9602](ERROR): Data Fault 2023-08-31T20:53:33.533Z,1693515213.533 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T20:53:33.921Z,1693515213.921 [NAL9602](INFO): Powering down 2023-08-31T20:53:34.752Z,1693515214.752 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T20:53:34.752Z,1693515214.752 [NAL9602] No Fault, FailCount= 3 2023-08-31T20:54:04.221Z,1693515244.221 [NAL9602](INFO): Powering up NAL9602 2023-08-31T20:54:15.133Z,1693515255.133 [NAL9602](INFO): NAL9602 initialized 2023-08-31T20:55:23.077Z,1693515323.077 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 66 2023-08-31T20:55:23.077Z,1693515323.077 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:55:23.111Z,1693515323.111 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:55:23.477Z,1693515323.477 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:55:23.477Z,1693515323.477 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 66 2023-08-31T20:58:00.224Z,1693515480.224 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T20:53:00.0Z 2023-08-31T20:58:00.224Z,1693515480.224 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T20:58:00.224Z,1693515480.224 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T20:58:08.903Z,1693515488.903 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0058.lzma 2023-08-31T20:58:09.906Z,1693515489.906 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0058.lzma.bak 2023-08-31T20:58:09.906Z,1693515489.906 [DataOverHttps](INFO): SBD MOMSN=18618739 2023-08-31T20:58:24.068Z,1693515504.068 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 67 2023-08-31T20:58:24.068Z,1693515504.068 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T20:58:24.125Z,1693515504.125 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T20:58:24.502Z,1693515504.502 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T20:58:24.502Z,1693515504.502 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 67 2023-08-31T20:58:29.239Z,1693515509.239 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230831T173604/Express0059.lzma 2023-08-31T20:58:30.242Z,1693515510.242 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0059.lzma.bak 2023-08-31T20:58:30.242Z,1693515510.242 [DataOverHttps](INFO): SBD MOMSN=18618741 2023-08-31T20:58:33.381Z,1693515513.381 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T20:58:33.381Z,1693515513.381 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T20:58:33.381Z,1693515513.381 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:00:48.351Z,1693515648.351 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T21:01:25.138Z,1693515685.138 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 68 2023-08-31T21:01:25.138Z,1693515685.138 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:01:25.168Z,1693515685.168 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:01:25.507Z,1693515685.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:01:25.507Z,1693515685.507 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 68 2023-08-31T21:01:49.347Z,1693515709.347 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T21:02:00.665Z,1693515720.665 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T21:03:33.990Z,1693515813.990 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T21:03:33.990Z,1693515813.990 [Default:CheckIn:C.Wait] Stopped 2023-08-31T21:03:33.990Z,1693515813.990 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:03:33.990Z,1693515813.990 [Default:CheckIn:D] Running Loop=1 2023-08-31T21:03:34.414Z,1693515814.414 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T21:03:34.435Z,1693515814.435 [Default:CheckIn:D] Stopped 2023-08-31T21:03:34.435Z,1693515814.435 [Default:CheckIn:E] Running Loop=1 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 202.332633 min 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn:E] Stopped 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn] Stopped 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn](INFO): Running loop #20 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn] Running Loop=20 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T21:03:34.770Z,1693515814.770 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:04:15.962Z,1693515855.962 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T21:04:15.962Z,1693515855.962 [NAL9602] Data Fault, FailCount= 4 2023-08-31T21:04:15.962Z,1693515855.962 [NAL9602](ERROR): Data Fault 2023-08-31T21:04:16.005Z,1693515856.005 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T21:04:16.373Z,1693515856.373 [NAL9602](INFO): Powering down 2023-08-31T21:04:17.215Z,1693515857.215 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T21:04:17.215Z,1693515857.215 [NAL9602] No Fault, FailCount= 4 2023-08-31T21:04:26.071Z,1693515866.071 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 69 2023-08-31T21:04:26.071Z,1693515866.071 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:04:26.082Z,1693515866.082 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:04:26.495Z,1693515866.495 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:04:26.495Z,1693515866.495 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 69 2023-08-31T21:04:34.996Z,1693515874.996 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-08-31T21:04:46.705Z,1693515886.705 [NAL9602](INFO): Powering up NAL9602 2023-08-31T21:04:57.617Z,1693515897.617 [NAL9602](INFO): NAL9602 initialized 2023-08-31T21:05:22.719Z,1693515922.719 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T21:05:49.789Z,1693515949.789 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-08-31T21:06:03.468Z,1693515963.468 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2023-08-31T21:06:03.471Z,1693515963.471 [BPC1](INFO): Received data from all battery sticks. 2023-08-31T21:07:27.124Z,1693516047.124 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 70 2023-08-31T21:07:27.124Z,1693516047.124 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:07:27.156Z,1693516047.156 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:07:27.519Z,1693516047.519 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:07:27.519Z,1693516047.519 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 70 2023-08-31T21:08:34.987Z,1693516114.987 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T21:03:34.8Z 2023-08-31T21:08:34.987Z,1693516114.987 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T21:08:34.987Z,1693516114.987 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T21:08:45.599Z,1693516125.599 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20230831T173604/Courier0061.lzma 2023-08-31T21:08:46.602Z,1693516126.602 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0061.lzma.bak 2023-08-31T21:08:46.602Z,1693516126.602 [DataOverHttps](INFO): SBD MOMSN=18618745 2023-08-31T21:09:05.579Z,1693516145.579 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20230831T173604/Express0062.lzma 2023-08-31T21:09:06.582Z,1693516146.582 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0062.lzma.bak 2023-08-31T21:09:06.582Z,1693516146.582 [DataOverHttps](INFO): SBD MOMSN=18618747 2023-08-31T21:09:11.814Z,1693516151.814 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T21:09:11.815Z,1693516151.815 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T21:09:11.815Z,1693516151.815 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:10:28.162Z,1693516228.162 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 71 2023-08-31T21:10:28.162Z,1693516228.162 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:10:28.198Z,1693516228.198 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:10:28.566Z,1693516228.566 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:10:28.566Z,1693516228.566 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 71 2023-08-31T21:13:29.145Z,1693516409.145 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 72 2023-08-31T21:13:29.145Z,1693516409.145 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:13:29.155Z,1693516409.155 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:13:29.563Z,1693516409.563 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:13:29.563Z,1693516409.563 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 72 2023-08-31T21:14:12.382Z,1693516452.382 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T21:14:12.382Z,1693516452.382 [Default:CheckIn:C.Wait] Stopped 2023-08-31T21:14:12.382Z,1693516452.382 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:14:12.382Z,1693516452.382 [Default:CheckIn:D] Running Loop=1 2023-08-31T21:14:12.806Z,1693516452.806 [Default:CheckIn:D] Stopped 2023-08-31T21:14:12.806Z,1693516452.806 [Default:CheckIn:E] Running Loop=1 2023-08-31T21:14:13.213Z,1693516453.213 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 212.972135 min 2023-08-31T21:14:13.213Z,1693516453.213 [Default:CheckIn:E] Stopped 2023-08-31T21:14:13.213Z,1693516453.213 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T21:14:13.213Z,1693516453.213 [Default:CheckIn] Stopped 2023-08-31T21:14:13.213Z,1693516453.213 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:14:13.214Z,1693516453.214 [Default:CheckIn](INFO): Running loop #21 2023-08-31T21:14:13.214Z,1693516453.214 [Default:CheckIn] Running Loop=21 2023-08-31T21:14:13.214Z,1693516453.214 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T21:14:13.214Z,1693516453.214 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:14:59.273Z,1693516499.273 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T21:14:59.273Z,1693516499.273 [NAL9602] Data Fault, FailCount= 5 2023-08-31T21:14:59.273Z,1693516499.273 [NAL9602](ERROR): Data Fault 2023-08-31T21:14:59.291Z,1693516499.291 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T21:14:59.291Z,1693516499.291 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-08-31T21:14:59.673Z,1693516499.673 [NAL9602](INFO): Powering down 2023-08-31T21:14:59.711Z,1693516499.711 [CBIT](INFO): Critical error at 20230831T211459 2023-08-31T21:16:30.184Z,1693516590.184 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 73 2023-08-31T21:16:30.184Z,1693516590.184 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:16:30.202Z,1693516590.202 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:16:30.637Z,1693516590.637 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:16:30.637Z,1693516590.637 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 73 2023-08-31T21:16:59.285Z,1693516619.285 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T21:16:59.285Z,1693516619.285 [NAL9602] No Fault, FailCount= 5 2023-08-31T21:16:59.662Z,1693516619.662 [NAL9602](INFO): Powering up NAL9602 2023-08-31T21:17:10.579Z,1693516630.579 [NAL9602](INFO): NAL9602 initialized 2023-08-31T21:19:13.422Z,1693516753.422 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T21:14:13.2Z 2023-08-31T21:19:13.423Z,1693516753.423 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T21:19:13.423Z,1693516753.423 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T21:19:21.243Z,1693516761.243 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20230831T173604/Courier0064.lzma 2023-08-31T21:19:22.246Z,1693516762.246 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0064.lzma.bak 2023-08-31T21:19:22.246Z,1693516762.246 [DataOverHttps](INFO): SBD MOMSN=18618751 2023-08-31T21:19:31.216Z,1693516771.216 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 74 2023-08-31T21:19:31.216Z,1693516771.216 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:19:31.238Z,1693516771.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:19:31.615Z,1693516771.615 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:19:31.615Z,1693516771.615 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 74 2023-08-31T21:19:41.791Z,1693516781.791 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230831T173604/Express0065.lzma 2023-08-31T21:19:42.794Z,1693516782.794 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0065.lzma.bak 2023-08-31T21:19:42.794Z,1693516782.794 [DataOverHttps](INFO): SBD MOMSN=18618754 2023-08-31T21:19:46.141Z,1693516786.141 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T21:19:46.141Z,1693516786.141 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T21:19:46.142Z,1693516786.142 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:22:32.164Z,1693516952.164 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 75 2023-08-31T21:22:32.164Z,1693516952.164 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:22:32.175Z,1693516952.175 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:22:32.610Z,1693516952.610 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:22:32.610Z,1693516952.610 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 75 2023-08-31T21:24:46.758Z,1693517086.758 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T21:24:46.758Z,1693517086.758 [Default:CheckIn:C.Wait] Stopped 2023-08-31T21:24:46.758Z,1693517086.758 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:24:46.758Z,1693517086.758 [Default:CheckIn:D] Running Loop=1 2023-08-31T21:24:47.177Z,1693517087.177 [Default:CheckIn:D] Stopped 2023-08-31T21:24:47.177Z,1693517087.177 [Default:CheckIn:E] Running Loop=1 2023-08-31T21:24:47.588Z,1693517087.588 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 223.544987 min 2023-08-31T21:24:47.588Z,1693517087.588 [Default:CheckIn:E] Stopped 2023-08-31T21:24:47.588Z,1693517087.588 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T21:24:47.588Z,1693517087.588 [Default:CheckIn] Stopped 2023-08-31T21:24:47.588Z,1693517087.588 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:24:47.589Z,1693517087.589 [Default:CheckIn](INFO): Running loop #22 2023-08-31T21:24:47.589Z,1693517087.589 [Default:CheckIn] Running Loop=22 2023-08-31T21:24:47.589Z,1693517087.589 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T21:24:47.589Z,1693517087.589 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:25:33.253Z,1693517133.253 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 76 2023-08-31T21:25:33.254Z,1693517133.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:25:33.299Z,1693517133.299 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:25:33.647Z,1693517133.647 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:25:33.647Z,1693517133.647 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 76 2023-08-31T21:27:12.597Z,1693517232.597 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T21:27:12.597Z,1693517232.597 [NAL9602] Data Fault, FailCount= 1 2023-08-31T21:27:12.597Z,1693517232.597 [NAL9602](ERROR): Data Fault 2023-08-31T21:27:12.615Z,1693517232.615 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T21:27:13.005Z,1693517233.005 [NAL9602](INFO): Powering down 2023-08-31T21:27:13.825Z,1693517233.825 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T21:27:13.826Z,1693517233.826 [NAL9602] No Fault, FailCount= 1 2023-08-31T21:27:43.301Z,1693517263.301 [NAL9602](INFO): Powering up NAL9602 2023-08-31T21:27:54.209Z,1693517274.209 [NAL9602](INFO): NAL9602 initialized 2023-08-31T21:28:34.214Z,1693517314.214 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 77 2023-08-31T21:28:34.214Z,1693517314.214 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:28:34.224Z,1693517314.224 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:28:34.638Z,1693517314.638 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:28:34.638Z,1693517314.638 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 77 2023-08-31T21:29:47.770Z,1693517387.770 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T21:24:47.6Z 2023-08-31T21:29:47.771Z,1693517387.771 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T21:29:47.771Z,1693517387.771 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T21:29:55.695Z,1693517395.695 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0067.lzma 2023-08-31T21:29:56.698Z,1693517396.698 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0067.lzma.bak 2023-08-31T21:29:56.698Z,1693517396.698 [DataOverHttps](INFO): SBD MOMSN=18618758 2023-08-31T21:30:14.215Z,1693517414.215 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230831T173604/Express0068.lzma 2023-08-31T21:30:15.218Z,1693517415.218 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0068.lzma.bak 2023-08-31T21:30:15.218Z,1693517415.218 [DataOverHttps](INFO): SBD MOMSN=18618760 2023-08-31T21:30:18.562Z,1693517418.562 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T21:30:18.562Z,1693517418.562 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T21:30:18.562Z,1693517418.562 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:31:35.257Z,1693517495.257 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 78 2023-08-31T21:31:35.257Z,1693517495.257 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:31:35.267Z,1693517495.267 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:31:35.683Z,1693517495.683 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:31:35.683Z,1693517495.683 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 78 2023-08-31T21:34:36.262Z,1693517676.262 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 79 2023-08-31T21:34:36.262Z,1693517676.262 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:34:36.281Z,1693517676.281 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:34:36.694Z,1693517676.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:34:36.694Z,1693517676.694 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 79 2023-08-31T21:35:19.114Z,1693517719.114 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-08-31T21:35:19.114Z,1693517719.114 [Default:CheckIn:C.Wait] Stopped 2023-08-31T21:35:19.114Z,1693517719.114 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:35:19.114Z,1693517719.114 [Default:CheckIn:D] Running Loop=1 2023-08-31T21:35:19.510Z,1693517719.510 [Default:CheckIn:D] Stopped 2023-08-31T21:35:19.510Z,1693517719.510 [Default:CheckIn:E] Running Loop=1 2023-08-31T21:35:19.914Z,1693517719.914 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 234.083887 min 2023-08-31T21:35:19.914Z,1693517719.914 [Default:CheckIn:E] Stopped 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn] Stopped 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn](INFO): Running loop #23 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn] Running Loop=23 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T21:35:19.915Z,1693517719.915 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:37:37.332Z,1693517857.332 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 80 2023-08-31T21:37:37.332Z,1693517857.332 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:37:37.370Z,1693517857.370 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:37:37.738Z,1693517857.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:37:37.738Z,1693517857.738 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 80 2023-08-31T21:37:55.881Z,1693517875.881 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T21:37:55.882Z,1693517875.882 [NAL9602] Data Fault, FailCount= 2 2023-08-31T21:37:55.882Z,1693517875.882 [NAL9602](ERROR): Data Fault 2023-08-31T21:37:55.899Z,1693517875.899 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T21:37:56.286Z,1693517876.286 [NAL9602](INFO): Powering down 2023-08-31T21:37:57.131Z,1693517877.131 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T21:37:57.131Z,1693517877.131 [NAL9602] No Fault, FailCount= 2 2023-08-31T21:38:26.585Z,1693517906.585 [NAL9602](INFO): Powering up NAL9602 2023-08-31T21:38:37.493Z,1693517917.493 [NAL9602](INFO): NAL9602 initialized 2023-08-31T21:40:20.138Z,1693518020.138 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-08-31T21:35:19.9Z 2023-08-31T21:40:20.139Z,1693518020.139 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T21:40:20.139Z,1693518020.139 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-08-31T21:40:28.059Z,1693518028.059 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230831T173604/Courier0070.lzma 2023-08-31T21:40:29.062Z,1693518029.062 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Courier0070.lzma.bak 2023-08-31T21:40:29.062Z,1693518029.062 [DataOverHttps](INFO): SBD MOMSN=18618764 2023-08-31T21:40:38.320Z,1693518038.320 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 81 2023-08-31T21:40:38.320Z,1693518038.320 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:40:38.339Z,1693518038.339 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:40:38.727Z,1693518038.727 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:40:38.727Z,1693518038.727 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 81 2023-08-31T21:40:50.602Z,1693518050.602 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20230831T173604/Express0071.lzma 2023-08-31T21:40:51.606Z,1693518051.606 [DataOverHttps](INFO): Moved sent file to Logs/20230831T173604/Express0071.lzma.bak 2023-08-31T21:40:51.606Z,1693518051.606 [DataOverHttps](INFO): SBD MOMSN=18618766 2023-08-31T21:40:54.909Z,1693518054.909 [Default:CheckIn:Read_Iridium] Stopped 2023-08-31T21:40:54.909Z,1693518054.909 [Default:CheckIn:C.Wait] Running Loop=1 2023-08-31T21:40:54.909Z,1693518054.909 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:43:39.358Z,1693518219.358 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 82 2023-08-31T21:43:39.358Z,1693518219.358 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:43:39.369Z,1693518219.369 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:43:39.771Z,1693518219.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:43:39.771Z,1693518219.771 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 82 2023-08-31T21:43:50.345Z,1693518230.345 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tx 2023-08-31T21:43:50.345Z,1693518230.345 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tx 2023-08-31T21:43:50.372Z,1693518230.372 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2023-08-31T21:43:50.372Z,1693518230.372 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2023-08-31T21:43:50.373Z,1693518230.373 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Insert/BackseatDriver.tx 2023-08-31T21:43:50.438Z,1693518230.438 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2023-08-31T21:43:50.443Z,1693518230.443 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2023-08-31T21:43:50.471Z,1693518230.471 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface. 2023-08-31T21:43:50.506Z,1693518230.506 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-08-31T21:43:50.509Z,1693518230.509 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-08-31T21:43:50.514Z,1693518230.514 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute. 2023-08-31T21:43:50.526Z,1693518230.526 [MissionManager](DEBUG): 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2023-08-31T21:43:50.529Z,1693518230.529 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tx 2023-08-31T21:43:50.654Z,1693518230.654 [Default] Stopped 2023-08-31T21:43:50.654Z,1693518230.654 [Default](DEBUG): Aggregate::uninitialize Default 2023-08-31T21:43:50.654Z,1693518230.654 [Default:B.GoToSurface] Stopped 2023-08-31T21:43:50.654Z,1693518230.654 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-08-31T21:43:50.654Z,1693518230.654 [Default:CheckIn] Stopped 2023-08-31T21:43:50.654Z,1693518230.654 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:43:50.654Z,1693518230.654 [Default:CheckIn:C.Wait] Stopped 2023-08-31T21:43:50.655Z,1693518230.655 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:43:50.655Z,1693518230.655 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface] Running Loop=1 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface:C.GoToSurface] Running Loop=1 2023-08-31T21:43:50.655Z,1693518230.655 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-08-31T21:43:50.660Z,1693518230.660 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-08-31T21:43:50.660Z,1693518230.660 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-08-31T21:43:50.661Z,1693518230.661 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-08-31T21:43:50.661Z,1693518230.661 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-08-31T21:43:50.661Z,1693518230.661 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-08-31T21:43:50.662Z,1693518230.662 [run_backseat_on_surface:B] Running Loop=1 2023-08-31T21:43:50.662Z,1693518230.662 [run_backseat_on_surface:B] Stopped 2023-08-31T21:43:50.663Z,1693518230.662 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2023-08-31T21:43:50.663Z,1693518230.663 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2023-08-31T21:43:50.720Z,1693518230.720 [BackseatComponent](INFO): Powering up 2023-08-31T21:43:50.721Z,1693518230.721 [BackseatComponent](INFO): Subscribing to LCM channels. 2023-08-31T21:43:51.064Z,1693518231.064 [Power24vConverter](INFO): Powering up. 2023-08-31T21:43:51.079Z,1693518231.079 [run_backseat_on_surface:CheckIn] Running Loop=1 2023-08-31T21:43:51.079Z,1693518231.079 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2023-08-31T21:43:51.079Z,1693518231.079 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:43:51.478Z,1693518231.478 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-08-31T21:46:07.665Z,1693518367.665 [CommandExec](IMPORTANT): got command stop 2023-08-31T21:46:07.665Z,1693518367.665 [CommandExec](IMPORTANT): Scheduling is paused 2023-08-31T21:46:07.665Z,1693518367.665 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2023-08-31T21:46:07.676Z,1693518367.676 [MissionManager](INFO): MissionManager is completed. 2023-08-31T21:46:07.676Z,1693518367.676 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2023-08-31T21:46:07.676Z,1693518367.676 [run_backseat_on_surface] Stopped 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:BackseatDriver] Stopped 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:C.GoToSurface] Stopped 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:CheckIn] Stopped 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2023-08-31T21:46:07.677Z,1693518367.677 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2023-08-31T21:46:08.090Z,1693518368.090 [MissionManager](IMPORTANT): Started mission Default 2023-08-31T21:46:08.091Z,1693518368.091 [Default] Running Loop=1 2023-08-31T21:46:08.091Z,1693518368.091 [Default](DEBUG): Aggregate::initialize Default 2023-08-31T21:46:08.091Z,1693518368.091 [Default:B.GoToSurface] Running Loop=1 2023-08-31T21:46:08.091Z,1693518368.091 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-08-31T21:46:08.091Z,1693518368.091 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-08-31T21:46:08.091Z,1693518368.091 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-08-31T21:46:08.092Z,1693518368.092 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-08-31T21:46:08.092Z,1693518368.092 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-08-31T21:46:08.093Z,1693518368.093 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-08-31T21:46:08.093Z,1693518368.093 [Default:A.Wait] Running Loop=1 2023-08-31T21:46:08.093Z,1693518368.093 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:46:08.540Z,1693518368.540 [BackseatComponent](INFO): Sent LCM shutdown request. 2023-08-31T21:46:21.398Z,1693518381.398 [Default:A.Wait](INFO): Done Waiting. 2023-08-31T21:46:21.398Z,1693518381.398 [Default:A.Wait] Stopped 2023-08-31T21:46:21.398Z,1693518381.398 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:46:21.802Z,1693518381.802 [Default:CheckIn] Running Loop=1 2023-08-31T21:46:21.802Z,1693518381.802 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T21:46:21.802Z,1693518381.802 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:46:23.656Z,1693518383.656 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2023-08-31T21:46:23.657Z,1693518383.657 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2023-08-31T21:46:23.657Z,1693518383.657 [LcmUniversalReporter](INFO): Deactivating messaging. 2023-08-31T21:46:40.405Z,1693518400.405 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 83 2023-08-31T21:46:40.405Z,1693518400.405 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:46:40.451Z,1693518400.451 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:46:40.827Z,1693518400.827 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:46:40.827Z,1693518400.827 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 83 2023-08-31T21:47:00.630Z,1693518420.630 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tx 2023-08-31T21:47:00.631Z,1693518420.631 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tx 2023-08-31T21:47:00.711Z,1693518420.711 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2023-08-31T21:47:00.716Z,1693518420.716 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2023-08-31T21:47:00.716Z,1693518420.716 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Insert/BackseatDriver.tx 2023-08-31T21:47:00.767Z,1693518420.767 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2023-08-31T21:47:00.774Z,1693518420.774 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2023-08-31T21:47:00.795Z,1693518420.795 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface. 2023-08-31T21:47:00.811Z,1693518420.811 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-08-31T21:47:00.817Z,1693518420.817 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-08-31T21:47:00.826Z,1693518420.826 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute. 2023-08-31T21:47:00.838Z,1693518420.838 [MissionManager](DEBUG): 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2023-08-31T21:47:00.844Z,1693518420.844 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tx 2023-08-31T21:47:01.017Z,1693518421.017 [Default] Stopped 2023-08-31T21:47:01.017Z,1693518421.017 [Default](DEBUG): Aggregate::uninitialize Default 2023-08-31T21:47:01.017Z,1693518421.017 [Default:B.GoToSurface] Stopped 2023-08-31T21:47:01.017Z,1693518421.017 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-08-31T21:47:01.017Z,1693518421.017 [Default:CheckIn] Stopped 2023-08-31T21:47:01.017Z,1693518421.017 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:47:01.017Z,1693518421.017 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T21:47:01.017Z,1693518421.017 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface] Running Loop=1 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface:C.GoToSurface] Running Loop=1 2023-08-31T21:47:01.018Z,1693518421.018 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-08-31T21:47:01.019Z,1693518421.019 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-08-31T21:47:01.019Z,1693518421.019 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-08-31T21:47:01.019Z,1693518421.019 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-08-31T21:47:01.019Z,1693518421.019 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-08-31T21:47:01.024Z,1693518421.024 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-08-31T21:47:01.024Z,1693518421.024 [run_backseat_on_surface:B] Running Loop=1 2023-08-31T21:47:01.025Z,1693518421.025 [run_backseat_on_surface:B] Stopped 2023-08-31T21:47:01.025Z,1693518421.025 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2023-08-31T21:47:01.026Z,1693518421.026 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2023-08-31T21:47:01.060Z,1693518421.060 [BackseatComponent](INFO): Powering up 2023-08-31T21:47:01.061Z,1693518421.061 [BackseatComponent](INFO): Subscribing to LCM channels. 2023-08-31T21:47:01.426Z,1693518421.426 [run_backseat_on_surface:CheckIn] Running Loop=1 2023-08-31T21:47:01.426Z,1693518421.426 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2023-08-31T21:47:01.426Z,1693518421.426 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:47:01.822Z,1693518421.822 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-08-31T21:47:21.393Z,1693518441.393 [BackseatComponent](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-08-31T21:47:21.393Z,1693518441.393 [BackseatComponent] Hardware Fault, FailCount= 1 2023-08-31T21:47:21.393Z,1693518441.393 [BackseatComponent](ERROR): Hardware Fault 2023-08-31T21:47:21.394Z,1693518441.394 [BackseatComponent](INFO): Sent LCM shutdown request. 2023-08-31T21:47:21.604Z,1693518441.604 [CBIT](ERROR): Hardware Fault in component: BackseatComponent 2023-08-31T21:47:36.416Z,1693518456.416 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2023-08-31T21:47:36.417Z,1693518456.417 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2023-08-31T21:47:36.417Z,1693518456.417 [LcmUniversalReporter](INFO): Deactivating messaging. 2023-08-31T21:47:51.768Z,1693518471.768 [BackseatComponent](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2023-08-31T21:47:52.172Z,1693518472.172 [BackseatComponent](INFO): Powering up 2023-08-31T21:47:52.172Z,1693518472.172 [BackseatComponent](INFO): Subscribing to LCM channels. 2023-08-31T21:47:52.345Z,1693518472.345 [CBIT](INFO): Clearing failed state for component BackseatComponent 2023-08-31T21:47:52.345Z,1693518472.345 [BackseatComponent] No Fault, FailCount= 1 2023-08-31T21:48:38.353Z,1693518518.353 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-08-31T21:48:38.353Z,1693518518.353 [NAL9602] Data Fault, FailCount= 3 2023-08-31T21:48:38.354Z,1693518518.354 [NAL9602](ERROR): Data Fault 2023-08-31T21:48:38.384Z,1693518518.384 [CBIT](ERROR): Data Fault in component: NAL9602 2023-08-31T21:48:38.745Z,1693518518.745 [NAL9602](INFO): Powering down 2023-08-31T21:48:39.660Z,1693518519.660 [CBIT](INFO): Clearing failed state for component NAL9602 2023-08-31T21:48:39.660Z,1693518519.660 [NAL9602] No Fault, FailCount= 3 2023-08-31T21:49:09.133Z,1693518549.133 [NAL9602](INFO): Powering up NAL9602 2023-08-31T21:49:20.041Z,1693518560.041 [NAL9602](INFO): NAL9602 initialized 2023-08-31T21:49:27.757Z,1693518567.757 [CommandExec](IMPORTANT): got command stop 2023-08-31T21:49:27.757Z,1693518567.757 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2023-08-31T21:49:27.764Z,1693518567.764 [MissionManager](INFO): MissionManager is completed. 2023-08-31T21:49:27.764Z,1693518567.764 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2023-08-31T21:49:27.764Z,1693518567.764 [run_backseat_on_surface] Stopped 2023-08-31T21:49:27.764Z,1693518567.764 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2023-08-31T21:49:27.764Z,1693518567.764 [run_backseat_on_surface:BackseatDriver] Stopped 2023-08-31T21:49:27.764Z,1693518567.764 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2023-08-31T21:49:27.764Z,1693518567.764 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2023-08-31T21:49:27.765Z,1693518567.765 [run_backseat_on_surface:C.GoToSurface] Stopped 2023-08-31T21:49:27.765Z,1693518567.765 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-08-31T21:49:27.765Z,1693518567.765 [run_backseat_on_surface:CheckIn] Stopped 2023-08-31T21:49:27.765Z,1693518567.765 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2023-08-31T21:49:27.765Z,1693518567.765 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2023-08-31T21:49:28.153Z,1693518568.153 [MissionManager](IMPORTANT): Started mission Default 2023-08-31T21:49:28.153Z,1693518568.153 [Default] Running Loop=1 2023-08-31T21:49:28.153Z,1693518568.153 [Default](DEBUG): Aggregate::initialize Default 2023-08-31T21:49:28.154Z,1693518568.154 [Default:B.GoToSurface] Running Loop=1 2023-08-31T21:49:28.154Z,1693518568.154 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-08-31T21:49:28.154Z,1693518568.154 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-08-31T21:49:28.154Z,1693518568.154 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-08-31T21:49:28.154Z,1693518568.154 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-08-31T21:49:28.155Z,1693518568.155 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-08-31T21:49:28.155Z,1693518568.155 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-08-31T21:49:28.156Z,1693518568.156 [Default:A.Wait] Running Loop=1 2023-08-31T21:49:28.156Z,1693518568.156 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-08-31T21:49:30.021Z,1693518570.021 [BackseatComponent](INFO): Sent LCM shutdown request. 2023-08-31T21:49:41.477Z,1693518581.477 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 84 2023-08-31T21:49:41.477Z,1693518581.477 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-08-31T21:49:41.479Z,1693518581.479 [Default:A.Wait](INFO): Done Waiting. 2023-08-31T21:49:41.479Z,1693518581.479 [Default:A.Wait] Stopped 2023-08-31T21:49:41.479Z,1693518581.479 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-08-31T21:49:41.529Z,1693518581.529 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-08-31T21:49:41.879Z,1693518581.879 [Default:CheckIn] Running Loop=1 2023-08-31T21:49:41.879Z,1693518581.879 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-08-31T21:49:41.879Z,1693518581.879 [Default:CheckIn:Read_GPS] Running Loop=1 2023-08-31T21:49:41.888Z,1693518581.888 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-08-31T21:49:41.888Z,1693518581.888 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 84 2023-08-31T21:49:45.124Z,1693518585.124 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec). 2023-08-31T21:49:45.125Z,1693518585.125 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2023-08-31T21:49:45.125Z,1693518585.125 [LcmUniversalReporter](INFO): Deactivating messaging. 2023-08-31T21:49:55.857Z,1693518595.857 [CommandExec](IMPORTANT): got command restart system 2023-08-31T21:49:57.944Z,1693518597.944 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:49:57.944Z,1693518597.944 [CommandExec](INFO): Uninitializing the command executive. 2023-08-31T21:49:57.944Z,1693518597.944 [CommandExec](INFO): Uninitializing the command scheduler. 2023-08-31T21:49:57.945Z,1693518597.945 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:57.976Z,1693518597.976 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-08-31T21:49:57.976Z,1693518597.976 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-08-31T21:49:57.976Z,1693518597.976 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:57.977Z,1693518597.977 [NavChartDb](INFO): Join timeout helper Thread ID is 1620 2023-08-31T21:49:58.240Z,1693518598.240 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:49:58.240Z,1693518598.240 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:58.248Z,1693518598.248 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-08-31T21:49:58.248Z,1693518598.248 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:58.248Z,1693518598.248 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1621 2023-08-31T21:49:58.648Z,1693518598.648 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:49:58.648Z,1693518598.648 [WetLabsBB2FL](INFO): Powering down 2023-08-31T21:49:58.649Z,1693518598.649 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:58.660Z,1693518598.660 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-08-31T21:49:58.660Z,1693518598.660 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:58.660Z,1693518598.660 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1622 2023-08-31T21:49:58.680Z,1693518598.680 [CTD_Seabird](INFO): Powering down 2023-08-31T21:49:58.692Z,1693518598.692 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:49:58.692Z,1693518598.692 [CTD_Seabird](INFO): Powering down 2023-08-31T21:49:58.704Z,1693518598.704 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:58.712Z,1693518598.712 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-08-31T21:49:58.712Z,1693518598.712 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:58.712Z,1693518598.712 [Radio_Surface](INFO): Join timeout helper Thread ID is 1623 2023-08-31T21:49:58.000Z,1693518599.000 [Radio_Surface](INFO): Powering down 2023-08-31T21:49:59.001Z,1693518599.001 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:49:59.001Z,1693518599.001 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:59.008Z,1693518599.008 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-08-31T21:49:59.008Z,1693518599.008 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:59.008Z,1693518599.008 [Onboard](INFO): Join timeout helper Thread ID is 1624 2023-08-31T21:49:59.524Z,1693518599.524 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:49:59.524Z,1693518599.524 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:59.541Z,1693518599.541 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-08-31T21:49:59.541Z,1693518599.541 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:49:59.541Z,1693518599.541 [DataOverHttps](INFO): Join timeout helper Thread ID is 1625 2023-08-31T21:50:01.396Z,1693518601.396 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:50:01.399Z,1693518601.399 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.401Z,1693518601.401 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-08-31T21:50:01.401Z,1693518601.401 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.401Z,1693518601.401 [BackseatComponent](INFO): Join timeout helper Thread ID is 1626 2023-08-31T21:50:01.464Z,1693518601.464 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:50:01.464Z,1693518601.464 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.483Z,1693518601.483 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-08-31T21:50:01.498Z,1693518601.498 [logger ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.498Z,1693518601.498 [logger](INFO): Join timeout helper Thread ID is 1627 2023-08-31T21:50:01.532Z,1693518601.532 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:50:01.532Z,1693518601.532 [logger ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.537Z,1693518601.537 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-08-31T21:50:01.537Z,1693518601.537 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.537Z,1693518601.537 [CommandLine](INFO): Join timeout helper Thread ID is 1628 2023-08-31T21:50:01.548Z,1693518601.548 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:50:01.548Z,1693518601.548 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.556Z,1693518601.556 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-08-31T21:50:01.557Z,1693518601.557 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.557Z,1693518601.557 [CommandExec](INFO): Join timeout helper Thread ID is 1629 2023-08-31T21:50:01.558Z,1693518601.558 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-08-31T21:50:01.558Z,1693518601.558 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.559Z,1693518601.559 [controlThread](INFO): Join timeout helper Thread ID is 1630 2023-08-31T21:50:01.652Z,1693518601.652 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-08-31T21:50:01.652Z,1693518601.652 [controlThread](DEBUG): Uninitializing ControlThread 2023-08-31T21:50:01.653Z,1693518601.653 [AHRS_M2](INFO): Powering down 2023-08-31T21:50:01.725Z,1693518601.725 [NAL9602](INFO): Powering down 2023-08-31T21:50:01.726Z,1693518601.726 [Sonardyne_Nano](INFO): Powering down 2023-08-31T21:50:01.845Z,1693518601.845 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-08-31T21:50:01.845Z,1693518601.845 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-08-31T21:50:01.846Z,1693518601.846 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-08-31T21:50:01.846Z,1693518601.846 [MissionManager](INFO): Uninitializing Mission Default 2023-08-31T21:50:01.847Z,1693518601.847 [Default] Stopped 2023-08-31T21:50:01.847Z,1693518601.847 [Default](DEBUG): Aggregate::uninitialize Default 2023-08-31T21:50:01.847Z,1693518601.847 [Default:B.GoToSurface] Stopped 2023-08-31T21:50:01.847Z,1693518601.847 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-08-31T21:50:01.847Z,1693518601.847 [Default:CheckIn] Stopped 2023-08-31T21:50:01.847Z,1693518601.847 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-08-31T21:50:01.847Z,1693518601.847 [Default:CheckIn:Read_GPS] Stopped 2023-08-31T21:50:01.850Z,1693518601.850 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-08-31T21:50:01.850Z,1693518601.850 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-08-31T21:50:01.851Z,1693518601.851 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-08-31T21:50:01.851Z,1693518601.851 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-08-31T21:50:01.851Z,1693518601.851 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-08-31T21:50:01.852Z,1693518601.852 [BuoyancyServo](INFO): Powering down 2023-08-31T21:50:01.864Z,1693518601.864 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-08-31T21:50:01.864Z,1693518601.864 [ElevatorServo](INFO): Powering down 2023-08-31T21:50:01.865Z,1693518601.865 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-08-31T21:50:01.865Z,1693518601.865 [MassServo](INFO): Powering down 2023-08-31T21:50:01.866Z,1693518601.866 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-08-31T21:50:01.866Z,1693518601.866 [RudderServo](INFO): Powering down 2023-08-31T21:50:01.867Z,1693518601.867 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-08-31T21:50:01.867Z,1693518601.867 [ThrusterHE](INFO): Powering down 2023-08-31T21:50:01.868Z,1693518601.868 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-08-31T21:50:01.869Z,1693518601.869 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-08-31T21:50:01.869Z,1693518601.869 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-08-31T21:50:01.869Z,1693518601.869 [CBIT](DEBUG): Powering off loads. 2023-08-31T21:50:01.880Z,1693518601.880 [CBIT](DEBUG): Disabling WDT. 2023-08-31T21:50:01.892Z,1693518601.892 [CBIT](DEBUG): Opening all GF detection circuits. 2023-08-31T21:50:01.893Z,1693518601.893 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.949Z,1693518601.949 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.951Z,1693518601.951 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:01.958Z,1693518601.958 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:02.005Z,1693518602.005 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:02.045Z,1693518602.045 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:02.050Z,1693518602.050 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:02.084Z,1693518602.084 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-08-31T21:50:02.134Z,1693518602.134 [logger ThreadHandler](INFO): Thread cancelled.