2024-09-12T18:27:21.253Z,1726165641.253 [Supervisor](DEBUG): Initializing supervisor.
2024-09-12T18:27:21.258Z,1726165641.258 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-09-12T18:27:21.258Z,1726165641.258 [SyncHandler](INFO): Protected caller Thread ID is 3655
2024-09-12T18:27:21.259Z,1726165641.259 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-09-12T18:27:21.259Z,1726165641.259 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-09-12T18:27:21.260Z,1726165641.260 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3656
2024-09-12T18:27:21.264Z,1726165641.264 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-09-12T18:27:21.281Z,1726165641.281 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-09-12T18:27:21.282Z,1726165641.282 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-09-12T18:27:21.282Z,1726165641.282 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3657
2024-09-12T18:27:21.286Z,1726165641.286 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-09-12T18:27:21.287Z,1726165641.287 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-09-12T18:27:21.287Z,1726165641.287 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3658
2024-09-12T18:27:21.289Z,1726165641.289 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-09-12T18:27:21.290Z,1726165641.290 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-09-12T18:27:21.291Z,1726165641.291 [logger ThreadHandler](INFO): Protected caller Thread ID is 3659
2024-09-12T18:27:21.294Z,1726165641.294 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-09-12T18:27:21.295Z,1726165641.295 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-09-12T18:27:21.300Z,1726165641.300 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-09-12T18:27:21.645Z,1726165641.645 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-09-12T18:27:21.647Z,1726165641.647 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-09-12T18:27:21.743Z,1726165641.743 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-09-12T18:27:22.299Z,1726165642.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-09-12T18:27:22.300Z,1726165642.300 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-09-12T18:27:22.666Z,1726165642.666 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-09-12T18:27:22.668Z,1726165642.668 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-09-12T18:27:22.779Z,1726165642.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-09-12T18:27:22.779Z,1726165642.779 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-09-12T18:27:23.208Z,1726165643.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-09-12T18:27:23.210Z,1726165643.210 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-09-12T18:27:23.440Z,1726165643.440 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-09-12T18:27:23.442Z,1726165643.442 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-09-12T18:27:24.040Z,1726165644.040 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-09-12T18:27:24.042Z,1726165644.042 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-09-12T18:27:24.239Z,1726165644.239 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-09-12T18:27:24.241Z,1726165644.241 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-09-12T18:27:24.337Z,1726165644.337 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-09-12T18:27:25.373Z,1726165645.373 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-09-12T18:27:25.374Z,1726165645.374 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-09-12T18:27:25.775Z,1726165645.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-09-12T18:27:25.777Z,1726165645.777 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-09-12T18:27:25.992Z,1726165645.992 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-09-12T18:27:25.993Z,1726165645.993 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-09-12T18:27:26.118Z,1726165646.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-09-12T18:27:26.119Z,1726165646.119 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-09-12T18:27:26.361Z,1726165646.361 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-09-12T18:27:26.362Z,1726165646.362 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-09-12T18:27:26.628Z,1726165646.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-09-12T18:27:26.630Z,1726165646.630 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2024-09-12T18:27:26.633Z,1726165646.633 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2024-09-12T18:27:26.748Z,1726165646.748 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2024-09-12T18:27:26.849Z,1726165646.849 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2024-09-12T18:27:26.967Z,1726165646.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2024-09-12T18:27:27.065Z,1726165647.065 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2024-09-12T18:27:27.185Z,1726165647.185 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2024-09-12T18:27:27.292Z,1726165647.292 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2024-09-12T18:27:27.423Z,1726165647.423 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2024-09-12T18:27:27.593Z,1726165647.593 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2024-09-12T18:27:27.757Z,1726165647.757 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2024-09-12T18:27:27.883Z,1726165647.883 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2024-09-12T18:27:28.160Z,1726165648.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-09-12T18:27:28.162Z,1726165648.162 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2024-09-12T18:27:28.162Z,1726165648.162 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-09-12T18:27:28.180Z,1726165648.180 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-09-12T18:27:28.258Z,1726165648.258 [VerticalControl](DEBUG): Construct VerticalControl.
2024-09-12T18:27:28.317Z,1726165648.317 [VerticalControl] Loaded
2024-09-12T18:27:28.317Z,1726165648.317 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-09-12T18:27:28.320Z,1726165648.320 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-09-12T18:27:28.366Z,1726165648.366 [HorizontalControl] Loaded
2024-09-12T18:27:28.366Z,1726165648.366 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-09-12T18:27:28.368Z,1726165648.368 [SpeedControl](DEBUG): Construct SpeedControl.
2024-09-12T18:27:28.371Z,1726165648.371 [SpeedControl] Loaded
2024-09-12T18:27:28.372Z,1726165648.372 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-09-12T18:27:28.374Z,1726165648.374 [LoopControl](DEBUG): Construct LoopControl.
2024-09-12T18:27:28.375Z,1726165648.375 [LoopControl] Loaded
2024-09-12T18:27:28.375Z,1726165648.375 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-09-12T18:27:28.375Z,1726165648.375 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-09-12T18:27:28.377Z,1726165648.377 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-09-12T18:27:28.393Z,1726165648.393 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-09-12T18:27:28.393Z,1726165648.393 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-09-12T18:27:28.597Z,1726165648.597 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-09-12T18:27:28.598Z,1726165648.598 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-09-12T18:27:28.758Z,1726165648.758 [BuoyancyServo] Loaded
2024-09-12T18:27:28.759Z,1726165648.759 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-09-12T18:27:28.780Z,1726165648.780 [ElevatorServo] Loaded
2024-09-12T18:27:28.780Z,1726165648.780 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-09-12T18:27:28.801Z,1726165648.801 [MassServo] Loaded
2024-09-12T18:27:28.801Z,1726165648.801 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-09-12T18:27:28.821Z,1726165648.821 [RudderServo] Loaded
2024-09-12T18:27:28.821Z,1726165648.821 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-09-12T18:27:28.837Z,1726165648.837 [ThrusterHE] Loaded
2024-09-12T18:27:28.837Z,1726165648.837 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-09-12T18:27:28.838Z,1726165648.838 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-09-12T18:27:28.838Z,1726165648.838 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-09-12T18:27:28.975Z,1726165648.975 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-09-12T18:27:28.975Z,1726165648.975 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-09-12T18:27:28.989Z,1726165648.989 [NavChart] Loaded
2024-09-12T18:27:28.989Z,1726165648.989 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-09-12T18:27:28.995Z,1726165648.995 [UniversalFixResidualReporter] Loaded
2024-09-12T18:27:28.995Z,1726165648.995 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-09-12T18:27:28.995Z,1726165648.995 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-09-12T18:27:28.996Z,1726165648.996 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-09-12T18:27:29.094Z,1726165649.094 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-09-12T18:27:29.095Z,1726165649.095 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-09-12T18:27:29.926Z,1726165649.926 [AHRS_M2] Loaded
2024-09-12T18:27:29.926Z,1726165649.926 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-09-12T18:27:31.100Z,1726165651.100 [BPC1] Loaded
2024-09-12T18:27:31.100Z,1726165651.100 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-09-12T18:27:31.294Z,1726165651.294 [DATMMP] Loaded
2024-09-12T18:27:31.294Z,1726165651.294 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2024-09-12T18:27:31.295Z,1726165651.295 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 4094C4E0
2024-09-12T18:27:31.296Z,1726165651.296 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 3742
2024-09-12T18:27:31.592Z,1726165651.592 [DataOverHttps] Loaded
2024-09-12T18:27:31.592Z,1726165651.592 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-09-12T18:27:31.593Z,1726165651.593 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4097C4E0
2024-09-12T18:27:31.594Z,1726165651.594 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3743
2024-09-12T18:27:31.616Z,1726165651.616 [Depth_Keller] Loaded
2024-09-12T18:27:31.616Z,1726165651.616 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-09-12T18:27:31.679Z,1726165651.679 [NAL9602] Loaded
2024-09-12T18:27:31.680Z,1726165651.680 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-09-12T18:27:31.710Z,1726165651.710 [Onboard] Loaded
2024-09-12T18:27:31.710Z,1726165651.710 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-09-12T18:27:31.711Z,1726165651.711 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409AC4E0
2024-09-12T18:27:31.711Z,1726165651.711 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3744
2024-09-12T18:27:31.725Z,1726165651.725 [Power24vConverter] Loaded
2024-09-12T18:27:31.726Z,1726165651.726 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-09-12T18:27:31.741Z,1726165651.741 [Radio_Surface] Loaded
2024-09-12T18:27:31.741Z,1726165651.741 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-09-12T18:27:31.742Z,1726165651.742 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409DC4E0
2024-09-12T18:27:31.742Z,1726165651.742 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3745
2024-09-12T18:27:31.743Z,1726165651.743 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-09-12T18:27:31.744Z,1726165651.744 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-09-12T18:27:31.822Z,1726165651.822 [DepthRateCalculator] Loaded
2024-09-12T18:27:31.822Z,1726165651.822 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-09-12T18:27:31.827Z,1726165651.827 [PitchRateCalculator] Loaded
2024-09-12T18:27:31.828Z,1726165651.828 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-09-12T18:27:31.836Z,1726165651.836 [SpeedCalculator] Loaded
2024-09-12T18:27:31.837Z,1726165651.837 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-09-12T18:27:31.841Z,1726165651.841 [YawRateCalculator] Loaded
2024-09-12T18:27:31.842Z,1726165651.842 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-09-12T18:27:31.860Z,1726165651.860 [ElevatorOffsetCalculator] Loaded
2024-09-12T18:27:31.860Z,1726165651.860 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-09-12T18:27:31.861Z,1726165651.861 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-09-12T18:27:31.862Z,1726165651.862 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-09-12T18:27:32.043Z,1726165652.043 [CANONSampler] Loaded
2024-09-12T18:27:32.043Z,1726165652.043 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2024-09-12T18:27:32.109Z,1726165652.109 [CTD_Seabird] Loaded
2024-09-12T18:27:32.109Z,1726165652.109 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-09-12T18:27:32.110Z,1726165652.110 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A984E0
2024-09-12T18:27:32.110Z,1726165652.110 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3746
2024-09-12T18:27:32.134Z,1726165652.134 [PAR_Licor] Loaded
2024-09-12T18:27:32.134Z,1726165652.134 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-09-12T18:27:32.176Z,1726165652.176 [WetLabsBB2FL] Loaded
2024-09-12T18:27:32.176Z,1726165652.176 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-09-12T18:27:32.177Z,1726165652.177 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AC84E0
2024-09-12T18:27:32.177Z,1726165652.177 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3747
2024-09-12T18:27:32.178Z,1726165652.178 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-09-12T18:27:32.179Z,1726165652.179 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-09-12T18:27:32.221Z,1726165652.221 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-09-12T18:27:32.222Z,1726165652.222 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-09-12T18:27:32.608Z,1726165652.608 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-09-12T18:27:32.609Z,1726165652.609 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-09-12T18:27:32.794Z,1726165652.794 [SBIT](DEBUG): Construct Startup Built In Test.
2024-09-12T18:27:32.803Z,1726165652.803 [SBIT] Loaded
2024-09-12T18:27:32.803Z,1726165652.803 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-09-12T18:27:32.806Z,1726165652.806 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-09-12T18:27:32.818Z,1726165652.818 [IBIT] Loaded
2024-09-12T18:27:32.819Z,1726165652.819 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-09-12T18:27:32.824Z,1726165652.824 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-09-12T18:27:32.928Z,1726165652.928 [CBIT] Loaded
2024-09-12T18:27:32.929Z,1726165652.929 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-09-12T18:27:32.929Z,1726165652.929 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-09-12T18:27:32.930Z,1726165652.930 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-09-12T18:27:33.066Z,1726165653.066 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-09-12T18:27:33.072Z,1726165653.072 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-09-12T18:27:33.075Z,1726165653.075 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-09-12T18:27:33.086Z,1726165653.086 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-09-12T18:27:33.087Z,1726165653.087 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0
2024-09-12T18:27:33.088Z,1726165653.088 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3748
2024-09-12T18:27:33.092Z,1726165653.092 [Supervisor](INFO): Main Thread ID is 3654
2024-09-12T18:27:33.092Z,1726165653.092 [Supervisor](DEBUG): Running supervisor.
2024-09-12T18:27:33.093Z,1726165653.093 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3749
2024-09-12T18:27:33.093Z,1726165653.093 [CommandExec](INFO): Initializing the command executive.
2024-09-12T18:27:33.095Z,1726165653.095 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3750
2024-09-12T18:27:33.098Z,1726165653.098 [controlThread ThreadHandler](INFO): Handler Thread ID is 3751
2024-09-12T18:27:33.099Z,1726165653.099 [controlThread](DEBUG): Initializing ControlThread
2024-09-12T18:27:33.099Z,1726165653.099 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-09-12T18:27:33.101Z,1726165653.101 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-09-12T18:27:33.102Z,1726165653.102 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-09-12T18:27:33.102Z,1726165653.102 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-09-12T18:27:33.104Z,1726165653.104 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-09-12T18:27:33.105Z,1726165653.105 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-09-12T18:27:33.109Z,1726165653.109 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-09-12T18:27:33.110Z,1726165653.110 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-09-12T18:27:33.110Z,1726165653.110 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-09-12T18:27:33.110Z,1726165653.110 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-09-12T18:27:33.111Z,1726165653.111 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-09-12T18:27:33.113Z,1726165653.113 [SBIT](INFO): Initialize SBIT Component.
2024-09-12T18:27:33.114Z,1726165653.114 [SBIT](IMPORTANT): git: 2024-09-05
2024-09-12T18:27:33.114Z,1726165653.114 [SBIT](INFO): git hash: dce0dc62070cf863068ea7da7140e449252762ed
2024-09-12T18:27:33.114Z,1726165653.114 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-09-12T18:27:33.115Z,1726165653.115 [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-09-12T18:27:33.116Z,1726165653.116 [SBIT](INFO): Beginning SBIT in 99.000000 seconds.
2024-09-12T18:27:33.117Z,1726165653.117 [IBIT](INFO): Initialize IBIT Component.
2024-09-12T18:27:33.118Z,1726165653.118 [CBIT](DEBUG): Initialize CBIT Component.
2024-09-12T18:27:33.119Z,1726165653.119 [logger ThreadHandler](INFO): Handler Thread ID is 3752
2024-09-12T18:27:33.129Z,1726165653.129 [CBIT](DEBUG): Initialized mux pins.
2024-09-12T18:27:33.129Z,1726165653.129 [CBIT](DEBUG): Initializing the watchdog timer.
2024-09-12T18:27:33.137Z,1726165653.137 [DATMMP ThreadHandler](INFO): Handler Thread ID is 3753
2024-09-12T18:27:33.138Z,1726165653.138 [DATMMP](INFO): Start
2024-09-12T18:27:33.138Z,1726165653.138 [DATMMP](INFO): Powering up
2024-09-12T18:27:33.138Z,1726165653.138 [DATMMP](DEBUG): Initializing DATMMP.
2024-09-12T18:27:33.142Z,1726165653.142 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3755
2024-09-12T18:27:33.144Z,1726165653.144 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-09-12T18:27:33.153Z,1726165653.153 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-09-12T18:27:33.153Z,1726165653.153 [CBIT](DEBUG): Initializing heartbeat.
2024-09-12T18:27:33.154Z,1726165653.154 [Onboard ThreadHandler](INFO): Handler Thread ID is 3756
2024-09-12T18:27:33.174Z,1726165653.174 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3757
2024-09-12T18:27:33.185Z,1726165653.185 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3758
2024-09-12T18:27:33.186Z,1726165653.186 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-09-12T18:27:33.198Z,1726165653.198 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3760
2024-09-12T18:27:33.201Z,1726165653.201 [WetLabsBB2FL](INFO): Powering up
2024-09-12T18:27:33.202Z,1726165653.202 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3762
2024-09-12T18:27:33.210Z,1726165653.210 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-09-12T18:27:33.211Z,1726165653.211 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-09-12T18:27:33.211Z,1726165653.211 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-09-12T18:27:33.211Z,1726165653.211 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-09-12T18:27:33.211Z,1726165653.211 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-09-12T18:27:33.211Z,1726165653.211 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-09-12T18:27:33.211Z,1726165653.211 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-09-12T18:27:33.212Z,1726165653.212 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-09-12T18:27:33.225Z,1726165653.225 [CBIT](DEBUG): Deactivating GF circuits.
2024-09-12T18:27:33.225Z,1726165653.225 [CBIT](DEBUG): Deactivating emergency mode.
2024-09-12T18:27:33.265Z,1726165653.265 [CBIT](DEBUG): Backplane powered.
2024-09-12T18:27:33.265Z,1726165653.265 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-09-12T18:27:33.266Z,1726165653.266 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-09-12T18:27:33.266Z,1726165653.266 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-09-12T18:27:33.273Z,1726165653.273 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-09-12T18:27:33.320Z,1726165653.320 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-09-12T18:27:33.339Z,1726165653.339 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-09-12T18:27:33.389Z,1726165653.389 [DATMMP](INFO): Starting
2024-09-12T18:27:33.391Z,1726165653.391 [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-09-12T18:27:33.392Z,1726165653.392 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-09-12T18:27:33.392Z,1726165653.392 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-09-12T18:27:33.396Z,1726165653.396 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-09-12T18:27:33.577Z,1726165653.577 [Radio_Surface](INFO): Powering up
2024-09-12T18:27:33.641Z,1726165653.641 [DATMMP](INFO): Starting
2024-09-12T18:27:33.700Z,1726165653.700 [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-09-12T18:27:33.723Z,1726165653.723 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-09-12T18:27:33.724Z,1726165653.724 [Default:A.Wait](DEBUG): Construct Wait.
2024-09-12T18:27:33.739Z,1726165653.739 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-09-12T18:27:33.794Z,1726165653.794 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-09-12T18:27:33.805Z,1726165653.805 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-09-12T18:27:33.829Z,1726165653.829 [Default:E.Execute](DEBUG): Construct Execute.
2024-09-12T18:27:33.832Z,1726165653.832 [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-09-12T18:27:33.836Z,1726165653.836 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,CANONSampler,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-09-12T18:27:33.859Z,1726165653.859 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-09-12T18:27:33.893Z,1726165653.893 [DATMMP](INFO): Starting
2024-09-12T18:27:33.969Z,1726165653.969 [Power24vConverter](INFO): Powering up.
2024-09-12T18:27:33.970Z,1726165653.970 [CANONSampler](INFO): Powering down
2024-09-12T18:27:34.023Z,1726165654.023 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-09-12T18:27:34.029Z,1726165654.029 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-09-12T18:27:34.030Z,1726165654.030 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-09-12T18:27:34.037Z,1726165654.037 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-09-12T18:27:34.038Z,1726165654.038 [MassServo](DEBUG): Initializing EZServoServo.
2024-09-12T18:27:34.045Z,1726165654.045 [MassServo](DEBUG): Initializing MassServo.
2024-09-12T18:27:34.046Z,1726165654.046 [RudderServo](DEBUG): Initializing EZServoServo.
2024-09-12T18:27:34.053Z,1726165654.053 [RudderServo](DEBUG): Initializing RudderServo.
2024-09-12T18:27:34.054Z,1726165654.054 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-09-12T18:27:34.061Z,1726165654.061 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-09-12T18:27:34.158Z,1726165654.158 [DATMMP](INFO): Starting
2024-09-12T18:27:34.409Z,1726165654.409 [DATMMP](INFO): Starting
2024-09-12T18:27:34.661Z,1726165654.661 [DATMMP](INFO): Starting
2024-09-12T18:27:34.913Z,1726165654.913 [DATMMP](INFO): Starting
2024-09-12T18:27:35.166Z,1726165655.166 [DATMMP](INFO): Starting
2024-09-12T18:27:35.417Z,1726165655.417 [DATMMP](INFO): Starting
2024-09-12T18:27:35.669Z,1726165655.669 [DATMMP](INFO): Starting
2024-09-12T18:27:35.813Z,1726165655.813 [WetLabsBB2FL](INFO): Powering down
2024-09-12T18:27:35.921Z,1726165655.921 [DATMMP](INFO): Starting
2024-09-12T18:27:36.173Z,1726165656.173 [DATMMP](INFO): Starting
2024-09-12T18:27:36.425Z,1726165656.425 [DATMMP](INFO): Starting
2024-09-12T18:27:36.677Z,1726165656.677 [DATMMP](INFO): Starting
2024-09-12T18:27:36.929Z,1726165656.929 [DATMMP](INFO): Starting
2024-09-12T18:27:37.181Z,1726165657.181 [DATMMP](INFO): Starting
2024-09-12T18:27:37.433Z,1726165657.433 [DATMMP](INFO): Starting
2024-09-12T18:27:37.685Z,1726165657.685 [DATMMP](INFO): Starting
2024-09-12T18:27:37.937Z,1726165657.937 [DATMMP](INFO): Starting
2024-09-12T18:27:38.189Z,1726165658.189 [DATMMP](INFO): Starting
2024-09-12T18:27:38.441Z,1726165658.441 [DATMMP](INFO): Starting
2024-09-12T18:27:38.693Z,1726165658.693 [DATMMP](INFO): Starting
2024-09-12T18:27:38.945Z,1726165658.945 [DATMMP](INFO): Starting
2024-09-12T18:27:39.197Z,1726165659.197 [DATMMP](INFO): Starting
2024-09-12T18:27:39.449Z,1726165659.449 [DATMMP](INFO): Starting
2024-09-12T18:27:39.702Z,1726165659.702 [DATMMP](INFO): Starting
2024-09-12T18:27:39.722Z,1726165659.722 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-09-12T18:27:39.953Z,1726165659.953 [DATMMP](INFO): Starting
2024-09-12T18:27:40.205Z,1726165660.205 [DATMMP](INFO): Starting
2024-09-12T18:27:40.457Z,1726165660.457 [DATMMP](INFO): Starting
2024-09-12T18:27:40.709Z,1726165660.709 [DATMMP](INFO): Starting
2024-09-12T18:27:40.961Z,1726165660.961 [DATMMP](INFO): Starting
2024-09-12T18:27:41.213Z,1726165661.213 [DATMMP](INFO): Starting
2024-09-12T18:27:41.465Z,1726165661.465 [DATMMP](INFO): Starting
2024-09-12T18:27:41.717Z,1726165661.717 [DATMMP](INFO): Starting
2024-09-12T18:27:41.969Z,1726165661.969 [DATMMP](INFO): Starting
2024-09-12T18:27:42.221Z,1726165662.221 [DATMMP](INFO): Starting
2024-09-12T18:27:42.473Z,1726165662.473 [DATMMP](INFO): Starting
2024-09-12T18:27:42.726Z,1726165662.726 [DATMMP](INFO): Starting
2024-09-12T18:27:42.977Z,1726165662.977 [DATMMP](INFO): Starting
2024-09-12T18:27:43.229Z,1726165663.229 [DATMMP](INFO): Starting
2024-09-12T18:27:43.481Z,1726165663.481 [DATMMP](INFO): Starting
2024-09-12T18:27:43.733Z,1726165663.733 [DATMMP](INFO): Starting
2024-09-12T18:27:43.985Z,1726165663.985 [DATMMP](INFO): Starting
2024-09-12T18:27:44.237Z,1726165664.237 [DATMMP](INFO): Starting
2024-09-12T18:27:44.489Z,1726165664.489 [DATMMP](INFO): Starting
2024-09-12T18:27:44.742Z,1726165664.742 [DATMMP](INFO): Starting
2024-09-12T18:27:44.743Z,1726165664.743 [DATMMP](INFO): DAT read:
2024-09-12T18:27:44.744Z,1726165664.744 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-09-12T18:27:44.993Z,1726165664.993 [DATMMP](INFO): Starting
2024-09-12T18:27:45.245Z,1726165665.245 [DATMMP](INFO): Starting
2024-09-12T18:27:45.497Z,1726165665.497 [DATMMP](INFO): Starting
2024-09-12T18:27:45.749Z,1726165665.749 [DATMMP](INFO): Starting
2024-09-12T18:27:46.002Z,1726165666.002 [DATMMP](INFO): Starting
2024-09-12T18:27:46.253Z,1726165666.253 [DATMMP](INFO): Starting
2024-09-12T18:27:46.254Z,1726165666.254 [DATMMP](INFO): DAT read: MF Frequency Band
2024-09-12T18:27:46.255Z,1726165666.255 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-09-12T18:27:46.255Z,1726165666.255 [DATMMP](INFO): DAT read: Aug 11 2000 21:28:17
2024-09-12T18:27:46.505Z,1726165666.505 [DATMMP](INFO): Starting
2024-09-12T18:27:46.757Z,1726165666.757 [DATMMP](INFO): Starting
2024-09-12T18:27:46.950Z,1726165666.950 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004222
2024-09-12T18:27:47.009Z,1726165667.009 [DATMMP](INFO): Starting
2024-09-12T18:27:47.261Z,1726165667.261 [DATMMP](INFO): Starting
2024-09-12T18:27:47.262Z,1726165667.262 [DATMMP](INFO): DAT read: Features enabled [Bearing]
2024-09-12T18:27:47.263Z,1726165667.263 [DATMMP](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2024-09-12T18:27:47.263Z,1726165667.263 [DATMMP](INFO): commRate: 1200
2024-09-12T18:27:47.513Z,1726165667.513 [DATMMP](INFO): Starting
2024-09-12T18:27:47.765Z,1726165667.765 [DATMMP](INFO): Starting
2024-09-12T18:27:48.017Z,1726165668.017 [DATMMP](INFO): Starting
2024-09-12T18:27:48.269Z,1726165668.269 [DATMMP](INFO): Starting
2024-09-12T18:27:48.521Z,1726165668.521 [DATMMP](INFO): Starting
2024-09-12T18:27:48.773Z,1726165668.773 [DATMMP](INFO): Starting
2024-09-12T18:27:49.025Z,1726165669.025 [DATMMP](INFO): Starting
2024-09-12T18:27:49.277Z,1726165669.277 [DATMMP](INFO): Starting
2024-09-12T18:27:49.329Z,1726165669.329 [DATMMP](INFO): entering command mode
2024-09-12T18:27:49.529Z,1726165669.529 [DATMMP](INFO): Starting
2024-09-12T18:27:49.529Z,1726165669.529 [DATMMP](INFO): DAT read:
2024-09-12T18:27:49.530Z,1726165669.530 [DATMMP](INFO): DAT read: user:1>
2024-09-12T18:27:49.530Z,1726165669.530 [DATMMP](DEBUG): read user prompt 1: user:1>
2024-09-12T18:27:49.530Z,1726165669.530 [DATMMP](INFO): entering MMP mode
2024-09-12T18:27:49.781Z,1726165669.781 [DATMMP](INFO): Starting
2024-09-12T18:27:49.782Z,1726165669.782 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-12T18:27:49.783Z,1726165669.783 [DATMMP](INFO): status rx: x1
2024-09-12T18:27:49.784Z,1726165669.784 [DATMMP](INFO): MMP status: 1: started
2024-09-12T18:27:49.784Z,1726165669.784 [DATMMP](INFO): Received message type: status
2024-09-12T18:27:49.784Z,1726165669.784 [DATMMP](INFO): Handled
2024-09-12T18:27:50.034Z,1726165670.034 [DATMMP](INFO): Starting
2024-09-12T18:27:50.036Z,1726165670.036 [DATMMP](INFO): Sent Tx Power Config 8
2024-09-12T18:27:50.036Z,1726165670.036 [DATMMP](INFO): Setting local address: 8
2024-09-12T18:27:50.044Z,1726165670.044 [DATMMP](INFO): Setting time to: 18:27:50 And date to:9/12/2024
2024-09-12T18:27:50.285Z,1726165670.285 [DATMMP](INFO): Starting
2024-09-12T18:27:50.285Z,1726165670.285 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-12T18:27:50.286Z,1726165670.286 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0
2024-09-12T18:27:50.286Z,1726165670.286 [DATMMP](INFO): Received message type: mdmpower
2024-09-12T18:27:50.287Z,1726165670.287 [DATMMP](INFO): Handled
2024-09-12T18:27:50.537Z,1726165670.537 [DATMMP](INFO): Starting
2024-09-12T18:27:50.537Z,1726165670.537 [DATMMP](INFO): GSXN notify for xid: 10
2024-09-12T18:27:50.538Z,1726165670.538 [DATMMP](INFO): sreg_txpower rx: x8
2024-09-12T18:27:50.538Z,1726165670.538 [DATMMP](INFO): Received message type: sreg_txpower
2024-09-12T18:27:50.538Z,1726165670.538 [DATMMP](INFO): Match for : sreg_txpower
2024-09-12T18:27:50.538Z,1726165670.538 [DATMMP](INFO): ACK
2024-09-12T18:27:50.789Z,1726165670.789 [DATMMP](INFO): Starting
2024-09-12T18:27:50.789Z,1726165670.789 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-12T18:27:50.790Z,1726165670.790 [DATMMP](INFO): mdmlocal rx: x8 x0 x0 x0
2024-09-12T18:27:50.790Z,1726165670.790 [DATMMP](INFO): Received message type: mdmlocal
2024-09-12T18:27:50.790Z,1726165670.790 [DATMMP](INFO): Handled
2024-09-12T18:27:51.041Z,1726165671.041 [DATMMP](INFO): Starting
2024-09-12T18:27:51.041Z,1726165671.041 [DATMMP](INFO): GSXN notify for xid: 11
2024-09-12T18:27:51.042Z,1726165671.042 [DATMMP](INFO): sreg_locaddr rx: x8
2024-09-12T18:27:51.042Z,1726165671.042 [DATMMP](INFO): Received message type: sreg_locaddr
2024-09-12T18:27:51.042Z,1726165671.042 [DATMMP](INFO): Match for : sreg_locaddr
2024-09-12T18:27:51.042Z,1726165671.042 [DATMMP](INFO): ACK
2024-09-12T18:27:51.293Z,1726165671.293 [DATMMP](INFO): Starting
2024-09-12T18:27:51.293Z,1726165671.293 [DATMMP](INFO): GSXN notify for xid: 12
2024-09-12T18:27:51.295Z,1726165671.295 [DATMMP](INFO): timedate rx: x0 x12 x1B x32 x8 xC x7C x0
2024-09-12T18:27:51.295Z,1726165671.295 [DATMMP](INFO): Received message type: timedate
2024-09-12T18:27:51.295Z,1726165671.295 [DATMMP](INFO): Match for : timedate
2024-09-12T18:27:51.295Z,1726165671.295 [DATMMP](INFO): ACK
2024-09-12T18:27:51.545Z,1726165671.545 [DATMMP](INFO): Starting
2024-09-12T18:27:51.545Z,1726165671.545 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-12T18:27:51.546Z,1726165671.546 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0
2024-09-12T18:27:51.546Z,1726165671.546 [DATMMP](INFO): Received message type: sys_verb
2024-09-12T18:27:51.546Z,1726165671.546 [DATMMP](INFO): Handled
2024-09-12T18:27:51.797Z,1726165671.797 [DATMMP](INFO): Starting
2024-09-12T18:27:51.797Z,1726165671.797 [DATMMP](INFO): GSXN notify for xid: 13
2024-09-12T18:27:51.798Z,1726165671.798 [DATMMP](INFO): sreg_verbosity rx: x0
2024-09-12T18:27:51.798Z,1726165671.798 [DATMMP](INFO): Received message type: sreg_verbosity
2024-09-12T18:27:51.798Z,1726165671.798 [DATMMP](INFO): Match for : sreg_verbosity
2024-09-12T18:27:51.798Z,1726165671.798 [DATMMP](INFO): ACK
2024-09-12T18:27:52.049Z,1726165672.049 [DATMMP](INFO): Starting
2024-09-12T18:27:52.049Z,1726165672.049 [DATMMP](INFO): GSXN notify for xid: 14
2024-09-12T18:27:52.050Z,1726165672.050 [DATMMP](INFO): version rx: x2 x5
2024-09-12T18:27:52.050Z,1726165672.050 [DATMMP](INFO): DatMMPVersion: 2.5
2024-09-12T18:27:52.051Z,1726165672.051 [DATMMP](INFO): Received message type: version
2024-09-12T18:27:52.051Z,1726165672.051 [DATMMP](INFO): Match for : version
2024-09-12T18:27:52.051Z,1726165672.051 [DATMMP](INFO): ACK
2024-09-12T18:27:52.051Z,1726165672.051 [DATMMP](INFO): in MMP mode: config complete going to runnable
2024-09-12T18:28:01.722Z,1726165681.722 [NAL9602](INFO): Powering up NAL9602
2024-09-12T18:28:06.425Z,1726165686.425 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-12T18:28:06.426Z,1726165686.426 [DATMMP](INFO): timesync rx: x0 x1 x1 x0
2024-09-12T18:28:06.426Z,1726165686.426 [DATMMP](INFO): Received message type: timesync
2024-09-12T18:28:06.426Z,1726165686.426 [DATMMP](INFO): Handled
2024-09-12T18:28:12.630Z,1726165692.630 [NAL9602](INFO): NAL9602 initialized
2024-09-12T18:28:16.509Z,1726165696.509 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-12T18:28:16.510Z,1726165696.510 [DATMMP](INFO): timesync rx: x1 x0 x1 x0
2024-09-12T18:28:16.510Z,1726165696.510 [DATMMP](INFO): Received message type: timesync
2024-09-12T18:28:16.511Z,1726165696.511 [DATMMP](INFO): Handled
2024-09-12T18:28:32.215Z,1726165712.215 [CommandExec](IMPORTANT): got command strobe off
2024-09-12T18:28:32.215Z,1726165712.215 [CommandExec](IMPORTANT): Deactivating strobe
2024-09-12T18:28:39.362Z,1726165719.362 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:28:51.482Z,1726165731.482 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:29:03.602Z,1726165743.602 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:29:12.915Z,1726165752.915 [SBIT](IMPORTANT): Beginning Startup BIT
2024-09-12T18:29:12.919Z,1726165752.919 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T18:29:15.722Z,1726165755.722 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:29:23.902Z,1726165763.902 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-09-12T18:29:24.306Z,1726165764.306 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T18:29:27.842Z,1726165767.842 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:29:35.210Z,1726165775.210 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-09-12T18:29:35.627Z,1726165775.627 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T18:29:39.962Z,1726165779.962 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:29:46.450Z,1726165786.450 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-09-12T18:29:46.451Z,1726165786.451 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2024-09-12T18:29:51.679Z,1726165791.679 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:30:03.001Z,1726165803.001 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:30:07.076Z,1726165807.076 [SBIT](IMPORTANT): SBIT PASSED
2024-09-12T18:30:07.076Z,1726165807.076 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-09-12T18:30:07.077Z,1726165807.077 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count;
2024-09-12T18:30:07.077Z,1726165807.077 [SBIT](IMPORTANT): CANONSampler.loadAtStartup=1 bool;
2024-09-12T18:30:07.077Z,1726165807.077 [SBIT](IMPORTANT): CANONSampler.simulateHardware=0 bool;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=0 bool;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter;
2024-09-12T18:30:07.078Z,1726165807.078 [SBIT](IMPORTANT): Express none _.predict_plankton_data_pct_dinos_sqerr;
2024-09-12T18:30:07.079Z,1726165807.079 [SBIT](IMPORTANT): Normal all WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;
2024-09-12T18:30:07.079Z,1726165807.079 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=80 cubic_centimeter;
2024-09-12T18:30:07.079Z,1726165807.079 [SBIT](IMPORTANT): VerticalControl.massDefault=-20 millimeter;
2024-09-12T18:30:07.456Z,1726165807.456 [MissionManager](IMPORTANT): Started mission Startup
2024-09-12T18:30:07.456Z,1726165807.456 [Startup] Running Loop=1
2024-09-12T18:30:07.456Z,1726165807.456 [Startup](DEBUG): Aggregate::initialize Startup
2024-09-12T18:30:07.456Z,1726165807.456 [Startup:A.GoToSurface] Running Loop=1
2024-09-12T18:30:07.456Z,1726165807.456 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-09-12T18:30:07.477Z,1726165807.477 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-09-12T18:30:07.477Z,1726165807.477 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-09-12T18:30:07.478Z,1726165807.478 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-09-12T18:30:07.478Z,1726165807.478 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-09-12T18:30:07.478Z,1726165807.478 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-09-12T18:30:07.479Z,1726165807.479 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-09-12T18:30:07.480Z,1726165807.480 [Startup:StartupSatComms] Running Loop=1
2024-09-12T18:30:07.481Z,1726165807.481 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-09-12T18:30:07.481Z,1726165807.481 [Startup:StartupSatComms:A] Running Loop=1
2024-09-12T18:30:07.855Z,1726165807.855 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-09-12T18:30:33.354Z,1726165833.354 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-09-12T18:30:33.354Z,1726165833.354 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:30:33.422Z,1726165833.422 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:30:33.777Z,1726165833.777 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:30:33.777Z,1726165833.777 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-09-12T18:31:07.650Z,1726165867.650 [Startup:StartupSatComms:A](INFO): Timed out from 2024-09-12T18:30:07.5Z
2024-09-12T18:31:07.650Z,1726165867.650 [Startup:StartupSatComms:A] Stopped
2024-09-12T18:31:07.650Z,1726165867.650 [Startup:StartupSatComms:B] Running Loop=1
2024-09-12T18:31:08.054Z,1726165868.054 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-09-12T18:31:13.808Z,1726165873.808 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20240911T192837/Courier0060.lzma
2024-09-12T18:31:14.811Z,1726165874.811 [DataOverHttps](INFO): Moved sent file to Logs/20240911T192837/Courier0060.lzma.bak
2024-09-12T18:31:14.811Z,1726165874.811 [DataOverHttps](INFO): SBD MOMSN=23173048
2024-09-12T18:31:31.080Z,1726165891.080 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240912T182721/Courier0000.lzma
2024-09-12T18:31:32.083Z,1726165892.083 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0000.lzma.bak
2024-09-12T18:31:32.083Z,1726165892.083 [DataOverHttps](INFO): SBD MOMSN=23173050
2024-09-12T18:31:48.164Z,1726165908.164 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20240911T192837/Express0061.lzma
2024-09-12T18:31:49.163Z,1726165909.163 [DataOverHttps](INFO): Moved sent file to Logs/20240911T192837/Express0061.lzma.bak
2024-09-12T18:31:49.163Z,1726165909.163 [DataOverHttps](INFO): SBD MOMSN=23173053
2024-09-12T18:32:05.154Z,1726165925.154 [DataOverHttps](INFO): Sending 964 bytes from file Logs/20240912T182721/Express0001.lzma
2024-09-12T18:32:06.151Z,1726165926.151 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0001.lzma.bak
2024-09-12T18:32:06.151Z,1726165926.151 [DataOverHttps](INFO): SBD MOMSN=23173056
2024-09-12T18:32:07.924Z,1726165927.924 [Startup:StartupSatComms:B](INFO): Timed out from 2024-09-12T18:31:07.7Z
2024-09-12T18:32:07.924Z,1726165927.924 [Startup:StartupSatComms:B] Stopped
2024-09-12T18:32:07.924Z,1726165927.924 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-09-12T18:32:07.924Z,1726165927.924 [Startup:StartupSatComms] Stopped
2024-09-12T18:32:07.924Z,1726165927.924 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-09-12T18:32:07.926Z,1726165927.926 [Startup](INFO): Completed Startup
2024-09-12T18:32:07.926Z,1726165927.926 [MissionManager](INFO): Startup is completed.
2024-09-12T18:32:07.926Z,1726165927.926 [MissionManager](INFO): Uninitializing Mission Startup
2024-09-12T18:32:07.926Z,1726165927.926 [Startup] Stopped
2024-09-12T18:32:07.926Z,1726165927.926 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-09-12T18:32:07.926Z,1726165927.926 [Startup:A.GoToSurface] Stopped
2024-09-12T18:32:07.926Z,1726165927.926 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-09-12T18:32:08.326Z,1726165928.326 [MissionManager](IMPORTANT): Started mission Default
2024-09-12T18:32:08.326Z,1726165928.326 [Default] Running Loop=1
2024-09-12T18:32:08.326Z,1726165928.326 [Default](DEBUG): Aggregate::initialize Default
2024-09-12T18:32:08.326Z,1726165928.326 [Default:B.GoToSurface] Running Loop=1
2024-09-12T18:32:08.326Z,1726165928.326 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-09-12T18:32:08.327Z,1726165928.327 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-09-12T18:32:08.327Z,1726165928.327 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-09-12T18:32:08.327Z,1726165928.327 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-09-12T18:32:08.328Z,1726165928.328 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-09-12T18:32:08.328Z,1726165928.328 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-09-12T18:32:08.328Z,1726165928.328 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-09-12T18:32:08.329Z,1726165928.329 [Default:A.Wait] Running Loop=1
2024-09-12T18:32:08.329Z,1726165928.329 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-09-12T18:32:21.668Z,1726165941.668 [Default:A.Wait](INFO): Done Waiting.
2024-09-12T18:32:21.668Z,1726165941.668 [Default:A.Wait] Stopped
2024-09-12T18:32:21.668Z,1726165941.668 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T18:32:22.067Z,1726165942.067 [Default:CheckIn] Running Loop=1
2024-09-12T18:32:22.068Z,1726165942.068 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T18:32:22.068Z,1726165942.068 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T18:32:22.571Z,1726165942.571 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-09-12T18:32:35.777Z,1726165955.777 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:32:48.301Z,1726165968.301 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:33:00.421Z,1726165980.421 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:33:09.561Z,1726165989.561 [CommandExec](IMPORTANT): got command failComponent
2024-09-12T18:33:09.561Z,1726165989.561 [CommandExec](IMPORTANT): Failed components:
2024-09-12T18:33:09.562Z,1726165989.562 [CommandExec](IMPORTANT): No failed Components.
2024-09-12T18:33:11.734Z,1726165991.734 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:33:13.825Z,1726165993.825 [CommandExec](IMPORTANT): got command gfscan
2024-09-12T18:33:13.873Z,1726165993.873 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T18:33:16.590Z,1726165996.590 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-09-12T18:33:23.858Z,1726166003.858 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:33:24.769Z,1726166004.769 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-09-12T18:33:25.189Z,1726166005.189 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T18:33:34.394Z,1726166014.394 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-09-12T18:33:34.394Z,1726166014.394 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:33:34.457Z,1726166014.457 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:33:34.857Z,1726166014.857 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:33:34.857Z,1726166014.857 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-09-12T18:33:36.081Z,1726166016.081 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-09-12T18:33:36.378Z,1726166016.378 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:33:36.482Z,1726166016.482 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T18:33:47.393Z,1726166027.393 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-09-12T18:33:47.393Z,1726166027.393 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2024-09-12T18:33:48.533Z,1726166028.533 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:34:01.021Z,1726166041.021 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:34:13.141Z,1726166053.141 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:34:24.857Z,1726166064.857 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:34:36.574Z,1726166076.574 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:34:45.622Z,1726166085.622 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-12T18:34:49.103Z,1726166089.103 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T18:34:52.342Z,1726166092.342 [BPC1](INFO): Calculating totals. Valid battery stick count: 42. Valid reserve battery stick count: 5.
2024-09-12T18:34:52.345Z,1726166092.345 [BPC1](INFO): Received data from all battery sticks.
2024-09-12T18:35:03.417Z,1726166103.417 [RudderServo](ERROR): getPosition uart error serial timeout
2024-09-12T18:35:03.417Z,1726166103.417 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2024-09-12T18:35:03.417Z,1726166103.417 [RudderServo] Communications Fault, FailCount= 1
2024-09-12T18:35:03.417Z,1726166103.417 [RudderServo](ERROR): Communications Fault
2024-09-12T18:35:03.428Z,1726166103.428 [CBIT](ERROR): Communications Fault in component: RudderServo
2024-09-12T18:35:03.689Z,1726166103.689 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-09-12T18:35:03.689Z,1726166103.689 [RudderServo](INFO): Powering down
2024-09-12T18:35:04.503Z,1726166104.503 [RudderServo](DEBUG): Initializing EZServoServo.
2024-09-12T18:35:04.618Z,1726166104.618 [RudderServo](DEBUG): Initializing RudderServo.
2024-09-12T18:35:04.622Z,1726166104.622 [CBIT](INFO): Clearing failed state for component RudderServo
2024-09-12T18:35:04.622Z,1726166104.622 [RudderServo] No Fault, FailCount= 1
2024-09-12T18:35:43.235Z,1726166143.235 [CommandExec](IMPORTANT): got command burn on
2024-09-12T18:35:43.235Z,1726166143.235 [CommandExec](IMPORTANT): Activating dropweight wire
2024-09-12T18:36:35.386Z,1726166195.386 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-09-12T18:36:35.386Z,1726166195.386 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:36:35.477Z,1726166195.477 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:36:35.853Z,1726166195.853 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:36:35.853Z,1726166195.853 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-09-12T18:36:56.266Z,1726166216.266 [CommandExec](IMPORTANT): got command burn off
2024-09-12T18:36:56.266Z,1726166216.266 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-09-12T18:37:22.252Z,1726166242.252 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T18:32:22.1Z
2024-09-12T18:37:22.252Z,1726166242.252 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T18:37:22.252Z,1726166242.252 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T18:37:22.655Z,1726166242.655 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-09-12T18:37:29.961Z,1726166249.961 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240912T182721/Courier0004.lzma
2024-09-12T18:37:30.962Z,1726166250.962 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0004.lzma.bak
2024-09-12T18:37:30.963Z,1726166250.963 [DataOverHttps](INFO): SBD MOMSN=23173097
2024-09-12T18:37:46.705Z,1726166266.705 [DataOverHttps](INFO): Sending 452 bytes from file Logs/20240912T182721/Express0005.lzma
2024-09-12T18:37:47.707Z,1726166267.707 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0005.lzma.bak
2024-09-12T18:37:47.707Z,1726166267.707 [DataOverHttps](INFO): SBD MOMSN=23173099
2024-09-12T18:37:49.747Z,1726166269.747 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T18:37:49.747Z,1726166269.747 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T18:37:49.747Z,1726166269.747 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T18:38:14.350Z,1726166294.350 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T18:38:14.350Z,1726166294.350 [NAL9602] Data Fault, FailCount= 1
2024-09-12T18:38:14.350Z,1726166294.350 [NAL9602](ERROR): Data Fault
2024-09-12T18:38:14.429Z,1726166294.429 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T18:38:14.754Z,1726166294.754 [NAL9602](INFO): Powering down
2024-09-12T18:38:15.645Z,1726166295.645 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T18:38:15.645Z,1726166295.645 [NAL9602] No Fault, FailCount= 1
2024-09-12T18:38:45.054Z,1726166325.054 [NAL9602](INFO): Powering up NAL9602
2024-09-12T18:38:55.963Z,1726166335.963 [NAL9602](INFO): NAL9602 initialized
2024-09-12T18:39:13.582Z,1726166353.582 [CommandExec](IMPORTANT): got command burn on
2024-09-12T18:39:13.582Z,1726166353.582 [CommandExec](IMPORTANT): Activating dropweight wire
2024-09-12T18:39:32.522Z,1726166372.522 [CommandExec](IMPORTANT): got command burn off
2024-09-12T18:39:32.522Z,1726166372.522 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-09-12T18:39:36.377Z,1726166376.377 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-09-12T18:39:36.377Z,1726166376.377 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:39:36.445Z,1726166376.445 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:39:36.849Z,1726166376.849 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:39:36.849Z,1726166376.849 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-09-12T18:40:26.067Z,1726166426.067 [CommandExec](IMPORTANT): got command burn on
2024-09-12T18:40:26.067Z,1726166426.067 [CommandExec](IMPORTANT): Activating dropweight wire
2024-09-12T18:41:55.442Z,1726166515.442 [CommandExec](IMPORTANT): got command burn off
2024-09-12T18:41:55.442Z,1726166515.442 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-09-12T18:42:37.487Z,1726166557.487 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-09-12T18:42:37.487Z,1726166557.487 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:42:37.553Z,1726166557.553 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:42:37.945Z,1726166557.945 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:42:37.945Z,1726166557.945 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-09-12T18:42:50.401Z,1726166570.401 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T18:42:50.402Z,1726166570.402 [Default:CheckIn:C.Wait] Stopped
2024-09-12T18:42:50.402Z,1726166570.402 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T18:42:50.402Z,1726166570.402 [Default:CheckIn:D] Running Loop=1
2024-09-12T18:42:50.826Z,1726166570.826 [Default:CheckIn:D] Stopped
2024-09-12T18:42:50.826Z,1726166570.826 [Default:CheckIn:E] Running Loop=1
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.708330 min
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn:E] Stopped
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn] Stopped
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn](INFO): Running loop #2
2024-09-12T18:42:51.232Z,1726166571.232 [Default:CheckIn] Running Loop=2
2024-09-12T18:42:51.233Z,1726166571.233 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T18:42:51.233Z,1726166571.233 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T18:45:38.490Z,1726166738.490 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-09-12T18:45:38.491Z,1726166738.491 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:45:38.565Z,1726166738.565 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:45:38.949Z,1726166738.949 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:45:38.949Z,1726166738.949 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-09-12T18:46:54.479Z,1726166814.479 [RudderServo](FAULT): Invalid EZ Servo response:"\377\r"
2024-09-12T18:46:54.479Z,1726166814.479 [RudderServo] Communications Fault, FailCount= 2
2024-09-12T18:46:54.479Z,1726166814.479 [RudderServo](ERROR): Communications Fault
2024-09-12T18:46:54.479Z,1726166814.479 [RudderServo](ERROR): Rudder reporting null position
2024-09-12T18:46:54.491Z,1726166814.491 [CBIT](ERROR): Communications Fault in component: RudderServo
2024-09-12T18:46:54.848Z,1726166814.848 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-09-12T18:46:54.849Z,1726166814.849 [RudderServo](INFO): Powering down
2024-09-12T18:46:55.648Z,1726166815.648 [RudderServo](DEBUG): Initializing EZServoServo.
2024-09-12T18:46:55.766Z,1726166815.766 [RudderServo](DEBUG): Initializing RudderServo.
2024-09-12T18:46:55.771Z,1726166815.771 [CBIT](INFO): Clearing failed state for component RudderServo
2024-09-12T18:46:55.771Z,1726166815.771 [RudderServo] No Fault, FailCount= 2
2024-09-12T18:47:51.408Z,1726166871.408 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T18:42:51.2Z
2024-09-12T18:47:51.408Z,1726166871.408 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T18:47:51.408Z,1726166871.408 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T18:47:59.093Z,1726166879.093 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0007.lzma
2024-09-12T18:48:00.095Z,1726166880.095 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0007.lzma.bak
2024-09-12T18:48:00.095Z,1726166880.095 [DataOverHttps](INFO): SBD MOMSN=23173128
2024-09-12T18:48:15.889Z,1726166895.889 [DataOverHttps](INFO): Sending 304 bytes from file Logs/20240912T182721/Express0008.lzma
2024-09-12T18:48:16.892Z,1726166896.892 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0008.lzma.bak
2024-09-12T18:48:16.892Z,1726166896.892 [DataOverHttps](INFO): SBD MOMSN=23173130
2024-09-12T18:48:19.335Z,1726166899.335 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T18:48:19.335Z,1726166899.335 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T18:48:19.335Z,1726166899.335 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T18:48:39.552Z,1726166919.552 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-09-12T18:48:39.552Z,1726166919.552 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:48:39.622Z,1726166919.622 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:48:40.025Z,1726166920.025 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:48:40.025Z,1726166920.025 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-09-12T18:48:56.918Z,1726166936.918 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T18:48:56.918Z,1726166936.918 [NAL9602] Data Fault, FailCount= 2
2024-09-12T18:48:56.918Z,1726166936.918 [NAL9602](ERROR): Data Fault
2024-09-12T18:48:56.989Z,1726166936.989 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T18:48:57.322Z,1726166937.322 [NAL9602](INFO): Powering down
2024-09-12T18:48:58.209Z,1726166938.209 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T18:48:58.209Z,1726166938.209 [NAL9602] No Fault, FailCount= 2
2024-09-12T18:49:27.618Z,1726166967.618 [NAL9602](INFO): Powering up NAL9602
2024-09-12T18:49:38.530Z,1726166978.530 [NAL9602](INFO): NAL9602 initialized
2024-09-12T18:51:40.562Z,1726167100.562 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-09-12T18:51:40.562Z,1726167100.562 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:51:40.649Z,1726167100.649 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:51:41.045Z,1726167101.045 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:51:41.045Z,1726167101.045 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-09-12T18:53:19.930Z,1726167199.930 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T18:53:19.930Z,1726167199.930 [Default:CheckIn:C.Wait] Stopped
2024-09-12T18:53:19.930Z,1726167199.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T18:53:19.930Z,1726167199.930 [Default:CheckIn:D] Running Loop=1
2024-09-12T18:53:20.343Z,1726167200.343 [Default:CheckIn:D] Stopped
2024-09-12T18:53:20.343Z,1726167200.343 [Default:CheckIn:E] Running Loop=1
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.200279 min
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn:E] Stopped
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn] Stopped
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn](INFO): Running loop #3
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn] Running Loop=3
2024-09-12T18:53:20.739Z,1726167200.739 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T18:53:20.740Z,1726167200.740 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T18:54:41.553Z,1726167281.553 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-09-12T18:54:41.553Z,1726167281.553 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:54:41.645Z,1726167281.645 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:54:42.053Z,1726167282.053 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:54:42.053Z,1726167282.053 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-09-12T18:57:42.541Z,1726167462.541 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-09-12T18:57:42.541Z,1726167462.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T18:57:42.613Z,1726167462.613 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T18:57:43.013Z,1726167463.013 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T18:57:43.013Z,1726167463.013 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-09-12T18:58:20.910Z,1726167500.910 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T18:53:20.7Z
2024-09-12T18:58:20.910Z,1726167500.910 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T18:58:20.910Z,1726167500.910 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T18:58:30.212Z,1726167510.212 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0010.lzma
2024-09-12T18:58:31.215Z,1726167511.215 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0010.lzma.bak
2024-09-12T18:58:31.215Z,1726167511.215 [DataOverHttps](INFO): SBD MOMSN=23173287
2024-09-12T18:58:48.077Z,1726167528.077 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240912T182721/Express0011.lzma
2024-09-12T18:58:49.079Z,1726167529.079 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0011.lzma.bak
2024-09-12T18:58:49.079Z,1726167529.079 [DataOverHttps](INFO): SBD MOMSN=23173290
2024-09-12T18:58:51.424Z,1726167531.424 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T18:58:51.424Z,1726167531.424 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T18:58:51.424Z,1726167531.424 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T18:59:40.319Z,1726167580.319 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T18:59:40.319Z,1726167580.319 [NAL9602] Data Fault, FailCount= 3
2024-09-12T18:59:40.319Z,1726167580.319 [NAL9602](ERROR): Data Fault
2024-09-12T18:59:40.383Z,1726167580.383 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T18:59:40.718Z,1726167580.718 [NAL9602](INFO): Powering down
2024-09-12T18:59:41.609Z,1726167581.609 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T18:59:41.609Z,1726167581.609 [NAL9602] No Fault, FailCount= 3
2024-09-12T19:00:11.015Z,1726167611.015 [NAL9602](INFO): Powering up NAL9602
2024-09-12T19:00:21.926Z,1726167621.926 [NAL9602](INFO): NAL9602 initialized
2024-09-12T19:00:43.374Z,1726167643.374 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2024-09-12T19:00:43.374Z,1726167643.374 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:00:43.449Z,1726167643.449 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:00:43.829Z,1726167643.829 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:00:43.829Z,1726167643.829 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2024-09-12T19:03:04.453Z,1726167784.453 [RudderServo](ERROR): getPosition uart error serial timeout
2024-09-12T19:03:04.453Z,1726167784.453 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2024-09-12T19:03:04.453Z,1726167784.453 [RudderServo] Communications Fault, FailCount= 3
2024-09-12T19:03:04.453Z,1726167784.453 [RudderServo](ERROR): Communications Fault
2024-09-12T19:03:04.478Z,1726167784.478 [CBIT](ERROR): Communications Fault in component: RudderServo
2024-09-12T19:03:04.478Z,1726167784.478 [CBIT](CRITICAL): Communications Fault in component: RudderServo
2024-09-12T19:03:04.764Z,1726167784.764 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-09-12T19:03:04.764Z,1726167784.764 [RudderServo](INFO): Powering down
2024-09-12T19:03:04.766Z,1726167784.766 [CommandExec](FAULT): Scheduling is paused
2024-09-12T19:03:04.766Z,1726167784.766 [CBIT](INFO): Critical error at 20240912T190304
2024-09-12T19:03:04.767Z,1726167784.767 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-09-12T19:03:05.563Z,1726167785.563 [RudderServo](DEBUG): Initializing EZServoServo.
2024-09-12T19:03:05.682Z,1726167785.682 [RudderServo](DEBUG): Initializing RudderServo.
2024-09-12T19:03:44.340Z,1726167824.340 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2024-09-12T19:03:44.340Z,1726167824.340 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:03:44.351Z,1726167824.351 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:03:44.758Z,1726167824.758 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:03:44.758Z,1726167824.758 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2024-09-12T19:03:52.035Z,1726167832.035 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T19:03:52.035Z,1726167832.035 [Default:CheckIn:C.Wait] Stopped
2024-09-12T19:03:52.035Z,1726167832.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T19:03:52.035Z,1726167832.035 [Default:CheckIn:D] Running Loop=1
2024-09-12T19:03:52.439Z,1726167832.439 [Default:CheckIn:D] Stopped
2024-09-12T19:03:52.439Z,1726167832.439 [Default:CheckIn:E] Running Loop=1
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.735211 min
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn:E] Stopped
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn] Stopped
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn](INFO): Running loop #4
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn] Running Loop=4
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T19:03:52.823Z,1726167832.823 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T19:06:45.328Z,1726168005.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2024-09-12T19:06:45.328Z,1726168005.328 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:06:45.340Z,1726168005.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:06:45.745Z,1726168005.745 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:06:45.745Z,1726168005.745 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2024-09-12T19:08:53.005Z,1726168133.005 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T19:03:52.8Z
2024-09-12T19:08:53.005Z,1726168133.005 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T19:08:53.005Z,1726168133.005 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T19:09:00.284Z,1726168140.284 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20240912T182721/Courier0013.lzma
2024-09-12T19:09:01.287Z,1726168141.287 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0013.lzma.bak
2024-09-12T19:09:01.287Z,1726168141.287 [DataOverHttps](INFO): SBD MOMSN=23173411
2024-09-12T19:09:16.809Z,1726168156.809 [DataOverHttps](INFO): Sending 217 bytes from file Logs/20240912T182721/Express0014.lzma
2024-09-12T19:09:17.811Z,1726168157.811 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0014.lzma.bak
2024-09-12T19:09:17.811Z,1726168157.811 [DataOverHttps](INFO): SBD MOMSN=23173414
2024-09-12T19:09:19.691Z,1726168159.691 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T19:09:19.691Z,1726168159.691 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T19:09:19.692Z,1726168159.692 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T19:09:46.332Z,1726168186.332 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2024-09-12T19:09:46.332Z,1726168186.332 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:09:46.343Z,1726168186.343 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:09:46.738Z,1726168186.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:09:46.739Z,1726168186.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2024-09-12T19:10:24.747Z,1726168224.747 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T19:10:24.747Z,1726168224.747 [NAL9602] Data Fault, FailCount= 4
2024-09-12T19:10:24.747Z,1726168224.747 [NAL9602](ERROR): Data Fault
2024-09-12T19:10:24.844Z,1726168224.844 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T19:10:25.166Z,1726168225.166 [NAL9602](INFO): Powering down
2024-09-12T19:10:26.029Z,1726168226.029 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T19:10:26.029Z,1726168226.029 [NAL9602] No Fault, FailCount= 4
2024-09-12T19:10:55.494Z,1726168255.494 [NAL9602](INFO): Powering up NAL9602
2024-09-12T19:11:06.386Z,1726168266.386 [NAL9602](INFO): NAL9602 initialized
2024-09-12T19:12:47.396Z,1726168367.396 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2024-09-12T19:12:47.396Z,1726168367.396 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:12:47.416Z,1726168367.416 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:12:47.819Z,1726168367.819 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:12:47.819Z,1726168367.819 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2024-09-12T19:14:20.318Z,1726168460.318 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T19:14:20.318Z,1726168460.318 [Default:CheckIn:C.Wait] Stopped
2024-09-12T19:14:20.318Z,1726168460.318 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T19:14:20.318Z,1726168460.318 [Default:CheckIn:D] Running Loop=1
2024-09-12T19:14:20.724Z,1726168460.724 [Default:CheckIn:D] Stopped
2024-09-12T19:14:20.725Z,1726168460.725 [Default:CheckIn:E] Running Loop=1
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.206637 min
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn:E] Stopped
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn] Stopped
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn](INFO): Running loop #5
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn] Running Loop=5
2024-09-12T19:14:21.139Z,1726168461.139 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T19:14:21.140Z,1726168461.140 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T19:15:48.393Z,1726168548.393 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2024-09-12T19:15:48.393Z,1726168548.393 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:15:48.424Z,1726168548.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:15:48.806Z,1726168548.806 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:15:48.806Z,1726168548.806 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2024-09-12T19:18:04.630Z,1726168684.630 [CBIT](INFO): Clearing failed state for component RudderServo
2024-09-12T19:18:04.631Z,1726168684.631 [RudderServo] No Fault, FailCount= 3
2024-09-12T19:18:49.438Z,1726168729.438 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2024-09-12T19:18:49.438Z,1726168729.438 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:18:49.533Z,1726168729.533 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:18:49.918Z,1726168729.918 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:18:49.918Z,1726168729.918 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2024-09-12T19:19:21.362Z,1726168761.362 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T19:14:21.1Z
2024-09-12T19:19:21.362Z,1726168761.362 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T19:19:21.362Z,1726168761.362 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T19:19:28.616Z,1726168768.616 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0016.lzma
2024-09-12T19:19:29.619Z,1726168769.619 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0016.lzma.bak
2024-09-12T19:19:29.619Z,1726168769.619 [DataOverHttps](INFO): SBD MOMSN=23173482
2024-09-12T19:19:45.830Z,1726168785.830 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240912T182721/Express0017.lzma
2024-09-12T19:19:46.720Z,1726168786.720 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0017.lzma.bak
2024-09-12T19:19:46.721Z,1726168786.721 [DataOverHttps](INFO): SBD MOMSN=23173486
2024-09-12T19:19:48.871Z,1726168788.871 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T19:19:48.871Z,1726168788.871 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T19:19:48.871Z,1726168788.871 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T19:21:07.202Z,1726168867.202 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T19:21:07.202Z,1726168867.202 [NAL9602] Data Fault, FailCount= 5
2024-09-12T19:21:07.202Z,1726168867.202 [NAL9602](ERROR): Data Fault
2024-09-12T19:21:07.281Z,1726168867.281 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T19:21:07.281Z,1726168867.281 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-09-12T19:21:07.602Z,1726168867.602 [NAL9602](INFO): Powering down
2024-09-12T19:21:07.679Z,1726168867.679 [CBIT](INFO): Critical error at 20240912T192107
2024-09-12T19:21:50.440Z,1726168910.440 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2024-09-12T19:21:50.440Z,1726168910.440 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:21:50.503Z,1726168910.503 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:21:50.901Z,1726168910.901 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:21:50.901Z,1726168910.901 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2024-09-12T19:23:07.265Z,1726168987.265 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T19:23:07.265Z,1726168987.265 [NAL9602] No Fault, FailCount= 5
2024-09-12T19:23:07.594Z,1726168987.594 [NAL9602](INFO): Powering up NAL9602
2024-09-12T19:23:18.498Z,1726168998.498 [NAL9602](INFO): NAL9602 initialized
2024-09-12T19:24:49.424Z,1726169089.424 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T19:24:49.424Z,1726169089.424 [Default:CheckIn:C.Wait] Stopped
2024-09-12T19:24:49.424Z,1726169089.424 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T19:24:49.425Z,1726169089.425 [Default:CheckIn:D] Running Loop=1
2024-09-12T19:24:49.831Z,1726169089.831 [Default:CheckIn:D] Stopped
2024-09-12T19:24:49.831Z,1726169089.831 [Default:CheckIn:E] Running Loop=1
2024-09-12T19:24:50.227Z,1726169090.227 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.691748 min
2024-09-12T19:24:50.227Z,1726169090.227 [Default:CheckIn:E] Stopped
2024-09-12T19:24:50.227Z,1726169090.227 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T19:24:50.227Z,1726169090.227 [Default:CheckIn] Stopped
2024-09-12T19:24:50.228Z,1726169090.228 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T19:24:50.228Z,1726169090.228 [Default:CheckIn](INFO): Running loop #6
2024-09-12T19:24:50.228Z,1726169090.228 [Default:CheckIn] Running Loop=6
2024-09-12T19:24:50.228Z,1726169090.228 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T19:24:50.228Z,1726169090.228 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T19:24:51.426Z,1726169091.426 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2024-09-12T19:24:51.426Z,1726169091.426 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:24:51.517Z,1726169091.517 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:24:51.906Z,1726169091.906 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:24:51.906Z,1726169091.906 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2024-09-12T19:27:52.424Z,1726169272.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2024-09-12T19:27:52.424Z,1726169272.424 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:27:52.509Z,1726169272.509 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:27:52.509Z,1726169272.509 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:29:50.393Z,1726169390.393 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T19:24:50.2Z
2024-09-12T19:29:50.393Z,1726169390.393 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T19:29:50.393Z,1726169390.393 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T19:29:57.356Z,1726169397.356 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20240912T182721/Courier0019.lzma
2024-09-12T19:29:58.359Z,1726169398.359 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0019.lzma.bak
2024-09-12T19:29:58.359Z,1726169398.359 [DataOverHttps](INFO): SBD MOMSN=23173498
2024-09-12T19:30:14.277Z,1726169414.277 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20240912T182721/Express0020.lzma
2024-09-12T19:30:15.744Z,1726169415.744 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0020.lzma.bak
2024-09-12T19:30:15.744Z,1726169415.744 [DataOverHttps](INFO): SBD MOMSN=23173501
2024-09-12T19:30:17.522Z,1726169417.522 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T19:30:17.522Z,1726169417.522 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T19:30:17.522Z,1726169417.522 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T19:33:19.355Z,1726169599.355 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T19:33:19.355Z,1726169599.355 [NAL9602] Data Fault, FailCount= 1
2024-09-12T19:33:19.355Z,1726169599.355 [NAL9602](ERROR): Data Fault
2024-09-12T19:33:19.453Z,1726169599.453 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T19:33:19.754Z,1726169599.754 [NAL9602](INFO): Powering down
2024-09-12T19:33:20.641Z,1726169600.641 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T19:33:20.641Z,1726169600.641 [NAL9602] No Fault, FailCount= 1
2024-09-12T19:33:29.153Z,1726169609.153 [RudderServo](ERROR): getPosition uart error serial timeout
2024-09-12T19:33:29.153Z,1726169609.153 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2024-09-12T19:33:29.153Z,1726169609.153 [RudderServo] Communications Fault, FailCount= 1
2024-09-12T19:33:29.153Z,1726169609.153 [RudderServo](ERROR): Communications Fault
2024-09-12T19:33:29.163Z,1726169609.163 [CBIT](ERROR): Communications Fault in component: RudderServo
2024-09-12T19:33:29.468Z,1726169609.468 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-09-12T19:33:29.468Z,1726169609.468 [RudderServo](INFO): Powering down
2024-09-12T19:33:30.274Z,1726169610.274 [RudderServo](DEBUG): Initializing EZServoServo.
2024-09-12T19:33:30.394Z,1726169610.394 [RudderServo](DEBUG): Initializing RudderServo.
2024-09-12T19:33:30.398Z,1726169610.398 [CBIT](INFO): Clearing failed state for component RudderServo
2024-09-12T19:33:30.398Z,1726169610.398 [RudderServo] No Fault, FailCount= 1
2024-09-12T19:33:50.058Z,1726169630.058 [NAL9602](INFO): Powering up NAL9602
2024-09-12T19:34:00.966Z,1726169640.966 [NAL9602](INFO): NAL9602 initialized
2024-09-12T19:35:18.142Z,1726169718.142 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T19:35:18.142Z,1726169718.142 [Default:CheckIn:C.Wait] Stopped
2024-09-12T19:35:18.142Z,1726169718.142 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T19:35:18.142Z,1726169718.142 [Default:CheckIn:D] Running Loop=1
2024-09-12T19:35:18.540Z,1726169718.540 [Default:CheckIn:D] Stopped
2024-09-12T19:35:18.540Z,1726169718.540 [Default:CheckIn:E] Running Loop=1
2024-09-12T19:35:18.945Z,1726169718.945 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.170235 min
2024-09-12T19:35:18.945Z,1726169718.945 [Default:CheckIn:E] Stopped
2024-09-12T19:35:18.945Z,1726169718.945 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T19:35:18.945Z,1726169718.945 [Default:CheckIn] Stopped
2024-09-12T19:35:18.946Z,1726169718.946 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T19:35:18.946Z,1726169718.946 [Default:CheckIn](INFO): Running loop #7
2024-09-12T19:35:18.946Z,1726169718.946 [Default:CheckIn] Running Loop=7
2024-09-12T19:35:18.946Z,1726169718.946 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T19:35:18.946Z,1726169718.946 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T19:35:58.522Z,1726169758.522 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:36:10.677Z,1726169770.677 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:36:22.761Z,1726169782.761 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:36:34.886Z,1726169794.886 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:36:47.406Z,1726169807.406 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:36:59.525Z,1726169819.525 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:37:10.838Z,1726169830.838 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:37:22.161Z,1726169842.161 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:40:00.523Z,1726170000.523 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:40:13.854Z,1726170013.854 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:40:19.134Z,1726170019.134 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T19:35:18.9Z
2024-09-12T19:40:19.134Z,1726170019.134 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T19:40:19.134Z,1726170019.134 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T19:40:27.314Z,1726170027.314 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:40:29.952Z,1726170029.952 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0022.lzma
2024-09-12T19:40:30.955Z,1726170030.955 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0022.lzma.bak
2024-09-12T19:40:30.955Z,1726170030.955 [DataOverHttps](INFO): SBD MOMSN=23173597
2024-09-12T19:40:40.650Z,1726170040.650 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:40:46.733Z,1726170046.733 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20240912T182721/Express0023.lzma
2024-09-12T19:40:47.735Z,1726170047.735 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0023.lzma.bak
2024-09-12T19:40:47.735Z,1726170047.735 [DataOverHttps](INFO): SBD MOMSN=23173599
2024-09-12T19:40:49.998Z,1726170049.998 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T19:40:49.998Z,1726170049.998 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T19:40:49.998Z,1726170049.998 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T19:40:54.413Z,1726170054.413 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:41:07.782Z,1726170067.782 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:41:22.326Z,1726170082.326 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:41:35.657Z,1726170095.657 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:41:48.995Z,1726170108.995 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:42:02.322Z,1726170122.322 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T19:42:11.621Z,1726170131.621 [BPC1](INFO): Calculating totals. Valid battery stick count: 42. Valid reserve battery stick count: 5.
2024-09-12T19:42:11.623Z,1726170131.623 [BPC1](INFO): Received data from all battery sticks.
2024-09-12T19:42:52.513Z,1726170172.513 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:42:52.513Z,1726170172.513 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2024-09-12T19:44:03.934Z,1726170243.934 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T19:44:03.934Z,1726170243.934 [NAL9602] Data Fault, FailCount= 2
2024-09-12T19:44:03.934Z,1726170243.934 [NAL9602](ERROR): Data Fault
2024-09-12T19:44:04.009Z,1726170244.009 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T19:44:04.338Z,1726170244.338 [NAL9602](INFO): Powering down
2024-09-12T19:44:05.215Z,1726170245.215 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T19:44:05.215Z,1726170245.215 [NAL9602] No Fault, FailCount= 2
2024-09-12T19:44:34.638Z,1726170274.638 [NAL9602](INFO): Powering up NAL9602
2024-09-12T19:44:45.546Z,1726170285.546 [NAL9602](INFO): NAL9602 initialized
2024-09-12T19:45:50.609Z,1726170350.609 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T19:45:50.609Z,1726170350.609 [Default:CheckIn:C.Wait] Stopped
2024-09-12T19:45:50.610Z,1726170350.610 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T19:45:50.610Z,1726170350.610 [Default:CheckIn:D] Running Loop=1
2024-09-12T19:45:50.998Z,1726170350.998 [Default:CheckIn:D] Stopped
2024-09-12T19:45:50.998Z,1726170350.998 [Default:CheckIn:E] Running Loop=1
2024-09-12T19:45:51.423Z,1726170351.423 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.711198 min
2024-09-12T19:45:51.423Z,1726170351.423 [Default:CheckIn:E] Stopped
2024-09-12T19:45:51.423Z,1726170351.423 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T19:45:51.423Z,1726170351.423 [Default:CheckIn] Stopped
2024-09-12T19:45:51.424Z,1726170351.424 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T19:45:51.424Z,1726170351.424 [Default:CheckIn](INFO): Running loop #8
2024-09-12T19:45:51.424Z,1726170351.424 [Default:CheckIn] Running Loop=8
2024-09-12T19:45:51.424Z,1726170351.424 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T19:45:51.424Z,1726170351.424 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T19:45:53.020Z,1726170353.020 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-09-12T19:45:53.020Z,1726170353.020 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:45:53.081Z,1726170353.081 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:45:53.504Z,1726170353.504 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:45:53.505Z,1726170353.505 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-09-12T19:48:54.010Z,1726170534.010 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-09-12T19:48:54.010Z,1726170534.010 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:48:54.101Z,1726170534.101 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:48:54.505Z,1726170534.505 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:48:54.505Z,1726170534.505 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-09-12T19:50:51.595Z,1726170651.595 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T19:45:51.4Z
2024-09-12T19:50:51.595Z,1726170651.595 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T19:50:51.595Z,1726170651.595 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T19:51:00.967Z,1726170660.967 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20240912T182721/Courier0025.lzma
2024-09-12T19:51:01.967Z,1726170661.967 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0025.lzma.bak
2024-09-12T19:51:01.967Z,1726170661.967 [DataOverHttps](INFO): SBD MOMSN=23173718
2024-09-12T19:51:17.776Z,1726170677.776 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240912T182721/Express0026.lzma
2024-09-12T19:51:18.779Z,1726170678.779 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0026.lzma.bak
2024-09-12T19:51:18.779Z,1726170678.779 [DataOverHttps](INFO): SBD MOMSN=23173725
2024-09-12T19:51:20.743Z,1726170680.743 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T19:51:20.743Z,1726170680.743 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T19:51:20.743Z,1726170680.743 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T19:51:55.097Z,1726170715.097 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-09-12T19:51:55.097Z,1726170715.097 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:51:55.177Z,1726170715.177 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:51:55.581Z,1726170715.581 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:51:55.581Z,1726170715.581 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-09-12T19:54:48.394Z,1726170888.394 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T19:54:48.394Z,1726170888.394 [NAL9602] Data Fault, FailCount= 3
2024-09-12T19:54:48.394Z,1726170888.394 [NAL9602](ERROR): Data Fault
2024-09-12T19:54:48.485Z,1726170888.485 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T19:54:48.798Z,1726170888.798 [NAL9602](INFO): Powering down
2024-09-12T19:54:49.689Z,1726170889.689 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T19:54:49.689Z,1726170889.689 [NAL9602] No Fault, FailCount= 3
2024-09-12T19:54:56.082Z,1726170896.082 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-09-12T19:54:56.082Z,1726170896.082 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:54:56.141Z,1726170896.141 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:54:56.561Z,1726170896.561 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:54:56.561Z,1726170896.561 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-09-12T19:55:19.102Z,1726170919.102 [NAL9602](INFO): Powering up NAL9602
2024-09-12T19:55:30.006Z,1726170930.006 [NAL9602](INFO): NAL9602 initialized
2024-09-12T19:56:21.339Z,1726170981.339 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T19:56:21.339Z,1726170981.339 [Default:CheckIn:C.Wait] Stopped
2024-09-12T19:56:21.339Z,1726170981.339 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T19:56:21.339Z,1726170981.339 [Default:CheckIn:D] Running Loop=1
2024-09-12T19:56:21.743Z,1726170981.743 [Default:CheckIn:D] Stopped
2024-09-12T19:56:21.743Z,1726170981.743 [Default:CheckIn:E] Running Loop=1
2024-09-12T19:56:22.142Z,1726170982.142 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.223617 min
2024-09-12T19:56:22.142Z,1726170982.142 [Default:CheckIn:E] Stopped
2024-09-12T19:56:22.142Z,1726170982.142 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T19:56:22.142Z,1726170982.142 [Default:CheckIn] Stopped
2024-09-12T19:56:22.142Z,1726170982.142 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T19:56:22.142Z,1726170982.142 [Default:CheckIn](INFO): Running loop #9
2024-09-12T19:56:22.143Z,1726170982.143 [Default:CheckIn] Running Loop=9
2024-09-12T19:56:22.143Z,1726170982.143 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T19:56:22.143Z,1726170982.143 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T19:57:57.072Z,1726171077.072 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-09-12T19:57:57.072Z,1726171077.072 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T19:57:57.153Z,1726171077.153 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T19:57:57.549Z,1726171077.549 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T19:57:57.549Z,1726171077.549 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-09-12T20:00:58.070Z,1726171258.070 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-09-12T20:00:58.070Z,1726171258.070 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:00:58.138Z,1726171258.138 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:00:58.541Z,1726171258.541 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:00:58.541Z,1726171258.541 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-09-12T20:01:22.310Z,1726171282.310 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T19:56:22.1Z
2024-09-12T20:01:22.310Z,1726171282.310 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T20:01:22.310Z,1726171282.310 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T20:01:30.704Z,1726171290.704 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0028.lzma
2024-09-12T20:01:31.707Z,1726171291.707 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0028.lzma.bak
2024-09-12T20:01:31.707Z,1726171291.707 [DataOverHttps](INFO): SBD MOMSN=23173820
2024-09-12T20:01:48.728Z,1726171308.728 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240912T182721/Express0029.lzma
2024-09-12T20:01:49.731Z,1726171309.731 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0029.lzma.bak
2024-09-12T20:01:49.731Z,1726171309.731 [DataOverHttps](INFO): SBD MOMSN=23173827
2024-09-12T20:01:51.395Z,1726171311.395 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T20:01:51.395Z,1726171311.395 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T20:01:51.395Z,1726171311.395 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T20:03:59.138Z,1726171439.138 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-09-12T20:03:59.138Z,1726171439.138 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:03:59.205Z,1726171439.205 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:03:59.601Z,1726171439.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:03:59.601Z,1726171439.601 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-09-12T20:05:32.860Z,1726171532.860 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T20:05:32.860Z,1726171532.860 [NAL9602] Data Fault, FailCount= 4
2024-09-12T20:05:32.860Z,1726171532.860 [NAL9602](ERROR): Data Fault
2024-09-12T20:05:32.933Z,1726171532.933 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T20:05:33.259Z,1726171533.259 [NAL9602](INFO): Powering down
2024-09-12T20:05:34.145Z,1726171534.145 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T20:05:34.145Z,1726171534.145 [NAL9602] No Fault, FailCount= 4
2024-09-12T20:06:03.562Z,1726171563.562 [NAL9602](INFO): Powering up NAL9602
2024-09-12T20:06:14.470Z,1726171574.470 [NAL9602](INFO): NAL9602 initialized
2024-09-12T20:06:52.066Z,1726171612.066 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T20:06:52.066Z,1726171612.066 [Default:CheckIn:C.Wait] Stopped
2024-09-12T20:06:52.066Z,1726171612.066 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T20:06:52.066Z,1726171612.066 [Default:CheckIn:D] Running Loop=1
2024-09-12T20:06:52.450Z,1726171612.450 [Default:CheckIn:D] Stopped
2024-09-12T20:06:52.451Z,1726171612.451 [Default:CheckIn:E] Running Loop=1
2024-09-12T20:06:52.854Z,1726171612.854 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.735400 min
2024-09-12T20:06:52.854Z,1726171612.854 [Default:CheckIn:E] Stopped
2024-09-12T20:06:52.854Z,1726171612.854 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T20:06:52.854Z,1726171612.854 [Default:CheckIn] Stopped
2024-09-12T20:06:52.855Z,1726171612.855 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T20:06:52.855Z,1726171612.855 [Default:CheckIn](INFO): Running loop #10
2024-09-12T20:06:52.855Z,1726171612.855 [Default:CheckIn] Running Loop=10
2024-09-12T20:06:52.855Z,1726171612.855 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T20:06:52.855Z,1726171612.855 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T20:07:00.148Z,1726171620.148 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-09-12T20:07:00.153Z,1726171620.153 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:07:00.225Z,1726171620.225 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:07:00.617Z,1726171620.617 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:07:00.617Z,1726171620.617 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-09-12T20:10:01.128Z,1726171801.128 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-09-12T20:10:01.128Z,1726171801.128 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:10:01.221Z,1726171801.221 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:10:01.606Z,1726171801.606 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:10:01.606Z,1726171801.606 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-09-12T20:11:53.039Z,1726171913.039 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T20:06:52.9Z
2024-09-12T20:11:53.039Z,1726171913.039 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T20:11:53.039Z,1726171913.039 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T20:12:00.448Z,1726171920.448 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0031.lzma
2024-09-12T20:12:01.451Z,1726171921.451 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0031.lzma.bak
2024-09-12T20:12:01.451Z,1726171921.451 [DataOverHttps](INFO): SBD MOMSN=23173864
2024-09-12T20:12:19.357Z,1726171939.357 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240912T182721/Express0032.lzma
2024-09-12T20:12:20.359Z,1726171940.359 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0032.lzma.bak
2024-09-12T20:12:20.359Z,1726171940.359 [DataOverHttps](INFO): SBD MOMSN=23173866
2024-09-12T20:12:22.570Z,1726171942.570 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T20:12:22.570Z,1726171942.570 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T20:12:22.570Z,1726171942.570 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T20:13:02.178Z,1726171982.178 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-09-12T20:13:02.178Z,1726171982.178 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:13:02.265Z,1726171982.265 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:13:02.657Z,1726171982.657 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:13:02.657Z,1726171982.657 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-09-12T20:16:03.153Z,1726172163.153 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2024-09-12T20:16:03.153Z,1726172163.153 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:16:03.237Z,1726172163.237 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:16:03.649Z,1726172163.649 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:16:03.649Z,1726172163.649 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2024-09-12T20:16:15.671Z,1726172175.671 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T20:16:15.671Z,1726172175.671 [NAL9602] Data Fault, FailCount= 5
2024-09-12T20:16:15.671Z,1726172175.671 [NAL9602](ERROR): Data Fault
2024-09-12T20:16:15.741Z,1726172175.741 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T20:16:15.741Z,1726172175.741 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-09-12T20:16:16.070Z,1726172176.070 [NAL9602](INFO): Powering down
2024-09-12T20:16:16.155Z,1726172176.155 [CBIT](INFO): Critical error at 20240912T201615
2024-09-12T20:17:23.141Z,1726172243.141 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T20:17:23.141Z,1726172243.141 [Default:CheckIn:C.Wait] Stopped
2024-09-12T20:17:23.141Z,1726172243.141 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T20:17:23.141Z,1726172243.141 [Default:CheckIn:D] Running Loop=1
2024-09-12T20:17:23.542Z,1726172243.542 [Default:CheckIn:D] Stopped
2024-09-12T20:17:23.542Z,1726172243.542 [Default:CheckIn:E] Running Loop=1
2024-09-12T20:17:23.953Z,1726172243.953 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.253597 min
2024-09-12T20:17:23.953Z,1726172243.953 [Default:CheckIn:E] Stopped
2024-09-12T20:17:23.953Z,1726172243.953 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T20:17:23.953Z,1726172243.953 [Default:CheckIn] Stopped
2024-09-12T20:17:23.953Z,1726172243.953 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T20:17:23.954Z,1726172243.954 [Default:CheckIn](INFO): Running loop #11
2024-09-12T20:17:23.954Z,1726172243.954 [Default:CheckIn] Running Loop=11
2024-09-12T20:17:23.954Z,1726172243.954 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T20:17:23.954Z,1726172243.954 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T20:18:15.741Z,1726172295.741 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T20:18:15.741Z,1726172295.741 [NAL9602] No Fault, FailCount= 5
2024-09-12T20:18:16.062Z,1726172296.062 [NAL9602](INFO): Powering up NAL9602
2024-09-12T20:18:26.970Z,1726172306.970 [NAL9602](INFO): NAL9602 initialized
2024-09-12T20:19:04.158Z,1726172344.158 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2024-09-12T20:19:04.158Z,1726172344.158 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:19:04.221Z,1726172344.221 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:19:04.614Z,1726172344.614 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:19:04.614Z,1726172344.614 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2024-09-12T20:22:05.144Z,1726172525.144 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2024-09-12T20:22:05.144Z,1726172525.144 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:22:05.209Z,1726172525.209 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:22:05.609Z,1726172525.609 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:22:05.609Z,1726172525.609 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2024-09-12T20:22:24.142Z,1726172544.142 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T20:17:23.0Z
2024-09-12T20:22:24.142Z,1726172544.142 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T20:22:24.142Z,1726172544.142 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T20:22:32.620Z,1726172552.620 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20240912T182721/Courier0034.lzma
2024-09-12T20:22:33.623Z,1726172553.623 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0034.lzma.bak
2024-09-12T20:22:33.623Z,1726172553.623 [DataOverHttps](INFO): SBD MOMSN=23173892
2024-09-12T20:22:52.725Z,1726172572.725 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20240912T182721/Express0035.lzma
2024-09-12T20:22:53.735Z,1726172573.735 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0035.lzma.bak
2024-09-12T20:22:53.735Z,1726172573.735 [DataOverHttps](INFO): SBD MOMSN=23173895
2024-09-12T20:22:56.171Z,1726172576.171 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T20:22:56.171Z,1726172576.171 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T20:22:56.171Z,1726172576.171 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T20:25:06.216Z,1726172706.216 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2024-09-12T20:25:06.216Z,1726172706.216 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:25:06.281Z,1726172706.281 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:25:06.685Z,1726172706.685 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:25:06.685Z,1726172706.685 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2024-09-12T20:27:56.731Z,1726172876.731 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T20:27:56.731Z,1726172876.731 [Default:CheckIn:C.Wait] Stopped
2024-09-12T20:27:56.731Z,1726172876.731 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T20:27:56.731Z,1726172876.731 [Default:CheckIn:D] Running Loop=1
2024-09-12T20:27:57.124Z,1726172877.124 [Default:CheckIn:D] Stopped
2024-09-12T20:27:57.124Z,1726172877.124 [Default:CheckIn:E] Running Loop=1
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.813298 min
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn:E] Stopped
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn] Stopped
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn](INFO): Running loop #12
2024-09-12T20:27:57.539Z,1726172877.539 [Default:CheckIn] Running Loop=12
2024-09-12T20:27:57.540Z,1726172877.540 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T20:27:57.540Z,1726172877.540 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T20:28:07.213Z,1726172887.213 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2024-09-12T20:28:07.213Z,1726172887.213 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:28:07.289Z,1726172887.289 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:28:07.677Z,1726172887.677 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:28:07.677Z,1726172887.677 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2024-09-12T20:28:29.824Z,1726172909.824 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T20:28:29.824Z,1726172909.824 [NAL9602] Data Fault, FailCount= 1
2024-09-12T20:28:29.824Z,1726172909.824 [NAL9602](ERROR): Data Fault
2024-09-12T20:28:29.921Z,1726172909.921 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T20:28:30.226Z,1726172910.226 [NAL9602](INFO): Powering down
2024-09-12T20:28:31.106Z,1726172911.106 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T20:28:31.106Z,1726172911.106 [NAL9602] No Fault, FailCount= 1
2024-09-12T20:29:00.526Z,1726172940.526 [NAL9602](INFO): Powering up NAL9602
2024-09-12T20:29:11.435Z,1726172951.435 [NAL9602](INFO): NAL9602 initialized
2024-09-12T20:31:08.245Z,1726173068.245 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2024-09-12T20:31:08.245Z,1726173068.245 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:31:08.333Z,1726173068.333 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:31:08.761Z,1726173068.761 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:31:08.761Z,1726173068.761 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2024-09-12T20:32:57.832Z,1726173177.832 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T20:27:57.5Z
2024-09-12T20:32:57.832Z,1726173177.832 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T20:32:57.832Z,1726173177.832 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T20:33:05.628Z,1726173185.628 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0037.lzma
2024-09-12T20:33:06.630Z,1726173186.630 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0037.lzma.bak
2024-09-12T20:33:06.631Z,1726173186.631 [DataOverHttps](INFO): SBD MOMSN=23173918
2024-09-12T20:33:22.409Z,1726173202.409 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240912T182721/Express0038.lzma
2024-09-12T20:33:23.411Z,1726173203.411 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0038.lzma.bak
2024-09-12T20:33:23.411Z,1726173203.411 [DataOverHttps](INFO): SBD MOMSN=23173920
2024-09-12T20:33:26.534Z,1726173206.534 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T20:33:26.534Z,1726173206.534 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T20:33:26.534Z,1726173206.534 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T20:34:09.357Z,1726173249.357 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2024-09-12T20:34:09.357Z,1726173249.357 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:34:09.438Z,1726173249.438 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:34:09.841Z,1726173249.841 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:34:09.841Z,1726173249.841 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2024-09-12T20:37:10.337Z,1726173430.337 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2024-09-12T20:37:10.337Z,1726173430.337 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:37:10.401Z,1726173430.401 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:37:10.817Z,1726173430.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:37:10.817Z,1726173430.817 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2024-09-12T20:38:27.122Z,1726173507.122 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T20:38:27.122Z,1726173507.122 [Default:CheckIn:C.Wait] Stopped
2024-09-12T20:38:27.122Z,1726173507.122 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T20:38:27.122Z,1726173507.122 [Default:CheckIn:D] Running Loop=1
2024-09-12T20:38:27.502Z,1726173507.502 [Default:CheckIn:D] Stopped
2024-09-12T20:38:27.502Z,1726173507.502 [Default:CheckIn:E] Running Loop=1
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 126.319596 min
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn:E] Stopped
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn] Stopped
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn](INFO): Running loop #13
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn] Running Loop=13
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T20:38:27.906Z,1726173507.906 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T20:39:13.146Z,1726173553.146 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T20:39:13.146Z,1726173553.146 [NAL9602] Data Fault, FailCount= 2
2024-09-12T20:39:13.146Z,1726173553.146 [NAL9602](ERROR): Data Fault
2024-09-12T20:39:13.217Z,1726173553.217 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T20:39:13.549Z,1726173553.549 [NAL9602](INFO): Powering down
2024-09-12T20:39:14.432Z,1726173554.432 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T20:39:14.432Z,1726173554.432 [NAL9602] No Fault, FailCount= 2
2024-09-12T20:39:43.846Z,1726173583.846 [NAL9602](INFO): Powering up NAL9602
2024-09-12T20:39:54.758Z,1726173594.758 [NAL9602](INFO): NAL9602 initialized
2024-09-12T20:40:11.328Z,1726173611.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2024-09-12T20:40:11.328Z,1726173611.328 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:40:11.413Z,1726173611.413 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:40:11.797Z,1726173611.797 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:40:11.797Z,1726173611.797 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2024-09-12T20:43:12.494Z,1726173792.494 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2024-09-12T20:43:12.494Z,1726173792.494 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T20:43:12.569Z,1726173792.569 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:43:12.569Z,1726173792.569 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T20:43:17.706Z,1726173797.706 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:43:28.254Z,1726173808.254 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T20:38:27.9Z
2024-09-12T20:43:28.254Z,1726173808.254 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T20:43:28.254Z,1726173808.254 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T20:43:29.926Z,1726173809.926 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:43:35.192Z,1726173815.192 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0040.lzma
2024-09-12T20:43:36.195Z,1726173816.195 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0040.lzma.bak
2024-09-12T20:43:36.195Z,1726173816.195 [DataOverHttps](INFO): SBD MOMSN=23173948
2024-09-12T20:43:42.046Z,1726173822.046 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:43:52.177Z,1726173832.177 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20240912T182721/Express0041.lzma
2024-09-12T20:43:53.179Z,1726173833.179 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0041.lzma.bak
2024-09-12T20:43:53.179Z,1726173833.179 [DataOverHttps](INFO): SBD MOMSN=23173950
2024-09-12T20:43:54.170Z,1726173834.170 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:43:55.013Z,1726173835.013 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T20:43:55.013Z,1726173835.013 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T20:43:55.013Z,1726173835.013 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T20:44:05.477Z,1726173845.477 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:44:18.002Z,1726173858.002 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:44:30.121Z,1726173870.121 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:44:41.445Z,1726173881.445 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:47:13.338Z,1726174033.338 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:47:25.054Z,1726174045.054 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:47:37.185Z,1726174057.185 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:47:49.294Z,1726174069.294 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:48:01.818Z,1726174081.818 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:48:14.342Z,1726174094.342 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:48:26.462Z,1726174106.462 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:48:38.177Z,1726174118.177 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:48:49.900Z,1726174129.900 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:48:55.580Z,1726174135.580 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T20:48:55.580Z,1726174135.580 [Default:CheckIn:C.Wait] Stopped
2024-09-12T20:48:55.580Z,1726174135.580 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T20:48:55.580Z,1726174135.580 [Default:CheckIn:D] Running Loop=1
2024-09-12T20:48:55.977Z,1726174135.977 [Default:CheckIn:D] Stopped
2024-09-12T20:48:55.978Z,1726174135.978 [Default:CheckIn:E] Running Loop=1
2024-09-12T20:48:56.440Z,1726174136.440 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 136.794189 min
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn:E] Stopped
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn] Stopped
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn](INFO): Running loop #14
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn] Running Loop=14
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T20:48:56.441Z,1726174136.441 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T20:49:02.022Z,1726174142.022 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:49:14.138Z,1726174154.138 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:49:23.491Z,1726174163.491 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-12T20:49:25.451Z,1726174165.451 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T20:49:29.900Z,1726174169.900 [BPC1](INFO): Calculating totals. Valid battery stick count: 42. Valid reserve battery stick count: 5.
2024-09-12T20:49:29.903Z,1726174169.903 [BPC1](INFO): Received data from all battery sticks.
2024-09-12T20:49:57.775Z,1726174197.775 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T20:49:57.775Z,1726174197.775 [NAL9602] Data Fault, FailCount= 3
2024-09-12T20:49:57.775Z,1726174197.775 [NAL9602](ERROR): Data Fault
2024-09-12T20:49:57.791Z,1726174197.791 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T20:49:58.183Z,1726174198.183 [NAL9602](INFO): Powering down
2024-09-12T20:49:59.007Z,1726174199.007 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T20:49:59.007Z,1726174199.007 [NAL9602] No Fault, FailCount= 3
2024-09-12T20:50:28.475Z,1726174228.475 [NAL9602](INFO): Powering up NAL9602
2024-09-12T20:50:39.391Z,1726174239.391 [NAL9602](INFO): NAL9602 initialized
2024-09-12T20:53:56.565Z,1726174436.565 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T20:48:56.4Z
2024-09-12T20:53:56.565Z,1726174436.565 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T20:53:56.565Z,1726174436.565 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T20:54:03.692Z,1726174443.692 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20240912T182721/Courier0043.lzma
2024-09-12T20:54:04.695Z,1726174444.695 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0043.lzma.bak
2024-09-12T20:54:04.695Z,1726174444.695 [DataOverHttps](INFO): SBD MOMSN=23173970
2024-09-12T20:54:22.100Z,1726174462.100 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20240912T182721/Express0044.lzma
2024-09-12T20:54:23.103Z,1726174463.103 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0044.lzma.bak
2024-09-12T20:54:23.103Z,1726174463.103 [DataOverHttps](INFO): SBD MOMSN=23173972
2024-09-12T20:54:26.154Z,1726174466.154 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T20:54:26.154Z,1726174466.154 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T20:54:26.154Z,1726174466.154 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T20:58:12.817Z,1726174692.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T20:58:12.817Z,1726174692.817 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2024-09-12T20:59:26.689Z,1726174766.689 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T20:59:26.689Z,1726174766.689 [Default:CheckIn:C.Wait] Stopped
2024-09-12T20:59:26.689Z,1726174766.689 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T20:59:26.689Z,1726174766.689 [Default:CheckIn:D] Running Loop=1
2024-09-12T20:59:27.119Z,1726174767.119 [Default:CheckIn:D] Stopped
2024-09-12T20:59:27.119Z,1726174767.119 [Default:CheckIn:E] Running Loop=1
2024-09-12T20:59:27.519Z,1726174767.519 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 147.313200 min
2024-09-12T20:59:27.519Z,1726174767.519 [Default:CheckIn:E] Stopped
2024-09-12T20:59:27.519Z,1726174767.519 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T20:59:27.519Z,1726174767.519 [Default:CheckIn] Stopped
2024-09-12T20:59:27.519Z,1726174767.519 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T20:59:27.520Z,1726174767.520 [Default:CheckIn](INFO): Running loop #15
2024-09-12T20:59:27.520Z,1726174767.520 [Default:CheckIn] Running Loop=15
2024-09-12T20:59:27.520Z,1726174767.520 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T20:59:27.520Z,1726174767.520 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T21:00:42.226Z,1726174842.226 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T21:00:42.226Z,1726174842.226 [NAL9602] Data Fault, FailCount= 4
2024-09-12T21:00:42.226Z,1726174842.226 [NAL9602](ERROR): Data Fault
2024-09-12T21:00:42.283Z,1726174842.283 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T21:00:42.630Z,1726174842.630 [NAL9602](INFO): Powering down
2024-09-12T21:00:43.483Z,1726174843.483 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T21:00:43.483Z,1726174843.483 [NAL9602] No Fault, FailCount= 4
2024-09-12T21:01:12.934Z,1726174872.934 [NAL9602](INFO): Powering up NAL9602
2024-09-12T21:01:13.354Z,1726174873.354 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-09-12T21:01:13.354Z,1726174873.354 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:01:13.377Z,1726174873.377 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:01:13.771Z,1726174873.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:01:13.771Z,1726174873.771 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-09-12T21:01:23.843Z,1726174883.843 [NAL9602](INFO): NAL9602 initialized
2024-09-12T21:04:14.372Z,1726175054.372 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-09-12T21:04:14.372Z,1726175054.372 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:04:14.385Z,1726175054.385 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:04:14.863Z,1726175054.863 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:04:14.863Z,1726175054.863 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-09-12T21:04:27.735Z,1726175067.735 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T20:59:27.5Z
2024-09-12T21:04:27.735Z,1726175067.735 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T21:04:27.735Z,1726175067.735 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T21:04:36.274Z,1726175076.274 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0046.lzma
2024-09-12T21:04:37.331Z,1726175077.331 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0046.lzma.bak
2024-09-12T21:04:37.331Z,1726175077.331 [DataOverHttps](INFO): SBD MOMSN=23173990
2024-09-12T21:04:55.248Z,1726175095.248 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20240912T182721/Express0047.lzma
2024-09-12T21:04:56.251Z,1726175096.251 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0047.lzma.bak
2024-09-12T21:04:56.251Z,1726175096.251 [DataOverHttps](INFO): SBD MOMSN=23173992
2024-09-12T21:04:58.483Z,1726175098.483 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T21:04:58.483Z,1726175098.483 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T21:04:58.483Z,1726175098.483 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T21:07:15.458Z,1726175235.458 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-09-12T21:07:15.458Z,1726175235.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:07:15.469Z,1726175235.469 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:07:15.860Z,1726175235.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:07:15.860Z,1726175235.860 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-09-12T21:09:59.115Z,1726175399.115 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T21:09:59.115Z,1726175399.115 [Default:CheckIn:C.Wait] Stopped
2024-09-12T21:09:59.115Z,1726175399.115 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T21:09:59.115Z,1726175399.115 [Default:CheckIn:D] Running Loop=1
2024-09-12T21:09:59.523Z,1726175399.523 [Default:CheckIn:D] Stopped
2024-09-12T21:09:59.523Z,1726175399.523 [Default:CheckIn:E] Running Loop=1
2024-09-12T21:09:59.902Z,1726175399.902 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 157.853288 min
2024-09-12T21:09:59.902Z,1726175399.902 [Default:CheckIn:E] Stopped
2024-09-12T21:09:59.902Z,1726175399.902 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T21:09:59.902Z,1726175399.902 [Default:CheckIn] Stopped
2024-09-12T21:09:59.902Z,1726175399.902 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T21:09:59.902Z,1726175399.902 [Default:CheckIn](INFO): Running loop #16
2024-09-12T21:09:59.903Z,1726175399.903 [Default:CheckIn] Running Loop=16
2024-09-12T21:09:59.903Z,1726175399.903 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T21:09:59.903Z,1726175399.903 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T21:10:00.877Z,1726175400.877 [CommandExec](IMPORTANT): got command failComponent
2024-09-12T21:10:00.877Z,1726175400.877 [CommandExec](IMPORTANT): Failed components:
2024-09-12T21:10:00.878Z,1726175400.878 [CommandExec](IMPORTANT): No failed Components.
2024-09-12T21:10:04.417Z,1726175404.417 [CommandExec](IMPORTANT): got command gfscan
2024-09-12T21:10:04.795Z,1726175404.795 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-12T21:10:15.724Z,1726175415.724 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002385
CHAN A1 (24V): 0.000234
CHAN A2 (12V): -0.002176
CHAN A3 (5V): -0.001821
CHAN B0 (3.3V): -0.000002
CHAN B1 (3.15aV): -0.000064
CHAN B2 (3.15bV): -0.000564
CHAN B3 (GND): -0.000327
OPEN: -0.000401
Full Scale: +/- 1 mA
2024-09-12T21:10:16.484Z,1726175416.484 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-09-12T21:10:16.484Z,1726175416.484 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:10:16.533Z,1726175416.533 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:10:16.939Z,1726175416.939 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:10:16.939Z,1726175416.939 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-09-12T21:11:25.535Z,1726175485.535 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T21:11:25.535Z,1726175485.535 [NAL9602] Data Fault, FailCount= 5
2024-09-12T21:11:25.535Z,1726175485.535 [NAL9602](ERROR): Data Fault
2024-09-12T21:11:25.593Z,1726175485.593 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T21:11:25.593Z,1726175485.593 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-09-12T21:11:25.946Z,1726175485.946 [NAL9602](INFO): Powering down
2024-09-12T21:11:25.983Z,1726175485.983 [CBIT](INFO): Critical error at 20240912T211125
2024-09-12T21:13:17.470Z,1726175597.470 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-09-12T21:13:17.470Z,1726175597.470 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:13:17.508Z,1726175597.508 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:13:17.872Z,1726175597.872 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:13:17.873Z,1726175597.873 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-09-12T21:13:25.539Z,1726175605.539 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T21:13:25.539Z,1726175605.539 [NAL9602] No Fault, FailCount= 5
2024-09-12T21:13:25.934Z,1726175605.934 [NAL9602](INFO): Powering up NAL9602
2024-09-12T21:13:36.844Z,1726175616.844 [NAL9602](INFO): NAL9602 initialized
2024-09-12T21:15:00.073Z,1726175700.073 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T21:09:59.9Z
2024-09-12T21:15:00.074Z,1726175700.074 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T21:15:00.074Z,1726175700.074 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T21:15:07.492Z,1726175707.492 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20240912T182721/Courier0049.lzma
2024-09-12T21:15:08.495Z,1726175708.495 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0049.lzma.bak
2024-09-12T21:15:08.495Z,1726175708.495 [DataOverHttps](INFO): SBD MOMSN=23174020
2024-09-12T21:15:23.957Z,1726175723.957 [DataOverHttps](INFO): Sending 372 bytes from file Logs/20240912T182721/Express0050.lzma
2024-09-12T21:15:24.959Z,1726175724.959 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0050.lzma.bak
2024-09-12T21:15:24.959Z,1726175724.959 [DataOverHttps](INFO): SBD MOMSN=23174023
2024-09-12T21:15:26.742Z,1726175726.742 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T21:15:26.742Z,1726175726.742 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T21:15:26.742Z,1726175726.742 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T21:16:18.462Z,1726175778.462 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-09-12T21:16:18.462Z,1726175778.462 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:16:18.473Z,1726175778.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:16:18.874Z,1726175778.874 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:16:18.874Z,1726175778.874 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-09-12T21:19:19.454Z,1726175959.454 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-09-12T21:19:19.454Z,1726175959.454 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:19:19.493Z,1726175959.493 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:19:19.856Z,1726175959.856 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:19:19.856Z,1726175959.856 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-09-12T21:20:27.368Z,1726176027.368 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T21:20:27.368Z,1726176027.368 [Default:CheckIn:C.Wait] Stopped
2024-09-12T21:20:27.368Z,1726176027.368 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T21:20:27.368Z,1726176027.368 [Default:CheckIn:D] Running Loop=1
2024-09-12T21:20:27.767Z,1726176027.767 [Default:CheckIn:D] Stopped
2024-09-12T21:20:27.767Z,1726176027.767 [Default:CheckIn:E] Running Loop=1
2024-09-12T21:20:28.167Z,1726176028.167 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 168.324007 min
2024-09-12T21:20:28.167Z,1726176028.167 [Default:CheckIn:E] Stopped
2024-09-12T21:20:28.167Z,1726176028.167 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T21:20:28.167Z,1726176028.167 [Default:CheckIn] Stopped
2024-09-12T21:20:28.167Z,1726176028.167 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T21:20:28.168Z,1726176028.168 [Default:CheckIn](INFO): Running loop #17
2024-09-12T21:20:28.168Z,1726176028.168 [Default:CheckIn] Running Loop=17
2024-09-12T21:20:28.168Z,1726176028.168 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T21:20:28.168Z,1726176028.168 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T21:22:20.481Z,1726176140.481 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-09-12T21:22:20.481Z,1726176140.481 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:22:20.492Z,1726176140.492 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:22:20.905Z,1726176140.905 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:22:20.905Z,1726176140.905 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-09-12T21:23:38.034Z,1726176218.034 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T21:23:38.034Z,1726176218.034 [NAL9602] Data Fault, FailCount= 1
2024-09-12T21:23:38.034Z,1726176218.034 [NAL9602](ERROR): Data Fault
2024-09-12T21:23:38.088Z,1726176218.088 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T21:23:38.442Z,1726176218.442 [NAL9602](INFO): Powering down
2024-09-12T21:23:39.270Z,1726176219.270 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T21:23:39.270Z,1726176219.270 [NAL9602] No Fault, FailCount= 1
2024-09-12T21:24:08.742Z,1726176248.742 [NAL9602](INFO): Powering up NAL9602
2024-09-12T21:24:19.651Z,1726176259.651 [NAL9602](INFO): NAL9602 initialized
2024-09-12T21:25:21.466Z,1726176321.466 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-09-12T21:25:21.466Z,1726176321.466 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:25:21.504Z,1726176321.504 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:25:21.882Z,1726176321.882 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:25:21.882Z,1726176321.882 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-09-12T21:25:28.354Z,1726176328.354 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T21:20:28.2Z
2024-09-12T21:25:28.354Z,1726176328.354 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T21:25:28.354Z,1726176328.354 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T21:25:35.805Z,1726176335.805 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0052.lzma
2024-09-12T21:25:36.807Z,1726176336.807 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0052.lzma.bak
2024-09-12T21:25:36.807Z,1726176336.807 [DataOverHttps](INFO): SBD MOMSN=23174051
2024-09-12T21:25:52.225Z,1726176352.225 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20240912T182721/Express0053.lzma
2024-09-12T21:25:53.227Z,1726176353.227 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0053.lzma.bak
2024-09-12T21:25:53.227Z,1726176353.227 [DataOverHttps](INFO): SBD MOMSN=23174053
2024-09-12T21:25:55.007Z,1726176355.007 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T21:25:55.007Z,1726176355.007 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T21:25:55.007Z,1726176355.007 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T21:28:22.458Z,1726176502.458 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-09-12T21:28:22.458Z,1726176502.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:28:22.506Z,1726176502.506 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:28:22.879Z,1726176502.879 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:28:22.879Z,1726176502.879 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-09-12T21:30:55.593Z,1726176655.593 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T21:30:55.593Z,1726176655.593 [Default:CheckIn:C.Wait] Stopped
2024-09-12T21:30:55.594Z,1726176655.594 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T21:30:55.594Z,1726176655.594 [Default:CheckIn:D] Running Loop=1
2024-09-12T21:30:55.995Z,1726176655.995 [Default:CheckIn:D] Stopped
2024-09-12T21:30:55.995Z,1726176655.995 [Default:CheckIn:E] Running Loop=1
2024-09-12T21:30:56.391Z,1726176656.391 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 178.794466 min
2024-09-12T21:30:56.391Z,1726176656.391 [Default:CheckIn:E] Stopped
2024-09-12T21:30:56.391Z,1726176656.391 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T21:30:56.392Z,1726176656.392 [Default:CheckIn] Stopped
2024-09-12T21:30:56.392Z,1726176656.392 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T21:30:56.392Z,1726176656.392 [Default:CheckIn](INFO): Running loop #18
2024-09-12T21:30:56.392Z,1726176656.392 [Default:CheckIn] Running Loop=18
2024-09-12T21:30:56.392Z,1726176656.392 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T21:30:56.392Z,1726176656.392 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T21:31:23.464Z,1726176683.464 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2024-09-12T21:31:23.464Z,1726176683.464 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:31:23.555Z,1726176683.555 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:31:23.879Z,1726176683.879 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:31:23.879Z,1726176683.879 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2024-09-12T21:34:22.427Z,1726176862.427 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T21:34:22.428Z,1726176862.428 [NAL9602] Data Fault, FailCount= 2
2024-09-12T21:34:22.428Z,1726176862.428 [NAL9602](ERROR): Data Fault
2024-09-12T21:34:22.480Z,1726176862.480 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T21:34:22.835Z,1726176862.835 [NAL9602](INFO): Powering down
2024-09-12T21:34:23.662Z,1726176863.662 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T21:34:23.662Z,1726176863.662 [NAL9602] No Fault, FailCount= 2
2024-09-12T21:34:24.467Z,1726176864.467 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2024-09-12T21:34:24.468Z,1726176864.468 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:34:24.478Z,1726176864.478 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:34:24.867Z,1726176864.867 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:34:24.867Z,1726176864.867 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2024-09-12T21:34:53.143Z,1726176893.143 [NAL9602](INFO): Powering up NAL9602
2024-09-12T21:35:04.042Z,1726176904.042 [NAL9602](INFO): NAL9602 initialized
2024-09-12T21:35:56.579Z,1726176956.579 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T21:30:56.4Z
2024-09-12T21:35:56.579Z,1726176956.579 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T21:35:56.579Z,1726176956.579 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T21:36:03.808Z,1726176963.808 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0055.lzma
2024-09-12T21:36:04.811Z,1726176964.811 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0055.lzma.bak
2024-09-12T21:36:04.811Z,1726176964.811 [DataOverHttps](INFO): SBD MOMSN=23174076
2024-09-12T21:36:20.920Z,1726176980.920 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240912T182721/Express0056.lzma
2024-09-12T21:36:21.259Z,1726176981.259 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0056.lzma.bak
2024-09-12T21:36:21.259Z,1726176981.259 [DataOverHttps](INFO): SBD MOMSN=23174082
2024-09-12T21:36:23.247Z,1726176983.247 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T21:36:23.247Z,1726176983.247 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T21:36:23.247Z,1726176983.247 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T21:37:25.449Z,1726177045.449 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2024-09-12T21:37:25.449Z,1726177045.449 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:37:25.459Z,1726177045.459 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:37:25.866Z,1726177045.866 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:37:25.866Z,1726177045.866 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2024-09-12T21:40:26.448Z,1726177226.448 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2024-09-12T21:40:26.448Z,1726177226.448 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:40:26.486Z,1726177226.486 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:40:26.890Z,1726177226.890 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:40:26.890Z,1726177226.890 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2024-09-12T21:41:23.817Z,1726177283.817 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T21:41:23.817Z,1726177283.817 [Default:CheckIn:C.Wait] Stopped
2024-09-12T21:41:23.817Z,1726177283.817 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T21:41:23.817Z,1726177283.817 [Default:CheckIn:D] Running Loop=1
2024-09-12T21:41:24.229Z,1726177284.229 [Default:CheckIn:D] Stopped
2024-09-12T21:41:24.229Z,1726177284.229 [Default:CheckIn:E] Running Loop=1
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 189.265039 min
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn:E] Stopped
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn] Stopped
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn](INFO): Running loop #19
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn] Running Loop=19
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T21:41:24.626Z,1726177284.626 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T21:43:27.442Z,1726177407.442 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2024-09-12T21:43:27.442Z,1726177407.442 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:43:27.453Z,1726177407.453 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:43:27.875Z,1726177407.875 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:43:27.875Z,1726177407.875 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2024-09-12T21:45:06.018Z,1726177506.018 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T21:45:06.018Z,1726177506.018 [NAL9602] Data Fault, FailCount= 3
2024-09-12T21:45:06.018Z,1726177506.018 [NAL9602](ERROR): Data Fault
2024-09-12T21:45:06.057Z,1726177506.057 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T21:45:06.423Z,1726177506.423 [NAL9602](INFO): Powering down
2024-09-12T21:45:07.246Z,1726177507.246 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T21:45:07.246Z,1726177507.246 [NAL9602] No Fault, FailCount= 3
2024-09-12T21:45:36.722Z,1726177536.722 [NAL9602](INFO): Powering up NAL9602
2024-09-12T21:45:47.630Z,1726177547.630 [NAL9602](INFO): NAL9602 initialized
2024-09-12T21:46:24.821Z,1726177584.821 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T21:41:24.6Z
2024-09-12T21:46:24.821Z,1726177584.821 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T21:46:24.821Z,1726177584.821 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T21:46:28.444Z,1726177588.444 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2024-09-12T21:46:28.444Z,1726177588.444 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:46:28.493Z,1726177588.493 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:46:28.874Z,1726177588.874 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:46:28.874Z,1726177588.874 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2024-09-12T21:46:32.192Z,1726177592.192 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240912T182721/Courier0058.lzma
2024-09-12T21:46:33.195Z,1726177593.195 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0058.lzma.bak
2024-09-12T21:46:33.195Z,1726177593.195 [DataOverHttps](INFO): SBD MOMSN=23174193
2024-09-12T21:46:48.684Z,1726177608.684 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240912T182721/Express0059.lzma
2024-09-12T21:46:51.221Z,1726177611.221 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0059.lzma.bak
2024-09-12T21:46:51.221Z,1726177611.221 [DataOverHttps](INFO): SBD MOMSN=23174195
2024-09-12T21:46:52.310Z,1726177612.310 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T21:46:52.310Z,1726177612.310 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T21:46:52.310Z,1726177612.310 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T21:49:29.458Z,1726177769.458 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2024-09-12T21:49:29.458Z,1726177769.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:49:29.469Z,1726177769.469 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:49:29.871Z,1726177769.871 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:49:29.871Z,1726177769.871 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2024-09-12T21:50:35.330Z,1726177835.330 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:50:47.451Z,1726177847.451 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:50:59.166Z,1726177859.166 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:51:10.882Z,1726177870.882 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:51:23.003Z,1726177883.003 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:51:34.754Z,1726177894.754 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:51:46.838Z,1726177906.838 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:51:52.932Z,1726177912.932 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T21:51:52.932Z,1726177912.932 [Default:CheckIn:C.Wait] Stopped
2024-09-12T21:51:52.932Z,1726177912.932 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T21:51:52.932Z,1726177912.932 [Default:CheckIn:D] Running Loop=1
2024-09-12T21:51:53.318Z,1726177913.318 [Default:CheckIn:D] Stopped
2024-09-12T21:51:53.318Z,1726177913.318 [Default:CheckIn:E] Running Loop=1
2024-09-12T21:51:53.770Z,1726177913.770 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 199.749854 min
2024-09-12T21:51:53.771Z,1726177913.770 [Default:CheckIn:E] Stopped
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn] Stopped
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn](INFO): Running loop #20
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn] Running Loop=20
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T21:51:53.771Z,1726177913.771 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T21:51:58.565Z,1726177918.565 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:52:30.502Z,1726177950.502 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2024-09-12T21:52:30.502Z,1726177950.502 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:52:30.513Z,1726177950.513 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:52:30.923Z,1726177950.923 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:52:30.923Z,1726177950.923 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2024-09-12T21:54:34.510Z,1726178074.510 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:54:47.831Z,1726178087.831 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:55:01.566Z,1726178101.566 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:55:15.706Z,1726178115.706 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:55:29.442Z,1726178129.442 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:55:31.535Z,1726178131.535 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2024-09-12T21:55:31.535Z,1726178131.535 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:55:31.550Z,1726178131.550 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:55:31.914Z,1726178131.914 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T21:55:31.914Z,1726178131.914 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2024-09-12T21:55:43.584Z,1726178143.584 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:55:49.654Z,1726178149.654 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T21:55:49.654Z,1726178149.654 [NAL9602] Data Fault, FailCount= 4
2024-09-12T21:55:49.654Z,1726178149.654 [NAL9602](ERROR): Data Fault
2024-09-12T21:55:49.672Z,1726178149.672 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T21:55:50.054Z,1726178150.054 [NAL9602](INFO): Powering down
2024-09-12T21:55:50.872Z,1726178150.872 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T21:55:50.872Z,1726178150.872 [NAL9602] No Fault, FailCount= 4
2024-09-12T21:55:57.318Z,1726178157.318 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:56:10.650Z,1726178170.650 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:56:20.351Z,1726178180.351 [NAL9602](INFO): Powering up NAL9602
2024-09-12T21:56:23.984Z,1726178183.984 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:56:31.258Z,1726178191.258 [NAL9602](INFO): NAL9602 initialized
2024-09-12T21:56:37.314Z,1726178197.314 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:56:50.705Z,1726178210.705 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-09-12T21:56:50.710Z,1726178210.710 [BPC1](INFO): Calculating totals. Valid battery stick count: 39. Valid reserve battery stick count: 5.
2024-09-12T21:56:50.712Z,1726178210.712 [BPC1](INFO): Received data from all battery sticks.
2024-09-12T21:56:53.887Z,1726178213.887 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T21:51:53.8Z
2024-09-12T21:56:53.888Z,1726178213.888 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T21:56:53.888Z,1726178213.888 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T21:57:00.868Z,1726178220.868 [DataOverHttps](INFO): Sending 48 bytes from file Logs/20240912T182721/Courier0061.lzma
2024-09-12T21:57:01.871Z,1726178221.871 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0061.lzma.bak
2024-09-12T21:57:01.871Z,1726178221.871 [DataOverHttps](INFO): SBD MOMSN=23174279
2024-09-12T21:57:17.404Z,1726178237.404 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240912T182721/Express0062.lzma
2024-09-12T21:57:18.407Z,1726178238.407 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0062.lzma.bak
2024-09-12T21:57:18.407Z,1726178238.407 [DataOverHttps](INFO): SBD MOMSN=23174281
2024-09-12T21:57:20.179Z,1726178240.179 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T21:57:20.179Z,1726178240.179 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T21:57:20.179Z,1726178240.179 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T21:58:32.469Z,1726178312.469 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2024-09-12T21:58:32.469Z,1726178312.469 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-12T21:58:32.480Z,1726178312.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T21:58:32.480Z,1726178312.480 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-12T22:02:20.724Z,1726178540.724 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T22:02:20.725Z,1726178540.725 [Default:CheckIn:C.Wait] Stopped
2024-09-12T22:02:20.725Z,1726178540.725 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T22:02:20.725Z,1726178540.725 [Default:CheckIn:D] Running Loop=1
2024-09-12T22:02:21.126Z,1726178541.126 [Default:CheckIn:D] Stopped
2024-09-12T22:02:21.127Z,1726178541.127 [Default:CheckIn:E] Running Loop=1
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 210.213330 min
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn:E] Stopped
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn] Stopped
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn](INFO): Running loop #21
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn] Running Loop=21
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T22:02:21.539Z,1726178541.539 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T22:06:33.226Z,1726178793.226 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-12T22:06:33.226Z,1726178793.226 [NAL9602] Data Fault, FailCount= 5
2024-09-12T22:06:33.226Z,1726178793.226 [NAL9602](ERROR): Data Fault
2024-09-12T22:06:33.274Z,1726178793.274 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-12T22:06:33.274Z,1726178793.274 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-09-12T22:06:33.626Z,1726178793.626 [NAL9602](INFO): Powering down
2024-09-12T22:06:33.641Z,1726178793.641 [CBIT](INFO): Critical error at 20240912T220633
2024-09-12T22:07:21.716Z,1726178841.716 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-12T22:02:21.5Z
2024-09-12T22:07:21.717Z,1726178841.717 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T22:07:21.717Z,1726178841.717 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-12T22:07:28.776Z,1726178848.776 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20240912T182721/Courier0064.lzma
2024-09-12T22:07:29.779Z,1726178849.779 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Courier0064.lzma.bak
2024-09-12T22:07:29.779Z,1726178849.779 [DataOverHttps](INFO): SBD MOMSN=23174370
2024-09-12T22:07:45.520Z,1726178865.520 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20240912T182721/Express0065.lzma
2024-09-12T22:07:46.523Z,1726178866.523 [DataOverHttps](INFO): Moved sent file to Logs/20240912T182721/Express0065.lzma.bak
2024-09-12T22:07:46.523Z,1726178866.523 [DataOverHttps](INFO): SBD MOMSN=23174373
2024-09-12T22:07:48.381Z,1726178868.381 [Default:CheckIn:Read_Iridium] Stopped
2024-09-12T22:07:48.381Z,1726178868.381 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-12T22:07:48.381Z,1726178868.381 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-12T22:08:33.638Z,1726178913.638 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-12T22:08:33.638Z,1726178913.638 [NAL9602] No Fault, FailCount= 5
2024-09-12T22:08:34.018Z,1726178914.018 [NAL9602](INFO): Powering up NAL9602
2024-09-12T22:08:44.930Z,1726178924.930 [NAL9602](INFO): NAL9602 initialized
2024-09-12T22:12:48.977Z,1726179168.977 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-12T22:12:48.977Z,1726179168.977 [Default:CheckIn:C.Wait] Stopped
2024-09-12T22:12:48.977Z,1726179168.977 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-12T22:12:48.977Z,1726179168.977 [Default:CheckIn:D] Running Loop=1
2024-09-12T22:12:49.381Z,1726179169.381 [Default:CheckIn:D] Stopped
2024-09-12T22:12:49.381Z,1726179169.381 [Default:CheckIn:E] Running Loop=1
2024-09-12T22:12:49.810Z,1726179169.810 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 220.684245 min
2024-09-12T22:12:49.810Z,1726179169.810 [Default:CheckIn:E] Stopped
2024-09-12T22:12:49.810Z,1726179169.810 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-12T22:12:49.811Z,1726179169.811 [Default:CheckIn] Stopped
2024-09-12T22:12:49.811Z,1726179169.811 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T22:12:49.811Z,1726179169.811 [Default:CheckIn](INFO): Running loop #22
2024-09-12T22:12:49.811Z,1726179169.811 [Default:CheckIn] Running Loop=22
2024-09-12T22:12:49.811Z,1726179169.811 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-12T22:12:49.811Z,1726179169.811 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-12T22:13:32.629Z,1726179212.629 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-12T22:13:32.629Z,1726179212.629 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2024-09-12T22:15:30.006Z,1726179330.006 [CommandExec](IMPORTANT): got command restart system
2024-09-12T22:15:32.065Z,1726179332.065 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:32.065Z,1726179332.065 [CommandExec](INFO): Uninitializing the command executive.
2024-09-12T22:15:32.065Z,1726179332.065 [CommandExec](INFO): Uninitializing the command scheduler.
2024-09-12T22:15:32.066Z,1726179332.066 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:32.177Z,1726179332.177 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-09-12T22:15:32.177Z,1726179332.177 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-09-12T22:15:32.177Z,1726179332.177 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:32.178Z,1726179332.178 [NavChartDb](INFO): Join timeout helper Thread ID is 4632
2024-09-12T22:15:32.301Z,1726179332.301 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:32.301Z,1726179332.301 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:32.321Z,1726179332.321 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-09-12T22:15:32.321Z,1726179332.321 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:32.321Z,1726179332.321 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4633
2024-09-12T22:15:32.577Z,1726179332.577 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:32.577Z,1726179332.577 [WetLabsBB2FL](INFO): Powering down
2024-09-12T22:15:32.578Z,1726179332.578 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:32.585Z,1726179332.585 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-09-12T22:15:32.585Z,1726179332.585 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:32.585Z,1726179332.585 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4634
2024-09-12T22:15:33.117Z,1726179333.117 [CTD_Seabird](INFO): Powering down
2024-09-12T22:15:33.129Z,1726179333.129 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:33.129Z,1726179333.129 [CTD_Seabird](INFO): Powering down
2024-09-12T22:15:33.141Z,1726179333.141 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:33.157Z,1726179333.157 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-09-12T22:15:33.157Z,1726179333.157 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:33.157Z,1726179333.157 [Radio_Surface](INFO): Join timeout helper Thread ID is 4635
2024-09-12T22:15:33.517Z,1726179333.517 [Radio_Surface](INFO): Powering down
2024-09-12T22:15:33.518Z,1726179333.518 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:33.518Z,1726179333.518 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:33.521Z,1726179333.521 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-09-12T22:15:33.521Z,1726179333.521 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:33.521Z,1726179333.521 [Onboard](INFO): Join timeout helper Thread ID is 4636
2024-09-12T22:15:34.101Z,1726179334.101 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-09-12T22:15:34.869Z,1726179334.869 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:34.869Z,1726179334.869 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:34.890Z,1726179334.890 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-09-12T22:15:34.890Z,1726179334.890 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:34.890Z,1726179334.890 [DataOverHttps](INFO): Join timeout helper Thread ID is 4637
2024-09-12T22:15:35.105Z,1726179335.105 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:35.105Z,1726179335.105 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.117Z,1726179335.117 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler
2024-09-12T22:15:35.118Z,1726179335.118 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.118Z,1726179335.118 [DATMMP](INFO): Join timeout helper Thread ID is 4638
2024-09-12T22:15:35.153Z,1726179335.153 [DATMMP](INFO): Stop
2024-09-12T22:15:35.153Z,1726179335.153 [DATMMP](INFO): uninitialize
2024-09-12T22:15:35.153Z,1726179335.153 [DATMMP](INFO): Powering down
2024-09-12T22:15:35.227Z,1726179335.227 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:35.228Z,1726179335.228 [DATMMP](INFO): uninitialize
2024-09-12T22:15:35.228Z,1726179335.228 [DATMMP](INFO): Powering down
2024-09-12T22:15:35.229Z,1726179335.229 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.249Z,1726179335.249 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-09-12T22:15:35.250Z,1726179335.250 [logger ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.250Z,1726179335.250 [logger](INFO): Join timeout helper Thread ID is 4639
2024-09-12T22:15:35.257Z,1726179335.257 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:35.257Z,1726179335.257 [logger ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.270Z,1726179335.270 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-09-12T22:15:35.270Z,1726179335.270 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.270Z,1726179335.270 [CommandLine](INFO): Join timeout helper Thread ID is 4640
2024-09-12T22:15:35.333Z,1726179335.333 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:35.333Z,1726179335.333 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.349Z,1726179335.349 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-09-12T22:15:35.350Z,1726179335.350 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.350Z,1726179335.350 [CommandExec](INFO): Join timeout helper Thread ID is 4641
2024-09-12T22:15:35.351Z,1726179335.351 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-09-12T22:15:35.351Z,1726179335.351 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.352Z,1726179335.352 [controlThread](INFO): Join timeout helper Thread ID is 4642
2024-09-12T22:15:35.401Z,1726179335.401 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-09-12T22:15:35.401Z,1726179335.401 [controlThread](DEBUG): Uninitializing ControlThread
2024-09-12T22:15:35.402Z,1726179335.402 [AHRS_M2](INFO): Powering down
2024-09-12T22:15:35.474Z,1726179335.474 [NAL9602](INFO): Powering down
2024-09-12T22:15:35.476Z,1726179335.476 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-09-12T22:15:35.477Z,1726179335.477 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-09-12T22:15:35.478Z,1726179335.478 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-09-12T22:15:35.478Z,1726179335.478 [MissionManager](INFO): Uninitializing Mission Default
2024-09-12T22:15:35.478Z,1726179335.478 [Default] Stopped
2024-09-12T22:15:35.478Z,1726179335.478 [Default](DEBUG): Aggregate::uninitialize Default
2024-09-12T22:15:35.478Z,1726179335.478 [Default:B.GoToSurface] Stopped
2024-09-12T22:15:35.479Z,1726179335.479 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-09-12T22:15:35.479Z,1726179335.479 [Default:CheckIn] Stopped
2024-09-12T22:15:35.479Z,1726179335.479 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-12T22:15:35.479Z,1726179335.479 [Default:CheckIn:Read_GPS] Stopped
2024-09-12T22:15:35.482Z,1726179335.482 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-09-12T22:15:35.482Z,1726179335.482 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-09-12T22:15:35.483Z,1726179335.483 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-09-12T22:15:35.483Z,1726179335.483 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-09-12T22:15:35.483Z,1726179335.483 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-09-12T22:15:35.483Z,1726179335.483 [BuoyancyServo](INFO): Powering down
2024-09-12T22:15:35.497Z,1726179335.497 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-09-12T22:15:35.497Z,1726179335.497 [ElevatorServo](INFO): Powering down
2024-09-12T22:15:35.498Z,1726179335.498 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-09-12T22:15:35.498Z,1726179335.498 [MassServo](INFO): Powering down
2024-09-12T22:15:35.499Z,1726179335.499 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-09-12T22:15:35.499Z,1726179335.499 [RudderServo](INFO): Powering down
2024-09-12T22:15:35.500Z,1726179335.500 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-09-12T22:15:35.500Z,1726179335.500 [ThrusterHE](INFO): Powering down
2024-09-12T22:15:35.501Z,1726179335.501 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-09-12T22:15:35.501Z,1726179335.501 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-09-12T22:15:35.502Z,1726179335.502 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-09-12T22:15:35.502Z,1726179335.502 [CBIT](DEBUG): Powering off loads.
2024-09-12T22:15:35.513Z,1726179335.513 [CBIT](DEBUG): Disabling WDT.
2024-09-12T22:15:35.525Z,1726179335.525 [CBIT](DEBUG): Opening all GF detection circuits.
2024-09-12T22:15:35.525Z,1726179335.525 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.571Z,1726179335.571 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.574Z,1726179335.574 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.580Z,1726179335.580 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.587Z,1726179335.587 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.664Z,1726179335.664 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.669Z,1726179335.669 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.714Z,1726179335.714 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-09-12T22:15:35.779Z,1726179335.779 [logger ThreadHandler](INFO): Thread cancelled.