2024-10-14T15:44:51.435Z,1728920691.435 [Supervisor](DEBUG): Initializing supervisor. 2024-10-14T15:44:51.439Z,1728920691.439 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-14T15:44:51.440Z,1728920691.440 [SyncHandler](INFO): Protected caller Thread ID is 3785 2024-10-14T15:44:51.440Z,1728920691.440 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-14T15:44:51.441Z,1728920691.441 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-14T15:44:51.441Z,1728920691.441 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3786 2024-10-14T15:44:51.445Z,1728920691.445 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-14T15:44:51.463Z,1728920691.463 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-14T15:44:51.464Z,1728920691.464 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-14T15:44:51.464Z,1728920691.464 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3787 2024-10-14T15:44:51.469Z,1728920691.469 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-14T15:44:51.469Z,1728920691.469 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-14T15:44:51.470Z,1728920691.470 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3788 2024-10-14T15:44:51.472Z,1728920691.472 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-14T15:44:51.473Z,1728920691.473 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-14T15:44:51.473Z,1728920691.473 [logger ThreadHandler](INFO): Protected caller Thread ID is 3789 2024-10-14T15:44:51.477Z,1728920691.477 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-14T15:44:51.477Z,1728920691.477 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-14T15:44:51.479Z,1728920691.479 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-14T15:44:51.777Z,1728920691.777 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-14T15:44:51.778Z,1728920691.778 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-14T15:44:51.877Z,1728920691.877 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-14T15:44:52.473Z,1728920692.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-14T15:44:52.473Z,1728920692.473 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-14T15:44:52.937Z,1728920692.937 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-14T15:44:52.938Z,1728920692.938 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-14T15:44:53.053Z,1728920693.053 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-14T15:44:53.054Z,1728920693.054 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-14T15:44:53.508Z,1728920693.508 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-14T15:44:53.509Z,1728920693.509 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-14T15:44:53.751Z,1728920693.751 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-14T15:44:53.752Z,1728920693.752 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-14T15:44:54.364Z,1728920694.364 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-14T15:44:54.365Z,1728920694.365 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-14T15:44:54.522Z,1728920694.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-14T15:44:54.522Z,1728920694.522 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-14T15:44:54.617Z,1728920694.617 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-14T15:44:55.530Z,1728920695.530 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-14T15:44:55.531Z,1728920695.531 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-14T15:44:55.955Z,1728920695.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-14T15:44:55.956Z,1728920695.956 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-14T15:44:56.219Z,1728920696.219 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-14T15:44:56.219Z,1728920696.219 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-14T15:44:56.445Z,1728920696.445 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-14T15:44:56.445Z,1728920696.445 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-14T15:44:56.914Z,1728920696.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-14T15:44:56.914Z,1728920696.914 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-14T15:44:57.302Z,1728920697.302 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-14T15:44:57.304Z,1728920697.304 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2024-10-14T15:44:57.305Z,1728920697.305 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2024-10-14T15:44:57.412Z,1728920697.412 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2024-10-14T15:44:57.514Z,1728920697.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2024-10-14T15:44:57.634Z,1728920697.634 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2024-10-14T15:44:57.733Z,1728920697.733 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2024-10-14T15:44:57.854Z,1728920697.854 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2024-10-14T15:44:57.963Z,1728920697.963 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2024-10-14T15:44:58.100Z,1728920698.100 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2024-10-14T15:44:58.280Z,1728920698.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2024-10-14T15:44:58.454Z,1728920698.454 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2024-10-14T15:44:58.584Z,1728920698.584 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2024-10-14T15:44:58.867Z,1728920698.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-14T15:44:58.869Z,1728920698.869 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2024-10-14T15:44:58.869Z,1728920698.869 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-14T15:44:58.879Z,1728920698.879 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-14T15:44:58.935Z,1728920698.935 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-14T15:44:58.994Z,1728920698.994 [VerticalControl] Loaded 2024-10-14T15:44:58.995Z,1728920698.995 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-14T15:44:58.997Z,1728920698.997 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-14T15:44:59.044Z,1728920699.044 [HorizontalControl] Loaded 2024-10-14T15:44:59.044Z,1728920699.044 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-14T15:44:59.046Z,1728920699.046 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-14T15:44:59.049Z,1728920699.049 [SpeedControl] Loaded 2024-10-14T15:44:59.050Z,1728920699.050 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-14T15:44:59.052Z,1728920699.052 [LoopControl](DEBUG): Construct LoopControl. 2024-10-14T15:44:59.053Z,1728920699.053 [LoopControl] Loaded 2024-10-14T15:44:59.053Z,1728920699.053 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-14T15:44:59.053Z,1728920699.053 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-14T15:44:59.054Z,1728920699.054 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-14T15:44:59.064Z,1728920699.064 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-14T15:44:59.065Z,1728920699.065 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-14T15:44:59.243Z,1728920699.243 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-14T15:44:59.244Z,1728920699.244 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-14T15:44:59.379Z,1728920699.379 [BuoyancyServo] Loaded 2024-10-14T15:44:59.379Z,1728920699.379 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-14T15:44:59.401Z,1728920699.401 [ElevatorServo] Loaded 2024-10-14T15:44:59.401Z,1728920699.401 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-14T15:44:59.423Z,1728920699.423 [MassServo] Loaded 2024-10-14T15:44:59.423Z,1728920699.423 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-14T15:44:59.446Z,1728920699.446 [RudderServo] Loaded 2024-10-14T15:44:59.446Z,1728920699.446 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-14T15:44:59.463Z,1728920699.463 [ThrusterHE] Loaded 2024-10-14T15:44:59.463Z,1728920699.463 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-10-14T15:44:59.463Z,1728920699.463 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-14T15:44:59.464Z,1728920699.464 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-14T15:44:59.576Z,1728920699.576 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-14T15:44:59.577Z,1728920699.577 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-14T15:44:59.590Z,1728920699.590 [NavChart] Loaded 2024-10-14T15:44:59.591Z,1728920699.591 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-14T15:44:59.596Z,1728920699.596 [UniversalFixResidualReporter] Loaded 2024-10-14T15:44:59.596Z,1728920699.596 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-14T15:44:59.597Z,1728920699.597 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-14T15:44:59.597Z,1728920699.597 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-14T15:44:59.670Z,1728920699.670 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-14T15:44:59.670Z,1728920699.670 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-14T15:45:00.160Z,1728920700.160 [AHRS_M2] Loaded 2024-10-14T15:45:00.161Z,1728920700.161 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-14T15:45:00.986Z,1728920700.986 [BPC1] Loaded 2024-10-14T15:45:00.986Z,1728920700.986 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-14T15:45:01.075Z,1728920701.075 [DATMMP] Loaded 2024-10-14T15:45:01.075Z,1728920701.075 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2024-10-14T15:45:01.076Z,1728920701.076 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 4094C4E0 2024-10-14T15:45:01.077Z,1728920701.077 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 3872 2024-10-14T15:45:01.149Z,1728920701.149 [DataOverHttps] Loaded 2024-10-14T15:45:01.149Z,1728920701.149 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-14T15:45:01.150Z,1728920701.150 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4097C4E0 2024-10-14T15:45:01.150Z,1728920701.150 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3873 2024-10-14T15:45:01.173Z,1728920701.173 [Depth_Keller] Loaded 2024-10-14T15:45:01.173Z,1728920701.173 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-14T15:45:01.178Z,1728920701.178 [DropWeight] Loaded 2024-10-14T15:45:01.179Z,1728920701.179 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-10-14T15:45:01.245Z,1728920701.245 [NAL9602] Loaded 2024-10-14T15:45:01.245Z,1728920701.245 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-14T15:45:01.276Z,1728920701.276 [Onboard] Loaded 2024-10-14T15:45:01.276Z,1728920701.276 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-14T15:45:01.277Z,1728920701.277 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409AC4E0 2024-10-14T15:45:01.278Z,1728920701.278 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3874 2024-10-14T15:45:01.284Z,1728920701.284 [PowerOnly](INFO): Adding load control power supply at /dev/loadC1 2024-10-14T15:45:01.299Z,1728920701.299 [PowerOnly] Loaded 2024-10-14T15:45:01.299Z,1728920701.299 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2024-10-14T15:45:01.314Z,1728920701.314 [Power24vConverter] Loaded 2024-10-14T15:45:01.314Z,1728920701.314 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-14T15:45:01.330Z,1728920701.330 [Radio_Surface] Loaded 2024-10-14T15:45:01.330Z,1728920701.330 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-14T15:45:01.331Z,1728920701.331 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409DC4E0 2024-10-14T15:45:01.331Z,1728920701.331 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3875 2024-10-14T15:45:01.332Z,1728920701.332 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-14T15:45:01.333Z,1728920701.333 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-14T15:45:01.554Z,1728920701.554 [DepthRateCalculator] Loaded 2024-10-14T15:45:01.554Z,1728920701.554 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-14T15:45:01.570Z,1728920701.570 [PitchRateCalculator] Loaded 2024-10-14T15:45:01.570Z,1728920701.570 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-14T15:45:01.587Z,1728920701.587 [SpeedCalculator] Loaded 2024-10-14T15:45:01.588Z,1728920701.588 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-14T15:45:01.635Z,1728920701.635 [YawRateCalculator] Loaded 2024-10-14T15:45:01.635Z,1728920701.635 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-14T15:45:01.709Z,1728920701.709 [ElevatorOffsetCalculator] Loaded 2024-10-14T15:45:01.709Z,1728920701.709 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-14T15:45:01.710Z,1728920701.710 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-14T15:45:01.710Z,1728920701.710 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-14T15:45:02.063Z,1728920702.063 [CTD_Seabird] Loaded 2024-10-14T15:45:02.064Z,1728920702.064 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-10-14T15:45:02.065Z,1728920702.065 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A984E0 2024-10-14T15:45:02.065Z,1728920702.065 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3876 2024-10-14T15:45:02.088Z,1728920702.088 [PAR_Licor] Loaded 2024-10-14T15:45:02.089Z,1728920702.089 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-14T15:45:02.133Z,1728920702.133 [WetLabsBB2FL] Loaded 2024-10-14T15:45:02.133Z,1728920702.133 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-10-14T15:45:02.134Z,1728920702.134 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AC84E0 2024-10-14T15:45:02.134Z,1728920702.134 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3877 2024-10-14T15:45:02.135Z,1728920702.135 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-14T15:45:02.136Z,1728920702.136 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-14T15:45:02.164Z,1728920702.164 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-14T15:45:02.164Z,1728920702.164 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-14T15:45:02.520Z,1728920702.520 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-14T15:45:02.521Z,1728920702.521 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-14T15:45:02.696Z,1728920702.696 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-14T15:45:02.705Z,1728920702.705 [SBIT] Loaded 2024-10-14T15:45:02.705Z,1728920702.705 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-14T15:45:02.708Z,1728920702.708 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-14T15:45:02.721Z,1728920702.721 [IBIT] Loaded 2024-10-14T15:45:02.721Z,1728920702.721 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-14T15:45:02.727Z,1728920702.727 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-14T15:45:02.831Z,1728920702.831 [CBIT] Loaded 2024-10-14T15:45:02.831Z,1728920702.831 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-14T15:45:02.831Z,1728920702.831 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-14T15:45:02.832Z,1728920702.832 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-14T15:45:02.978Z,1728920702.978 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-14T15:45:02.985Z,1728920702.985 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-14T15:45:02.987Z,1728920702.987 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-14T15:45:02.999Z,1728920702.999 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-14T15:45:02.000Z,1728920703.000 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0 2024-10-14T15:45:03.000Z,1728920703.000 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3878 2024-10-14T15:45:03.005Z,1728920703.005 [Supervisor](INFO): Main Thread ID is 3784 2024-10-14T15:45:03.005Z,1728920703.005 [Supervisor](DEBUG): Running supervisor. 2024-10-14T15:45:03.006Z,1728920703.006 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3879 2024-10-14T15:45:03.006Z,1728920703.006 [CommandExec](INFO): Initializing the command executive. 2024-10-14T15:45:03.008Z,1728920703.008 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3880 2024-10-14T15:45:03.010Z,1728920703.010 [controlThread ThreadHandler](INFO): Handler Thread ID is 3881 2024-10-14T15:45:03.010Z,1728920703.010 [controlThread](DEBUG): Initializing ControlThread 2024-10-14T15:45:03.011Z,1728920703.011 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-14T15:45:03.013Z,1728920703.013 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-14T15:45:03.013Z,1728920703.013 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-14T15:45:03.014Z,1728920703.014 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-14T15:45:03.016Z,1728920703.016 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-14T15:45:03.016Z,1728920703.016 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-14T15:45:03.023Z,1728920703.023 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-14T15:45:03.023Z,1728920703.023 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-14T15:45:03.024Z,1728920703.024 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-14T15:45:03.024Z,1728920703.024 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-14T15:45:03.024Z,1728920703.024 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-14T15:45:03.029Z,1728920703.029 [SBIT](INFO): Initialize SBIT Component. 2024-10-14T15:45:03.029Z,1728920703.029 [SBIT](IMPORTANT): git: 2024-09-16_D 2024-10-14T15:45:03.030Z,1728920703.030 [SBIT](INFO): git hash: 0de9f8b4fab077d10194b536abee104cbdf12c92 2024-10-14T15:45:03.030Z,1728920703.030 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-14T15:45:03.031Z,1728920703.031 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-10-14T15:45:03.032Z,1728920703.032 [SBIT](INFO): Beginning SBIT in 39.000000 seconds. 2024-10-14T15:45:03.033Z,1728920703.033 [IBIT](INFO): Initialize IBIT Component. 2024-10-14T15:45:03.034Z,1728920703.034 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-14T15:45:03.034Z,1728920703.034 [logger ThreadHandler](INFO): Handler Thread ID is 3882 2024-10-14T15:45:03.045Z,1728920703.045 [CBIT](DEBUG): Initialized mux pins. 2024-10-14T15:45:03.045Z,1728920703.045 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-14T15:45:03.053Z,1728920703.053 [DATMMP ThreadHandler](INFO): Handler Thread ID is 3883 2024-10-14T15:45:03.054Z,1728920703.054 [DATMMP](INFO): Start 2024-10-14T15:45:03.054Z,1728920703.054 [DATMMP](INFO): Powering up 2024-10-14T15:45:03.054Z,1728920703.054 [DATMMP](DEBUG): Initializing DATMMP. 2024-10-14T15:45:03.058Z,1728920703.058 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3885 2024-10-14T15:45:03.060Z,1728920703.060 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-14T15:45:03.069Z,1728920703.069 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-14T15:45:03.069Z,1728920703.069 [CBIT](DEBUG): Initializing heartbeat. 2024-10-14T15:45:03.070Z,1728920703.070 [Onboard ThreadHandler](INFO): Handler Thread ID is 3886 2024-10-14T15:45:03.092Z,1728920703.092 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3887 2024-10-14T15:45:03.101Z,1728920703.101 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3888 2024-10-14T15:45:03.102Z,1728920703.102 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-10-14T15:45:03.105Z,1728920703.105 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3890 2024-10-14T15:45:03.110Z,1728920703.110 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3892 2024-10-14T15:45:03.110Z,1728920703.110 [WetLabsBB2FL](INFO): Powering up 2024-10-14T15:45:03.115Z,1728920703.115 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-10-14T15:45:03.116Z,1728920703.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-10-14T15:45:03.116Z,1728920703.116 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-10-14T15:45:03.116Z,1728920703.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-10-14T15:45:03.116Z,1728920703.116 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-10-14T15:45:03.116Z,1728920703.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-10-14T15:45:03.117Z,1728920703.117 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-10-14T15:45:03.117Z,1728920703.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-10-14T15:45:03.141Z,1728920703.141 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-14T15:45:03.141Z,1728920703.141 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-14T15:45:03.181Z,1728920703.181 [CBIT](DEBUG): Backplane powered. 2024-10-14T15:45:03.182Z,1728920703.182 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-14T15:45:03.182Z,1728920703.182 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-10-14T15:45:03.183Z,1728920703.183 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-10-14T15:45:03.189Z,1728920703.189 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-10-14T15:45:03.232Z,1728920703.232 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-10-14T15:45:03.245Z,1728920703.245 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-14T15:45:03.281Z,1728920703.281 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-10-14T15:45:03.282Z,1728920703.282 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-10-14T15:45:03.282Z,1728920703.282 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-10-14T15:45:03.285Z,1728920703.285 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-10-14T15:45:03.305Z,1728920703.305 [DATMMP](INFO): Starting 2024-10-14T15:45:03.505Z,1728920703.505 [Radio_Surface](INFO): Powering up 2024-10-14T15:45:03.557Z,1728920703.557 [DATMMP](INFO): Starting 2024-10-14T15:45:03.598Z,1728920703.598 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-10-14T15:45:03.620Z,1728920703.620 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-14T15:45:03.633Z,1728920703.633 [Default:A.Wait](DEBUG): Construct Wait. 2024-10-14T15:45:03.636Z,1728920703.636 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-14T15:45:03.695Z,1728920703.695 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-14T15:45:03.710Z,1728920703.710 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-14T15:45:03.716Z,1728920703.716 [Default:E.Execute](DEBUG): Construct Execute. 2024-10-14T15:45:03.735Z,1728920703.735 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-10-14T15:45:03.739Z,1728920703.739 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,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,Reporter,LogSplitter, 2024-10-14T15:45:03.766Z,1728920703.766 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-14T15:45:03.809Z,1728920703.809 [DATMMP](INFO): Starting 2024-10-14T15:45:03.830Z,1728920703.830 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1831.023193 decibar, 0.000000 m 2024-10-14T15:45:03.831Z,1728920703.831 [PowerOnly](INFO): Powering up loadControl 2024-10-14T15:45:03.849Z,1728920703.849 [Power24vConverter](INFO): Powering up. 2024-10-14T15:45:03.855Z,1728920703.855 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-10-14T15:45:03.889Z,1728920703.889 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-14T15:45:03.897Z,1728920703.897 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-14T15:45:03.898Z,1728920703.898 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-14T15:45:03.905Z,1728920703.905 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-14T15:45:03.907Z,1728920703.907 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-14T15:45:03.914Z,1728920703.914 [MassServo](DEBUG): Initializing MassServo. 2024-10-14T15:45:03.915Z,1728920703.915 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-14T15:45:03.921Z,1728920703.921 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-14T15:45:03.922Z,1728920703.922 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-10-14T15:45:03.929Z,1728920703.929 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-10-14T15:45:04.061Z,1728920704.061 [DATMMP](INFO): Starting 2024-10-14T15:45:04.179Z,1728920704.179 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-10-14T15:45:04.179Z,1728920704.179 [DropWeight] Hardware Fault, FailCount= 1 2024-10-14T15:45:04.179Z,1728920704.179 [DropWeight](ERROR): Hardware Fault 2024-10-14T15:45:04.215Z,1728920704.215 [CommandExec](FAULT): Scheduling is paused 2024-10-14T15:45:04.223Z,1728920704.223 [CBIT](INFO): Critical error at 20241014T154504 2024-10-14T15:45:04.224Z,1728920704.224 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-10-14T15:45:04.234Z,1728920704.234 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-10-14T15:45:04.235Z,1728920704.235 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-10-14T15:45:04.313Z,1728920704.313 [DATMMP](INFO): Starting 2024-10-14T15:45:04.565Z,1728920704.565 [DATMMP](INFO): Starting 2024-10-14T15:45:04.580Z,1728920704.580 [CBIT](INFO): Critical error at 20241014T154504 2024-10-14T15:45:04.817Z,1728920704.817 [DATMMP](INFO): Starting 2024-10-14T15:45:05.070Z,1728920705.070 [DATMMP](INFO): Starting 2024-10-14T15:45:05.321Z,1728920705.321 [DATMMP](INFO): Starting 2024-10-14T15:45:05.573Z,1728920705.573 [DATMMP](INFO): Starting 2024-10-14T15:45:05.721Z,1728920705.721 [WetLabsBB2FL](INFO): Powering down 2024-10-14T15:45:05.825Z,1728920705.825 [DATMMP](INFO): Starting 2024-10-14T15:45:06.077Z,1728920706.077 [DATMMP](INFO): Starting 2024-10-14T15:45:06.329Z,1728920706.329 [DATMMP](INFO): Starting 2024-10-14T15:45:06.581Z,1728920706.581 [DATMMP](INFO): Starting 2024-10-14T15:45:06.833Z,1728920706.833 [DATMMP](INFO): Starting 2024-10-14T15:45:07.085Z,1728920707.085 [DATMMP](INFO): Starting 2024-10-14T15:45:07.337Z,1728920707.337 [DATMMP](INFO): Starting 2024-10-14T15:45:07.589Z,1728920707.589 [DATMMP](INFO): Starting 2024-10-14T15:45:07.841Z,1728920707.841 [DATMMP](INFO): Starting 2024-10-14T15:45:08.093Z,1728920708.093 [DATMMP](INFO): Starting 2024-10-14T15:45:08.346Z,1728920708.346 [DATMMP](INFO): Starting 2024-10-14T15:45:08.597Z,1728920708.597 [DATMMP](INFO): Starting 2024-10-14T15:45:08.849Z,1728920708.849 [DATMMP](INFO): Starting 2024-10-14T15:45:09.101Z,1728920709.101 [DATMMP](INFO): Starting 2024-10-14T15:45:09.353Z,1728920709.353 [DATMMP](INFO): Starting 2024-10-14T15:45:09.605Z,1728920709.605 [DATMMP](INFO): Starting 2024-10-14T15:45:09.665Z,1728920709.665 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-10-14T15:45:09.857Z,1728920709.857 [DATMMP](INFO): Starting 2024-10-14T15:45:10.109Z,1728920710.109 [DATMMP](INFO): Starting 2024-10-14T15:45:10.361Z,1728920710.361 [DATMMP](INFO): Starting 2024-10-14T15:45:10.613Z,1728920710.613 [DATMMP](INFO): Starting 2024-10-14T15:45:10.865Z,1728920710.865 [DATMMP](INFO): Starting 2024-10-14T15:45:11.117Z,1728920711.117 [DATMMP](INFO): Starting 2024-10-14T15:45:11.369Z,1728920711.369 [DATMMP](INFO): Starting 2024-10-14T15:45:11.621Z,1728920711.621 [DATMMP](INFO): Starting 2024-10-14T15:45:11.873Z,1728920711.873 [DATMMP](INFO): Starting 2024-10-14T15:45:12.125Z,1728920712.125 [DATMMP](INFO): Starting 2024-10-14T15:45:12.377Z,1728920712.377 [DATMMP](INFO): Starting 2024-10-14T15:45:12.630Z,1728920712.630 [DATMMP](INFO): Starting 2024-10-14T15:45:12.881Z,1728920712.881 [DATMMP](INFO): Starting 2024-10-14T15:45:13.133Z,1728920713.133 [DATMMP](INFO): Starting 2024-10-14T15:45:13.385Z,1728920713.385 [DATMMP](INFO): Starting 2024-10-14T15:45:13.637Z,1728920713.637 [DATMMP](INFO): Starting 2024-10-14T15:45:13.889Z,1728920713.889 [DATMMP](INFO): Starting 2024-10-14T15:45:14.141Z,1728920714.141 [DATMMP](INFO): Starting 2024-10-14T15:45:14.393Z,1728920714.393 [DATMMP](INFO): Starting 2024-10-14T15:45:14.646Z,1728920714.646 [DATMMP](INFO): Starting 2024-10-14T15:45:14.897Z,1728920714.897 [DATMMP](INFO): Starting 2024-10-14T15:45:15.149Z,1728920715.149 [DATMMP](INFO): Starting 2024-10-14T15:45:15.401Z,1728920715.401 [DATMMP](INFO): Starting 2024-10-14T15:45:15.653Z,1728920715.653 [DATMMP](INFO): Starting 2024-10-14T15:45:15.906Z,1728920715.906 [DATMMP](INFO): Starting 2024-10-14T15:45:16.157Z,1728920716.157 [DATMMP](INFO): Starting 2024-10-14T15:45:16.409Z,1728920716.409 [DATMMP](INFO): Starting 2024-10-14T15:45:16.409Z,1728920716.409 [DATMMP](INFO): DAT read: 2024-10-14T15:45:16.410Z,1728920716.410 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-10-14T15:45:16.661Z,1728920716.661 [DATMMP](INFO): Starting 2024-10-14T15:45:16.913Z,1728920716.913 [DATMMP](INFO): Starting 2024-10-14T15:45:16.992Z,1728920716.992 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005306 2024-10-14T15:45:17.165Z,1728920717.165 [DATMMP](INFO): Starting 2024-10-14T15:45:17.417Z,1728920717.417 [DATMMP](INFO): Starting 2024-10-14T15:45:17.669Z,1728920717.669 [DATMMP](INFO): Starting 2024-10-14T15:45:17.921Z,1728920717.921 [DATMMP](INFO): Starting 2024-10-14T15:45:17.921Z,1728920717.921 [DATMMP](INFO): DAT read: MF Frequency Band 2024-10-14T15:45:17.923Z,1728920717.923 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-10-14T15:45:17.923Z,1728920717.923 [DATMMP](INFO): DAT read: Sep 12 2000 00:20:03 2024-10-14T15:45:18.173Z,1728920718.173 [DATMMP](INFO): Starting 2024-10-14T15:45:18.425Z,1728920718.425 [DATMMP](INFO): Starting 2024-10-14T15:45:18.677Z,1728920718.677 [DATMMP](INFO): Starting 2024-10-14T15:45:18.929Z,1728920718.929 [DATMMP](INFO): Starting 2024-10-14T15:45:18.931Z,1728920718.931 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2024-10-14T15:45:18.932Z,1728920718.932 [DATMMP](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2024-10-14T15:45:18.932Z,1728920718.932 [DATMMP](INFO): commRate: 1200 2024-10-14T15:45:19.181Z,1728920719.181 [DATMMP](INFO): Starting 2024-10-14T15:45:19.433Z,1728920719.433 [DATMMP](INFO): Starting 2024-10-14T15:45:19.685Z,1728920719.685 [DATMMP](INFO): Starting 2024-10-14T15:45:19.937Z,1728920719.937 [DATMMP](INFO): Starting 2024-10-14T15:45:20.189Z,1728920720.189 [DATMMP](INFO): Starting 2024-10-14T15:45:20.441Z,1728920720.441 [DATMMP](INFO): Starting 2024-10-14T15:45:20.693Z,1728920720.693 [DATMMP](INFO): Starting 2024-10-14T15:45:20.945Z,1728920720.945 [DATMMP](INFO): Starting 2024-10-14T15:45:20.997Z,1728920720.997 [DATMMP](INFO): entering command mode 2024-10-14T15:45:21.197Z,1728920721.197 [DATMMP](INFO): Starting 2024-10-14T15:45:21.197Z,1728920721.197 [DATMMP](INFO): DAT read: 2024-10-14T15:45:21.198Z,1728920721.198 [DATMMP](INFO): DAT read: user:1> 2024-10-14T15:45:21.198Z,1728920721.198 [DATMMP](DEBUG): read user prompt 1: user:1> 2024-10-14T15:45:21.198Z,1728920721.198 [DATMMP](INFO): entering MMP mode 2024-10-14T15:45:21.449Z,1728920721.449 [DATMMP](INFO): Starting 2024-10-14T15:45:21.450Z,1728920721.450 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:45:21.451Z,1728920721.451 [DATMMP](INFO): status rx: x1 2024-10-14T15:45:21.451Z,1728920721.451 [DATMMP](INFO): MMP status: 1: started 2024-10-14T15:45:21.452Z,1728920721.452 [DATMMP](INFO): Received message type: status 2024-10-14T15:45:21.452Z,1728920721.452 [DATMMP](INFO): Handled 2024-10-14T15:45:21.701Z,1728920721.701 [DATMMP](INFO): Starting 2024-10-14T15:45:21.702Z,1728920721.702 [DATMMP](INFO): Sent Tx Power Config 8 2024-10-14T15:45:21.702Z,1728920721.702 [DATMMP](INFO): Setting local address: 8 2024-10-14T15:45:21.704Z,1728920721.704 [DATMMP](INFO): Setting time to: 15:45:21 And date to:10/14/2024 2024-10-14T15:45:21.953Z,1728920721.953 [DATMMP](INFO): Starting 2024-10-14T15:45:21.953Z,1728920721.953 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:45:21.954Z,1728920721.954 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2024-10-14T15:45:21.954Z,1728920721.954 [DATMMP](INFO): Received message type: mdmpower 2024-10-14T15:45:21.955Z,1728920721.955 [DATMMP](INFO): Handled 2024-10-14T15:45:22.205Z,1728920722.205 [DATMMP](INFO): Starting 2024-10-14T15:45:22.205Z,1728920722.205 [DATMMP](INFO): GSXN notify for xid: 10 2024-10-14T15:45:22.206Z,1728920722.206 [DATMMP](INFO): sreg_txpower rx: x8 2024-10-14T15:45:22.206Z,1728920722.206 [DATMMP](INFO): Received message type: sreg_txpower 2024-10-14T15:45:22.206Z,1728920722.206 [DATMMP](INFO): Match for : sreg_txpower 2024-10-14T15:45:22.206Z,1728920722.206 [DATMMP](INFO): ACK 2024-10-14T15:45:22.457Z,1728920722.457 [DATMMP](INFO): Starting 2024-10-14T15:45:22.457Z,1728920722.457 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:45:22.458Z,1728920722.458 [DATMMP](INFO): mdmlocal rx: x8 x0 x0 x0 2024-10-14T15:45:22.458Z,1728920722.458 [DATMMP](INFO): Received message type: mdmlocal 2024-10-14T15:45:22.458Z,1728920722.458 [DATMMP](INFO): Handled 2024-10-14T15:45:22.709Z,1728920722.709 [DATMMP](INFO): Starting 2024-10-14T15:45:22.709Z,1728920722.709 [DATMMP](INFO): GSXN notify for xid: 11 2024-10-14T15:45:22.710Z,1728920722.710 [DATMMP](INFO): sreg_locaddr rx: x8 2024-10-14T15:45:22.710Z,1728920722.710 [DATMMP](INFO): Received message type: sreg_locaddr 2024-10-14T15:45:22.710Z,1728920722.710 [DATMMP](INFO): Match for : sreg_locaddr 2024-10-14T15:45:22.710Z,1728920722.710 [DATMMP](INFO): ACK 2024-10-14T15:45:22.961Z,1728920722.961 [DATMMP](INFO): Starting 2024-10-14T15:45:22.961Z,1728920722.961 [DATMMP](INFO): GSXN notify for xid: 12 2024-10-14T15:45:22.962Z,1728920722.962 [DATMMP](INFO): timedate rx: x0 xF x2D x15 x9 xE x7C x0 2024-10-14T15:45:22.963Z,1728920722.963 [DATMMP](INFO): Received message type: timedate 2024-10-14T15:45:22.963Z,1728920722.963 [DATMMP](INFO): Match for : timedate 2024-10-14T15:45:22.963Z,1728920722.963 [DATMMP](INFO): ACK 2024-10-14T15:45:23.213Z,1728920723.213 [DATMMP](INFO): Starting 2024-10-14T15:45:23.213Z,1728920723.213 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:45:23.214Z,1728920723.214 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2024-10-14T15:45:23.214Z,1728920723.214 [DATMMP](INFO): Received message type: sys_verb 2024-10-14T15:45:23.214Z,1728920723.214 [DATMMP](INFO): Handled 2024-10-14T15:45:23.465Z,1728920723.465 [DATMMP](INFO): Starting 2024-10-14T15:45:23.465Z,1728920723.465 [DATMMP](INFO): GSXN notify for xid: 13 2024-10-14T15:45:23.466Z,1728920723.466 [DATMMP](INFO): sreg_verbosity rx: x0 2024-10-14T15:45:23.466Z,1728920723.466 [DATMMP](INFO): Received message type: sreg_verbosity 2024-10-14T15:45:23.466Z,1728920723.466 [DATMMP](INFO): Match for : sreg_verbosity 2024-10-14T15:45:23.466Z,1728920723.466 [DATMMP](INFO): ACK 2024-10-14T15:45:23.717Z,1728920723.717 [DATMMP](INFO): Starting 2024-10-14T15:45:23.717Z,1728920723.717 [DATMMP](INFO): GSXN notify for xid: 14 2024-10-14T15:45:23.718Z,1728920723.718 [DATMMP](INFO): version rx: x2 x5 2024-10-14T15:45:23.718Z,1728920723.718 [DATMMP](INFO): DatMMPVersion: 2.5 2024-10-14T15:45:23.718Z,1728920723.718 [DATMMP](INFO): Received message type: version 2024-10-14T15:45:23.719Z,1728920723.719 [DATMMP](INFO): Match for : version 2024-10-14T15:45:23.719Z,1728920723.719 [DATMMP](INFO): ACK 2024-10-14T15:45:23.719Z,1728920723.719 [DATMMP](INFO): in MMP mode: config complete going to runnable 2024-10-14T15:45:31.626Z,1728920731.626 [NAL9602](INFO): Powering up NAL9602 2024-10-14T15:45:38.081Z,1728920738.081 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:45:38.082Z,1728920738.082 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2024-10-14T15:45:38.082Z,1728920738.082 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:45:38.082Z,1728920738.082 [DATMMP](INFO): Handled 2024-10-14T15:45:42.538Z,1728920742.538 [NAL9602](INFO): NAL9602 initialized 2024-10-14T15:45:42.571Z,1728920742.571 [SBIT](IMPORTANT): Beginning Startup BIT 2024-10-14T15:45:42.576Z,1728920742.576 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T15:45:48.161Z,1728920748.161 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:45:48.162Z,1728920748.162 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-10-14T15:45:48.162Z,1728920748.162 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:45:48.162Z,1728920748.162 [DATMMP](INFO): Handled 2024-10-14T15:45:53.546Z,1728920753.546 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-10-14T15:45:53.959Z,1728920753.959 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T15:46:04.830Z,1728920764.830 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-10-14T15:46:05.238Z,1728920765.238 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-14T15:46:16.082Z,1728920776.082 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-10-14T15:46:16.082Z,1728920776.082 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule. 2024-10-14T15:46:18.170Z,1728920778.170 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:46:18.171Z,1728920778.171 [DATMMP](INFO): timesync rx: x0 x0 x0 x0 2024-10-14T15:46:18.171Z,1728920778.171 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:46:18.171Z,1728920778.171 [DATMMP](INFO): Handled 2024-10-14T15:46:35.904Z,1728920795.904 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:46:36.698Z,1728920796.698 [SBIT](IMPORTANT): SBIT PASSED 2024-10-14T15:46:36.698Z,1728920796.698 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-14T15:46:36.699Z,1728920796.699 [SBIT](IMPORTANT): CANONSampler.loadAtStartup=0 bool; 2024-10-14T15:46:36.699Z,1728920796.699 [SBIT](IMPORTANT): CANONSampler.simulateHardware=1 bool; 2024-10-14T15:46:36.699Z,1728920796.699 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=89.418285 cubic_centimeter; 2024-10-14T15:46:36.700Z,1728920796.700 [SBIT](IMPORTANT): VerticalControl.massDefault=4.795493 millimeter; 2024-10-14T15:46:37.091Z,1728920797.091 [MissionManager](IMPORTANT): Started mission Startup 2024-10-14T15:46:37.092Z,1728920797.092 [Startup] Running Loop=1 2024-10-14T15:46:37.092Z,1728920797.092 [Startup](DEBUG): Aggregate::initialize Startup 2024-10-14T15:46:37.092Z,1728920797.092 [Startup:A.GoToSurface] Running Loop=1 2024-10-14T15:46:37.092Z,1728920797.092 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-14T15:46:37.109Z,1728920797.109 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-14T15:46:37.109Z,1728920797.109 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-14T15:46:37.110Z,1728920797.110 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-14T15:46:37.110Z,1728920797.110 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-14T15:46:37.110Z,1728920797.110 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-14T15:46:37.111Z,1728920797.111 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-14T15:46:37.112Z,1728920797.112 [Startup:StartupSatComms] Running Loop=1 2024-10-14T15:46:37.112Z,1728920797.112 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-10-14T15:46:37.113Z,1728920797.113 [Startup:StartupSatComms:A] Running Loop=1 2024-10-14T15:46:37.503Z,1728920797.503 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-10-14T15:46:39.089Z,1728920799.089 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:46:39.090Z,1728920799.090 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2024-10-14T15:46:39.090Z,1728920799.090 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:46:39.091Z,1728920799.091 [DATMMP](INFO): Handled 2024-10-14T15:46:45.221Z,1728920805.221 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T15:46:49.169Z,1728920809.169 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:46:49.170Z,1728920809.170 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-10-14T15:46:49.170Z,1728920809.170 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:46:49.170Z,1728920809.170 [DATMMP](INFO): Handled 2024-10-14T15:47:37.309Z,1728920857.309 [Startup:StartupSatComms:A](INFO): Timed out from 2024-10-14T15:46:37.1Z 2024-10-14T15:47:37.309Z,1728920857.309 [Startup:StartupSatComms:A] Stopped 2024-10-14T15:47:37.309Z,1728920857.309 [Startup:StartupSatComms:B] Running Loop=1 2024-10-14T15:47:37.707Z,1728920857.707 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-10-14T15:47:42.488Z,1728920862.488 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241011T194503/Courier0064.lzma 2024-10-14T15:47:43.491Z,1728920863.491 [DataOverHttps](INFO): Moved sent file to Logs/20241011T194503/Courier0064.lzma.bak 2024-10-14T15:47:43.491Z,1728920863.491 [DataOverHttps](INFO): SBD MOMSN=23294588 2024-10-14T15:47:46.658Z,1728920866.658 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:47:57.964Z,1728920877.964 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:47:59.205Z,1728920879.205 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20241014T154451/Courier0000.lzma 2024-10-14T15:48:00.207Z,1728920880.207 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0000.lzma.bak 2024-10-14T15:48:00.207Z,1728920880.207 [DataOverHttps](INFO): SBD MOMSN=23294590 2024-10-14T15:48:03.158Z,1728920883.158 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-10-14T15:48:03.158Z,1728920883.158 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T15:48:03.169Z,1728920883.169 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T15:48:03.575Z,1728920883.575 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T15:48:03.576Z,1728920883.576 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-10-14T15:48:10.851Z,1728920890.851 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:48:13.695Z,1728920893.695 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T15:48:16.621Z,1728920896.621 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20241011T194503/Express0065.lzma 2024-10-14T15:48:17.623Z,1728920897.623 [DataOverHttps](INFO): Moved sent file to Logs/20241011T194503/Express0065.lzma.bak 2024-10-14T15:48:17.623Z,1728920897.623 [DataOverHttps](INFO): SBD MOMSN=23294595 2024-10-14T15:48:28.230Z,1728920908.230 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T15:48:33.154Z,1728920913.154 [DataOverHttps](INFO): Sending 867 bytes from file Logs/20241014T154451/Express0001.lzma 2024-10-14T15:48:34.154Z,1728920914.154 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0001.lzma.bak 2024-10-14T15:48:34.155Z,1728920914.155 [DataOverHttps](INFO): SBD MOMSN=23294600 2024-10-14T15:48:35.896Z,1728920915.896 [Startup:StartupSatComms:B] Stopped 2024-10-14T15:48:35.896Z,1728920915.896 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-10-14T15:48:35.896Z,1728920915.896 [Startup:StartupSatComms] Stopped 2024-10-14T15:48:35.896Z,1728920915.896 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-10-14T15:48:35.897Z,1728920915.897 [Startup](INFO): Completed Startup 2024-10-14T15:48:35.897Z,1728920915.897 [MissionManager](INFO): Startup is completed. 2024-10-14T15:48:35.898Z,1728920915.898 [MissionManager](INFO): Uninitializing Mission Startup 2024-10-14T15:48:35.898Z,1728920915.898 [Startup] Stopped 2024-10-14T15:48:35.898Z,1728920915.898 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-10-14T15:48:35.898Z,1728920915.898 [Startup:A.GoToSurface] Stopped 2024-10-14T15:48:35.898Z,1728920915.898 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-14T15:48:36.273Z,1728920916.273 [MissionManager](IMPORTANT): Started mission Default 2024-10-14T15:48:36.274Z,1728920916.274 [Default] Running Loop=1 2024-10-14T15:48:36.274Z,1728920916.274 [Default](DEBUG): Aggregate::initialize Default 2024-10-14T15:48:36.274Z,1728920916.274 [Default:B.GoToSurface] Running Loop=1 2024-10-14T15:48:36.274Z,1728920916.274 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-14T15:48:36.274Z,1728920916.274 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-14T15:48:36.274Z,1728920916.274 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-14T15:48:36.275Z,1728920916.275 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-14T15:48:36.275Z,1728920916.275 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-14T15:48:36.275Z,1728920916.275 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-14T15:48:36.275Z,1728920916.275 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-14T15:48:36.276Z,1728920916.276 [Default:A.Wait] Running Loop=1 2024-10-14T15:48:36.276Z,1728920916.276 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-10-14T15:48:49.721Z,1728920929.721 [Default:A.Wait](INFO): Done Waiting. 2024-10-14T15:48:49.721Z,1728920929.721 [Default:A.Wait] Stopped 2024-10-14T15:48:49.721Z,1728920929.721 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T15:48:50.016Z,1728920930.016 [Default:CheckIn] Running Loop=1 2024-10-14T15:48:50.016Z,1728920930.016 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T15:48:50.016Z,1728920930.016 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T15:48:50.433Z,1728920930.433 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-10-14T15:49:06.145Z,1728920946.145 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:49:08.674Z,1728920948.674 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:49:20.346Z,1728920960.346 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:49:25.133Z,1728920965.133 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:49:31.258Z,1728920971.258 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:49:44.930Z,1728920984.930 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:50:04.726Z,1728921004.726 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:50:25.329Z,1728921025.329 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:50:43.128Z,1728921043.128 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T15:50:46.345Z,1728921046.345 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-10-14T15:51:03.709Z,1728921063.709 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:51:04.150Z,1728921064.150 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-10-14T15:51:04.150Z,1728921064.150 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T15:51:04.161Z,1728921064.161 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T15:51:04.544Z,1728921064.544 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T15:51:04.544Z,1728921064.544 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-10-14T15:51:19.063Z,1728921079.063 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-10-14T15:52:11.089Z,1728921131.089 [CommandExec](IMPORTANT): got command failComponent 2024-10-14T15:52:11.090Z,1728921131.090 [CommandExec](IMPORTANT): Failed components: 2024-10-14T15:52:11.090Z,1728921131.090 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-10-14T15:52:29.137Z,1728921149.137 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:52:29.138Z,1728921149.138 [DATMMP](INFO): timesync rx: x2 x0 x0 x0 2024-10-14T15:52:29.138Z,1728921149.138 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:52:29.139Z,1728921149.139 [DATMMP](INFO): Handled 2024-10-14T15:52:39.221Z,1728921159.221 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:52:39.222Z,1728921159.222 [DATMMP](INFO): timesync rx: x2 x1 x1 x0 2024-10-14T15:52:39.222Z,1728921159.222 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:52:39.222Z,1728921159.222 [DATMMP](INFO): Handled 2024-10-14T15:52:49.301Z,1728921169.301 [DATMMP](INFO): GSXN notify for xid: 0 2024-10-14T15:52:49.302Z,1728921169.302 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2024-10-14T15:52:49.302Z,1728921169.302 [DATMMP](INFO): Received message type: timesync 2024-10-14T15:52:49.302Z,1728921169.302 [DATMMP](INFO): Handled 2024-10-14T15:53:50.188Z,1728921230.188 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T15:48:50.0Z 2024-10-14T15:53:50.188Z,1728921230.188 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T15:53:50.188Z,1728921230.188 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T15:53:50.603Z,1728921230.603 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-10-14T15:53:57.552Z,1728921237.552 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241014T154451/Courier0004.lzma 2024-10-14T15:53:58.554Z,1728921238.554 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0004.lzma.bak 2024-10-14T15:53:58.555Z,1728921238.555 [DataOverHttps](INFO): SBD MOMSN=23294640 2024-10-14T15:54:05.126Z,1728921245.126 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-10-14T15:54:05.126Z,1728921245.126 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T15:54:05.163Z,1728921245.163 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T15:54:05.539Z,1728921245.539 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T15:54:05.539Z,1728921245.539 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-10-14T15:54:14.149Z,1728921254.149 [DataOverHttps](INFO): Sending 261 bytes from file Logs/20241014T154451/Express0005.lzma 2024-10-14T15:54:14.463Z,1728921254.463 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:54:15.151Z,1728921255.151 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0005.lzma.bak 2024-10-14T15:54:15.151Z,1728921255.151 [DataOverHttps](INFO): SBD MOMSN=23294642 2024-10-14T15:54:16.843Z,1728921256.843 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T15:54:16.843Z,1728921256.843 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T15:54:16.843Z,1728921256.843 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T15:54:28.604Z,1728921268.604 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:55:44.498Z,1728921344.498 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T15:55:44.498Z,1728921344.498 [NAL9602] Data Fault, FailCount= 1 2024-10-14T15:55:44.498Z,1728921344.498 [NAL9602](ERROR): Data Fault 2024-10-14T15:55:44.549Z,1728921344.549 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T15:55:44.902Z,1728921344.902 [NAL9602](INFO): Powering down 2024-10-14T15:55:45.737Z,1728921345.737 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T15:55:45.737Z,1728921345.737 [NAL9602] No Fault, FailCount= 1 2024-10-14T15:55:53.045Z,1728921353.045 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:56:00.702Z,1728921360.702 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T15:56:15.264Z,1728921375.264 [NAL9602](INFO): Powering up NAL9602 2024-10-14T15:56:26.110Z,1728921386.110 [NAL9602](INFO): NAL9602 initialized 2024-10-14T15:57:06.145Z,1728921426.145 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-10-14T15:57:06.145Z,1728921426.145 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T15:57:06.158Z,1728921426.158 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T15:57:06.568Z,1728921426.568 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T15:57:06.568Z,1728921426.568 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-10-14T15:57:38.479Z,1728921458.479 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:58:43.466Z,1728921523.466 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:59:03.665Z,1728921543.665 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:59:08.979Z,1728921548.979 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:59:17.418Z,1728921557.418 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T15:59:17.418Z,1728921557.418 [Default:CheckIn:C.Wait] Stopped 2024-10-14T15:59:17.418Z,1728921557.418 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T15:59:17.418Z,1728921557.418 [Default:CheckIn:D] Running Loop=1 2024-10-14T15:59:17.824Z,1728921557.824 [Default:CheckIn:D] Stopped 2024-10-14T15:59:17.824Z,1728921557.824 [Default:CheckIn:E] Running Loop=1 2024-10-14T15:59:18.241Z,1728921558.241 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.692508 min 2024-10-14T15:59:18.241Z,1728921558.241 [Default:CheckIn:E] Stopped 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn] Stopped 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn](INFO): Running loop #2 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn] Running Loop=2 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T15:59:18.242Z,1728921558.242 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T15:59:20.693Z,1728921560.693 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T15:59:23.058Z,1728921563.058 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:59:43.257Z,1728921583.257 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T15:59:47.759Z,1728921587.759 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:00:03.473Z,1728921603.473 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:00:04.320Z,1728921604.320 [CBIT](INFO): Clearing failed state for component DropWeight 2024-10-14T16:00:04.320Z,1728921604.320 [DropWeight] No Fault, FailCount= 1 2024-10-14T16:00:07.114Z,1728921607.114 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-10-14T16:00:07.114Z,1728921607.114 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:00:07.124Z,1728921607.124 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:00:07.531Z,1728921607.531 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:00:07.531Z,1728921607.531 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-10-14T16:00:24.070Z,1728921624.070 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:00:32.209Z,1728921632.209 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:00:44.266Z,1728921644.266 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:00:45.132Z,1728921645.132 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:01:05.327Z,1728921665.327 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:03:08.108Z,1728921788.108 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-10-14T16:03:08.108Z,1728921788.108 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:03:08.119Z,1728921788.119 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:03:08.532Z,1728921788.532 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:03:08.532Z,1728921788.532 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-10-14T16:03:14.302Z,1728921794.302 [CommandExec](IMPORTANT): got command strobe off 2024-10-14T16:03:14.302Z,1728921794.302 [CommandExec](IMPORTANT): Deactivating strobe 2024-10-14T16:03:16.230Z,1728921796.230 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:03:27.557Z,1728921807.557 [CommandExec](IMPORTANT): got command configSet list 2024-10-14T16:03:27.557Z,1728921807.557 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-14T16:03:27.558Z,1728921807.558 [CommandExec](IMPORTANT): CANONSampler.loadAtStartup=0 bool; 2024-10-14T16:03:27.559Z,1728921807.559 [CommandExec](IMPORTANT): CANONSampler.simulateHardware=1 bool; 2024-10-14T16:03:27.559Z,1728921807.559 [CommandExec](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-10-14T16:03:27.560Z,1728921807.560 [CommandExec](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-10-14T16:03:27.570Z,1728921807.570 [CommandExec](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-10-14T16:03:27.571Z,1728921807.571 [CommandExec](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2024-10-14T16:03:27.572Z,1728921807.572 [CommandExec](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-10-14T16:03:27.572Z,1728921807.572 [CommandExec](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2024-10-14T16:03:27.591Z,1728921807.591 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=89.418285 cubic_centimeter; 2024-10-14T16:03:27.591Z,1728921807.591 [CommandExec](IMPORTANT): VerticalControl.massDefault=4.795493 millimeter; 2024-10-14T16:04:13.597Z,1728921853.597 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:04:18.403Z,1728921858.403 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T15:59:18.2Z 2024-10-14T16:04:18.403Z,1728921858.403 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T16:04:18.403Z,1728921858.403 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T16:04:25.196Z,1728921865.196 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241014T154451/Courier0007.lzma 2024-10-14T16:04:26.198Z,1728921866.198 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0007.lzma.bak 2024-10-14T16:04:26.199Z,1728921866.199 [DataOverHttps](INFO): SBD MOMSN=23294661 2024-10-14T16:04:39.859Z,1728921879.859 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:04:41.937Z,1728921881.937 [DataOverHttps](INFO): Sending 554 bytes from file Logs/20241014T154451/Express0008.lzma 2024-10-14T16:04:42.939Z,1728921882.939 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0008.lzma.bak 2024-10-14T16:04:42.939Z,1728921882.939 [DataOverHttps](INFO): SBD MOMSN=23294663 2024-10-14T16:04:44.672Z,1728921884.672 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T16:04:44.672Z,1728921884.672 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T16:04:44.672Z,1728921884.672 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T16:05:33.590Z,1728921933.590 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:05:36.009Z,1728921936.009 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:06:09.098Z,1728921969.098 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-10-14T16:06:09.098Z,1728921969.098 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:06:09.133Z,1728921969.133 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:06:09.511Z,1728921969.511 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:06:09.511Z,1728921969.511 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-10-14T16:06:28.079Z,1728921988.079 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T16:06:28.079Z,1728921988.079 [NAL9602] Data Fault, FailCount= 2 2024-10-14T16:06:28.079Z,1728921988.079 [NAL9602](ERROR): Data Fault 2024-10-14T16:06:28.117Z,1728921988.117 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T16:06:28.481Z,1728921988.481 [NAL9602](INFO): Powering down 2024-10-14T16:06:29.318Z,1728921989.318 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T16:06:29.318Z,1728921989.318 [NAL9602] No Fault, FailCount= 2 2024-10-14T16:06:44.686Z,1728922004.686 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:06:58.782Z,1728922018.782 [NAL9602](INFO): Powering up NAL9602 2024-10-14T16:07:09.695Z,1728922029.695 [NAL9602](INFO): NAL9602 initialized 2024-10-14T16:07:14.934Z,1728922034.934 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-10-14T16:07:32.363Z,1728922052.363 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:07:44.912Z,1728922064.912 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:08:02.201Z,1728922082.201 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:08:22.806Z,1728922102.806 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:08:39.798Z,1728922119.798 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:08:59.982Z,1728922139.982 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:09:10.095Z,1728922150.095 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-10-14T16:09:10.095Z,1728922150.095 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:09:10.106Z,1728922150.106 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:09:10.530Z,1728922150.530 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:09:10.530Z,1728922150.530 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-10-14T16:09:20.577Z,1728922160.577 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:09:27.504Z,1728922167.504 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:09:40.778Z,1728922180.778 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:09:45.262Z,1728922185.262 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T16:09:45.262Z,1728922185.262 [Default:CheckIn:C.Wait] Stopped 2024-10-14T16:09:45.262Z,1728922185.262 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T16:09:45.262Z,1728922185.262 [Default:CheckIn:D] Running Loop=1 2024-10-14T16:09:45.639Z,1728922185.639 [Default:CheckIn:D] Stopped 2024-10-14T16:09:45.640Z,1728922185.640 [Default:CheckIn:E] Running Loop=1 2024-10-14T16:09:46.047Z,1728922186.047 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.156097 min 2024-10-14T16:09:46.047Z,1728922186.047 [Default:CheckIn:E] Stopped 2024-10-14T16:09:46.047Z,1728922186.047 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T16:09:46.047Z,1728922186.047 [Default:CheckIn] Stopped 2024-10-14T16:09:46.047Z,1728922186.047 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T16:09:46.048Z,1728922186.048 [Default:CheckIn](INFO): Running loop #3 2024-10-14T16:09:46.048Z,1728922186.048 [Default:CheckIn] Running Loop=3 2024-10-14T16:09:46.048Z,1728922186.048 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T16:09:46.048Z,1728922186.048 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T16:09:59.765Z,1728922199.765 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T16:10:43.462Z,1728922243.462 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:11:00.008Z,1728922260.008 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:12:08.279Z,1728922328.279 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T16:12:11.081Z,1728922331.081 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-10-14T16:12:11.081Z,1728922331.081 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:12:11.092Z,1728922331.092 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:12:11.511Z,1728922331.511 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:12:11.512Z,1728922331.512 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-10-14T16:13:01.226Z,1728922381.226 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:13:28.707Z,1728922408.707 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:13:42.038Z,1728922422.038 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:14:01.015Z,1728922441.015 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T16:14:46.243Z,1728922486.243 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T16:09:46.0Z 2024-10-14T16:14:46.243Z,1728922486.243 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T16:14:46.243Z,1728922486.243 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T16:14:53.868Z,1728922493.868 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20241014T154451/Courier0010.lzma 2024-10-14T16:14:54.870Z,1728922494.870 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0010.lzma.bak 2024-10-14T16:14:54.871Z,1728922494.871 [DataOverHttps](INFO): SBD MOMSN=23294695 2024-10-14T16:15:06.417Z,1728922506.417 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T16:15:11.072Z,1728922511.072 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20241014T154451/Express0011.lzma 2024-10-14T16:15:12.074Z,1728922512.074 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0011.lzma.bak 2024-10-14T16:15:12.075Z,1728922512.075 [DataOverHttps](INFO): SBD MOMSN=23294697 2024-10-14T16:15:12.125Z,1728922512.125 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-10-14T16:15:12.125Z,1728922512.125 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:15:12.149Z,1728922512.149 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:15:12.536Z,1728922512.536 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:15:12.536Z,1728922512.536 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-10-14T16:15:13.718Z,1728922513.718 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T16:15:13.718Z,1728922513.718 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T16:15:13.718Z,1728922513.718 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T16:16:04.214Z,1728922564.214 [BPC1](INFO): Calculating totals. Valid battery stick count: 46. Valid reserve battery stick count: 4. 2024-10-14T16:16:04.222Z,1728922564.222 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-10-14T16:17:12.503Z,1728922632.503 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T16:17:12.504Z,1728922632.504 [NAL9602] Data Fault, FailCount= 3 2024-10-14T16:17:12.504Z,1728922632.504 [NAL9602](ERROR): Data Fault 2024-10-14T16:17:12.521Z,1728922632.521 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T16:17:12.898Z,1728922632.898 [NAL9602](INFO): Powering down 2024-10-14T16:17:13.724Z,1728922633.724 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T16:17:13.724Z,1728922633.724 [NAL9602] No Fault, FailCount= 3 2024-10-14T16:17:43.214Z,1728922663.214 [NAL9602](INFO): Powering up NAL9602 2024-10-14T16:17:54.115Z,1728922674.115 [NAL9602](INFO): NAL9602 initialized 2024-10-14T16:18:13.126Z,1728922693.126 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-10-14T16:18:13.126Z,1728922693.126 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:18:13.137Z,1728922693.137 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:18:13.551Z,1728922693.551 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:18:13.551Z,1728922693.551 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-10-14T16:20:14.322Z,1728922814.322 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T16:20:14.322Z,1728922814.322 [Default:CheckIn:C.Wait] Stopped 2024-10-14T16:20:14.322Z,1728922814.322 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T16:20:14.322Z,1728922814.322 [Default:CheckIn:D] Running Loop=1 2024-10-14T16:20:14.726Z,1728922814.726 [Default:CheckIn:D] Stopped 2024-10-14T16:20:14.726Z,1728922814.726 [Default:CheckIn:E] Running Loop=1 2024-10-14T16:20:15.144Z,1728922815.144 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.640875 min 2024-10-14T16:20:15.144Z,1728922815.144 [Default:CheckIn:E] Stopped 2024-10-14T16:20:15.144Z,1728922815.144 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T16:20:15.144Z,1728922815.144 [Default:CheckIn] Stopped 2024-10-14T16:20:15.145Z,1728922815.145 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T16:20:15.145Z,1728922815.145 [Default:CheckIn](INFO): Running loop #4 2024-10-14T16:20:15.145Z,1728922815.145 [Default:CheckIn] Running Loop=4 2024-10-14T16:20:15.145Z,1728922815.145 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T16:20:15.145Z,1728922815.145 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T16:21:14.103Z,1728922874.103 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-10-14T16:21:14.103Z,1728922874.103 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:21:14.114Z,1728922874.114 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:21:14.534Z,1728922874.534 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:21:14.534Z,1728922874.534 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-10-14T16:21:38.727Z,1728922898.727 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.loadAtStartup 2024-10-14T16:21:38.768Z,1728922898.768 [CommandExec](IMPORTANT): Sonardyne_Nano.loadAtStartup 0 bool 2024-10-14T16:21:48.846Z,1728922908.846 [CommandExec](IMPORTANT): got command get PowerOnly.loadAtStartup 2024-10-14T16:21:48.847Z,1728922908.847 [CommandExec](IMPORTANT): PowerOnly.loadAtStartup 1 bool 2024-10-14T16:24:15.122Z,1728923055.122 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-10-14T16:24:15.122Z,1728923055.122 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:24:15.179Z,1728923055.179 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:24:15.535Z,1728923055.535 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:24:15.535Z,1728923055.535 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-10-14T16:25:15.333Z,1728923115.333 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T16:20:15.1Z 2024-10-14T16:25:15.333Z,1728923115.333 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T16:25:15.333Z,1728923115.333 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T16:25:22.232Z,1728923122.232 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20241014T154451/Courier0013.lzma 2024-10-14T16:25:23.234Z,1728923123.234 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0013.lzma.bak 2024-10-14T16:25:23.235Z,1728923123.235 [DataOverHttps](INFO): SBD MOMSN=23294730 2024-10-14T16:25:38.705Z,1728923138.705 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20241014T154451/Express0014.lzma 2024-10-14T16:25:39.707Z,1728923139.707 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0014.lzma.bak 2024-10-14T16:25:39.707Z,1728923139.707 [DataOverHttps](INFO): SBD MOMSN=23294732 2024-10-14T16:25:41.183Z,1728923141.183 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T16:25:41.183Z,1728923141.183 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T16:25:41.183Z,1728923141.183 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T16:27:16.129Z,1728923236.129 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-10-14T16:27:16.129Z,1728923236.129 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:27:16.168Z,1728923236.168 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:27:16.585Z,1728923236.585 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:27:16.585Z,1728923236.585 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-10-14T16:27:56.907Z,1728923276.907 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T16:27:56.907Z,1728923276.907 [NAL9602] Data Fault, FailCount= 4 2024-10-14T16:27:56.907Z,1728923276.907 [NAL9602](ERROR): Data Fault 2024-10-14T16:27:56.949Z,1728923276.949 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T16:27:57.310Z,1728923277.310 [NAL9602](INFO): Powering down 2024-10-14T16:27:58.140Z,1728923278.140 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T16:27:58.140Z,1728923278.140 [NAL9602] No Fault, FailCount= 4 2024-10-14T16:28:27.614Z,1728923307.614 [NAL9602](INFO): Powering up NAL9602 2024-10-14T16:28:38.523Z,1728923318.523 [NAL9602](INFO): NAL9602 initialized 2024-10-14T16:30:05.786Z,1728923405.786 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-10-14T16:30:05.786Z,1728923405.786 [DropWeight] Hardware Fault, FailCount= 1 2024-10-14T16:30:05.786Z,1728923405.786 [DropWeight](ERROR): Hardware Fault 2024-10-14T16:30:05.853Z,1728923405.853 [CBIT](INFO): Critical error at 20241014T163005 2024-10-14T16:30:05.856Z,1728923405.856 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-10-14T16:30:05.856Z,1728923405.856 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-10-14T16:30:06.239Z,1728923406.239 [CBIT](INFO): Critical error at 20241014T163005 2024-10-14T16:30:17.110Z,1728923417.110 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-10-14T16:30:17.110Z,1728923417.110 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:30:17.169Z,1728923417.169 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:30:17.524Z,1728923417.524 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:30:17.524Z,1728923417.524 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-10-14T16:30:41.751Z,1728923441.751 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T16:30:41.751Z,1728923441.751 [Default:CheckIn:C.Wait] Stopped 2024-10-14T16:30:41.751Z,1728923441.751 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T16:30:41.751Z,1728923441.751 [Default:CheckIn:D] Running Loop=1 2024-10-14T16:30:42.155Z,1728923442.155 [Default:CheckIn:D] Stopped 2024-10-14T16:30:42.155Z,1728923442.155 [Default:CheckIn:E] Running Loop=1 2024-10-14T16:30:42.579Z,1728923442.579 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.098022 min 2024-10-14T16:30:42.579Z,1728923442.579 [Default:CheckIn:E] Stopped 2024-10-14T16:30:42.579Z,1728923442.579 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T16:30:42.579Z,1728923442.579 [Default:CheckIn] Stopped 2024-10-14T16:30:42.579Z,1728923442.579 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T16:30:42.579Z,1728923442.579 [Default:CheckIn](INFO): Running loop #5 2024-10-14T16:30:42.580Z,1728923442.580 [Default:CheckIn] Running Loop=5 2024-10-14T16:30:42.580Z,1728923442.580 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T16:30:42.580Z,1728923442.580 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T16:33:18.106Z,1728923598.106 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2024-10-14T16:33:18.106Z,1728923598.106 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:33:18.117Z,1728923598.117 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:33:18.545Z,1728923598.545 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:33:18.545Z,1728923598.545 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2024-10-14T16:35:42.751Z,1728923742.751 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T16:30:42.6Z 2024-10-14T16:35:42.751Z,1728923742.751 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T16:35:42.751Z,1728923742.751 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T16:35:49.388Z,1728923749.388 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20241014T154451/Courier0016.lzma 2024-10-14T16:35:50.391Z,1728923750.391 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0016.lzma.bak 2024-10-14T16:35:50.391Z,1728923750.391 [DataOverHttps](INFO): SBD MOMSN=23294753 2024-10-14T16:36:06.060Z,1728923766.060 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20241014T154451/Express0017.lzma 2024-10-14T16:36:07.063Z,1728923767.063 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0017.lzma.bak 2024-10-14T16:36:07.063Z,1728923767.063 [DataOverHttps](INFO): SBD MOMSN=23294757 2024-10-14T16:36:08.606Z,1728923768.606 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T16:36:08.606Z,1728923768.606 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T16:36:08.606Z,1728923768.606 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T16:36:19.089Z,1728923779.089 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2024-10-14T16:36:19.089Z,1728923779.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:36:19.100Z,1728923779.100 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:36:19.515Z,1728923779.515 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:36:19.516Z,1728923779.516 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2024-10-14T16:38:40.479Z,1728923920.479 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T16:38:40.479Z,1728923920.479 [NAL9602] Data Fault, FailCount= 5 2024-10-14T16:38:40.479Z,1728923920.479 [NAL9602](ERROR): Data Fault 2024-10-14T16:38:40.505Z,1728923920.505 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T16:38:40.505Z,1728923920.505 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-10-14T16:38:40.890Z,1728923920.890 [NAL9602](INFO): Powering down 2024-10-14T16:38:40.908Z,1728923920.908 [CBIT](INFO): Critical error at 20241014T163840 2024-10-14T16:39:20.088Z,1728923960.088 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2024-10-14T16:39:20.088Z,1728923960.088 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:39:20.099Z,1728923960.099 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:39:20.507Z,1728923960.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:39:20.507Z,1728923960.507 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2024-10-14T16:40:40.509Z,1728924040.509 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T16:40:40.509Z,1728924040.509 [NAL9602] No Fault, FailCount= 5 2024-10-14T16:40:40.874Z,1728924040.874 [NAL9602](INFO): Powering up NAL9602 2024-10-14T16:40:51.782Z,1728924051.782 [NAL9602](INFO): NAL9602 initialized 2024-10-14T16:41:09.198Z,1728924069.198 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T16:41:09.199Z,1728924069.199 [Default:CheckIn:C.Wait] Stopped 2024-10-14T16:41:09.199Z,1728924069.199 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T16:41:09.199Z,1728924069.199 [Default:CheckIn:D] Running Loop=1 2024-10-14T16:41:09.590Z,1728924069.590 [Default:CheckIn:D] Stopped 2024-10-14T16:41:09.590Z,1728924069.590 [Default:CheckIn:E] Running Loop=1 2024-10-14T16:41:09.980Z,1728924069.980 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.555278 min 2024-10-14T16:41:09.980Z,1728924069.980 [Default:CheckIn:E] Stopped 2024-10-14T16:41:09.980Z,1728924069.980 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T16:41:09.980Z,1728924069.980 [Default:CheckIn] Stopped 2024-10-14T16:41:09.980Z,1728924069.980 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T16:41:09.980Z,1728924069.980 [Default:CheckIn](INFO): Running loop #6 2024-10-14T16:41:09.981Z,1728924069.981 [Default:CheckIn] Running Loop=6 2024-10-14T16:41:09.981Z,1728924069.981 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T16:41:09.981Z,1728924069.981 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T16:42:21.086Z,1728924141.086 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2024-10-14T16:42:21.086Z,1728924141.086 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:42:21.115Z,1728924141.115 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:42:21.529Z,1728924141.529 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T16:42:21.529Z,1728924141.529 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2024-10-14T16:45:05.933Z,1728924305.933 [CBIT](INFO): Clearing failed state for component DropWeight 2024-10-14T16:45:05.933Z,1728924305.933 [DropWeight] No Fault, FailCount= 1 2024-10-14T16:45:22.075Z,1728924322.075 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2024-10-14T16:45:22.075Z,1728924322.075 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T16:45:22.086Z,1728924322.086 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:45:22.086Z,1728924322.086 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T16:46:10.146Z,1728924370.146 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T16:41:09.0Z 2024-10-14T16:46:10.146Z,1728924370.146 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T16:46:10.146Z,1728924370.146 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T16:46:17.076Z,1728924377.076 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20241014T154451/Courier0019.lzma 2024-10-14T16:46:18.078Z,1728924378.078 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0019.lzma.bak 2024-10-14T16:46:18.079Z,1728924378.079 [DataOverHttps](INFO): SBD MOMSN=23294775 2024-10-14T16:46:32.633Z,1728924392.633 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20241014T154451/Express0020.lzma 2024-10-14T16:46:33.635Z,1728924393.635 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0020.lzma.bak 2024-10-14T16:46:33.635Z,1728924393.635 [DataOverHttps](INFO): SBD MOMSN=23294778 2024-10-14T16:46:35.206Z,1728924395.206 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T16:46:35.206Z,1728924395.206 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T16:46:35.206Z,1728924395.206 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T16:50:53.750Z,1728924653.750 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T16:50:53.751Z,1728924653.751 [NAL9602] Data Fault, FailCount= 1 2024-10-14T16:50:53.751Z,1728924653.751 [NAL9602](ERROR): Data Fault 2024-10-14T16:50:53.800Z,1728924653.800 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T16:50:54.150Z,1728924654.150 [NAL9602](INFO): Powering down 2024-10-14T16:50:54.980Z,1728924654.980 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T16:50:54.980Z,1728924654.980 [NAL9602] No Fault, FailCount= 1 2024-10-14T16:51:24.454Z,1728924684.454 [NAL9602](INFO): Powering up NAL9602 2024-10-14T16:51:35.362Z,1728924695.362 [NAL9602](INFO): NAL9602 initialized 2024-10-14T16:51:35.781Z,1728924695.781 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T16:51:35.781Z,1728924695.781 [Default:CheckIn:C.Wait] Stopped 2024-10-14T16:51:35.781Z,1728924695.781 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T16:51:35.781Z,1728924695.781 [Default:CheckIn:D] Running Loop=1 2024-10-14T16:51:36.198Z,1728924696.198 [Default:CheckIn:D] Stopped 2024-10-14T16:51:36.198Z,1728924696.198 [Default:CheckIn:E] Running Loop=1 2024-10-14T16:51:36.609Z,1728924696.609 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.998739 min 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn:E] Stopped 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn] Stopped 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn](INFO): Running loop #7 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn] Running Loop=7 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T16:51:36.610Z,1728924696.610 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T16:56:36.854Z,1728924996.854 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T16:51:36.6Z 2024-10-14T16:56:36.854Z,1728924996.854 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T16:56:36.854Z,1728924996.854 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T16:56:43.876Z,1728925003.876 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241014T154451/Courier0022.lzma 2024-10-14T16:56:45.487Z,1728925005.487 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0022.lzma.bak 2024-10-14T16:56:45.487Z,1728925005.487 [DataOverHttps](INFO): SBD MOMSN=23294797 2024-10-14T16:57:00.380Z,1728925020.380 [DataOverHttps](INFO): Sending 158 bytes from file Logs/20241014T154451/Express0023.lzma 2024-10-14T16:57:01.383Z,1728925021.383 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0023.lzma.bak 2024-10-14T16:57:01.383Z,1728925021.383 [DataOverHttps](INFO): SBD MOMSN=23294799 2024-10-14T16:57:03.119Z,1728925023.119 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T16:57:03.119Z,1728925023.119 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T16:57:03.119Z,1728925023.119 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T17:00:22.340Z,1728925222.340 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:00:22.340Z,1728925222.340 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2024-10-14T17:01:37.066Z,1728925297.066 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T17:01:37.067Z,1728925297.067 [NAL9602] Data Fault, FailCount= 2 2024-10-14T17:01:37.067Z,1728925297.067 [NAL9602](ERROR): Data Fault 2024-10-14T17:01:37.085Z,1728925297.085 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T17:01:37.462Z,1728925297.462 [NAL9602](INFO): Powering down 2024-10-14T17:01:38.341Z,1728925298.341 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T17:01:38.342Z,1728925298.342 [NAL9602] No Fault, FailCount= 2 2024-10-14T17:02:03.746Z,1728925323.746 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T17:02:03.746Z,1728925323.746 [Default:CheckIn:C.Wait] Stopped 2024-10-14T17:02:03.746Z,1728925323.746 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T17:02:03.746Z,1728925323.746 [Default:CheckIn:D] Running Loop=1 2024-10-14T17:02:04.127Z,1728925324.127 [Default:CheckIn:D] Stopped 2024-10-14T17:02:04.127Z,1728925324.127 [Default:CheckIn:E] Running Loop=1 2024-10-14T17:02:04.534Z,1728925324.534 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.464217 min 2024-10-14T17:02:04.534Z,1728925324.534 [Default:CheckIn:E] Stopped 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn] Stopped 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn](INFO): Running loop #8 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn] Running Loop=8 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T17:02:04.535Z,1728925324.535 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T17:02:07.762Z,1728925327.762 [NAL9602](INFO): Powering up NAL9602 2024-10-14T17:02:18.666Z,1728925338.666 [NAL9602](INFO): NAL9602 initialized 2024-10-14T17:03:22.914Z,1728925402.914 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-10-14T17:03:22.914Z,1728925402.914 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:03:22.925Z,1728925402.925 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:03:23.335Z,1728925403.335 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:03:23.335Z,1728925403.335 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-10-14T17:06:23.926Z,1728925583.926 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-10-14T17:06:23.926Z,1728925583.926 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:06:23.937Z,1728925583.937 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:06:24.346Z,1728925584.346 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:06:24.346Z,1728925584.346 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-10-14T17:07:04.731Z,1728925624.731 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T17:02:04.5Z 2024-10-14T17:07:04.731Z,1728925624.731 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T17:07:04.731Z,1728925624.731 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T17:07:11.688Z,1728925631.688 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241014T154451/Courier0025.lzma 2024-10-14T17:07:12.690Z,1728925632.690 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0025.lzma.bak 2024-10-14T17:07:12.691Z,1728925632.691 [DataOverHttps](INFO): SBD MOMSN=23294816 2024-10-14T17:07:28.220Z,1728925648.220 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20241014T154451/Express0026.lzma 2024-10-14T17:07:29.223Z,1728925649.223 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0026.lzma.bak 2024-10-14T17:07:29.223Z,1728925649.223 [DataOverHttps](INFO): SBD MOMSN=23294818 2024-10-14T17:07:30.591Z,1728925650.591 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T17:07:30.591Z,1728925650.591 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T17:07:30.591Z,1728925650.591 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T17:09:24.898Z,1728925764.898 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-10-14T17:09:24.898Z,1728925764.898 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:09:24.925Z,1728925764.925 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:09:25.311Z,1728925765.311 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:09:25.311Z,1728925765.311 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-10-14T17:12:19.867Z,1728925939.867 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T17:12:19.867Z,1728925939.867 [NAL9602] Data Fault, FailCount= 3 2024-10-14T17:12:19.867Z,1728925939.867 [NAL9602](ERROR): Data Fault 2024-10-14T17:12:19.885Z,1728925939.885 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T17:12:20.274Z,1728925940.274 [NAL9602](INFO): Powering down 2024-10-14T17:12:21.088Z,1728925941.088 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T17:12:21.088Z,1728925941.088 [NAL9602] No Fault, FailCount= 3 2024-10-14T17:12:25.933Z,1728925945.933 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-10-14T17:12:25.933Z,1728925945.933 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:12:25.961Z,1728925945.961 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:12:26.339Z,1728925946.339 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:12:26.340Z,1728925946.340 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-10-14T17:12:31.187Z,1728925951.187 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T17:12:31.187Z,1728925951.187 [Default:CheckIn:C.Wait] Stopped 2024-10-14T17:12:31.187Z,1728925951.187 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T17:12:31.187Z,1728925951.187 [Default:CheckIn:D] Running Loop=1 2024-10-14T17:12:31.594Z,1728925951.594 [Default:CheckIn:D] Stopped 2024-10-14T17:12:31.595Z,1728925951.595 [Default:CheckIn:E] Running Loop=1 2024-10-14T17:12:31.987Z,1728925951.987 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.922013 min 2024-10-14T17:12:31.987Z,1728925951.987 [Default:CheckIn:E] Stopped 2024-10-14T17:12:31.987Z,1728925951.987 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T17:12:31.987Z,1728925951.987 [Default:CheckIn] Stopped 2024-10-14T17:12:31.988Z,1728925951.988 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:12:31.988Z,1728925951.988 [Default:CheckIn](INFO): Running loop #9 2024-10-14T17:12:31.988Z,1728925951.988 [Default:CheckIn] Running Loop=9 2024-10-14T17:12:31.988Z,1728925951.988 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T17:12:31.988Z,1728925951.988 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T17:12:50.566Z,1728925970.566 [NAL9602](INFO): Powering up NAL9602 2024-10-14T17:13:01.478Z,1728925981.478 [NAL9602](INFO): NAL9602 initialized 2024-10-14T17:15:07.118Z,1728926107.118 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-10-14T17:15:07.118Z,1728926107.118 [DropWeight] Hardware Fault, FailCount= 1 2024-10-14T17:15:07.118Z,1728926107.118 [DropWeight](ERROR): Hardware Fault 2024-10-14T17:15:07.185Z,1728926107.185 [CBIT](INFO): Critical error at 20241014T171507 2024-10-14T17:15:07.187Z,1728926107.187 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-10-14T17:15:07.188Z,1728926107.188 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-10-14T17:15:07.539Z,1728926107.539 [CBIT](INFO): Critical error at 20241014T171507 2024-10-14T17:15:26.946Z,1728926126.946 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-10-14T17:15:26.946Z,1728926126.946 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:15:26.957Z,1728926126.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:15:27.365Z,1728926127.365 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:15:27.365Z,1728926127.365 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-10-14T17:17:26.144Z,1728926246.144 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:17:32.182Z,1728926252.182 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T17:12:31.0Z 2024-10-14T17:17:32.182Z,1728926252.182 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T17:17:32.183Z,1728926252.183 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T17:17:40.258Z,1728926260.258 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20241014T154451/Courier0028.lzma 2024-10-14T17:17:40.699Z,1728926260.699 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0028.lzma.bak 2024-10-14T17:17:40.699Z,1728926260.699 [DataOverHttps](INFO): SBD MOMSN=23294836 2024-10-14T17:17:52.861Z,1728926272.861 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:17:56.308Z,1728926276.308 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20241014T154451/Express0029.lzma 2024-10-14T17:17:57.310Z,1728926277.310 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0029.lzma.bak 2024-10-14T17:17:57.311Z,1728926277.311 [DataOverHttps](INFO): SBD MOMSN=23294840 2024-10-14T17:17:58.842Z,1728926278.842 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T17:17:58.842Z,1728926278.842 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T17:17:58.842Z,1728926278.842 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T17:18:27.994Z,1728926307.994 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-10-14T17:18:27.994Z,1728926307.994 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:18:28.005Z,1728926308.005 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:18:28.379Z,1728926308.379 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:18:28.379Z,1728926308.379 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-10-14T17:18:55.038Z,1728926335.038 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:19:39.469Z,1728926379.469 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:20:13.078Z,1728926413.078 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:20:38.896Z,1728926438.896 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:21:07.183Z,1728926467.183 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:21:20.918Z,1728926480.918 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:21:28.962Z,1728926488.962 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-10-14T17:21:28.962Z,1728926488.962 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:21:28.973Z,1728926488.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:21:29.379Z,1728926489.379 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:21:29.379Z,1728926489.379 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-10-14T17:21:54.856Z,1728926514.856 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:22:01.315Z,1728926521.315 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:22:42.877Z,1728926562.877 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-10-14T17:22:42.879Z,1728926562.879 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2024-10-14T17:22:59.468Z,1728926579.468 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T17:22:59.468Z,1728926579.468 [Default:CheckIn:C.Wait] Stopped 2024-10-14T17:22:59.469Z,1728926579.469 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T17:22:59.469Z,1728926579.469 [Default:CheckIn:D] Running Loop=1 2024-10-14T17:22:59.890Z,1728926579.890 [Default:CheckIn:D] Stopped 2024-10-14T17:22:59.890Z,1728926579.890 [Default:CheckIn:E] Running Loop=1 2024-10-14T17:23:00.278Z,1728926580.278 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.393612 min 2024-10-14T17:23:00.278Z,1728926580.278 [Default:CheckIn:E] Stopped 2024-10-14T17:23:00.278Z,1728926580.278 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T17:23:00.278Z,1728926580.278 [Default:CheckIn] Stopped 2024-10-14T17:23:00.278Z,1728926580.278 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:23:00.278Z,1728926580.278 [Default:CheckIn](INFO): Running loop #10 2024-10-14T17:23:00.279Z,1728926580.279 [Default:CheckIn] Running Loop=10 2024-10-14T17:23:00.279Z,1728926580.279 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T17:23:00.279Z,1728926580.279 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T17:23:02.695Z,1728926582.695 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T17:23:02.695Z,1728926582.695 [NAL9602] Data Fault, FailCount= 4 2024-10-14T17:23:02.695Z,1728926582.695 [NAL9602](ERROR): Data Fault 2024-10-14T17:23:02.713Z,1728926582.713 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T17:23:03.109Z,1728926583.109 [NAL9602](INFO): Powering down 2024-10-14T17:23:03.911Z,1728926583.911 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T17:23:03.911Z,1728926583.911 [NAL9602] No Fault, FailCount= 4 2024-10-14T17:23:10.410Z,1728926590.410 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:23:24.555Z,1728926604.555 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:23:33.382Z,1728926613.382 [NAL9602](INFO): Powering up NAL9602 2024-10-14T17:23:39.102Z,1728926619.102 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:23:44.294Z,1728926624.294 [NAL9602](INFO): NAL9602 initialized 2024-10-14T17:23:55.259Z,1728926635.259 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:24:29.968Z,1728926669.968 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-10-14T17:24:29.968Z,1728926669.968 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:24:30.006Z,1728926670.006 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:24:30.384Z,1728926670.384 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:24:30.384Z,1728926670.384 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-10-14T17:24:31.974Z,1728926671.974 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:24:52.578Z,1728926692.578 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:25:13.586Z,1728926713.586 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:25:33.785Z,1728926733.785 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:25:53.992Z,1728926753.992 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:26:11.420Z,1728926771.420 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:26:14.186Z,1728926774.186 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:26:34.789Z,1728926794.789 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:26:40.105Z,1728926800.105 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:26:54.649Z,1728926814.649 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:27:30.978Z,1728926850.978 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-10-14T17:27:30.978Z,1728926850.978 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:27:31.021Z,1728926851.021 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:27:31.377Z,1728926851.377 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:27:31.377Z,1728926851.377 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-10-14T17:27:53.626Z,1728926873.626 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:28:00.468Z,1728926880.468 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T17:23:00.3Z 2024-10-14T17:28:00.468Z,1728926880.468 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T17:28:00.468Z,1728926880.468 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T17:28:07.768Z,1728926887.768 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20241014T154451/Courier0031.lzma 2024-10-14T17:28:08.770Z,1728926888.770 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0031.lzma.bak 2024-10-14T17:28:08.771Z,1728926888.771 [DataOverHttps](INFO): SBD MOMSN=23294857 2024-10-14T17:28:24.444Z,1728926904.444 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20241014T154451/Express0032.lzma 2024-10-14T17:28:25.447Z,1728926905.447 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0032.lzma.bak 2024-10-14T17:28:25.447Z,1728926905.447 [DataOverHttps](INFO): SBD MOMSN=23294859 2024-10-14T17:28:27.124Z,1728926907.124 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T17:28:27.124Z,1728926907.124 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T17:28:27.124Z,1728926907.124 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T17:29:50.381Z,1728926990.381 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:30:07.361Z,1728927007.361 [CBIT](INFO): Clearing failed state for component DropWeight 2024-10-14T17:30:07.361Z,1728927007.361 [DropWeight] No Fault, FailCount= 1 2024-10-14T17:30:32.009Z,1728927032.009 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-10-14T17:30:32.009Z,1728927032.009 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:30:32.028Z,1728927032.028 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:30:32.443Z,1728927032.443 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:30:32.443Z,1728927032.443 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-10-14T17:30:46.975Z,1728927046.975 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:31:27.379Z,1728927087.379 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:32:27.582Z,1728927147.582 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:32:31.617Z,1728927151.617 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:33:12.018Z,1728927192.018 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:33:27.783Z,1728927207.783 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T17:33:27.783Z,1728927207.783 [Default:CheckIn:C.Wait] Stopped 2024-10-14T17:33:27.783Z,1728927207.783 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T17:33:27.783Z,1728927207.783 [Default:CheckIn:D] Running Loop=1 2024-10-14T17:33:28.163Z,1728927208.163 [Default:CheckIn:D] Stopped 2024-10-14T17:33:28.163Z,1728927208.163 [Default:CheckIn:E] Running Loop=1 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.864819 min 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn:E] Stopped 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn] Stopped 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn](INFO): Running loop #11 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn] Running Loop=11 2024-10-14T17:33:28.554Z,1728927208.554 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T17:33:28.555Z,1728927208.555 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T17:33:32.992Z,1728927212.992 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-10-14T17:33:32.992Z,1728927212.992 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:33:33.003Z,1728927213.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:33:33.419Z,1728927213.419 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:33:33.419Z,1728927213.419 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-10-14T17:33:45.498Z,1728927225.498 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T17:33:45.498Z,1728927225.498 [NAL9602] Data Fault, FailCount= 5 2024-10-14T17:33:45.498Z,1728927225.498 [NAL9602](ERROR): Data Fault 2024-10-14T17:33:45.553Z,1728927225.553 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T17:33:45.553Z,1728927225.553 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-10-14T17:33:45.951Z,1728927225.951 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:33:45.954Z,1728927225.954 [NAL9602](INFO): Powering down 2024-10-14T17:33:45.970Z,1728927225.970 [CBIT](INFO): Critical error at 20241014T173345 2024-10-14T17:33:54.378Z,1728927234.378 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:34:12.216Z,1728927252.216 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:34:14.578Z,1728927254.578 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:34:35.181Z,1728927275.181 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:34:55.786Z,1728927295.786 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:34:57.869Z,1728927297.869 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:35:15.615Z,1728927315.615 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:35:36.605Z,1728927336.605 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:35:45.499Z,1728927345.499 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T17:35:45.499Z,1728927345.499 [NAL9602] No Fault, FailCount= 5 2024-10-14T17:35:45.886Z,1728927345.886 [NAL9602](INFO): Powering up NAL9602 2024-10-14T17:35:56.826Z,1728927356.826 [NAL9602](INFO): NAL9602 initialized 2024-10-14T17:35:57.194Z,1728927357.194 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:36:26.341Z,1728927386.341 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:36:33.977Z,1728927393.977 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-10-14T17:36:33.977Z,1728927393.977 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:36:34.013Z,1728927394.013 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:36:34.387Z,1728927394.387 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:36:34.387Z,1728927394.387 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-10-14T17:36:56.289Z,1728927416.289 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:37:37.865Z,1728927457.865 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:38:28.720Z,1728927508.720 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T17:33:28.6Z 2024-10-14T17:38:28.720Z,1728927508.720 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T17:38:28.720Z,1728927508.720 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T17:38:35.504Z,1728927515.504 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20241014T154451/Courier0034.lzma 2024-10-14T17:38:36.507Z,1728927516.507 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0034.lzma.bak 2024-10-14T17:38:36.507Z,1728927516.507 [DataOverHttps](INFO): SBD MOMSN=23294876 2024-10-14T17:38:52.081Z,1728927532.081 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20241014T154451/Express0035.lzma 2024-10-14T17:38:53.083Z,1728927533.083 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0035.lzma.bak 2024-10-14T17:38:53.083Z,1728927533.083 [DataOverHttps](INFO): SBD MOMSN=23294879 2024-10-14T17:38:54.575Z,1728927534.575 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T17:38:54.575Z,1728927534.575 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T17:38:54.575Z,1728927534.575 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T17:39:28.963Z,1728927568.963 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:39:34.970Z,1728927574.970 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-10-14T17:39:34.970Z,1728927574.970 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:39:34.981Z,1728927574.981 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:39:35.382Z,1728927575.382 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:39:35.382Z,1728927575.382 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-10-14T17:39:55.201Z,1728927595.201 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:40:50.959Z,1728927650.959 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:40:57.015Z,1728927657.015 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:41:05.921Z,1728927665.921 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:42:19.437Z,1728927739.437 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:42:35.963Z,1728927755.963 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-10-14T17:42:35.963Z,1728927755.963 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:42:35.974Z,1728927755.974 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:42:36.391Z,1728927756.391 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:42:36.391Z,1728927756.391 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-10-14T17:43:05.043Z,1728927785.043 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-10-14T17:43:20.801Z,1728927800.801 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-10-14T17:43:28.466Z,1728927808.466 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:43:47.914Z,1728927827.914 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:43:49.070Z,1728927829.070 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:43:55.146Z,1728927835.146 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T17:43:55.146Z,1728927835.146 [Default:CheckIn:C.Wait] Stopped 2024-10-14T17:43:55.146Z,1728927835.146 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T17:43:55.147Z,1728927835.147 [Default:CheckIn:D] Running Loop=1 2024-10-14T17:43:55.576Z,1728927835.576 [Default:CheckIn:D] Stopped 2024-10-14T17:43:55.576Z,1728927835.576 [Default:CheckIn:E] Running Loop=1 2024-10-14T17:43:55.978Z,1728927835.978 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.321704 min 2024-10-14T17:43:55.978Z,1728927835.978 [Default:CheckIn:E] Stopped 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn] Stopped 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn](INFO): Running loop #12 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn] Running Loop=12 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T17:43:55.979Z,1728927835.979 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T17:44:08.865Z,1728927848.865 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:44:29.469Z,1728927869.469 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:44:31.144Z,1728927871.144 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-10-14T17:44:50.073Z,1728927890.073 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:45:09.874Z,1728927909.874 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:45:30.474Z,1728927930.474 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2024-10-14T17:45:36.954Z,1728927936.954 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-10-14T17:45:36.955Z,1728927936.955 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:45:36.985Z,1728927936.985 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:45:37.367Z,1728927937.367 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:45:37.368Z,1728927937.368 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-10-14T17:45:58.762Z,1728927958.762 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T17:45:58.762Z,1728927958.762 [NAL9602] Data Fault, FailCount= 1 2024-10-14T17:45:58.762Z,1728927958.762 [NAL9602](ERROR): Data Fault 2024-10-14T17:45:58.780Z,1728927958.780 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T17:45:59.167Z,1728927959.167 [NAL9602](INFO): Powering down 2024-10-14T17:45:59.809Z,1728927959.809 [CommandExec](IMPORTANT): got command configSet list 2024-10-14T17:45:59.810Z,1728927959.810 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-14T17:45:59.810Z,1728927959.810 [CommandExec](IMPORTANT): CANONSampler.loadAtStartup=0 bool; 2024-10-14T17:45:59.811Z,1728927959.811 [CommandExec](IMPORTANT): CANONSampler.simulateHardware=1 bool; 2024-10-14T17:45:59.812Z,1728927959.812 [CommandExec](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-10-14T17:45:59.813Z,1728927959.813 [CommandExec](IMPORTANT): DATMMP.loadAtStartup=1 bool; 2024-10-14T17:45:59.813Z,1728927959.813 [CommandExec](IMPORTANT): DATMMP.simulateHardware=0 bool; 2024-10-14T17:45:59.814Z,1728927959.814 [CommandExec](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2024-10-14T17:45:59.814Z,1728927959.814 [CommandExec](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-10-14T17:45:59.815Z,1728927959.815 [CommandExec](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2024-10-14T17:45:59.816Z,1728927959.816 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=89.418285 cubic_centimeter; 2024-10-14T17:45:59.817Z,1728927959.817 [CommandExec](IMPORTANT): VerticalControl.massDefault=4.795493 millimeter; 2024-10-14T17:46:00.034Z,1728927960.034 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T17:46:00.035Z,1728927960.035 [NAL9602] No Fault, FailCount= 1 2024-10-14T17:46:00.420Z,1728927960.420 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:46:13.351Z,1728927973.351 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:46:29.466Z,1728927989.466 [NAL9602](INFO): Powering up NAL9602 2024-10-14T17:46:40.386Z,1728928000.386 [NAL9602](INFO): NAL9602 initialized 2024-10-14T17:46:53.348Z,1728928013.348 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-10-14T17:47:05.426Z,1728928025.426 [BPC1](INFO): Calculating totals. Valid battery stick count: 47. Valid reserve battery stick count: 4. 2024-10-14T17:47:05.428Z,1728928025.428 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-10-14T17:48:37.959Z,1728928117.959 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2024-10-14T17:48:37.959Z,1728928117.959 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:48:37.982Z,1728928117.982 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:48:38.381Z,1728928118.381 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:48:38.381Z,1728928118.381 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2024-10-14T17:48:56.147Z,1728928136.147 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T17:43:55.0Z 2024-10-14T17:48:56.147Z,1728928136.147 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T17:48:56.147Z,1728928136.147 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T17:49:03.776Z,1728928143.776 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20241014T154451/Courier0037.lzma 2024-10-14T17:49:04.781Z,1728928144.781 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0037.lzma.bak 2024-10-14T17:49:04.781Z,1728928144.781 [DataOverHttps](INFO): SBD MOMSN=23294932 2024-10-14T17:49:20.293Z,1728928160.293 [DataOverHttps](INFO): Sending 498 bytes from file Logs/20241014T154451/Express0038.lzma 2024-10-14T17:49:21.295Z,1728928161.295 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Express0038.lzma.bak 2024-10-14T17:49:21.295Z,1728928161.295 [DataOverHttps](INFO): SBD MOMSN=23294934 2024-10-14T17:49:22.807Z,1728928162.807 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T17:49:22.808Z,1728928162.808 [Default:CheckIn:C.Wait] Running Loop=1 2024-10-14T17:49:22.808Z,1728928162.808 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-10-14T17:51:38.946Z,1728928298.946 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2024-10-14T17:51:38.946Z,1728928298.946 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:51:38.957Z,1728928298.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:51:39.372Z,1728928299.372 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:51:39.372Z,1728928299.372 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2024-10-14T17:54:23.379Z,1728928463.379 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-10-14T17:54:23.380Z,1728928463.380 [Default:CheckIn:C.Wait] Stopped 2024-10-14T17:54:23.380Z,1728928463.380 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-10-14T17:54:23.380Z,1728928463.380 [Default:CheckIn:D] Running Loop=1 2024-10-14T17:54:23.767Z,1728928463.767 [Default:CheckIn:D] Stopped 2024-10-14T17:54:23.767Z,1728928463.767 [Default:CheckIn:E] Running Loop=1 2024-10-14T17:54:24.185Z,1728928464.185 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 125.791561 min 2024-10-14T17:54:24.185Z,1728928464.185 [Default:CheckIn:E] Stopped 2024-10-14T17:54:24.185Z,1728928464.185 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-10-14T17:54:24.185Z,1728928464.185 [Default:CheckIn] Stopped 2024-10-14T17:54:24.185Z,1728928464.185 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:54:24.185Z,1728928464.185 [Default:CheckIn](INFO): Running loop #13 2024-10-14T17:54:24.186Z,1728928464.186 [Default:CheckIn] Running Loop=13 2024-10-14T17:54:24.186Z,1728928464.186 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-10-14T17:54:24.186Z,1728928464.186 [Default:CheckIn:Read_GPS] Running Loop=1 2024-10-14T17:54:39.939Z,1728928479.939 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2024-10-14T17:54:39.939Z,1728928479.939 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:54:39.950Z,1728928479.950 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:54:40.355Z,1728928480.355 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:54:40.355Z,1728928480.355 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2024-10-14T17:56:42.335Z,1728928602.335 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-10-14T17:56:42.335Z,1728928602.335 [NAL9602] Data Fault, FailCount= 2 2024-10-14T17:56:42.335Z,1728928602.335 [NAL9602](ERROR): Data Fault 2024-10-14T17:56:42.393Z,1728928602.393 [CBIT](ERROR): Data Fault in component: NAL9602 2024-10-14T17:56:42.738Z,1728928602.738 [NAL9602](INFO): Powering down 2024-10-14T17:56:43.567Z,1728928603.567 [CBIT](INFO): Clearing failed state for component NAL9602 2024-10-14T17:56:43.567Z,1728928603.567 [NAL9602] No Fault, FailCount= 2 2024-10-14T17:57:13.038Z,1728928633.038 [NAL9602](INFO): Powering up NAL9602 2024-10-14T17:57:23.946Z,1728928643.946 [NAL9602](INFO): NAL9602 initialized 2024-10-14T17:57:40.945Z,1728928660.945 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2024-10-14T17:57:40.945Z,1728928660.945 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-14T17:57:40.957Z,1728928660.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-14T17:57:41.373Z,1728928661.373 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-14T17:57:41.373Z,1728928661.373 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2024-10-14T17:59:24.350Z,1728928764.350 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-14T17:54:24.2Z 2024-10-14T17:59:24.350Z,1728928764.350 [Default:CheckIn:Read_GPS] Stopped 2024-10-14T17:59:24.350Z,1728928764.350 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-10-14T17:59:29.553Z,1728928769.553 [CommandExec](IMPORTANT): got command failComponent 2024-10-14T17:59:29.553Z,1728928769.553 [CommandExec](IMPORTANT): Failed components: 2024-10-14T17:59:29.554Z,1728928769.554 [CommandExec](IMPORTANT): No failed Components. 2024-10-14T17:59:31.889Z,1728928771.889 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241014T154451/Courier0040.lzma 2024-10-14T17:59:32.890Z,1728928772.890 [DataOverHttps](INFO): Moved sent file to Logs/20241014T154451/Courier0040.lzma.bak 2024-10-14T17:59:32.891Z,1728928772.891 [DataOverHttps](INFO): SBD MOMSN=23295001 2024-10-14T17:59:36.527Z,1728928776.527 [CommandExec](IMPORTANT): got command restart application 2024-10-14T17:59:37.529Z,1728928777.529 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:37.529Z,1728928777.529 [CommandExec](INFO): Uninitializing the command executive. 2024-10-14T17:59:37.529Z,1728928777.529 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-14T17:59:37.529Z,1728928777.529 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:37.733Z,1728928777.733 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-14T17:59:37.733Z,1728928777.733 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-14T17:59:37.733Z,1728928777.733 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:37.734Z,1728928777.734 [NavChartDb](INFO): Join timeout helper Thread ID is 3939 2024-10-14T17:59:37.837Z,1728928777.837 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:37.837Z,1728928777.837 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:37.841Z,1728928777.841 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-10-14T17:59:37.841Z,1728928777.841 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:37.841Z,1728928777.841 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3940 2024-10-14T17:59:38.313Z,1728928778.313 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:38.313Z,1728928778.313 [WetLabsBB2FL](INFO): Powering down 2024-10-14T17:59:38.314Z,1728928778.314 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:38.317Z,1728928778.317 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-10-14T17:59:38.317Z,1728928778.317 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:38.317Z,1728928778.317 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3941 2024-10-14T17:59:38.689Z,1728928778.689 [CTD_Seabird](INFO): Powering down 2024-10-14T17:59:38.701Z,1728928778.701 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:38.701Z,1728928778.701 [CTD_Seabird](INFO): Powering down 2024-10-14T17:59:38.713Z,1728928778.713 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:38.726Z,1728928778.726 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-14T17:59:38.726Z,1728928778.726 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:38.726Z,1728928778.726 [Radio_Surface](INFO): Join timeout helper Thread ID is 3942 2024-10-14T17:59:39.057Z,1728928779.057 [Radio_Surface](INFO): Powering down 2024-10-14T17:59:39.058Z,1728928779.058 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:39.058Z,1728928779.058 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:39.069Z,1728928779.069 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-14T17:59:39.069Z,1728928779.069 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:39.069Z,1728928779.069 [Onboard](INFO): Join timeout helper Thread ID is 3943 2024-10-14T17:59:39.845Z,1728928779.845 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:39.845Z,1728928779.845 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:39.850Z,1728928779.850 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-14T17:59:39.850Z,1728928779.850 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:39.850Z,1728928779.850 [DataOverHttps](INFO): Join timeout helper Thread ID is 3944 2024-10-14T17:59:40.593Z,1728928780.593 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:40.596Z,1728928780.596 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.605Z,1728928780.605 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-10-14T17:59:40.605Z,1728928780.605 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.606Z,1728928780.606 [DATMMP](INFO): Join timeout helper Thread ID is 3945 2024-10-14T17:59:40.741Z,1728928780.741 [DATMMP](INFO): Stop 2024-10-14T17:59:40.741Z,1728928780.741 [DATMMP](INFO): uninitialize 2024-10-14T17:59:40.741Z,1728928780.741 [DATMMP](INFO): Powering down 2024-10-14T17:59:40.813Z,1728928780.813 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:40.814Z,1728928780.814 [DATMMP](INFO): uninitialize 2024-10-14T17:59:40.814Z,1728928780.814 [DATMMP](INFO): Powering down 2024-10-14T17:59:40.815Z,1728928780.815 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.829Z,1728928780.829 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-14T17:59:40.830Z,1728928780.830 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.830Z,1728928780.830 [logger](INFO): Join timeout helper Thread ID is 3946 2024-10-14T17:59:40.849Z,1728928780.849 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:40.849Z,1728928780.849 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.869Z,1728928780.869 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-14T17:59:40.869Z,1728928780.869 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.870Z,1728928780.870 [CommandLine](INFO): Join timeout helper Thread ID is 3947 2024-10-14T17:59:40.953Z,1728928780.953 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:40.953Z,1728928780.953 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.961Z,1728928780.961 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-14T17:59:40.961Z,1728928780.961 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.962Z,1728928780.962 [CommandExec](INFO): Join timeout helper Thread ID is 3948 2024-10-14T17:59:40.963Z,1728928780.963 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-14T17:59:40.963Z,1728928780.963 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:40.964Z,1728928780.964 [controlThread](INFO): Join timeout helper Thread ID is 3949 2024-10-14T17:59:41.289Z,1728928781.289 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-14T17:59:41.289Z,1728928781.289 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-14T17:59:41.289Z,1728928781.289 [AHRS_M2](INFO): Powering down 2024-10-14T17:59:41.362Z,1728928781.362 [NAL9602](INFO): Powering down 2024-10-14T17:59:41.364Z,1728928781.364 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-14T17:59:41.364Z,1728928781.364 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-14T17:59:41.365Z,1728928781.365 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-14T17:59:41.365Z,1728928781.365 [MissionManager](INFO): Uninitializing Mission Default 2024-10-14T17:59:41.366Z,1728928781.366 [Default] Stopped 2024-10-14T17:59:41.366Z,1728928781.366 [Default](DEBUG): Aggregate::uninitialize Default 2024-10-14T17:59:41.366Z,1728928781.366 [Default:B.GoToSurface] Stopped 2024-10-14T17:59:41.366Z,1728928781.366 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-14T17:59:41.366Z,1728928781.366 [Default:CheckIn] Stopped 2024-10-14T17:59:41.366Z,1728928781.366 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-10-14T17:59:41.366Z,1728928781.366 [Default:CheckIn:Read_Iridium] Stopped 2024-10-14T17:59:41.369Z,1728928781.369 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-14T17:59:41.369Z,1728928781.369 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-14T17:59:41.369Z,1728928781.369 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-14T17:59:41.370Z,1728928781.370 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-14T17:59:41.370Z,1728928781.370 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-14T17:59:41.370Z,1728928781.370 [BuoyancyServo](INFO): Powering down 2024-10-14T17:59:41.385Z,1728928781.385 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-14T17:59:41.385Z,1728928781.385 [ElevatorServo](INFO): Powering down 2024-10-14T17:59:41.386Z,1728928781.386 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-14T17:59:41.386Z,1728928781.386 [MassServo](INFO): Powering down 2024-10-14T17:59:41.387Z,1728928781.387 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-14T17:59:41.387Z,1728928781.387 [RudderServo](INFO): Powering down 2024-10-14T17:59:41.388Z,1728928781.388 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-10-14T17:59:41.388Z,1728928781.388 [ThrusterHE](INFO): Powering down 2024-10-14T17:59:41.389Z,1728928781.389 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-14T17:59:41.389Z,1728928781.389 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-14T17:59:41.389Z,1728928781.389 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-14T17:59:41.389Z,1728928781.389 [CBIT](DEBUG): Powering off loads. 2024-10-14T17:59:41.401Z,1728928781.401 [CBIT](DEBUG): Disabling WDT. 2024-10-14T17:59:41.412Z,1728928781.412 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-14T17:59:41.413Z,1728928781.413 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.461Z,1728928781.461 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.465Z,1728928781.465 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.471Z,1728928781.471 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.477Z,1728928781.477 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.550Z,1728928781.550 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.554Z,1728928781.554 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.596Z,1728928781.596 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-14T17:59:41.661Z,1728928781.661 [logger ThreadHandler](INFO): Thread cancelled.