2025-02-13T22:32:37.021Z,1739485957.021 [Supervisor](DEBUG): Initializing supervisor.
2025-02-13T22:32:37.025Z,1739485957.025 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-02-13T22:32:37.026Z,1739485957.026 [SyncHandler](INFO): Protected caller Thread ID is 5398
2025-02-13T22:32:37.026Z,1739485957.026 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-02-13T22:32:37.027Z,1739485957.027 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-02-13T22:32:37.027Z,1739485957.027 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5399
2025-02-13T22:32:37.031Z,1739485957.031 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-02-13T22:32:37.048Z,1739485957.048 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-02-13T22:32:37.049Z,1739485957.049 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-02-13T22:32:37.050Z,1739485957.050 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5400
2025-02-13T22:32:37.054Z,1739485957.054 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-02-13T22:32:37.055Z,1739485957.055 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-02-13T22:32:37.055Z,1739485957.055 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5401
2025-02-13T22:32:37.057Z,1739485957.057 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-02-13T22:32:37.058Z,1739485957.058 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-02-13T22:32:37.058Z,1739485957.058 [logger ThreadHandler](INFO): Protected caller Thread ID is 5402
2025-02-13T22:32:37.062Z,1739485957.062 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-02-13T22:32:37.062Z,1739485957.062 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-02-13T22:32:37.064Z,1739485957.064 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-02-13T22:32:37.299Z,1739485957.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-02-13T22:32:37.300Z,1739485957.300 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-02-13T22:32:37.515Z,1739485957.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-02-13T22:32:37.516Z,1739485957.516 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-02-13T22:32:37.621Z,1739485957.621 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-02-13T22:32:37.622Z,1739485957.622 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-02-13T22:32:37.811Z,1739485957.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-02-13T22:32:37.811Z,1739485957.811 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-02-13T22:32:38.390Z,1739485958.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-02-13T22:32:38.391Z,1739485958.391 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-02-13T22:32:38.508Z,1739485958.508 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-02-13T22:32:38.509Z,1739485958.509 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-02-13T22:32:38.784Z,1739485958.784 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-02-13T22:32:38.784Z,1739485958.784 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-02-13T22:32:39.001Z,1739485959.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-02-13T22:32:39.002Z,1739485959.002 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-02-13T22:32:39.532Z,1739485959.532 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-02-13T22:32:39.533Z,1739485959.533 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-02-13T22:32:39.948Z,1739485959.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-02-13T22:32:39.949Z,1739485959.949 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-02-13T22:32:40.039Z,1739485960.039 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-02-13T22:32:40.431Z,1739485960.431 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-02-13T22:32:40.431Z,1739485960.431 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-02-13T22:32:40.615Z,1739485960.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-02-13T22:32:40.615Z,1739485960.615 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-02-13T22:32:41.455Z,1739485961.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-02-13T22:32:41.455Z,1739485961.455 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-02-13T22:32:41.810Z,1739485961.810 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-02-13T22:32:41.811Z,1739485961.811 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-02-13T22:32:41.904Z,1739485961.904 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/
2025-02-13T22:32:41.905Z,1739485961.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg
2025-02-13T22:32:41.999Z,1739485961.999 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg
2025-02-13T22:32:42.114Z,1739485962.114 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg
2025-02-13T22:32:42.228Z,1739485962.228 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg
2025-02-13T22:32:42.326Z,1739485962.326 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg
2025-02-13T22:32:42.421Z,1739485962.421 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg
2025-02-13T22:32:42.534Z,1739485962.534 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg
2025-02-13T22:32:42.697Z,1739485962.697 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg
2025-02-13T22:32:42.871Z,1739485962.871 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg
2025-02-13T22:32:42.976Z,1739485962.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg
2025-02-13T22:32:43.248Z,1739485963.248 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-02-13T22:32:43.250Z,1739485963.250 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/
2025-02-13T22:32:43.250Z,1739485963.250 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-02-13T22:32:43.262Z,1739485963.262 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-02-13T22:32:43.618Z,1739485963.618 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-02-13T22:32:43.618Z,1739485963.618 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-02-13T22:32:44.070Z,1739485964.070 [AHRS_M2] Loaded
2025-02-13T22:32:44.070Z,1739485964.070 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-02-13T22:32:44.109Z,1739485964.109 [BackseatComponent] Loaded
2025-02-13T22:32:44.109Z,1739485964.109 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-02-13T22:32:44.110Z,1739485964.110 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408AB4E0
2025-02-13T22:32:44.111Z,1739485964.111 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5482
2025-02-13T22:32:44.114Z,1739485964.114 [LcmUniversalReporter] Loaded
2025-02-13T22:32:44.114Z,1739485964.114 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-02-13T22:32:44.120Z,1739485964.120 [BioacousticsDataBridge] Loaded
2025-02-13T22:32:44.120Z,1739485964.120 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2025-02-13T22:32:44.992Z,1739485964.992 [BPC1] Loaded
2025-02-13T22:32:44.992Z,1739485964.992 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-02-13T22:32:45.068Z,1739485965.068 [DataOverHttps] Loaded
2025-02-13T22:32:45.068Z,1739485965.068 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-02-13T22:32:45.069Z,1739485965.069 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408DB4E0
2025-02-13T22:32:45.070Z,1739485965.070 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5483
2025-02-13T22:32:45.092Z,1739485965.092 [Depth_Keller] Loaded
2025-02-13T22:32:45.092Z,1739485965.092 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-02-13T22:32:45.097Z,1739485965.097 [DropWeight] Loaded
2025-02-13T22:32:45.097Z,1739485965.097 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-02-13T22:32:45.161Z,1739485965.161 [NAL9602] Loaded
2025-02-13T22:32:45.161Z,1739485965.161 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-02-13T22:32:45.189Z,1739485965.189 [Onboard] Loaded
2025-02-13T22:32:45.190Z,1739485965.190 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-02-13T22:32:45.191Z,1739485965.191 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0
2025-02-13T22:32:45.191Z,1739485965.191 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5484
2025-02-13T22:32:45.205Z,1739485965.205 [Power24vConverter] Loaded
2025-02-13T22:32:45.205Z,1739485965.205 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-02-13T22:32:45.222Z,1739485965.222 [Radio_Surface] Loaded
2025-02-13T22:32:45.223Z,1739485965.223 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-02-13T22:32:45.224Z,1739485965.224 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0
2025-02-13T22:32:45.224Z,1739485965.224 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5485
2025-02-13T22:32:45.239Z,1739485965.239 [Sonardyne_Nano] Loaded
2025-02-13T22:32:45.239Z,1739485965.239 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-02-13T22:32:45.240Z,1739485965.240 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-02-13T22:32:45.240Z,1739485965.240 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-02-13T22:32:45.442Z,1739485965.442 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-02-13T22:32:45.443Z,1739485965.443 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-02-13T22:32:45.494Z,1739485965.494 [VerticalControl](DEBUG): Construct VerticalControl.
2025-02-13T22:32:45.551Z,1739485965.551 [VerticalControl] Loaded
2025-02-13T22:32:45.551Z,1739485965.551 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-02-13T22:32:45.554Z,1739485965.554 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-02-13T22:32:45.601Z,1739485965.601 [HorizontalControl] Loaded
2025-02-13T22:32:45.601Z,1739485965.601 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-02-13T22:32:45.603Z,1739485965.603 [SpeedControl](DEBUG): Construct SpeedControl.
2025-02-13T22:32:45.606Z,1739485965.606 [SpeedControl] Loaded
2025-02-13T22:32:45.607Z,1739485965.607 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-02-13T22:32:45.609Z,1739485965.609 [LoopControl](DEBUG): Construct LoopControl.
2025-02-13T22:32:45.610Z,1739485965.610 [LoopControl] Loaded
2025-02-13T22:32:45.610Z,1739485965.610 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-02-13T22:32:45.610Z,1739485965.610 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-02-13T22:32:45.611Z,1739485965.611 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-02-13T22:32:45.621Z,1739485965.621 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-02-13T22:32:45.622Z,1739485965.622 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-02-13T22:32:45.648Z,1739485965.648 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-02-13T22:32:45.648Z,1739485965.648 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-02-13T22:32:45.757Z,1739485965.757 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-02-13T22:32:45.758Z,1739485965.758 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-02-13T22:32:45.771Z,1739485965.771 [NavChart] Loaded
2025-02-13T22:32:45.771Z,1739485965.771 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-02-13T22:32:45.777Z,1739485965.777 [UniversalFixResidualReporter] Loaded
2025-02-13T22:32:45.777Z,1739485965.777 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-02-13T22:32:45.777Z,1739485965.777 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-02-13T22:32:45.778Z,1739485965.778 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-02-13T22:32:45.919Z,1739485965.919 [SBIT](DEBUG): Construct Startup Built In Test.
2025-02-13T22:32:45.928Z,1739485965.928 [SBIT] Loaded
2025-02-13T22:32:45.928Z,1739485965.928 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-02-13T22:32:45.931Z,1739485965.931 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-02-13T22:32:45.943Z,1739485965.943 [IBIT] Loaded
2025-02-13T22:32:45.943Z,1739485965.943 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-02-13T22:32:45.949Z,1739485965.949 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-02-13T22:32:46.050Z,1739485966.050 [CBIT] Loaded
2025-02-13T22:32:46.051Z,1739485966.051 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-02-13T22:32:46.051Z,1739485966.051 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-02-13T22:32:46.052Z,1739485966.052 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-02-13T22:32:46.221Z,1739485966.221 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-02-13T22:32:46.222Z,1739485966.222 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-02-13T22:32:46.370Z,1739485966.370 [BuoyancyServo] Loaded
2025-02-13T22:32:46.370Z,1739485966.370 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-02-13T22:32:46.391Z,1739485966.391 [ElevatorServo] Loaded
2025-02-13T22:32:46.391Z,1739485966.391 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-02-13T22:32:46.412Z,1739485966.412 [MassServo] Loaded
2025-02-13T22:32:46.412Z,1739485966.412 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-02-13T22:32:46.434Z,1739485966.434 [RudderServo] Loaded
2025-02-13T22:32:46.434Z,1739485966.434 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-02-13T22:32:46.450Z,1739485966.450 [ThrusterHE] Loaded
2025-02-13T22:32:46.451Z,1739485966.451 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-02-13T22:32:46.451Z,1739485966.451 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-02-13T22:32:46.451Z,1739485966.451 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-02-13T22:32:46.624Z,1739485966.624 [CTD_Seabird] Loaded
2025-02-13T22:32:46.625Z,1739485966.625 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-02-13T22:32:46.626Z,1739485966.626 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B6C4E0
2025-02-13T22:32:46.626Z,1739485966.626 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5486
2025-02-13T22:32:46.648Z,1739485966.648 [PAR_Licor] Loaded
2025-02-13T22:32:46.649Z,1739485966.649 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-02-13T22:32:46.693Z,1739485966.693 [WetLabsBB2FL] Loaded
2025-02-13T22:32:46.693Z,1739485966.693 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-02-13T22:32:46.694Z,1739485966.694 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B9C4E0
2025-02-13T22:32:46.694Z,1739485966.694 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5487
2025-02-13T22:32:46.695Z,1739485966.695 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-02-13T22:32:46.695Z,1739485966.695 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-02-13T22:32:46.745Z,1739485966.745 [DepthRateCalculator] Loaded
2025-02-13T22:32:46.746Z,1739485966.746 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-02-13T22:32:46.750Z,1739485966.750 [PitchRateCalculator] Loaded
2025-02-13T22:32:46.751Z,1739485966.751 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-02-13T22:32:46.759Z,1739485966.759 [SpeedCalculator] Loaded
2025-02-13T22:32:46.760Z,1739485966.760 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-02-13T22:32:46.764Z,1739485966.764 [YawRateCalculator] Loaded
2025-02-13T22:32:46.764Z,1739485966.764 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-02-13T22:32:46.783Z,1739485966.783 [ElevatorOffsetCalculator] Loaded
2025-02-13T22:32:46.783Z,1739485966.783 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-02-13T22:32:46.784Z,1739485966.784 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-02-13T22:32:46.784Z,1739485966.784 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-02-13T22:32:46.843Z,1739485966.843 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-02-13T22:32:46.849Z,1739485966.849 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-02-13T22:32:46.852Z,1739485966.852 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-02-13T22:32:46.863Z,1739485966.863 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-02-13T22:32:46.865Z,1739485966.865 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C294E0
2025-02-13T22:32:46.865Z,1739485966.865 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5488
2025-02-13T22:32:46.869Z,1739485966.869 [Supervisor](INFO): Main Thread ID is 5397
2025-02-13T22:32:46.869Z,1739485966.869 [Supervisor](DEBUG): Running supervisor.
2025-02-13T22:32:46.870Z,1739485966.870 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5489
2025-02-13T22:32:46.871Z,1739485966.871 [CommandExec](INFO): Initializing the command executive.
2025-02-13T22:32:46.872Z,1739485966.872 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5490
2025-02-13T22:32:46.874Z,1739485966.874 [controlThread ThreadHandler](INFO): Handler Thread ID is 5491
2025-02-13T22:32:46.875Z,1739485966.875 [controlThread](DEBUG): Initializing ControlThread
2025-02-13T22:32:46.882Z,1739485966.882 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-02-13T22:32:46.884Z,1739485966.884 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-02-13T22:32:46.884Z,1739485966.884 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-02-13T22:32:46.885Z,1739485966.885 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-02-13T22:32:46.886Z,1739485966.886 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-02-13T22:32:46.886Z,1739485966.886 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-02-13T22:32:46.886Z,1739485966.886 [SBIT](INFO): Initialize SBIT Component.
2025-02-13T22:32:46.887Z,1739485966.887 [SBIT](IMPORTANT): git: 2025-02-05-1-g5cb57f0c0
2025-02-13T22:32:46.887Z,1739485966.887 [SBIT](INFO): git hash: 5cb57f0c0fd82defa895bec40183b0f814ee32ad
2025-02-13T22:32:46.887Z,1739485966.887 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-02-13T22:32:46.889Z,1739485966.889 [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 Dec 4 01:17:04 UTC 2024
2025-02-13T22:32:46.890Z,1739485966.890 [SBIT](INFO): Beginning SBIT in 60.000000 seconds.
2025-02-13T22:32:46.890Z,1739485966.890 [IBIT](INFO): Initialize IBIT Component.
2025-02-13T22:32:46.891Z,1739485966.891 [CBIT](DEBUG): Initialize CBIT Component.
2025-02-13T22:32:46.892Z,1739485966.892 [logger ThreadHandler](INFO): Handler Thread ID is 5492
2025-02-13T22:32:46.905Z,1739485966.905 [CBIT](DEBUG): Initialized mux pins.
2025-02-13T22:32:46.905Z,1739485966.905 [CBIT](DEBUG): Initializing the watchdog timer.
2025-02-13T22:32:46.914Z,1739485966.914 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5493
2025-02-13T22:32:46.925Z,1739485966.925 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5494
2025-02-13T22:32:46.926Z,1739485966.926 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-02-13T22:32:46.928Z,1739485966.928 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-02-13T22:32:46.929Z,1739485966.929 [CBIT](DEBUG): Initializing heartbeat.
2025-02-13T22:32:46.937Z,1739485966.937 [Onboard ThreadHandler](INFO): Handler Thread ID is 5495
2025-02-13T22:32:46.954Z,1739485966.954 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5496
2025-02-13T22:32:46.973Z,1739485966.973 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5497
2025-02-13T22:32:46.974Z,1739485966.974 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-02-13T22:32:46.978Z,1739485966.978 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5499
2025-02-13T22:32:46.981Z,1739485966.981 [WetLabsBB2FL](INFO): Powering up
2025-02-13T22:32:46.982Z,1739485966.982 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5501
2025-02-13T22:32:46.984Z,1739485966.984 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-02-13T22:32:46.985Z,1739485966.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-02-13T22:32:46.985Z,1739485966.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-02-13T22:32:46.985Z,1739485966.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-02-13T22:32:46.985Z,1739485966.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-02-13T22:32:46.985Z,1739485966.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-02-13T22:32:46.985Z,1739485966.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-02-13T22:32:46.985Z,1739485966.986 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-02-13T22:32:47.000Z,1739485967.000 [CBIT](DEBUG): Deactivating GF circuits.
2025-02-13T22:32:47.000Z,1739485967.000 [CBIT](DEBUG): Deactivating emergency mode.
2025-02-13T22:32:47.040Z,1739485967.040 [CBIT](DEBUG): Backplane powered.
2025-02-13T22:32:47.045Z,1739485967.045 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-02-13T22:32:47.045Z,1739485967.045 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-02-13T22:32:47.045Z,1739485967.045 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-02-13T22:32:47.046Z,1739485967.046 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-02-13T22:32:47.046Z,1739485967.046 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-02-13T22:32:47.047Z,1739485967.047 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-02-13T22:32:47.048Z,1739485967.048 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-02-13T22:32:47.048Z,1739485967.048 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-02-13T22:32:47.049Z,1739485967.049 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-02-13T22:32:47.126Z,1739485967.126 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-02-13T22:32:47.131Z,1739485967.131 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-13T22:32:47.181Z,1739485967.181 [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
}
}
}
2025-02-13T22:32:47.182Z,1739485967.182 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-02-13T22:32:47.182Z,1739485967.182 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-02-13T22:32:47.183Z,1739485967.183 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-02-13T22:32:47.360Z,1739485967.360 [Radio_Surface](INFO): Powering up
2025-02-13T22:32:47.513Z,1739485967.513 [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
2025-02-13T22:32:47.530Z,1739485967.530 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-02-13T22:32:47.531Z,1739485967.531 [Default:A.Wait](DEBUG): Construct Wait.
2025-02-13T22:32:47.533Z,1739485967.533 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-13T22:32:47.571Z,1739485967.571 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-02-13T22:32:47.590Z,1739485967.590 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-02-13T22:32:47.612Z,1739485967.612 [Default:E.Execute](DEBUG): Construct Execute.
2025-02-13T22:32:47.615Z,1739485967.615 [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"
}
}
2025-02-13T22:32:47.620Z,1739485967.620 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2025-02-13T22:32:47.634Z,1739485967.634 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-02-13T22:32:47.699Z,1739485967.699 [Power24vConverter](INFO): Powering up.
2025-02-13T22:32:47.699Z,1739485967.699 [Sonardyne_Nano](INFO): Initializing.
2025-02-13T22:32:47.754Z,1739485967.754 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:32:47.760Z,1739485967.760 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-02-13T22:32:47.761Z,1739485967.761 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:32:47.768Z,1739485967.768 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:32:47.769Z,1739485967.769 [MassServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:32:47.776Z,1739485967.776 [MassServo](DEBUG): Initializing MassServo.
2025-02-13T22:32:47.777Z,1739485967.777 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:32:47.784Z,1739485967.784 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:32:47.785Z,1739485967.785 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-13T22:32:47.792Z,1739485967.792 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-13T22:32:48.073Z,1739485968.073 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-02-13T22:32:48.073Z,1739485968.073 [DropWeight] Hardware Fault, FailCount= 1
2025-02-13T22:32:48.074Z,1739485968.074 [DropWeight](ERROR): Hardware Fault
2025-02-13T22:32:48.099Z,1739485968.099 [CommandExec](FAULT): Scheduling is paused
2025-02-13T22:32:48.099Z,1739485968.099 [CBIT](INFO): Critical error at 20250213T223248
2025-02-13T22:32:48.099Z,1739485968.099 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-02-13T22:32:48.110Z,1739485968.110 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-02-13T22:32:48.110Z,1739485968.110 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-02-13T22:32:48.478Z,1739485968.478 [CBIT](INFO): Critical error at 20250213T223248
2025-02-13T22:32:49.088Z,1739485969.088 [WetLabsBB2FL](INFO): Powering down
2025-02-13T22:32:49.650Z,1739485969.650 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-02-13T22:32:50.936Z,1739485970.936 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409
2025-02-13T22:32:53.012Z,1739485973.012 [RudderServo](FAULT): Overload Error
2025-02-13T22:32:53.013Z,1739485973.013 [RudderServo] Hardware Fault, FailCount= 1
2025-02-13T22:32:53.013Z,1739485973.013 [RudderServo](ERROR): Hardware Fault
2025-02-13T22:32:53.136Z,1739485973.136 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T22:32:53.389Z,1739485973.389 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T22:32:53.389Z,1739485973.389 [RudderServo](INFO): Powering down
2025-02-13T22:32:54.205Z,1739485974.205 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:32:54.325Z,1739485974.325 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:32:54.329Z,1739485974.329 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T22:32:54.329Z,1739485974.329 [RudderServo] No Fault, FailCount= 1
2025-02-13T22:32:59.468Z,1739485979.468 [RudderServo](FAULT): Overload Error
2025-02-13T22:32:59.469Z,1739485979.469 [RudderServo] Hardware Fault, FailCount= 2
2025-02-13T22:32:59.469Z,1739485979.469 [RudderServo](ERROR): Hardware Fault
2025-02-13T22:32:59.581Z,1739485979.581 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T22:32:59.853Z,1739485979.853 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T22:32:59.853Z,1739485979.853 [RudderServo](INFO): Powering down
2025-02-13T22:33:00.665Z,1739485980.665 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:33:00.785Z,1739485980.785 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:33:00.789Z,1739485980.789 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T22:33:00.789Z,1739485980.789 [RudderServo] No Fault, FailCount= 2
2025-02-13T22:33:01.227Z,1739485981.227 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004781
2025-02-13T22:33:05.965Z,1739485985.965 [RudderServo](FAULT): Overload Error
2025-02-13T22:33:05.965Z,1739485985.965 [RudderServo] Hardware Fault, FailCount= 3
2025-02-13T22:33:05.965Z,1739485985.965 [RudderServo](ERROR): Hardware Fault
2025-02-13T22:33:06.077Z,1739485986.077 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T22:33:06.077Z,1739485986.077 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-13T22:33:06.305Z,1739485986.305 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T22:33:06.305Z,1739485986.305 [RudderServo](INFO): Powering down
2025-02-13T22:33:06.307Z,1739485986.307 [CBIT](INFO): Critical error at 20250213T223306
2025-02-13T22:33:07.125Z,1739485987.125 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:33:07.246Z,1739485987.246 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:33:15.510Z,1739485995.510 [NAL9602](INFO): Powering up NAL9602
2025-02-13T22:33:26.418Z,1739486006.418 [NAL9602](INFO): NAL9602 initialized
2025-02-13T22:33:47.586Z,1739486027.586 [SBIT](IMPORTANT): Beginning Startup BIT
2025-02-13T22:33:47.590Z,1739486027.590 [CBIT](IMPORTANT): Beginning ground fault scan
2025-02-13T22:33:49.492Z,1739486029.492 [ElevatorServo](FAULT): Overload Error
2025-02-13T22:33:49.492Z,1739486029.492 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-13T22:33:49.492Z,1739486029.492 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T22:33:49.633Z,1739486029.633 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T22:33:49.870Z,1739486029.870 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T22:33:49.870Z,1739486029.870 [ElevatorServo](INFO): Powering down
2025-02-13T22:33:50.705Z,1739486030.705 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:33:50.826Z,1739486030.826 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:33:50.860Z,1739486030.860 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T22:33:50.860Z,1739486030.860 [ElevatorServo] No Fault, FailCount= 1
2025-02-13T22:33:54.290Z,1739486034.290 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:33:55.708Z,1739486035.708 [ElevatorServo](FAULT): Overload Error
2025-02-13T22:33:55.708Z,1739486035.708 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-13T22:33:55.708Z,1739486035.708 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T22:33:55.746Z,1739486035.746 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T22:33:55.957Z,1739486035.957 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T22:33:55.957Z,1739486035.957 [ElevatorServo](INFO): Powering down
2025-02-13T22:33:56.750Z,1739486036.750 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:33:56.869Z,1739486036.869 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:33:56.901Z,1739486036.901 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T22:33:56.901Z,1739486036.901 [ElevatorServo] No Fault, FailCount= 2
2025-02-13T22:33:58.484Z,1739486038.484 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000891
CHAN A1 (24V): -0.001355
CHAN A2 (12V): 0.000286
CHAN A3 (5V): -0.001880
CHAN B0 (3.3V): -0.001019
CHAN B1 (3.15aV): -0.001008
CHAN B2 (3.15bV): -0.001038
CHAN B3 (GND): -0.002173
OPEN: 0.005002
Full Scale: +/- 1 mA
2025-02-13T22:34:00.642Z,1739486040.642 [SBIT](ERROR): Could not read rudderAngleReader_.
2025-02-13T22:34:01.744Z,1739486041.744 [ElevatorServo](FAULT): Overload Error
2025-02-13T22:34:01.744Z,1739486041.744 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-13T22:34:01.744Z,1739486041.744 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T22:34:01.777Z,1739486041.777 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T22:34:01.778Z,1739486041.778 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-13T22:34:01.997Z,1739486041.997 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T22:34:01.997Z,1739486041.997 [ElevatorServo](INFO): Powering down
2025-02-13T22:34:02.087Z,1739486042.087 [CBIT](INFO): Critical error at 20250213T223401
2025-02-13T22:34:02.793Z,1739486042.793 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:34:02.909Z,1739486042.909 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:34:06.813Z,1739486046.813 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:34:20.145Z,1739486060.145 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:34:27.206Z,1739486067.206 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-02-13T22:34:27.206Z,1739486067.206 [SBIT](ERROR): Could not read rudderAngleReader_.
2025-02-13T22:34:27.206Z,1739486067.206 [SBIT](FAULT): Control surface position failure.
2025-02-13T22:34:32.265Z,1739486072.265 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:34:40.902Z,1739486080.902 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-02-13T22:34:40.902Z,1739486080.902 [SBIT](ERROR): Could not read rudderAngleReader_.
2025-02-13T22:34:40.902Z,1739486080.902 [SBIT](FAULT): Control surface position failure.
2025-02-13T22:34:41.309Z,1739486081.309 [SBIT](CRITICAL): SBIT FAILED
2025-02-13T22:34:41.310Z,1739486081.310 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-02-13T22:34:41.310Z,1739486081.310 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2025-02-13T22:34:41.310Z,1739486081.310 [SBIT](IMPORTANT): DATMMP.loadAtStartup=0 bool;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): Express none platform_roll_angle;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-0.5 ampere_hour;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.925 meter_per_second;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=345.701638 cubic_centimeter;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): VerticalControl.kdPitchMass=0.1 second;
2025-02-13T22:34:41.311Z,1739486081.311 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=0.001 reciprocal_second;
2025-02-13T22:34:41.312Z,1739486081.312 [SBIT](IMPORTANT): VerticalControl.kpPitchMass=0.1 none;
2025-02-13T22:34:41.312Z,1739486081.312 [SBIT](IMPORTANT): VerticalControl.massDeadband=0 millimeter;
2025-02-13T22:34:41.312Z,1739486081.312 [SBIT](IMPORTANT): VerticalControl.massDefault=10.247203 millimeter;
2025-02-13T22:34:41.312Z,1739486081.312 [SBIT](IMPORTANT): VerticalControl.massOnlyForceInt=1 bool;
2025-02-13T22:34:41.314Z,1739486081.314 [CBIT](INFO): Critical error at 20250213T223441
2025-02-13T22:34:41.578Z,1739486081.578 [MissionManager](IMPORTANT): Started mission Startup
2025-02-13T22:34:41.579Z,1739486081.579 [Startup] Running Loop=1
2025-02-13T22:34:41.579Z,1739486081.579 [Startup](DEBUG): Aggregate::initialize Startup
2025-02-13T22:34:41.579Z,1739486081.579 [Startup:A.GoToSurface] Running Loop=1
2025-02-13T22:34:41.579Z,1739486081.579 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-13T22:34:41.579Z,1739486081.579 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-13T22:34:41.580Z,1739486081.580 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-13T22:34:41.580Z,1739486081.580 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-13T22:34:41.581Z,1739486081.581 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-13T22:34:41.581Z,1739486081.581 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-13T22:34:41.581Z,1739486081.581 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-13T22:34:41.583Z,1739486081.583 [Startup:StartupSatComms] Running Loop=1
2025-02-13T22:34:41.583Z,1739486081.583 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-02-13T22:34:41.583Z,1739486081.583 [Startup:StartupSatComms:A] Running Loop=1
2025-02-13T22:34:41.978Z,1739486081.978 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-02-13T22:34:44.795Z,1739486084.795 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:34:57.717Z,1739486097.717 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:35:10.242Z,1739486110.242 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T22:35:41.781Z,1739486141.781 [Startup:StartupSatComms:A](INFO): Timed out from 2025-02-13T22:34:41.6Z
2025-02-13T22:35:41.781Z,1739486141.781 [Startup:StartupSatComms:A] Stopped
2025-02-13T22:35:41.781Z,1739486141.781 [Startup:StartupSatComms:B] Running Loop=1
2025-02-13T22:35:42.174Z,1739486142.174 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-13T22:35:47.031Z,1739486147.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-02-13T22:35:47.031Z,1739486147.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-13T22:35:47.173Z,1739486147.173 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-13T22:35:47.588Z,1739486147.588 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-13T22:35:47.589Z,1739486147.589 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-02-13T22:35:50.041Z,1739486150.041 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:36:21.165Z,1739486181.165 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:36:41.962Z,1739486201.962 [Startup:StartupSatComms:B](INFO): Timed out from 2025-02-13T22:35:41.8Z
2025-02-13T22:36:41.962Z,1739486201.962 [Startup:StartupSatComms:B] Stopped
2025-02-13T22:36:41.962Z,1739486201.962 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-02-13T22:36:41.963Z,1739486201.963 [Startup:StartupSatComms] Stopped
2025-02-13T22:36:41.963Z,1739486201.963 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-02-13T22:36:41.964Z,1739486201.964 [Startup](INFO): Completed Startup
2025-02-13T22:36:41.964Z,1739486201.964 [MissionManager](INFO): Startup is completed.
2025-02-13T22:36:41.964Z,1739486201.964 [MissionManager](INFO): Uninitializing Mission Startup
2025-02-13T22:36:41.964Z,1739486201.964 [Startup] Stopped
2025-02-13T22:36:41.964Z,1739486201.964 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-02-13T22:36:41.964Z,1739486201.964 [Startup:A.GoToSurface] Stopped
2025-02-13T22:36:41.964Z,1739486201.964 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-13T22:36:42.394Z,1739486202.394 [MissionManager](IMPORTANT): Started mission Default
2025-02-13T22:36:42.394Z,1739486202.394 [Default] Running Loop=1
2025-02-13T22:36:42.394Z,1739486202.394 [Default](DEBUG): Aggregate::initialize Default
2025-02-13T22:36:42.395Z,1739486202.395 [Default:B.GoToSurface] Running Loop=1
2025-02-13T22:36:42.395Z,1739486202.395 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-13T22:36:42.395Z,1739486202.395 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-13T22:36:42.395Z,1739486202.395 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-13T22:36:42.395Z,1739486202.395 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-13T22:36:42.396Z,1739486202.396 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-13T22:36:42.396Z,1739486202.396 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-13T22:36:42.397Z,1739486202.397 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-13T22:36:42.397Z,1739486202.397 [Default:A.Wait] Running Loop=1
2025-02-13T22:36:42.397Z,1739486202.397 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-13T22:36:52.288Z,1739486212.288 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:36:55.702Z,1739486215.702 [Default:A.Wait](INFO): Done Waiting.
2025-02-13T22:36:55.702Z,1739486215.702 [Default:A.Wait] Stopped
2025-02-13T22:36:55.702Z,1739486215.702 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T22:36:56.110Z,1739486216.110 [Default:CheckIn] Running Loop=1
2025-02-13T22:36:56.110Z,1739486216.110 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T22:36:56.111Z,1739486216.111 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T22:36:56.510Z,1739486216.510 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-13T22:37:23.412Z,1739486243.412 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:37:54.536Z,1739486274.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:37:57.549Z,1739486277.549 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.743744
2025-02-13T22:38:29.826Z,1739486309.826 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-13T22:38:48.034Z,1739486328.034 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-02-13T22:38:48.034Z,1739486328.034 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-13T22:38:48.184Z,1739486328.184 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-13T22:38:48.589Z,1739486328.589 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-13T22:38:48.589Z,1739486328.589 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-02-13T22:38:55.780Z,1739486335.780 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:39:26.918Z,1739486366.918 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:39:37.521Z,1739486377.521 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.006752
2025-02-13T22:40:14.937Z,1739486414.937 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-13T22:40:20.537Z,1739486420.537 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2025-02-13T22:40:20.571Z,1739486420.571 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-02-13T22:40:20.571Z,1739486420.571 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 6.
2025-02-13T22:40:20.575Z,1739486420.575 [BPC1](INFO): Received data from all battery sticks.
2025-02-13T22:41:49.043Z,1739486509.043 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-02-13T22:41:49.043Z,1739486509.043 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-13T22:41:49.189Z,1739486509.189 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-13T22:41:49.593Z,1739486509.593 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-13T22:41:49.593Z,1739486509.593 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-02-13T22:41:56.316Z,1739486516.316 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-13T22:36:56.1Z
2025-02-13T22:41:56.316Z,1739486516.316 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T22:41:56.316Z,1739486516.316 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T22:41:56.728Z,1739486516.728 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-13T22:42:04.760Z,1739486524.760 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250212T164333/Courier0007.lzma
2025-02-13T22:42:05.762Z,1739486525.762 [DataOverHttps](INFO): Moved sent file to Logs/20250212T164333/Courier0007.lzma.bak
2025-02-13T22:42:05.762Z,1739486525.762 [DataOverHttps](INFO): SBD MOMSN=23965578
2025-02-13T22:42:21.789Z,1739486541.789 [DataOverHttps](INFO): Sending 298 bytes from file Logs/20250213T223236/Courier0000.lzma
2025-02-13T22:42:22.790Z,1739486542.790 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0000.lzma.bak
2025-02-13T22:42:22.790Z,1739486542.790 [DataOverHttps](INFO): SBD MOMSN=23965580
2025-02-13T22:42:38.756Z,1739486558.756 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250213T223236/Courier0004.lzma
2025-02-13T22:42:39.758Z,1739486559.758 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0004.lzma.bak
2025-02-13T22:42:39.758Z,1739486559.758 [DataOverHttps](INFO): SBD MOMSN=23965588
2025-02-13T22:42:48.822Z,1739486568.822 [Power24vConverter](INFO): Powering down.
2025-02-13T22:43:29.222Z,1739486609.222 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-13T22:43:29.222Z,1739486609.222 [NAL9602] Data Fault, FailCount= 1
2025-02-13T22:43:29.222Z,1739486609.222 [NAL9602](ERROR): Data Fault
2025-02-13T22:43:29.372Z,1739486609.372 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-13T22:43:29.629Z,1739486609.629 [NAL9602](INFO): Powering down
2025-02-13T22:43:30.592Z,1739486610.592 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-13T22:43:30.592Z,1739486610.592 [NAL9602] No Fault, FailCount= 1
2025-02-13T22:43:42.432Z,1739486622.432 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:43:59.925Z,1739486639.925 [NAL9602](INFO): Powering up NAL9602
2025-02-13T22:44:10.834Z,1739486650.834 [NAL9602](INFO): NAL9602 initialized
2025-02-13T22:44:13.569Z,1739486653.569 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:44:44.705Z,1739486684.705 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:44:50.039Z,1739486690.039 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-02-13T22:44:50.039Z,1739486690.039 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-13T22:44:50.177Z,1739486690.177 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-13T22:44:50.588Z,1739486690.588 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-13T22:44:50.588Z,1739486690.588 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-02-13T22:45:15.829Z,1739486715.829 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T22:45:50.860Z,1739486750.860 [MassServo](ERROR): getPosition uart error serial timeout
2025-02-13T22:45:50.861Z,1739486750.861 [MassServo](FAULT): Invalid EZ Servo response:"\377"
2025-02-13T22:45:50.861Z,1739486750.861 [MassServo] Communications Fault, FailCount= 1
2025-02-13T22:45:50.861Z,1739486750.861 [MassServo](ERROR): Communications Fault
2025-02-13T22:45:50.865Z,1739486750.865 [CBIT](ERROR): Communications Fault in component: MassServo
2025-02-13T22:45:51.173Z,1739486751.173 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-02-13T22:45:51.173Z,1739486751.173 [MassServo](INFO): Powering down
2025-02-13T22:45:52.014Z,1739486752.014 [MassServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:45:52.146Z,1739486752.146 [MassServo](DEBUG): Initializing MassServo.
2025-02-13T22:45:52.150Z,1739486752.150 [CBIT](INFO): Clearing failed state for component MassServo
2025-02-13T22:45:52.150Z,1739486752.150 [MassServo] No Fault, FailCount= 1
2025-02-13T22:45:53.369Z,1739486753.369 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=193.610977
2025-02-13T22:46:07.660Z,1739486767.660 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002909
2025-02-13T22:46:15.620Z,1739486775.620 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20250212T164333/Express0008.lzma
2025-02-13T22:46:16.622Z,1739486776.622 [DataOverHttps](INFO): Moved sent file to Logs/20250212T164333/Express0008.lzma.bak
2025-02-13T22:46:16.622Z,1739486776.622 [DataOverHttps](INFO): SBD MOMSN=23965590
2025-02-13T22:46:35.536Z,1739486795.536 [DataOverHttps](INFO): Sending 1093 bytes from file Logs/20250213T223236/Express0001.lzma
2025-02-13T22:46:36.534Z,1739486796.534 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0001.lzma.bak
2025-02-13T22:46:36.534Z,1739486796.534 [DataOverHttps](INFO): SBD MOMSN=23965598
2025-02-13T22:46:53.016Z,1739486813.016 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20250213T223236/Express0005.lzma
2025-02-13T22:46:54.018Z,1739486814.018 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0005.lzma.bak
2025-02-13T22:46:54.018Z,1739486814.018 [DataOverHttps](INFO): SBD MOMSN=23965633
2025-02-13T22:46:55.178Z,1739486815.178 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T22:46:55.178Z,1739486815.178 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T22:46:55.178Z,1739486815.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T22:47:48.184Z,1739486868.184 [CBIT](INFO): Clearing failed state for component DropWeight
2025-02-13T22:47:48.184Z,1739486868.184 [DropWeight] No Fault, FailCount= 1
2025-02-13T22:47:50.872Z,1739486870.872 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-02-13T22:47:50.872Z,1739486870.872 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-13T22:47:51.036Z,1739486871.036 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-13T22:47:51.445Z,1739486871.445 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-13T22:47:51.445Z,1739486871.445 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-02-13T22:48:05.970Z,1739486885.970 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T22:48:05.970Z,1739486885.970 [RudderServo] No Fault, FailCount= 3
2025-02-13T22:48:10.448Z,1739486890.448 [RudderServo](FAULT): Overload Error
2025-02-13T22:48:10.448Z,1739486890.448 [RudderServo] Hardware Fault, FailCount= 1
2025-02-13T22:48:10.448Z,1739486890.448 [RudderServo](ERROR): Hardware Fault
2025-02-13T22:48:10.561Z,1739486890.561 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T22:48:10.829Z,1739486890.829 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T22:48:10.829Z,1739486890.829 [RudderServo](INFO): Powering down
2025-02-13T22:48:11.650Z,1739486891.650 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:48:11.769Z,1739486891.769 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:48:11.773Z,1739486891.773 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T22:48:11.773Z,1739486891.773 [RudderServo] No Fault, FailCount= 1
2025-02-13T22:48:16.928Z,1739486896.928 [RudderServo](FAULT): Overload Error
2025-02-13T22:48:16.928Z,1739486896.928 [RudderServo] Hardware Fault, FailCount= 2
2025-02-13T22:48:16.928Z,1739486896.928 [RudderServo](ERROR): Hardware Fault
2025-02-13T22:48:17.041Z,1739486897.041 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T22:48:17.313Z,1739486897.313 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T22:48:17.313Z,1739486897.313 [RudderServo](INFO): Powering down
2025-02-13T22:48:18.101Z,1739486898.101 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:48:18.221Z,1739486898.221 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:48:18.225Z,1739486898.225 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T22:48:18.225Z,1739486898.225 [RudderServo] No Fault, FailCount= 2
2025-02-13T22:48:23.400Z,1739486903.400 [RudderServo](FAULT): Overload Error
2025-02-13T22:48:23.400Z,1739486903.400 [RudderServo] Hardware Fault, FailCount= 3
2025-02-13T22:48:23.400Z,1739486903.400 [RudderServo](ERROR): Hardware Fault
2025-02-13T22:48:23.515Z,1739486903.515 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T22:48:23.517Z,1739486903.517 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-13T22:48:23.733Z,1739486903.733 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T22:48:23.733Z,1739486903.733 [RudderServo](INFO): Powering down
2025-02-13T22:48:23.735Z,1739486903.735 [CBIT](INFO): Critical error at 20250213T224823
2025-02-13T22:48:24.549Z,1739486904.549 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:48:24.669Z,1739486904.669 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T22:49:01.756Z,1739486941.756 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T22:49:01.756Z,1739486941.756 [ElevatorServo] No Fault, FailCount= 3
2025-02-13T22:49:04.866Z,1739486944.866 [DataOverHttps](IMPORTANT): SBD MTMSN=20250213T224903
2025-02-13T22:49:06.080Z,1739486946.080 [ElevatorServo](FAULT): Overload Error
2025-02-13T22:49:06.080Z,1739486946.080 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-13T22:49:06.080Z,1739486946.080 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T22:49:06.332Z,1739486946.332 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T22:49:06.439Z,1739486946.439 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T22:49:06.439Z,1739486946.439 [ElevatorServo](INFO): Powering down
2025-02-13T22:49:07.257Z,1739486947.257 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:49:07.373Z,1739486947.373 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:49:07.500Z,1739486947.500 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T22:49:07.500Z,1739486947.500 [ElevatorServo] No Fault, FailCount= 1
2025-02-13T22:49:12.752Z,1739486952.752 [ElevatorServo](FAULT): Overload Error
2025-02-13T22:49:12.752Z,1739486952.752 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-13T22:49:12.752Z,1739486952.752 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T22:49:13.004Z,1739486953.004 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T22:49:13.122Z,1739486953.122 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T22:49:13.122Z,1739486953.122 [ElevatorServo](INFO): Powering down
2025-02-13T22:49:13.923Z,1739486953.923 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:49:14.045Z,1739486954.045 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:49:14.176Z,1739486954.176 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T22:49:14.176Z,1739486954.176 [ElevatorServo] No Fault, FailCount= 2
2025-02-13T22:49:15.610Z,1739486955.610 [DataOverHttps](INFO): Received command: configSet Normal all depth persist
2025-02-13T22:49:15.979Z,1739486955.979 [CommandExec](IMPORTANT): got command configSet Normal all depth persist
2025-02-13T22:49:19.160Z,1739486959.160 [ElevatorServo](FAULT): Overload Error
2025-02-13T22:49:19.182Z,1739486959.182 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-13T22:49:19.182Z,1739486959.182 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T22:49:19.436Z,1739486959.436 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T22:49:19.436Z,1739486959.436 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-13T22:49:19.535Z,1739486959.535 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T22:49:19.536Z,1739486959.536 [ElevatorServo](INFO): Powering down
2025-02-13T22:49:19.674Z,1739486959.674 [CBIT](INFO): Critical error at 20250213T224919
2025-02-13T22:49:20.349Z,1739486960.349 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T22:49:20.465Z,1739486960.465 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T22:50:52.037Z,1739487052.037 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-02-13T22:50:52.037Z,1739487052.037 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-13T22:50:52.208Z,1739487052.208 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-13T22:50:52.600Z,1739487052.600 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-13T22:50:52.600Z,1739487052.600 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-02-13T22:50:56.071Z,1739487056.071 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225052.00,A,3648.14879,N,12147.25078,W,0.058,207.30,130225,,,A*71
2025-02-13T22:50:56.074Z,1739487056.074 [NAL9602](INFO): GPS fix at 20250213T225052: (36.802480, -121.787513)
2025-02-13T22:51:28.405Z,1739487088.405 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T22:51:55.891Z,1739487115.891 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T22:51:55.891Z,1739487115.891 [Default:CheckIn:C.Wait] Stopped
2025-02-13T22:51:55.891Z,1739487115.891 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T22:51:55.891Z,1739487115.891 [Default:CheckIn:D] Running Loop=1
2025-02-13T22:51:56.288Z,1739487116.288 [Default:CheckIn:D] Stopped
2025-02-13T22:51:56.288Z,1739487116.288 [Default:CheckIn:E] Running Loop=1
2025-02-13T22:51:56.710Z,1739487116.710 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 15.231562 min
2025-02-13T22:51:56.710Z,1739487116.710 [Default:CheckIn:E] Stopped
2025-02-13T22:51:56.710Z,1739487116.710 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T22:51:56.710Z,1739487116.710 [Default:CheckIn] Stopped
2025-02-13T22:51:56.711Z,1739487116.711 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T22:51:56.711Z,1739487116.711 [Default:CheckIn](INFO): Running loop #2
2025-02-13T22:51:56.711Z,1739487116.711 [Default:CheckIn] Running Loop=2
2025-02-13T22:51:56.711Z,1739487116.711 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T22:51:56.711Z,1739487116.711 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T22:51:58.702Z,1739487118.702 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225154.00,A,3648.16520,N,12147.27332,W,0.117,207.30,130225,,,D*75
2025-02-13T22:51:58.704Z,1739487118.704 [NAL9602](INFO): GPS fix at 20250213T225154: (36.802753, -121.787889)
2025-02-13T22:51:58.715Z,1739487118.715 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T22:51:58.715Z,1739487118.715 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T22:52:07.566Z,1739487127.566 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20250213T223236/Courier0007.lzma
2025-02-13T22:52:07.914Z,1739487127.914 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0007.lzma.bak
2025-02-13T22:52:07.914Z,1739487127.914 [DataOverHttps](INFO): SBD MOMSN=23965640
2025-02-13T22:52:24.685Z,1739487144.685 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250213T223236/Courier0010.lzma
2025-02-13T22:52:25.001Z,1739487145.001 [NAL9602](INFO): SBD MO Status=2, MOMSN=12653, MT Status=2, MTMSN=0
2025-02-13T22:52:25.001Z,1739487145.001 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T22:52:25.686Z,1739487145.686 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0010.lzma.bak
2025-02-13T22:52:25.686Z,1739487145.686 [DataOverHttps](INFO): SBD MOMSN=23965645
2025-02-13T22:52:41.146Z,1739487161.146 [NAL9602](INFO): SBD MO Status=2, MOMSN=12653, MT Status=2, MTMSN=0
2025-02-13T22:52:41.147Z,1739487161.147 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T22:52:42.669Z,1739487162.669 [DataOverHttps](INFO): Sending 510 bytes from file Logs/20250213T223236/Express0008.lzma
2025-02-13T22:52:43.670Z,1739487163.670 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0008.lzma.bak
2025-02-13T22:52:43.670Z,1739487163.670 [DataOverHttps](INFO): SBD MOMSN=23965647
2025-02-13T22:52:58.555Z,1739487178.555 [NAL9602](INFO): SBD MO Status=0, MOMSN=12653, MT Status=0, MTMSN=0
2025-02-13T22:52:58.555Z,1739487178.555 [NAL9602](INFO): No messages in MT queue
2025-02-13T22:53:03.532Z,1739487183.532 [DataOverHttps](INFO): Sending 60 bytes from file Logs/20250213T223236/Express0011.lzma
2025-02-13T22:53:04.534Z,1739487184.534 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0011.lzma.bak
2025-02-13T22:53:04.534Z,1739487184.534 [DataOverHttps](INFO): SBD MOMSN=23965660
2025-02-13T22:53:05.840Z,1739487185.840 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T22:53:05.840Z,1739487185.840 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T22:53:05.840Z,1739487185.840 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T22:53:29.253Z,1739487209.253 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T22:58:06.460Z,1739487486.460 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T22:58:06.460Z,1739487486.460 [Default:CheckIn:C.Wait] Stopped
2025-02-13T22:58:06.461Z,1739487486.461 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T22:58:06.461Z,1739487486.461 [Default:CheckIn:D] Running Loop=1
2025-02-13T22:58:06.863Z,1739487486.863 [Default:CheckIn:D] Stopped
2025-02-13T22:58:06.863Z,1739487486.863 [Default:CheckIn:E] Running Loop=1
2025-02-13T22:58:07.259Z,1739487487.259 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.407815 min
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn:E] Stopped
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn] Stopped
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn](INFO): Running loop #3
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn] Running Loop=3
2025-02-13T22:58:07.260Z,1739487487.260 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T22:58:07.261Z,1739487487.261 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T22:58:09.275Z,1739487489.275 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225808.00,A,3648.17124,N,12147.28791,W,0.039,207.30,130225,,,D*7B
2025-02-13T22:58:09.277Z,1739487489.277 [NAL9602](INFO): GPS fix at 20250213T225808: (36.802854, -121.788132)
2025-02-13T22:58:09.287Z,1739487489.287 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T22:58:09.287Z,1739487489.287 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T22:58:17.523Z,1739487497.523 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250213T223236/Courier0013.lzma
2025-02-13T22:58:18.526Z,1739487498.526 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0013.lzma.bak
2025-02-13T22:58:18.526Z,1739487498.526 [DataOverHttps](INFO): SBD MOMSN=23965665
2025-02-13T22:58:34.852Z,1739487514.852 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250213T223236/Express0014.lzma
2025-02-13T22:58:35.854Z,1739487515.854 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0014.lzma.bak
2025-02-13T22:58:35.854Z,1739487515.854 [DataOverHttps](INFO): SBD MOMSN=23965668
2025-02-13T22:58:37.169Z,1739487517.169 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T22:58:37.169Z,1739487517.169 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T22:58:37.170Z,1739487517.170 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:02:07.349Z,1739487727.349 [NAL9602](INFO): SBD MO Status=0, MOMSN=12654, MT Status=0, MTMSN=0
2025-02-13T23:02:07.349Z,1739487727.349 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:02:38.049Z,1739487758.049 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:03:23.480Z,1739487803.480 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:03:23.480Z,1739487803.480 [RudderServo] No Fault, FailCount= 3
2025-02-13T23:03:27.936Z,1739487807.936 [RudderServo](FAULT): Overload Error
2025-02-13T23:03:27.936Z,1739487807.936 [RudderServo] Hardware Fault, FailCount= 1
2025-02-13T23:03:27.936Z,1739487807.936 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:03:28.056Z,1739487808.056 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:03:28.329Z,1739487808.329 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:03:28.329Z,1739487808.329 [RudderServo](INFO): Powering down
2025-02-13T23:03:29.134Z,1739487809.134 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:03:29.253Z,1739487809.253 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:03:29.257Z,1739487809.257 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:03:29.257Z,1739487809.257 [RudderServo] No Fault, FailCount= 1
2025-02-13T23:03:34.408Z,1739487814.408 [RudderServo](FAULT): Overload Error
2025-02-13T23:03:34.408Z,1739487814.408 [RudderServo] Hardware Fault, FailCount= 2
2025-02-13T23:03:34.408Z,1739487814.408 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:03:34.520Z,1739487814.520 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:03:34.793Z,1739487814.793 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:03:34.793Z,1739487814.793 [RudderServo](INFO): Powering down
2025-02-13T23:03:35.597Z,1739487815.597 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:03:35.717Z,1739487815.717 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:03:35.721Z,1739487815.721 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:03:35.721Z,1739487815.721 [RudderServo] No Fault, FailCount= 2
2025-02-13T23:03:37.866Z,1739487817.866 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:03:37.866Z,1739487817.866 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:03:37.866Z,1739487817.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:03:37.866Z,1739487817.866 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:03:38.271Z,1739487818.271 [Default:CheckIn:D] Stopped
2025-02-13T23:03:38.271Z,1739487818.271 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.931281 min
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn:E] Stopped
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn] Stopped
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn](INFO): Running loop #4
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn] Running Loop=4
2025-02-13T23:03:38.680Z,1739487818.680 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:03:38.681Z,1739487818.681 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:03:40.688Z,1739487820.688 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230339.00,A,3648.16962,N,12147.28480,W,0.505,207.30,130225,,,D*74
2025-02-13T23:03:40.691Z,1739487820.691 [NAL9602](INFO): GPS fix at 20250213T230339: (36.802827, -121.788080)
2025-02-13T23:03:40.727Z,1739487820.727 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:03:40.727Z,1739487820.727 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:03:40.892Z,1739487820.892 [RudderServo](FAULT): Overload Error
2025-02-13T23:03:40.892Z,1739487820.892 [RudderServo] Hardware Fault, FailCount= 3
2025-02-13T23:03:40.892Z,1739487820.892 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:03:41.004Z,1739487821.004 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:03:41.004Z,1739487821.004 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-13T23:03:41.273Z,1739487821.273 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:03:41.273Z,1739487821.273 [RudderServo](INFO): Powering down
2025-02-13T23:03:41.276Z,1739487821.276 [CBIT](INFO): Critical error at 20250213T230341
2025-02-13T23:03:42.097Z,1739487822.097 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:03:42.217Z,1739487822.217 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:03:49.583Z,1739487829.583 [DataOverHttps](INFO): Sending 122 bytes from file Logs/20250213T223236/Courier0016.lzma
2025-02-13T23:03:50.586Z,1739487830.586 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0016.lzma.bak
2025-02-13T23:03:50.586Z,1739487830.586 [DataOverHttps](INFO): SBD MOMSN=23965672
2025-02-13T23:04:05.746Z,1739487845.746 [NAL9602](INFO): SBD MO Status=2, MOMSN=12655, MT Status=2, MTMSN=0
2025-02-13T23:04:05.747Z,1739487845.747 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:04:07.275Z,1739487847.275 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20250213T223236/Express0017.lzma
2025-02-13T23:04:08.278Z,1739487848.278 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0017.lzma.bak
2025-02-13T23:04:08.278Z,1739487848.278 [DataOverHttps](INFO): SBD MOMSN=23965676
2025-02-13T23:04:09.794Z,1739487849.794 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:04:09.794Z,1739487849.794 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:04:09.794Z,1739487849.794 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:04:19.252Z,1739487859.252 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:04:19.253Z,1739487859.253 [ElevatorServo] No Fault, FailCount= 3
2025-02-13T23:04:23.576Z,1739487863.576 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:04:23.576Z,1739487863.576 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-13T23:04:23.576Z,1739487863.576 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:04:23.820Z,1739487863.820 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:04:23.950Z,1739487863.950 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:04:23.950Z,1739487863.950 [ElevatorServo](INFO): Powering down
2025-02-13T23:04:24.757Z,1739487864.757 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:04:24.881Z,1739487864.881 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:04:25.020Z,1739487865.020 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:04:25.020Z,1739487865.020 [ElevatorServo] No Fault, FailCount= 1
2025-02-13T23:04:30.028Z,1739487870.028 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:04:30.028Z,1739487870.028 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-13T23:04:30.028Z,1739487870.028 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:04:30.264Z,1739487870.264 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:04:30.419Z,1739487870.419 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:04:30.419Z,1739487870.419 [ElevatorServo](INFO): Powering down
2025-02-13T23:04:31.212Z,1739487871.212 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:04:31.333Z,1739487871.333 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:04:31.476Z,1739487871.476 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:04:31.476Z,1739487871.476 [ElevatorServo] No Fault, FailCount= 2
2025-02-13T23:04:36.533Z,1739487876.533 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:04:36.533Z,1739487876.533 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-13T23:04:36.533Z,1739487876.533 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:04:36.776Z,1739487876.776 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:04:36.776Z,1739487876.776 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-13T23:04:36.894Z,1739487876.894 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:04:36.894Z,1739487876.894 [ElevatorServo](INFO): Powering down
2025-02-13T23:04:37.038Z,1739487877.038 [CBIT](INFO): Critical error at 20250213T230436
2025-02-13T23:04:37.675Z,1739487877.675 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:04:37.793Z,1739487877.793 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:08:42.537Z,1739488122.537 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-13T23:09:10.430Z,1739488150.430 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:09:10.430Z,1739488150.430 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:09:10.430Z,1739488150.430 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:09:10.430Z,1739488150.430 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:09:10.858Z,1739488150.858 [Default:CheckIn:D] Stopped
2025-02-13T23:09:10.858Z,1739488150.858 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:09:11.242Z,1739488151.242 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.474388 min
2025-02-13T23:09:11.242Z,1739488151.242 [Default:CheckIn:E] Stopped
2025-02-13T23:09:11.242Z,1739488151.242 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:09:11.242Z,1739488151.242 [Default:CheckIn] Stopped
2025-02-13T23:09:11.242Z,1739488151.242 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:09:11.243Z,1739488151.243 [Default:CheckIn](INFO): Running loop #5
2025-02-13T23:09:11.243Z,1739488151.243 [Default:CheckIn] Running Loop=5
2025-02-13T23:09:11.243Z,1739488151.243 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:09:11.243Z,1739488151.243 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:09:13.242Z,1739488153.242 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230912.00,A,3648.16468,N,12147.27995,W,0.175,99.87,130225,,,D*4C
2025-02-13T23:09:13.262Z,1739488153.262 [NAL9602](INFO): GPS fix at 20250213T230912: (36.802745, -121.787999)
2025-02-13T23:09:13.281Z,1739488153.281 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:09:13.281Z,1739488153.281 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:09:23.783Z,1739488163.783 [DataOverHttps](INFO): Sending 124 bytes from file Logs/20250213T223236/Courier0019.lzma
2025-02-13T23:09:24.786Z,1739488164.786 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0019.lzma.bak
2025-02-13T23:09:24.786Z,1739488164.786 [DataOverHttps](INFO): SBD MOMSN=23965682
2025-02-13T23:09:41.596Z,1739488181.596 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20250213T223236/Express0020.lzma
2025-02-13T23:09:42.598Z,1739488182.598 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0020.lzma.bak
2025-02-13T23:09:42.598Z,1739488182.598 [DataOverHttps](INFO): SBD MOMSN=23965686
2025-02-13T23:09:43.931Z,1739488183.931 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:09:43.932Z,1739488183.932 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:09:43.932Z,1739488183.932 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:09:45.533Z,1739488185.533 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:14:44.371Z,1739488484.371 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:14:44.371Z,1739488484.371 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:14:44.371Z,1739488484.371 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:14:44.371Z,1739488484.371 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:14:44.776Z,1739488484.776 [Default:CheckIn:D] Stopped
2025-02-13T23:14:44.776Z,1739488484.776 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.039689 min
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn:E] Stopped
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn] Stopped
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn](INFO): Running loop #6
2025-02-13T23:14:45.182Z,1739488485.182 [Default:CheckIn] Running Loop=6
2025-02-13T23:14:45.183Z,1739488485.183 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:14:45.183Z,1739488485.183 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:14:47.186Z,1739488487.186 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231446.00,A,3648.16574,N,12147.28376,W,0.136,213.05,130225,,,D*78
2025-02-13T23:14:47.188Z,1739488487.188 [NAL9602](INFO): GPS fix at 20250213T231446: (36.802762, -121.788063)
2025-02-13T23:14:47.214Z,1739488487.214 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:14:47.214Z,1739488487.214 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:14:55.323Z,1739488495.323 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250213T223236/Courier0022.lzma
2025-02-13T23:14:56.326Z,1739488496.326 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0022.lzma.bak
2025-02-13T23:14:56.326Z,1739488496.326 [DataOverHttps](INFO): SBD MOMSN=23965693
2025-02-13T23:15:17.312Z,1739488517.312 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250213T223236/Express0023.lzma
2025-02-13T23:15:17.952Z,1739488517.952 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-02-13T23:15:18.031Z,1739488518.031 [NAL9602](ERROR): received:
+CSQ:0
OK655, 2, 0, 0, 0
OK
2025-02-13T23:15:18.313Z,1739488518.313 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0023.lzma.bak
2025-02-13T23:15:18.313Z,1739488518.313 [DataOverHttps](INFO): SBD MOMSN=23965696
2025-02-13T23:15:19.996Z,1739488519.996 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:15:19.996Z,1739488519.996 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:15:19.996Z,1739488519.996 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:17:49.495Z,1739488669.495 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-02-13T23:17:49.495Z,1739488669.495 [DropWeight] Hardware Fault, FailCount= 1
2025-02-13T23:17:49.496Z,1739488669.496 [DropWeight](ERROR): Hardware Fault
2025-02-13T23:17:49.670Z,1739488669.670 [CBIT](INFO): Critical error at 20250213T231749
2025-02-13T23:17:49.672Z,1739488669.672 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-02-13T23:17:49.673Z,1739488669.673 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-02-13T23:17:50.077Z,1739488670.077 [CBIT](INFO): Critical error at 20250213T231749
2025-02-13T23:18:40.992Z,1739488720.992 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:18:40.992Z,1739488720.992 [RudderServo] No Fault, FailCount= 3
2025-02-13T23:18:45.459Z,1739488725.459 [RudderServo](FAULT): Overload Error
2025-02-13T23:18:45.460Z,1739488725.460 [RudderServo] Hardware Fault, FailCount= 1
2025-02-13T23:18:45.460Z,1739488725.460 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:18:45.564Z,1739488725.564 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:18:45.848Z,1739488725.848 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:18:45.848Z,1739488725.848 [RudderServo](INFO): Powering down
2025-02-13T23:18:46.616Z,1739488726.616 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:18:46.736Z,1739488726.736 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:18:46.741Z,1739488726.741 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:18:46.741Z,1739488726.741 [RudderServo] No Fault, FailCount= 1
2025-02-13T23:18:51.888Z,1739488731.888 [RudderServo](FAULT): Overload Error
2025-02-13T23:18:51.888Z,1739488731.888 [RudderServo] Hardware Fault, FailCount= 2
2025-02-13T23:18:51.888Z,1739488731.888 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:18:52.005Z,1739488732.005 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:18:52.285Z,1739488732.285 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:18:52.285Z,1739488732.285 [RudderServo](INFO): Powering down
2025-02-13T23:18:53.080Z,1739488733.080 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:18:53.200Z,1739488733.200 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:18:53.205Z,1739488733.205 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:18:53.205Z,1739488733.205 [RudderServo] No Fault, FailCount= 2
2025-02-13T23:18:58.372Z,1739488738.372 [RudderServo](FAULT): Overload Error
2025-02-13T23:18:58.372Z,1739488738.372 [RudderServo] Hardware Fault, FailCount= 3
2025-02-13T23:18:58.372Z,1739488738.372 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:18:58.496Z,1739488738.496 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:18:58.496Z,1739488738.496 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-13T23:18:58.764Z,1739488738.764 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:18:58.765Z,1739488738.765 [RudderServo](INFO): Powering down
2025-02-13T23:18:58.767Z,1739488738.767 [CBIT](INFO): Critical error at 20250213T231858
2025-02-13T23:18:59.576Z,1739488739.576 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:18:59.707Z,1739488739.707 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:19:02.049Z,1739488742.049 [DataOverHttps](IMPORTANT): SBD MTMSN=20250213T231901
2025-02-13T23:19:12.707Z,1739488752.707 [DataOverHttps](INFO): Received command: failc
2025-02-13T23:19:12.724Z,1739488752.724 [CommandExec](IMPORTANT): got command failComponent
2025-02-13T23:19:12.724Z,1739488752.724 [CommandExec](IMPORTANT): Failed components:
2025-02-13T23:19:12.725Z,1739488752.725 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2025-02-13T23:19:12.725Z,1739488752.725 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2025-02-13T23:19:12.725Z,1739488752.725 [CommandExec](IMPORTANT): RudderServo: Hardware Fault
2025-02-13T23:19:36.784Z,1739488776.784 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:19:36.784Z,1739488776.784 [ElevatorServo] No Fault, FailCount= 3
2025-02-13T23:19:41.132Z,1739488781.132 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:19:41.132Z,1739488781.132 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-13T23:19:41.132Z,1739488781.132 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:19:41.391Z,1739488781.391 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:19:41.497Z,1739488781.497 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:19:41.497Z,1739488781.497 [ElevatorServo](INFO): Powering down
2025-02-13T23:19:42.305Z,1739488782.305 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:19:42.424Z,1739488782.424 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:19:42.570Z,1739488782.570 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:19:42.570Z,1739488782.570 [ElevatorServo] No Fault, FailCount= 1
2025-02-13T23:19:47.579Z,1739488787.579 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:19:47.580Z,1739488787.580 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-13T23:19:47.580Z,1739488787.580 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:19:47.820Z,1739488787.820 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:19:47.993Z,1739488787.993 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:19:47.993Z,1739488787.993 [ElevatorServo](INFO): Powering down
2025-02-13T23:19:48.759Z,1739488788.759 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:19:48.880Z,1739488788.880 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:19:49.028Z,1739488789.028 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:19:49.028Z,1739488789.028 [ElevatorServo] No Fault, FailCount= 2
2025-02-13T23:19:49.543Z,1739488789.543 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-13T23:19:54.051Z,1739488794.051 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:19:54.051Z,1739488794.051 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-13T23:19:54.052Z,1739488794.052 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:19:54.304Z,1739488794.304 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:19:54.304Z,1739488794.304 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-13T23:19:54.441Z,1739488794.441 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:19:54.442Z,1739488794.442 [ElevatorServo](INFO): Powering down
2025-02-13T23:19:54.593Z,1739488794.593 [CBIT](INFO): Critical error at 20250213T231954
2025-02-13T23:19:55.230Z,1739488795.230 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:19:55.345Z,1739488795.345 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:20:20.252Z,1739488820.252 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:20:20.664Z,1739488820.664 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:20:20.664Z,1739488820.664 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:20:20.664Z,1739488820.664 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:20:20.664Z,1739488820.664 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:20:21.073Z,1739488821.073 [Default:CheckIn:D] Stopped
2025-02-13T23:20:21.073Z,1739488821.073 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:20:21.471Z,1739488821.471 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.644649 min
2025-02-13T23:20:21.471Z,1739488821.471 [Default:CheckIn:E] Stopped
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn] Stopped
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn](INFO): Running loop #7
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn] Running Loop=7
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:20:21.472Z,1739488821.472 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:20:23.482Z,1739488823.482 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232022.00,A,3648.16703,N,12147.28355,W,0.233,339.78,130225,,,D*7B
2025-02-13T23:20:23.484Z,1739488823.484 [NAL9602](INFO): GPS fix at 20250213T232022: (36.802784, -121.788059)
2025-02-13T23:20:23.495Z,1739488823.495 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:20:23.495Z,1739488823.495 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:20:31.467Z,1739488831.467 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20250213T223236/Courier0025.lzma
2025-02-13T23:20:32.470Z,1739488832.470 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0025.lzma.bak
2025-02-13T23:20:32.470Z,1739488832.470 [DataOverHttps](INFO): SBD MOMSN=23965701
2025-02-13T23:20:49.158Z,1739488849.158 [DataOverHttps](INFO): Sending 371 bytes from file Logs/20250213T223236/Express0026.lzma
2025-02-13T23:20:50.157Z,1739488850.157 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0026.lzma.bak
2025-02-13T23:20:50.157Z,1739488850.157 [DataOverHttps](INFO): SBD MOMSN=23965708
2025-02-13T23:20:54.180Z,1739488854.180 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-02-13T23:20:54.263Z,1739488854.263 [NAL9602](ERROR): received:
+CSQ:0
OK655, 2, 0, 0, 0
OK
2025-02-13T23:21:09.563Z,1739488869.563 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250213T223236/Express0029.lzma
2025-02-13T23:21:10.716Z,1739488870.716 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0029.lzma.bak
2025-02-13T23:21:10.717Z,1739488870.717 [DataOverHttps](INFO): SBD MOMSN=23965724
2025-02-13T23:21:12.020Z,1739488872.020 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:21:12.020Z,1739488872.020 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:21:12.020Z,1739488872.020 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:21:12.806Z,1739488872.806 [NAL9602](INFO): SBD MO Status=2, MOMSN=12655, MT Status=2, MTMSN=0
2025-02-13T23:21:12.806Z,1739488872.806 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:21:40.286Z,1739488900.286 [NAL9602](INFO): SBD MO Status=0, MOMSN=12655, MT Status=0, MTMSN=0
2025-02-13T23:21:40.286Z,1739488900.286 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:22:10.984Z,1739488930.984 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:26:12.619Z,1739489172.619 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:26:12.619Z,1739489172.619 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:26:12.619Z,1739489172.619 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:26:12.620Z,1739489172.620 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:26:13.028Z,1739489173.028 [Default:CheckIn:D] Stopped
2025-02-13T23:26:13.028Z,1739489173.028 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:26:13.445Z,1739489173.445 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.510551 min
2025-02-13T23:26:13.445Z,1739489173.445 [Default:CheckIn:E] Stopped
2025-02-13T23:26:13.445Z,1739489173.445 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:26:13.445Z,1739489173.445 [Default:CheckIn] Stopped
2025-02-13T23:26:13.446Z,1739489173.446 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:26:13.446Z,1739489173.446 [Default:CheckIn](INFO): Running loop #8
2025-02-13T23:26:13.446Z,1739489173.446 [Default:CheckIn] Running Loop=8
2025-02-13T23:26:13.446Z,1739489173.446 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:26:13.446Z,1739489173.446 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:26:15.437Z,1739489175.437 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232614.00,A,3648.16616,N,12147.28180,W,0.214,339.78,130225,,,A*77
2025-02-13T23:26:15.440Z,1739489175.440 [NAL9602](INFO): GPS fix at 20250213T232614: (36.802769, -121.788030)
2025-02-13T23:26:15.452Z,1739489175.452 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:26:15.452Z,1739489175.452 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:26:23.155Z,1739489183.155 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250213T223236/Courier0031.lzma
2025-02-13T23:26:24.157Z,1739489184.157 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0031.lzma.bak
2025-02-13T23:26:24.157Z,1739489184.157 [DataOverHttps](INFO): SBD MOMSN=23965727
2025-02-13T23:26:40.689Z,1739489200.689 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20250213T223236/Express0032.lzma
2025-02-13T23:26:41.689Z,1739489201.689 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0032.lzma.bak
2025-02-13T23:26:41.690Z,1739489201.690 [DataOverHttps](INFO): SBD MOMSN=23965730
2025-02-13T23:26:43.011Z,1739489203.011 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:26:43.011Z,1739489203.011 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:26:43.028Z,1739489203.028 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:29:12.106Z,1739489352.106 [NAL9602](INFO): SBD MO Status=2, MOMSN=12656, MT Status=2, MTMSN=0
2025-02-13T23:29:12.106Z,1739489352.106 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:29:39.166Z,1739489379.166 [NAL9602](INFO): SBD MO Status=2, MOMSN=12656, MT Status=2, MTMSN=0
2025-02-13T23:29:39.166Z,1739489379.166 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:30:01.798Z,1739489401.798 [NAL9602](INFO): SBD MO Status=2, MOMSN=12656, MT Status=2, MTMSN=0
2025-02-13T23:30:01.798Z,1739489401.798 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:30:39.361Z,1739489439.361 [NAL9602](INFO): SBD MO Status=2, MOMSN=12656, MT Status=2, MTMSN=0
2025-02-13T23:30:39.361Z,1739489439.361 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:30:53.106Z,1739489453.106 [NAL9602](INFO): SBD MO Status=0, MOMSN=12656, MT Status=0, MTMSN=0
2025-02-13T23:30:53.106Z,1739489453.106 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:31:23.804Z,1739489483.804 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:31:43.606Z,1739489503.606 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:31:43.606Z,1739489503.606 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:31:43.606Z,1739489503.606 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:31:43.606Z,1739489503.606 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:31:44.012Z,1739489504.012 [Default:CheckIn:D] Stopped
2025-02-13T23:31:44.012Z,1739489504.012 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:31:44.426Z,1739489504.426 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.026953 min
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn:E] Stopped
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn] Stopped
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn](INFO): Running loop #9
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn] Running Loop=9
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:31:44.427Z,1739489504.427 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:31:46.430Z,1739489506.430 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233145.00,A,3648.16787,N,12147.28202,W,0.505,0.00,130225,,,A*74
2025-02-13T23:31:46.432Z,1739489506.432 [NAL9602](INFO): GPS fix at 20250213T233145: (36.802798, -121.788034)
2025-02-13T23:31:46.464Z,1739489506.464 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:31:46.464Z,1739489506.464 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:31:53.931Z,1739489513.931 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250213T223236/Courier0034.lzma
2025-02-13T23:31:54.933Z,1739489514.933 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0034.lzma.bak
2025-02-13T23:31:54.933Z,1739489514.933 [DataOverHttps](INFO): SBD MOMSN=23965734
2025-02-13T23:32:08.786Z,1739489528.786 [NAL9602](INFO): SBD MO Status=0, MOMSN=12657, MT Status=0, MTMSN=0
2025-02-13T23:32:08.786Z,1739489528.786 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:32:11.319Z,1739489531.319 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20250213T223236/Express0035.lzma
2025-02-13T23:32:12.321Z,1739489532.321 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0035.lzma.bak
2025-02-13T23:32:12.321Z,1739489532.321 [DataOverHttps](INFO): SBD MOMSN=23965737
2025-02-13T23:32:13.665Z,1739489533.665 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:32:13.665Z,1739489533.665 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:32:13.665Z,1739489533.665 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:32:39.487Z,1739489559.487 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:32:49.808Z,1739489569.808 [CBIT](INFO): Clearing failed state for component DropWeight
2025-02-13T23:32:49.808Z,1739489569.808 [DropWeight] No Fault, FailCount= 1
2025-02-13T23:33:58.464Z,1739489638.464 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:33:58.464Z,1739489638.464 [RudderServo] No Fault, FailCount= 3
2025-02-13T23:34:02.931Z,1739489642.931 [RudderServo](FAULT): Overload Error
2025-02-13T23:34:02.931Z,1739489642.931 [RudderServo] Hardware Fault, FailCount= 1
2025-02-13T23:34:02.932Z,1739489642.932 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:34:03.044Z,1739489643.044 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:34:03.372Z,1739489643.372 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:34:03.372Z,1739489643.372 [RudderServo](INFO): Powering down
2025-02-13T23:34:04.117Z,1739489644.117 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:34:04.236Z,1739489644.236 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:34:04.241Z,1739489644.241 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:34:04.241Z,1739489644.241 [RudderServo] No Fault, FailCount= 1
2025-02-13T23:34:09.407Z,1739489649.407 [RudderServo](FAULT): Overload Error
2025-02-13T23:34:09.407Z,1739489649.407 [RudderServo] Hardware Fault, FailCount= 2
2025-02-13T23:34:09.408Z,1739489649.408 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:34:09.512Z,1739489649.512 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:34:09.768Z,1739489649.768 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:34:09.768Z,1739489649.768 [RudderServo](INFO): Powering down
2025-02-13T23:34:10.572Z,1739489650.572 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:34:10.692Z,1739489650.692 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:34:10.696Z,1739489650.696 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:34:10.696Z,1739489650.696 [RudderServo] No Fault, FailCount= 2
2025-02-13T23:34:15.851Z,1739489655.851 [RudderServo](FAULT): Overload Error
2025-02-13T23:34:15.852Z,1739489655.852 [RudderServo] Hardware Fault, FailCount= 3
2025-02-13T23:34:15.852Z,1739489655.852 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:34:15.968Z,1739489655.968 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:34:15.968Z,1739489655.968 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-13T23:34:16.253Z,1739489656.253 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:34:16.253Z,1739489656.253 [RudderServo](INFO): Powering down
2025-02-13T23:34:16.255Z,1739489656.255 [CBIT](INFO): Critical error at 20250213T233415
2025-02-13T23:34:17.056Z,1739489657.056 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:34:17.176Z,1739489657.176 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:34:54.276Z,1739489694.276 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:34:54.276Z,1739489694.276 [ElevatorServo] No Fault, FailCount= 3
2025-02-13T23:34:58.559Z,1739489698.559 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:34:58.560Z,1739489698.560 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-13T23:34:58.560Z,1739489698.560 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:34:58.812Z,1739489698.812 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:34:58.929Z,1739489698.929 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:34:58.929Z,1739489698.929 [ElevatorServo](INFO): Powering down
2025-02-13T23:34:59.734Z,1739489699.734 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:34:59.848Z,1739489699.848 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:35:00.004Z,1739489700.004 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:35:00.004Z,1739489700.004 [ElevatorServo] No Fault, FailCount= 1
2025-02-13T23:35:05.036Z,1739489705.036 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:35:05.036Z,1739489705.036 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-13T23:35:05.036Z,1739489705.036 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:35:05.292Z,1739489705.292 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:35:05.408Z,1739489705.408 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:35:05.408Z,1739489705.408 [ElevatorServo](INFO): Powering down
2025-02-13T23:35:06.213Z,1739489706.213 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:35:06.336Z,1739489706.336 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:35:06.472Z,1739489706.472 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:35:06.472Z,1739489706.472 [ElevatorServo] No Fault, FailCount= 2
2025-02-13T23:35:11.500Z,1739489711.500 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:35:11.500Z,1739489711.500 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-13T23:35:11.500Z,1739489711.500 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:35:11.756Z,1739489711.756 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:35:11.756Z,1739489711.756 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-13T23:35:11.874Z,1739489711.874 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:35:11.874Z,1739489711.874 [ElevatorServo](INFO): Powering down
2025-02-13T23:35:12.014Z,1739489712.014 [CBIT](INFO): Critical error at 20250213T233511
2025-02-13T23:35:12.677Z,1739489712.677 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:35:12.796Z,1739489712.796 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:37:14.272Z,1739489834.272 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:37:14.272Z,1739489834.272 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:37:14.272Z,1739489834.272 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:37:14.273Z,1739489834.273 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:37:14.687Z,1739489834.687 [Default:CheckIn:D] Stopped
2025-02-13T23:37:14.687Z,1739489834.687 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:37:15.069Z,1739489835.069 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.538212 min
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn:E] Stopped
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn] Stopped
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn](INFO): Running loop #10
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn] Running Loop=10
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:37:15.070Z,1739489835.070 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:37:17.091Z,1739489837.091 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233716.00,A,3648.16795,N,12147.28032,W,0.194,0.00,130225,,,A*7A
2025-02-13T23:37:17.094Z,1739489837.094 [NAL9602](INFO): GPS fix at 20250213T233716: (36.802799, -121.788005)
2025-02-13T23:37:17.105Z,1739489837.105 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:37:17.105Z,1739489837.105 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:37:25.087Z,1739489845.087 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20250213T223236/Courier0037.lzma
2025-02-13T23:37:26.089Z,1739489846.089 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0037.lzma.bak
2025-02-13T23:37:26.089Z,1739489846.089 [DataOverHttps](INFO): SBD MOMSN=23965741
2025-02-13T23:37:40.126Z,1739489860.126 [NAL9602](INFO): SBD MO Status=2, MOMSN=12658, MT Status=2, MTMSN=0
2025-02-13T23:37:40.126Z,1739489860.126 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:37:42.972Z,1739489862.972 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20250213T223236/Express0038.lzma
2025-02-13T23:37:43.973Z,1739489863.973 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0038.lzma.bak
2025-02-13T23:37:43.973Z,1739489863.973 [DataOverHttps](INFO): SBD MOMSN=23965746
2025-02-13T23:37:45.388Z,1739489865.388 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:37:45.388Z,1739489865.388 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:37:45.388Z,1739489865.388 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:38:37.534Z,1739489917.534 [NAL9602](INFO): SBD MO Status=2, MOMSN=12658, MT Status=2, MTMSN=0
2025-02-13T23:38:37.534Z,1739489917.534 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:39:13.490Z,1739489953.490 [NAL9602](INFO): SBD MO Status=2, MOMSN=12658, MT Status=2, MTMSN=0
2025-02-13T23:39:13.490Z,1739489953.490 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:39:48.655Z,1739489988.655 [NAL9602](INFO): SBD MO Status=0, MOMSN=12658, MT Status=0, MTMSN=0
2025-02-13T23:39:48.655Z,1739489988.655 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:40:19.352Z,1739490019.352 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:41:19.036Z,1739490079.036 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-13T23:41:28.056Z,1739490088.056 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:41:40.584Z,1739490100.584 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:41:53.105Z,1739490113.105 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:42:06.434Z,1739490126.434 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:42:18.991Z,1739490138.991 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:42:31.482Z,1739490151.482 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:42:44.414Z,1739490164.414 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-13T23:42:46.050Z,1739490166.050 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:42:46.050Z,1739490166.050 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:42:46.051Z,1739490166.051 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:42:46.051Z,1739490166.051 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:42:46.442Z,1739490166.442 [Default:CheckIn:D] Stopped
2025-02-13T23:42:46.442Z,1739490166.442 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:42:46.916Z,1739490166.916 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.067464 min
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn:E] Stopped
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn] Stopped
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn](INFO): Running loop #11
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn] Running Loop=11
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:42:46.917Z,1739490166.917 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:42:48.882Z,1739490168.882 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234247.00,A,3648.16760,N,12147.27278,W,0.039,131.04,130225,,,A*74
2025-02-13T23:42:48.884Z,1739490168.884 [NAL9602](INFO): GPS fix at 20250213T234247: (36.802793, -121.787880)
2025-02-13T23:42:48.954Z,1739490168.954 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:42:48.954Z,1739490168.954 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:42:58.763Z,1739490178.763 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250213T223236/Courier0040.lzma
2025-02-13T23:42:59.765Z,1739490179.765 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0040.lzma.bak
2025-02-13T23:42:59.765Z,1739490179.765 [DataOverHttps](INFO): SBD MOMSN=23965756
2025-02-13T23:43:12.085Z,1739490192.085 [DataOverHttps](IMPORTANT): SBD MTMSN=20250213T234310
2025-02-13T23:43:18.451Z,1739490198.451 [NAL9602](INFO): SBD MO Status=0, MOMSN=12659, MT Status=0, MTMSN=0
2025-02-13T23:43:18.451Z,1739490198.451 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:43:19.684Z,1739490199.684 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20250213T223236/Express0041.lzma
2025-02-13T23:43:19.687Z,1739490199.687 [DataOverHttps](INFO): Received command: failc
2025-02-13T23:43:19.749Z,1739490199.749 [CommandExec](IMPORTANT): got command failComponent
2025-02-13T23:43:19.749Z,1739490199.749 [CommandExec](IMPORTANT): Failed components:
2025-02-13T23:43:19.749Z,1739490199.749 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2025-02-13T23:43:19.750Z,1739490199.750 [CommandExec](IMPORTANT): RudderServo: Hardware Fault
2025-02-13T23:43:20.916Z,1739490200.916 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0041.lzma.bak
2025-02-13T23:43:20.916Z,1739490200.916 [DataOverHttps](INFO): SBD MOMSN=23965760
2025-02-13T23:43:37.852Z,1739490217.852 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250213T223236/Courier0043.lzma
2025-02-13T23:43:38.854Z,1739490218.854 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0043.lzma.bak
2025-02-13T23:43:38.854Z,1739490218.854 [DataOverHttps](INFO): SBD MOMSN=23965764
2025-02-13T23:43:49.166Z,1739490229.166 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:43:59.029Z,1739490239.029 [DataOverHttps](INFO): Sending 179 bytes from file Logs/20250213T223236/Express0044.lzma
2025-02-13T23:44:00.030Z,1739490240.030 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0044.lzma.bak
2025-02-13T23:44:00.030Z,1739490240.030 [DataOverHttps](INFO): SBD MOMSN=23965767
2025-02-13T23:44:01.361Z,1739490241.361 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:44:01.361Z,1739490241.361 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:44:01.362Z,1739490241.362 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:47:47.777Z,1739490467.777 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-02-13T23:47:51.847Z,1739490471.847 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-02-13T23:47:51.847Z,1739490471.847 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 6.
2025-02-13T23:47:51.850Z,1739490471.850 [BPC1](INFO): Received data from all battery sticks.
2025-02-13T23:49:01.756Z,1739490541.756 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:49:01.756Z,1739490541.756 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:49:01.756Z,1739490541.756 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:49:01.756Z,1739490541.756 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:49:02.149Z,1739490542.149 [Default:CheckIn:D] Stopped
2025-02-13T23:49:02.149Z,1739490542.149 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:49:02.561Z,1739490542.561 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.329240 min
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn:E] Stopped
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn] Stopped
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn](INFO): Running loop #12
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn] Running Loop=12
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:49:02.562Z,1739490542.562 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:49:04.551Z,1739490544.551 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234903.00,A,3648.16712,N,12147.27758,W,1.633,128.00,130225,,,A*7C
2025-02-13T23:49:04.554Z,1739490544.554 [NAL9602](INFO): GPS fix at 20250213T234903: (36.802785, -121.787960)
2025-02-13T23:49:04.618Z,1739490544.618 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:49:04.618Z,1739490544.618 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:49:15.436Z,1739490555.436 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20250213T223236/Courier0046.lzma
2025-02-13T23:49:16.163Z,1739490556.163 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:49:16.163Z,1739490556.163 [RudderServo] No Fault, FailCount= 3
2025-02-13T23:49:16.439Z,1739490556.439 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0046.lzma.bak
2025-02-13T23:49:16.439Z,1739490556.439 [DataOverHttps](INFO): SBD MOMSN=23965774
2025-02-13T23:49:20.649Z,1739490560.649 [RudderServo](FAULT): Overload Error
2025-02-13T23:49:20.649Z,1739490560.649 [RudderServo] Hardware Fault, FailCount= 1
2025-02-13T23:49:20.649Z,1739490560.649 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:49:20.769Z,1739490560.769 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:49:21.049Z,1739490561.049 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:49:21.049Z,1739490561.049 [RudderServo](INFO): Powering down
2025-02-13T23:49:21.838Z,1739490561.838 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:49:21.957Z,1739490561.957 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:49:21.962Z,1739490561.962 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:49:21.962Z,1739490561.962 [RudderServo] No Fault, FailCount= 1
2025-02-13T23:49:27.100Z,1739490567.100 [RudderServo](FAULT): Overload Error
2025-02-13T23:49:27.100Z,1739490567.100 [RudderServo] Hardware Fault, FailCount= 2
2025-02-13T23:49:27.101Z,1739490567.101 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:49:27.205Z,1739490567.205 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:49:27.465Z,1739490567.465 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:49:27.465Z,1739490567.465 [RudderServo](INFO): Powering down
2025-02-13T23:49:28.124Z,1739490568.124 [NAL9602](INFO): SBD MO Status=2, MOMSN=12660, MT Status=2, MTMSN=0
2025-02-13T23:49:28.124Z,1739490568.124 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:49:28.297Z,1739490568.297 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:49:28.417Z,1739490568.417 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:49:28.422Z,1739490568.422 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-13T23:49:28.422Z,1739490568.422 [RudderServo] No Fault, FailCount= 2
2025-02-13T23:49:33.576Z,1739490573.576 [RudderServo](FAULT): Overload Error
2025-02-13T23:49:33.577Z,1739490573.577 [RudderServo] Hardware Fault, FailCount= 3
2025-02-13T23:49:33.577Z,1739490573.577 [RudderServo](ERROR): Hardware Fault
2025-02-13T23:49:33.636Z,1739490573.636 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250213T223236/Express0047.lzma
2025-02-13T23:49:33.685Z,1739490573.685 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-13T23:49:33.685Z,1739490573.685 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-13T23:49:34.001Z,1739490574.001 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-13T23:49:34.001Z,1739490574.001 [RudderServo](INFO): Powering down
2025-02-13T23:49:34.004Z,1739490574.004 [CBIT](INFO): Critical error at 20250213T234933
2025-02-13T23:49:34.640Z,1739490574.640 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0047.lzma.bak
2025-02-13T23:49:34.640Z,1739490574.640 [DataOverHttps](INFO): SBD MOMSN=23965777
2025-02-13T23:49:34.789Z,1739490574.789 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:49:34.909Z,1739490574.909 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-13T23:49:35.832Z,1739490575.832 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:49:35.832Z,1739490575.832 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:49:35.832Z,1739490575.832 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:49:53.206Z,1739490593.206 [NAL9602](INFO): SBD MO Status=2, MOMSN=12660, MT Status=2, MTMSN=0
2025-02-13T23:49:53.206Z,1739490593.206 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:50:11.584Z,1739490611.584 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:50:11.585Z,1739490611.585 [ElevatorServo] No Fault, FailCount= 3
2025-02-13T23:50:15.876Z,1739490615.876 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:50:15.877Z,1739490615.877 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-13T23:50:15.877Z,1739490615.877 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:50:16.125Z,1739490616.125 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:50:16.274Z,1739490616.274 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:50:16.274Z,1739490616.274 [ElevatorServo](INFO): Powering down
2025-02-13T23:50:17.066Z,1739490617.066 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:50:17.190Z,1739490617.190 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:50:17.329Z,1739490617.329 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:50:17.329Z,1739490617.329 [ElevatorServo] No Fault, FailCount= 1
2025-02-13T23:50:19.872Z,1739490619.872 [NAL9602](INFO): SBD MO Status=0, MOMSN=12660, MT Status=0, MTMSN=0
2025-02-13T23:50:19.872Z,1739490619.872 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:50:22.336Z,1739490622.336 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:50:22.337Z,1739490622.337 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-13T23:50:22.337Z,1739490622.337 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:50:22.584Z,1739490622.584 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:50:22.727Z,1739490622.727 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:50:22.727Z,1739490622.727 [ElevatorServo](INFO): Powering down
2025-02-13T23:50:23.520Z,1739490623.520 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:50:23.633Z,1739490623.633 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:50:23.776Z,1739490623.776 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-13T23:50:23.777Z,1739490623.777 [ElevatorServo] No Fault, FailCount= 2
2025-02-13T23:50:28.805Z,1739490628.805 [ElevatorServo](FAULT): Overload Error
2025-02-13T23:50:28.805Z,1739490628.805 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-13T23:50:28.805Z,1739490628.805 [ElevatorServo](ERROR): Hardware Fault
2025-02-13T23:50:29.061Z,1739490629.061 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-13T23:50:29.061Z,1739490629.061 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-13T23:50:29.192Z,1739490629.192 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-13T23:50:29.196Z,1739490629.196 [ElevatorServo](INFO): Powering down
2025-02-13T23:50:29.334Z,1739490629.334 [CBIT](INFO): Critical error at 20250213T235029
2025-02-13T23:50:29.985Z,1739490629.985 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-13T23:50:30.101Z,1739490630.101 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-13T23:50:50.576Z,1739490650.576 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-13T23:52:53.399Z,1739490773.399 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging
2025-02-13T23:54:36.435Z,1739490876.435 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-13T23:54:36.435Z,1739490876.435 [Default:CheckIn:C.Wait] Stopped
2025-02-13T23:54:36.435Z,1739490876.435 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-13T23:54:36.435Z,1739490876.435 [Default:CheckIn:D] Running Loop=1
2025-02-13T23:54:36.839Z,1739490876.839 [Default:CheckIn:D] Stopped
2025-02-13T23:54:36.839Z,1739490876.839 [Default:CheckIn:E] Running Loop=1
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.907406 min
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn:E] Stopped
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn] Stopped
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn](INFO): Running loop #13
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn] Running Loop=13
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-13T23:54:37.237Z,1739490877.237 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-13T23:54:39.246Z,1739490879.246 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235438.00,A,3648.16180,N,12147.27953,W,0.991,180.53,130225,,,A*72
2025-02-13T23:54:39.249Z,1739490879.249 [NAL9602](INFO): GPS fix at 20250213T235438: (36.802697, -121.787992)
2025-02-13T23:54:39.259Z,1739490879.259 [Default:CheckIn:Read_GPS] Stopped
2025-02-13T23:54:39.259Z,1739490879.259 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-13T23:54:46.688Z,1739490886.688 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20250213T223236/Courier0049.lzma
2025-02-13T23:54:47.694Z,1739490887.694 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0049.lzma.bak
2025-02-13T23:54:47.695Z,1739490887.695 [DataOverHttps](INFO): SBD MOMSN=23965781
2025-02-13T23:55:05.713Z,1739490905.713 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20250213T223236/Express0050.lzma
2025-02-13T23:55:06.582Z,1739490906.582 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0050.lzma.bak
2025-02-13T23:55:06.582Z,1739490906.582 [DataOverHttps](INFO): SBD MOMSN=23965786
2025-02-13T23:55:08.041Z,1739490908.041 [Default:CheckIn:Read_Iridium] Stopped
2025-02-13T23:55:08.041Z,1739490908.041 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-13T23:55:08.041Z,1739490908.041 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-13T23:58:04.195Z,1739491084.195 [NAL9602](INFO): SBD MO Status=2, MOMSN=12661, MT Status=2, MTMSN=0
2025-02-13T23:58:04.195Z,1739491084.195 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:58:19.954Z,1739491099.954 [NAL9602](INFO): SBD MO Status=2, MOMSN=12661, MT Status=2, MTMSN=0
2025-02-13T23:58:19.954Z,1739491099.954 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-13T23:58:41.783Z,1739491121.783 [NAL9602](INFO): SBD MO Status=0, MOMSN=12661, MT Status=0, MTMSN=0
2025-02-13T23:58:41.783Z,1739491121.783 [NAL9602](INFO): No messages in MT queue
2025-02-13T23:59:12.477Z,1739491152.477 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-14T00:00:08.647Z,1739491208.647 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-14T00:00:08.647Z,1739491208.647 [Default:CheckIn:C.Wait] Stopped
2025-02-14T00:00:08.647Z,1739491208.647 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-14T00:00:08.647Z,1739491208.647 [Default:CheckIn:D] Running Loop=1
2025-02-14T00:00:09.050Z,1739491209.050 [Default:CheckIn:D] Stopped
2025-02-14T00:00:09.050Z,1739491209.050 [Default:CheckIn:E] Running Loop=1
2025-02-14T00:00:09.447Z,1739491209.447 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.444263 min
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn:E] Stopped
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn] Stopped
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn](INFO): Running loop #14
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn] Running Loop=14
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-14T00:00:09.448Z,1739491209.448 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-14T00:00:11.459Z,1739491211.459 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000010.00,A,3648.16852,N,12147.27549,W,0.194,180.53,140225,,,A*73
2025-02-14T00:00:11.461Z,1739491211.461 [NAL9602](INFO): GPS fix at 20250214T000010: (36.802809, -121.787925)
2025-02-14T00:00:11.472Z,1739491211.472 [Default:CheckIn:Read_GPS] Stopped
2025-02-14T00:00:11.472Z,1739491211.472 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-14T00:00:19.560Z,1739491219.560 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250213T223236/Courier0052.lzma
2025-02-14T00:00:20.562Z,1739491220.562 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0052.lzma.bak
2025-02-14T00:00:20.563Z,1739491220.563 [DataOverHttps](INFO): SBD MOMSN=23965796
2025-02-14T00:00:26.852Z,1739491226.852 [NAL9602](INFO): SBD MO Status=0, MOMSN=12662, MT Status=0, MTMSN=0
2025-02-14T00:00:26.852Z,1739491226.852 [NAL9602](INFO): No messages in MT queue
2025-02-14T00:00:38.308Z,1739491238.308 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20250213T223236/Express0053.lzma
2025-02-14T00:00:39.310Z,1739491239.310 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0053.lzma.bak
2025-02-14T00:00:39.311Z,1739491239.311 [DataOverHttps](INFO): SBD MOMSN=23965799
2025-02-14T00:00:40.584Z,1739491240.584 [Default:CheckIn:Read_Iridium] Stopped
2025-02-14T00:00:40.584Z,1739491240.584 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-14T00:00:40.584Z,1739491240.584 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-14T00:00:57.534Z,1739491257.534 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-14T00:02:51.087Z,1739491371.087 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-02-14T00:02:51.088Z,1739491371.088 [DropWeight] Hardware Fault, FailCount= 1
2025-02-14T00:02:51.088Z,1739491371.088 [DropWeight](ERROR): Hardware Fault
2025-02-14T00:02:51.254Z,1739491371.254 [CBIT](INFO): Critical error at 20250214T000251
2025-02-14T00:02:51.257Z,1739491371.257 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-02-14T00:02:51.257Z,1739491371.257 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-02-14T00:02:51.667Z,1739491371.667 [CBIT](INFO): Critical error at 20250214T000251
2025-02-14T00:04:33.877Z,1739491473.877 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:04:33.877Z,1739491473.877 [RudderServo] No Fault, FailCount= 3
2025-02-14T00:04:38.328Z,1739491478.328 [RudderServo](FAULT): Overload Error
2025-02-14T00:04:38.329Z,1739491478.329 [RudderServo] Hardware Fault, FailCount= 1
2025-02-14T00:04:38.329Z,1739491478.329 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:04:38.445Z,1739491478.445 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:04:38.709Z,1739491478.709 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:04:38.709Z,1739491478.709 [RudderServo](INFO): Powering down
2025-02-14T00:04:39.501Z,1739491479.501 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:04:39.623Z,1739491479.623 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:04:39.628Z,1739491479.628 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:04:39.628Z,1739491479.628 [RudderServo] No Fault, FailCount= 1
2025-02-14T00:04:44.817Z,1739491484.817 [RudderServo](FAULT): Overload Error
2025-02-14T00:04:44.817Z,1739491484.817 [RudderServo] Hardware Fault, FailCount= 2
2025-02-14T00:04:44.817Z,1739491484.817 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:04:44.921Z,1739491484.921 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:04:45.190Z,1739491485.190 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:04:45.190Z,1739491485.190 [RudderServo](INFO): Powering down
2025-02-14T00:04:45.986Z,1739491485.986 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:04:46.105Z,1739491486.105 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:04:46.110Z,1739491486.110 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:04:46.110Z,1739491486.110 [RudderServo] No Fault, FailCount= 2
2025-02-14T00:04:51.289Z,1739491491.289 [RudderServo](FAULT): Overload Error
2025-02-14T00:04:51.289Z,1739491491.289 [RudderServo] Hardware Fault, FailCount= 3
2025-02-14T00:04:51.289Z,1739491491.289 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:04:51.413Z,1739491491.413 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:04:51.413Z,1739491491.413 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-14T00:04:51.677Z,1739491491.677 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:04:51.677Z,1739491491.677 [RudderServo](INFO): Powering down
2025-02-14T00:04:51.680Z,1739491491.680 [CBIT](INFO): Critical error at 20250214T000451
2025-02-14T00:04:52.505Z,1739491492.505 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:04:52.625Z,1739491492.625 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:05:28.809Z,1739491528.809 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:05:28.809Z,1739491528.809 [ElevatorServo] No Fault, FailCount= 3
2025-02-14T00:05:33.149Z,1739491533.149 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:05:33.149Z,1739491533.149 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-14T00:05:33.149Z,1739491533.149 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:05:33.389Z,1739491533.389 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:05:33.517Z,1739491533.517 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:05:33.517Z,1739491533.517 [ElevatorServo](INFO): Powering down
2025-02-14T00:05:34.325Z,1739491534.325 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:05:34.441Z,1739491534.441 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:05:34.588Z,1739491534.588 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:05:34.588Z,1739491534.588 [ElevatorServo] No Fault, FailCount= 1
2025-02-14T00:05:39.616Z,1739491539.616 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:05:39.617Z,1739491539.617 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-14T00:05:39.617Z,1739491539.617 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:05:39.865Z,1739491539.865 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:05:39.992Z,1739491539.992 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:05:39.992Z,1739491539.992 [ElevatorServo](INFO): Powering down
2025-02-14T00:05:40.788Z,1739491540.788 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:05:40.905Z,1739491540.905 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:05:41.045Z,1739491541.045 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:05:41.045Z,1739491541.045 [ElevatorServo] No Fault, FailCount= 2
2025-02-14T00:05:41.188Z,1739491541.188 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-14T00:05:41.188Z,1739491541.188 [Default:CheckIn:C.Wait] Stopped
2025-02-14T00:05:41.188Z,1739491541.188 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-14T00:05:41.188Z,1739491541.188 [Default:CheckIn:D] Running Loop=1
2025-02-14T00:05:41.598Z,1739491541.598 [Default:CheckIn:D] Stopped
2025-02-14T00:05:41.598Z,1739491541.598 [Default:CheckIn:E] Running Loop=1
2025-02-14T00:05:41.995Z,1739491541.995 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 88.986727 min
2025-02-14T00:05:41.995Z,1739491541.995 [Default:CheckIn:E] Stopped
2025-02-14T00:05:41.995Z,1739491541.995 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-14T00:05:41.995Z,1739491541.995 [Default:CheckIn] Stopped
2025-02-14T00:05:41.996Z,1739491541.996 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-14T00:05:41.996Z,1739491541.996 [Default:CheckIn](INFO): Running loop #15
2025-02-14T00:05:41.996Z,1739491541.996 [Default:CheckIn] Running Loop=15
2025-02-14T00:05:41.996Z,1739491541.996 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-14T00:05:41.996Z,1739491541.996 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-14T00:05:46.081Z,1739491546.081 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:05:46.081Z,1739491546.081 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-14T00:05:46.081Z,1739491546.081 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:05:46.321Z,1739491546.321 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:05:46.321Z,1739491546.321 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-14T00:05:46.462Z,1739491546.462 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:05:46.462Z,1739491546.462 [ElevatorServo](INFO): Powering down
2025-02-14T00:05:46.591Z,1739491546.591 [CBIT](INFO): Critical error at 20250214T000546
2025-02-14T00:05:47.266Z,1739491547.266 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:05:47.385Z,1739491547.385 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:07:11.278Z,1739491631.278 [NAL9602](INFO): SBD MO Status=2, MOMSN=12663, MT Status=2, MTMSN=0
2025-02-14T00:07:11.278Z,1739491631.278 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-14T00:07:49.260Z,1739491669.260 [NAL9602](INFO): SBD MO Status=2, MOMSN=12663, MT Status=2, MTMSN=0
2025-02-14T00:07:49.260Z,1739491669.260 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-14T00:09:14.534Z,1739491754.534 [NAL9602](INFO): SBD MO Status=2, MOMSN=12663, MT Status=2, MTMSN=0
2025-02-14T00:09:14.534Z,1739491754.534 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-14T00:10:30.096Z,1739491830.096 [NAL9602](INFO): SBD MO Status=2, MOMSN=12663, MT Status=2, MTMSN=0
2025-02-14T00:10:30.096Z,1739491830.096 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-14T00:10:42.231Z,1739491842.231 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-14T00:05:41.0Z
2025-02-14T00:10:42.231Z,1739491842.231 [Default:CheckIn:Read_GPS] Stopped
2025-02-14T00:10:42.231Z,1739491842.231 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-14T00:10:46.649Z,1739491846.649 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-14T00:10:50.869Z,1739491850.869 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250213T223236/Courier0055.lzma
2025-02-14T00:10:51.870Z,1739491851.870 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0055.lzma.bak
2025-02-14T00:10:51.871Z,1739491851.871 [DataOverHttps](INFO): SBD MOMSN=23965803
2025-02-14T00:11:12.248Z,1739491872.248 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20250213T223236/Express0056.lzma
2025-02-14T00:11:13.250Z,1739491873.250 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0056.lzma.bak
2025-02-14T00:11:13.251Z,1739491873.251 [DataOverHttps](INFO): SBD MOMSN=23965809
2025-02-14T00:11:14.600Z,1739491874.600 [Default:CheckIn:Read_Iridium] Stopped
2025-02-14T00:11:14.600Z,1739491874.600 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-14T00:11:14.600Z,1739491874.600 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-14T00:11:17.425Z,1739491877.425 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-14T00:16:15.059Z,1739492175.059 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-14T00:16:15.059Z,1739492175.059 [Default:CheckIn:C.Wait] Stopped
2025-02-14T00:16:15.059Z,1739492175.059 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-14T00:16:15.059Z,1739492175.059 [Default:CheckIn:D] Running Loop=1
2025-02-14T00:16:15.477Z,1739492175.477 [Default:CheckIn:D] Stopped
2025-02-14T00:16:15.477Z,1739492175.477 [Default:CheckIn:E] Running Loop=1
2025-02-14T00:16:15.870Z,1739492175.870 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 99.551375 min
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn:E] Stopped
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn] Stopped
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn](INFO): Running loop #16
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn] Running Loop=16
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-14T00:16:15.871Z,1739492175.871 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-14T00:16:17.472Z,1739492177.472 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-14T00:16:17.473Z,1739492177.473 [NAL9602] Data Fault, FailCount= 1
2025-02-14T00:16:17.473Z,1739492177.473 [NAL9602](ERROR): Data Fault
2025-02-14T00:16:17.629Z,1739492177.629 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-14T00:16:17.893Z,1739492177.893 [NAL9602](INFO): Powering down
2025-02-14T00:16:18.890Z,1739492178.890 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-14T00:16:18.890Z,1739492178.890 [NAL9602] No Fault, FailCount= 1
2025-02-14T00:16:48.185Z,1739492208.185 [NAL9602](INFO): Powering up NAL9602
2025-02-14T00:16:59.091Z,1739492219.091 [NAL9602](INFO): NAL9602 initialized
2025-02-14T00:17:25.758Z,1739492245.758 [NAL9602](INFO): SBD MO Status=0, MOMSN=12663, MT Status=0, MTMSN=0
2025-02-14T00:17:25.758Z,1739492245.758 [NAL9602](INFO): No messages in MT queue
2025-02-14T00:17:51.364Z,1739492271.364 [CBIT](INFO): Clearing failed state for component DropWeight
2025-02-14T00:17:51.364Z,1739492271.364 [DropWeight] No Fault, FailCount= 1
2025-02-14T00:18:00.829Z,1739492280.829 [DataOverHttps](IMPORTANT): SBD MTMSN=20250214T001759
2025-02-14T00:18:08.513Z,1739492288.513 [DataOverHttps](INFO): Received command: failc
2025-02-14T00:18:08.540Z,1739492288.540 [CommandExec](IMPORTANT): got command failComponent
2025-02-14T00:18:08.541Z,1739492288.541 [CommandExec](IMPORTANT): Failed components:
2025-02-14T00:18:08.541Z,1739492288.541 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2025-02-14T00:18:08.541Z,1739492288.541 [CommandExec](IMPORTANT): RudderServo: Hardware Fault
2025-02-14T00:19:51.428Z,1739492391.428 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:19:51.428Z,1739492391.428 [RudderServo] No Fault, FailCount= 3
2025-02-14T00:19:55.864Z,1739492395.864 [RudderServo](FAULT): Overload Error
2025-02-14T00:19:55.864Z,1739492395.864 [RudderServo] Hardware Fault, FailCount= 1
2025-02-14T00:19:55.864Z,1739492395.864 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:19:55.966Z,1739492395.966 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:19:56.253Z,1739492396.253 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:19:56.253Z,1739492396.253 [RudderServo](INFO): Powering down
2025-02-14T00:19:57.065Z,1739492397.065 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:19:57.185Z,1739492397.185 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:19:57.189Z,1739492397.189 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:19:57.189Z,1739492397.189 [RudderServo] No Fault, FailCount= 1
2025-02-14T00:20:02.328Z,1739492402.328 [RudderServo](FAULT): Overload Error
2025-02-14T00:20:02.328Z,1739492402.328 [RudderServo] Hardware Fault, FailCount= 2
2025-02-14T00:20:02.328Z,1739492402.328 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:20:02.440Z,1739492402.440 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:20:02.729Z,1739492402.729 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:20:02.729Z,1739492402.729 [RudderServo](INFO): Powering down
2025-02-14T00:20:03.553Z,1739492403.553 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:20:03.673Z,1739492403.673 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:20:03.677Z,1739492403.677 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:20:03.677Z,1739492403.677 [RudderServo] No Fault, FailCount= 2
2025-02-14T00:20:08.832Z,1739492408.832 [RudderServo](FAULT): Overload Error
2025-02-14T00:20:08.832Z,1739492408.832 [RudderServo] Hardware Fault, FailCount= 3
2025-02-14T00:20:08.832Z,1739492408.832 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:20:08.944Z,1739492408.944 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:20:08.944Z,1739492408.944 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-14T00:20:09.229Z,1739492409.229 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:20:09.229Z,1739492409.229 [RudderServo](INFO): Powering down
2025-02-14T00:20:09.231Z,1739492409.231 [CBIT](INFO): Critical error at 20250214T002008
2025-02-14T00:20:10.033Z,1739492410.033 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:20:10.153Z,1739492410.153 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:20:46.377Z,1739492446.377 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:20:46.377Z,1739492446.377 [ElevatorServo] No Fault, FailCount= 3
2025-02-14T00:20:50.684Z,1739492450.684 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:20:50.684Z,1739492450.684 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-14T00:20:50.684Z,1739492450.684 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:20:50.944Z,1739492450.944 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:20:51.058Z,1739492451.058 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:20:51.058Z,1739492451.058 [ElevatorServo](INFO): Powering down
2025-02-14T00:20:51.943Z,1739492451.943 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:20:52.057Z,1739492452.057 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:20:52.209Z,1739492452.209 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:20:52.209Z,1739492452.209 [ElevatorServo] No Fault, FailCount= 1
2025-02-14T00:20:57.168Z,1739492457.168 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:20:57.168Z,1739492457.168 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-14T00:20:57.169Z,1739492457.169 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:20:57.434Z,1739492457.434 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:20:57.569Z,1739492457.569 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:20:57.570Z,1739492457.570 [ElevatorServo](INFO): Powering down
2025-02-14T00:20:58.401Z,1739492458.401 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:20:58.521Z,1739492458.521 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:20:58.667Z,1739492458.667 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:20:58.667Z,1739492458.667 [ElevatorServo] No Fault, FailCount= 2
2025-02-14T00:21:03.672Z,1739492463.672 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:21:03.672Z,1739492463.672 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-14T00:21:03.672Z,1739492463.672 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:21:03.937Z,1739492463.937 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:21:03.937Z,1739492463.937 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-14T00:21:04.109Z,1739492464.109 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:21:04.109Z,1739492464.109 [ElevatorServo](INFO): Powering down
2025-02-14T00:21:04.238Z,1739492464.238 [CBIT](INFO): Critical error at 20250214T002103
2025-02-14T00:21:04.853Z,1739492464.853 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:21:04.970Z,1739492464.970 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:21:08.340Z,1739492468.340 [MassServo](ERROR): getPosition uart error serial timeout
2025-02-14T00:21:08.607Z,1739492468.607 [MassServo](FAULT): Invalid EZ Servo response:"5\r"
2025-02-14T00:21:08.660Z,1739492468.660 [MassServo] Communications Fault, FailCount= 2
2025-02-14T00:21:08.660Z,1739492468.660 [MassServo](ERROR): Communications Fault
2025-02-14T00:21:08.673Z,1739492468.673 [CBIT](ERROR): Communications Fault in component: MassServo
2025-02-14T00:21:09.056Z,1739492469.056 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-02-14T00:21:09.056Z,1739492469.056 [MassServo](INFO): Powering down
2025-02-14T00:21:09.915Z,1739492469.915 [MassServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:21:10.068Z,1739492470.068 [MassServo](DEBUG): Initializing MassServo.
2025-02-14T00:21:10.102Z,1739492470.102 [CBIT](INFO): Clearing failed state for component MassServo
2025-02-14T00:21:10.102Z,1739492470.102 [MassServo] No Fault, FailCount= 2
2025-02-14T00:21:15.921Z,1739492475.921 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-14T00:16:15.9Z
2025-02-14T00:21:15.921Z,1739492475.921 [Default:CheckIn:Read_GPS] Stopped
2025-02-14T00:21:15.922Z,1739492475.922 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-14T00:21:23.658Z,1739492483.658 [DataOverHttps](INFO): Sending 103 bytes from file Logs/20250213T223236/Courier0058.lzma
2025-02-14T00:21:23.766Z,1739492483.766 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0058.lzma.bak
2025-02-14T00:21:23.766Z,1739492483.766 [DataOverHttps](INFO): SBD MOMSN=23965821
2025-02-14T00:21:47.817Z,1739492507.817 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-14T00:21:50.837Z,1739492510.837 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250213T223236/Courier0061.lzma
2025-02-14T00:21:51.838Z,1739492511.838 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0061.lzma.bak
2025-02-14T00:21:51.838Z,1739492511.838 [DataOverHttps](INFO): SBD MOMSN=23965825
2025-02-14T00:22:12.640Z,1739492532.640 [DataOverHttps](INFO): Sending 402 bytes from file Logs/20250213T223236/Express0059.lzma
2025-02-14T00:22:13.642Z,1739492533.642 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0059.lzma.bak
2025-02-14T00:22:13.643Z,1739492533.643 [DataOverHttps](INFO): SBD MOMSN=23965827
2025-02-14T00:22:34.652Z,1739492554.652 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250213T223236/Express0062.lzma
2025-02-14T00:22:35.654Z,1739492555.654 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0062.lzma.bak
2025-02-14T00:22:35.655Z,1739492555.655 [DataOverHttps](INFO): SBD MOMSN=23965844
2025-02-14T00:22:37.195Z,1739492557.195 [Default:CheckIn:Read_Iridium] Stopped
2025-02-14T00:22:37.196Z,1739492557.196 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-14T00:22:37.196Z,1739492557.196 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-14T00:24:47.835Z,1739492687.835 [DataOverHttps](IMPORTANT): SBD MTMSN=20250214T002446
2025-02-14T00:24:56.976Z,1739492696.976 [DataOverHttps](INFO): Received command: failc
2025-02-14T00:24:57.041Z,1739492697.041 [CommandExec](IMPORTANT): got command failComponent
2025-02-14T00:24:57.041Z,1739492697.041 [CommandExec](IMPORTANT): Failed components:
2025-02-14T00:24:57.041Z,1739492697.041 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault
2025-02-14T00:24:57.041Z,1739492697.041 [CommandExec](IMPORTANT): RudderServo: Hardware Fault
2025-02-14T00:27:37.913Z,1739492857.913 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-14T00:27:37.913Z,1739492857.913 [Default:CheckIn:C.Wait] Stopped
2025-02-14T00:27:37.913Z,1739492857.913 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-14T00:27:37.913Z,1739492857.913 [Default:CheckIn:D] Running Loop=1
2025-02-14T00:27:38.305Z,1739492858.305 [Default:CheckIn:D] Stopped
2025-02-14T00:27:38.306Z,1739492858.306 [Default:CheckIn:E] Running Loop=1
2025-02-14T00:27:38.715Z,1739492858.715 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 110.931852 min
2025-02-14T00:27:38.715Z,1739492858.715 [Default:CheckIn:E] Stopped
2025-02-14T00:27:38.715Z,1739492858.715 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-14T00:27:38.715Z,1739492858.715 [Default:CheckIn] Stopped
2025-02-14T00:27:38.715Z,1739492858.715 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-14T00:27:38.716Z,1739492858.716 [Default:CheckIn](INFO): Running loop #17
2025-02-14T00:27:38.716Z,1739492858.716 [Default:CheckIn] Running Loop=17
2025-02-14T00:27:38.716Z,1739492858.716 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-14T00:27:38.716Z,1739492858.716 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-14T00:27:40.318Z,1739492860.318 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-14T00:27:40.318Z,1739492860.318 [NAL9602] Data Fault, FailCount= 1
2025-02-14T00:27:40.318Z,1739492860.318 [NAL9602](ERROR): Data Fault
2025-02-14T00:27:40.497Z,1739492860.497 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-14T00:27:40.723Z,1739492860.723 [NAL9602](INFO): Powering down
2025-02-14T00:27:41.716Z,1739492861.716 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-14T00:27:41.716Z,1739492861.716 [NAL9602] No Fault, FailCount= 1
2025-02-14T00:28:11.029Z,1739492891.029 [NAL9602](INFO): Powering up NAL9602
2025-02-14T00:28:21.933Z,1739492901.933 [NAL9602](INFO): NAL9602 initialized
2025-02-14T00:29:34.250Z,1739492974.250 [NAL9602](INFO): SBD MO Status=2, MOMSN=12664, MT Status=2, MTMSN=0
2025-02-14T00:29:34.250Z,1739492974.250 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-14T00:32:38.911Z,1739493158.911 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-14T00:27:38.7Z
2025-02-14T00:32:38.911Z,1739493158.911 [Default:CheckIn:Read_GPS] Stopped
2025-02-14T00:32:38.911Z,1739493158.911 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-14T00:32:46.943Z,1739493166.943 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250213T223236/Courier0064.lzma
2025-02-14T00:32:47.946Z,1739493167.946 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0064.lzma.bak
2025-02-14T00:32:47.946Z,1739493167.946 [DataOverHttps](INFO): SBD MOMSN=23965848
2025-02-14T00:33:07.763Z,1739493187.763 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250213T223236/Courier0067.lzma
2025-02-14T00:33:08.766Z,1739493188.766 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Courier0067.lzma.bak
2025-02-14T00:33:08.767Z,1739493188.767 [DataOverHttps](INFO): SBD MOMSN=23965850
2025-02-14T00:33:25.509Z,1739493205.509 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-14T00:33:27.253Z,1739493207.253 [DataOverHttps](INFO): Sending 275 bytes from file Logs/20250213T223236/Express0065.lzma
2025-02-14T00:33:28.258Z,1739493208.258 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0065.lzma.bak
2025-02-14T00:33:28.258Z,1739493208.258 [DataOverHttps](INFO): SBD MOMSN=23965852
2025-02-14T00:33:45.049Z,1739493225.049 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250213T223236/Express0068.lzma
2025-02-14T00:33:46.046Z,1739493226.046 [DataOverHttps](INFO): Moved sent file to Logs/20250213T223236/Express0068.lzma.bak
2025-02-14T00:33:46.046Z,1739493226.046 [DataOverHttps](INFO): SBD MOMSN=23965861
2025-02-14T00:33:47.328Z,1739493227.328 [Default:CheckIn:Read_Iridium] Stopped
2025-02-14T00:33:47.329Z,1739493227.329 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-14T00:33:47.329Z,1739493227.329 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-14T00:33:56.208Z,1739493236.208 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-14T00:35:09.088Z,1739493309.088 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:35:09.089Z,1739493309.089 [RudderServo] No Fault, FailCount= 3
2025-02-14T00:35:13.572Z,1739493313.572 [RudderServo](FAULT): Overload Error
2025-02-14T00:35:13.572Z,1739493313.572 [RudderServo] Hardware Fault, FailCount= 1
2025-02-14T00:35:13.572Z,1739493313.572 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:35:13.676Z,1739493313.676 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:35:13.925Z,1739493313.925 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:35:13.925Z,1739493313.925 [RudderServo](INFO): Powering down
2025-02-14T00:35:14.757Z,1739493314.757 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:35:14.877Z,1739493314.877 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:35:14.881Z,1739493314.881 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:35:14.881Z,1739493314.881 [RudderServo] No Fault, FailCount= 1
2025-02-14T00:35:20.024Z,1739493320.024 [RudderServo](FAULT): Overload Error
2025-02-14T00:35:20.024Z,1739493320.024 [RudderServo] Hardware Fault, FailCount= 2
2025-02-14T00:35:20.024Z,1739493320.024 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:35:20.140Z,1739493320.140 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:35:20.424Z,1739493320.424 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:35:20.424Z,1739493320.424 [RudderServo](INFO): Powering down
2025-02-14T00:35:21.249Z,1739493321.249 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:35:21.365Z,1739493321.365 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:35:21.369Z,1739493321.369 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:35:21.369Z,1739493321.369 [RudderServo] No Fault, FailCount= 2
2025-02-14T00:35:26.496Z,1739493326.496 [RudderServo](FAULT): Overload Error
2025-02-14T00:35:26.496Z,1739493326.496 [RudderServo] Hardware Fault, FailCount= 3
2025-02-14T00:35:26.496Z,1739493326.496 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:35:26.612Z,1739493326.612 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:35:26.612Z,1739493326.612 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-14T00:35:26.869Z,1739493326.869 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:35:26.869Z,1739493326.869 [RudderServo](INFO): Powering down
2025-02-14T00:35:26.871Z,1739493326.871 [CBIT](INFO): Critical error at 20250214T003526
2025-02-14T00:35:27.685Z,1739493327.685 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:35:27.806Z,1739493327.806 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:36:04.056Z,1739493364.056 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:36:04.056Z,1739493364.056 [ElevatorServo] No Fault, FailCount= 3
2025-02-14T00:36:08.384Z,1739493368.384 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:36:08.384Z,1739493368.384 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-14T00:36:08.384Z,1739493368.384 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:36:08.626Z,1739493368.626 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:36:08.771Z,1739493368.771 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:36:08.771Z,1739493368.771 [ElevatorServo](INFO): Powering down
2025-02-14T00:36:09.570Z,1739493369.570 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:36:09.689Z,1739493369.689 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:36:09.828Z,1739493369.828 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:36:09.828Z,1739493369.828 [ElevatorServo] No Fault, FailCount= 1
2025-02-14T00:36:14.868Z,1739493374.868 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:36:14.869Z,1739493374.869 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-14T00:36:14.869Z,1739493374.869 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:36:15.116Z,1739493375.116 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:36:15.233Z,1739493375.233 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:36:15.233Z,1739493375.233 [ElevatorServo](INFO): Powering down
2025-02-14T00:36:16.040Z,1739493376.040 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:36:16.157Z,1739493376.157 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:36:16.297Z,1739493376.297 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:36:16.298Z,1739493376.298 [ElevatorServo] No Fault, FailCount= 2
2025-02-14T00:36:21.316Z,1739493381.316 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:36:21.316Z,1739493381.316 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-14T00:36:21.316Z,1739493381.316 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:36:21.552Z,1739493381.552 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:36:21.553Z,1739493381.553 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-14T00:36:21.694Z,1739493381.694 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:36:21.694Z,1739493381.694 [ElevatorServo](INFO): Powering down
2025-02-14T00:36:21.842Z,1739493381.842 [CBIT](INFO): Critical error at 20250214T003621
2025-02-14T00:36:22.530Z,1739493382.530 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:36:22.645Z,1739493382.645 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:38:29.950Z,1739493509.950 [DataOverHttps](IMPORTANT): SBD MTMSN=20250214T003828
2025-02-14T00:38:37.813Z,1739493517.813 [DataOverHttps](INFO): Received command: configSet Normal none depth persist
2025-02-14T00:38:38.090Z,1739493518.090 [CommandExec](IMPORTANT): got command configSet Normal none depth persist
2025-02-14T00:38:47.935Z,1739493527.935 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-14T00:38:47.935Z,1739493527.935 [Default:CheckIn:C.Wait] Stopped
2025-02-14T00:38:47.935Z,1739493527.935 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-14T00:38:47.935Z,1739493527.935 [Default:CheckIn:D] Running Loop=1
2025-02-14T00:38:48.339Z,1739493528.339 [Default:CheckIn:D] Stopped
2025-02-14T00:38:48.339Z,1739493528.339 [Default:CheckIn:E] Running Loop=1
2025-02-14T00:38:48.746Z,1739493528.746 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 122.099080 min
2025-02-14T00:38:48.746Z,1739493528.746 [Default:CheckIn:E] Stopped
2025-02-14T00:38:48.746Z,1739493528.746 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-14T00:38:48.746Z,1739493528.746 [Default:CheckIn] Stopped
2025-02-14T00:38:48.746Z,1739493528.746 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-14T00:38:48.747Z,1739493528.747 [Default:CheckIn](INFO): Running loop #18
2025-02-14T00:38:48.747Z,1739493528.747 [Default:CheckIn] Running Loop=18
2025-02-14T00:38:48.747Z,1739493528.747 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-14T00:38:48.747Z,1739493528.747 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-14T00:38:50.350Z,1739493530.350 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-14T00:38:50.350Z,1739493530.350 [NAL9602] Data Fault, FailCount= 2
2025-02-14T00:38:50.350Z,1739493530.350 [NAL9602](ERROR): Data Fault
2025-02-14T00:38:50.504Z,1739493530.504 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-14T00:38:50.753Z,1739493530.753 [NAL9602](INFO): Powering down
2025-02-14T00:38:51.725Z,1739493531.725 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-14T00:38:51.725Z,1739493531.725 [NAL9602] No Fault, FailCount= 2
2025-02-14T00:39:21.077Z,1739493561.077 [NAL9602](INFO): Powering up NAL9602
2025-02-14T00:39:31.977Z,1739493571.977 [NAL9602](INFO): NAL9602 initialized
2025-02-14T00:42:06.874Z,1739493726.874 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:42:38.012Z,1739493758.012 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:43:09.136Z,1739493789.136 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:43:40.280Z,1739493820.280 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:43:42.289Z,1739493822.289 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.539352
2025-02-14T00:43:48.955Z,1739493828.955 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-14T00:38:48.7Z
2025-02-14T00:43:48.955Z,1739493828.955 [Default:CheckIn:Read_GPS] Stopped
2025-02-14T00:43:48.955Z,1739493828.955 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-14T00:44:35.410Z,1739493875.410 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-14T00:44:41.576Z,1739493881.576 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:45:12.700Z,1739493912.700 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:45:43.824Z,1739493943.824 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:46:14.949Z,1739493974.949 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:46:46.072Z,1739494006.072 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:47:17.200Z,1739494037.200 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:47:48.324Z,1739494068.324 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:47:52.589Z,1739494072.589 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-02-14T00:47:52.589Z,1739494072.589 [DropWeight] Hardware Fault, FailCount= 1
2025-02-14T00:47:52.589Z,1739494072.589 [DropWeight](ERROR): Hardware Fault
2025-02-14T00:47:52.766Z,1739494072.766 [CBIT](INFO): Critical error at 20250214T004752
2025-02-14T00:47:52.769Z,1739494072.769 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-02-14T00:47:52.769Z,1739494072.769 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-02-14T00:47:53.142Z,1739494073.142 [CBIT](INFO): Critical error at 20250214T004752
2025-02-14T00:48:19.456Z,1739494099.456 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:48:50.580Z,1739494130.580 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:48:59.232Z,1739494139.232 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:49:12.025Z,1739494152.025 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:49:21.724Z,1739494161.724 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:49:25.356Z,1739494165.356 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:49:37.879Z,1739494177.879 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:49:51.211Z,1739494191.211 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:49:52.848Z,1739494192.848 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:50:04.543Z,1739494204.543 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:50:17.067Z,1739494217.067 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-14T00:50:23.976Z,1739494223.976 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:50:26.533Z,1739494226.533 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:50:26.533Z,1739494226.533 [RudderServo] No Fault, FailCount= 3
2025-02-14T00:50:31.040Z,1739494231.040 [RudderServo](FAULT): Overload Error
2025-02-14T00:50:31.040Z,1739494231.040 [RudderServo] Hardware Fault, FailCount= 1
2025-02-14T00:50:31.040Z,1739494231.040 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:50:31.145Z,1739494231.145 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:50:31.481Z,1739494231.481 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:50:31.481Z,1739494231.481 [RudderServo](INFO): Powering down
2025-02-14T00:50:32.197Z,1739494232.197 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:50:32.326Z,1739494232.326 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:50:32.331Z,1739494232.331 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:50:32.331Z,1739494232.331 [RudderServo] No Fault, FailCount= 1
2025-02-14T00:50:37.464Z,1739494237.464 [RudderServo](FAULT): Overload Error
2025-02-14T00:50:37.464Z,1739494237.464 [RudderServo] Hardware Fault, FailCount= 2
2025-02-14T00:50:37.464Z,1739494237.464 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:50:37.577Z,1739494237.577 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:50:37.929Z,1739494237.929 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:50:37.929Z,1739494237.929 [RudderServo](INFO): Powering down
2025-02-14T00:50:38.629Z,1739494238.629 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:50:38.749Z,1739494238.749 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:50:38.753Z,1739494238.753 [CBIT](INFO): Clearing failed state for component RudderServo
2025-02-14T00:50:38.754Z,1739494238.754 [RudderServo] No Fault, FailCount= 2
2025-02-14T00:50:44.000Z,1739494244.000 [RudderServo](FAULT): Overload Error
2025-02-14T00:50:44.000Z,1739494244.000 [RudderServo] Hardware Fault, FailCount= 3
2025-02-14T00:50:44.000Z,1739494244.000 [RudderServo](ERROR): Hardware Fault
2025-02-14T00:50:44.105Z,1739494244.105 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-02-14T00:50:44.105Z,1739494244.105 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2025-02-14T00:50:44.457Z,1739494244.457 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:50:44.457Z,1739494244.457 [RudderServo](INFO): Powering down
2025-02-14T00:50:44.459Z,1739494244.459 [CBIT](INFO): Critical error at 20250214T005044
2025-02-14T00:50:45.157Z,1739494245.157 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:50:45.277Z,1739494245.277 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-14T00:50:55.101Z,1739494255.101 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:51:21.508Z,1739494281.508 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:51:21.508Z,1739494281.508 [ElevatorServo] No Fault, FailCount= 3
2025-02-14T00:51:25.864Z,1739494285.864 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:51:25.864Z,1739494285.864 [ElevatorServo] Hardware Fault, FailCount= 1
2025-02-14T00:51:25.864Z,1739494285.864 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:51:26.105Z,1739494286.105 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:51:26.219Z,1739494286.219 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:51:26.219Z,1739494286.219 [ElevatorServo](INFO): Powering down
2025-02-14T00:51:26.232Z,1739494286.232 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:51:27.172Z,1739494287.172 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:51:27.289Z,1739494287.289 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:51:27.428Z,1739494287.428 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:51:27.428Z,1739494287.428 [ElevatorServo] No Fault, FailCount= 1
2025-02-14T00:51:32.348Z,1739494292.348 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:51:32.348Z,1739494292.348 [ElevatorServo] Hardware Fault, FailCount= 2
2025-02-14T00:51:32.348Z,1739494292.348 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:51:32.588Z,1739494292.588 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:51:32.713Z,1739494292.713 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:51:32.713Z,1739494292.713 [ElevatorServo](INFO): Powering down
2025-02-14T00:51:33.626Z,1739494293.626 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:51:33.745Z,1739494293.745 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:51:33.884Z,1739494293.884 [CBIT](INFO): Clearing failed state for component ElevatorServo
2025-02-14T00:51:33.884Z,1739494293.884 [ElevatorServo] No Fault, FailCount= 2
2025-02-14T00:51:38.812Z,1739494298.812 [ElevatorServo](FAULT): Overload Error
2025-02-14T00:51:38.812Z,1739494298.812 [ElevatorServo] Hardware Fault, FailCount= 3
2025-02-14T00:51:38.812Z,1739494298.812 [ElevatorServo](ERROR): Hardware Fault
2025-02-14T00:51:39.044Z,1739494299.044 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2025-02-14T00:51:39.045Z,1739494299.045 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2025-02-14T00:51:39.201Z,1739494299.201 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:51:39.201Z,1739494299.201 [ElevatorServo](INFO): Powering down
2025-02-14T00:51:39.326Z,1739494299.326 [CBIT](INFO): Critical error at 20250214T005139
2025-02-14T00:51:40.074Z,1739494300.074 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-14T00:51:40.198Z,1739494300.198 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-14T00:51:57.372Z,1739494317.372 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:52:28.506Z,1739494348.506 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:52:59.628Z,1739494379.628 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:53:30.769Z,1739494410.769 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:54:01.896Z,1739494441.896 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:54:33.020Z,1739494473.020 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:55:04.157Z,1739494504.157 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:55:24.185Z,1739494524.185 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2025-02-14T00:55:25.402Z,1739494525.402 [BPC1](FAULT): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-02-14T00:55:25.403Z,1739494525.403 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 6.
2025-02-14T00:55:25.406Z,1739494525.406 [BPC1](INFO): Received data from all battery sticks.
2025-02-14T00:55:35.280Z,1739494535.280 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:56:06.407Z,1739494566.407 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-14T00:56:09.085Z,1739494569.085 [CommandExec](IMPORTANT): got command quit
2025-02-14T00:56:10.092Z,1739494570.092 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:10.092Z,1739494570.092 [CommandExec](INFO): Uninitializing the command executive.
2025-02-14T00:56:10.092Z,1739494570.092 [CommandExec](INFO): Uninitializing the command scheduler.
2025-02-14T00:56:10.093Z,1739494570.093 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.288Z,1739494570.288 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-02-14T00:56:10.288Z,1739494570.288 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-02-14T00:56:10.288Z,1739494570.288 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.289Z,1739494570.289 [NavChartDb](INFO): Join timeout helper Thread ID is 6332
2025-02-14T00:56:10.476Z,1739494570.476 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:10.477Z,1739494570.477 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.488Z,1739494570.488 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-02-14T00:56:10.488Z,1739494570.488 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.489Z,1739494570.489 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6333
2025-02-14T00:56:10.670Z,1739494570.670 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:10.670Z,1739494570.670 [WetLabsBB2FL](INFO): Powering down
2025-02-14T00:56:10.671Z,1739494570.671 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.688Z,1739494570.688 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-02-14T00:56:10.688Z,1739494570.688 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.689Z,1739494570.689 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6334
2025-02-14T00:56:10.941Z,1739494570.941 [CTD_Seabird](INFO): Powering down
2025-02-14T00:56:10.956Z,1739494570.956 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:10.956Z,1739494570.956 [CTD_Seabird](INFO): Powering down
2025-02-14T00:56:10.968Z,1739494570.968 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.976Z,1739494570.976 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-02-14T00:56:10.976Z,1739494570.976 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:10.977Z,1739494570.977 [Radio_Surface](INFO): Join timeout helper Thread ID is 6335
2025-02-14T00:56:11.300Z,1739494571.300 [Radio_Surface](INFO): Powering down
2025-02-14T00:56:11.301Z,1739494571.301 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:11.301Z,1739494571.301 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:11.313Z,1739494571.313 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-02-14T00:56:11.313Z,1739494571.313 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:11.313Z,1739494571.313 [Onboard](INFO): Join timeout helper Thread ID is 6336
2025-02-14T00:56:15.568Z,1739494575.568 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:15.569Z,1739494575.569 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:15.573Z,1739494575.573 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-02-14T00:56:15.574Z,1739494575.574 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:15.574Z,1739494575.574 [DataOverHttps](INFO): Join timeout helper Thread ID is 6337
2025-02-14T00:56:16.024Z,1739494576.024 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:16.027Z,1739494576.027 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.037Z,1739494576.037 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-02-14T00:56:16.037Z,1739494576.037 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.037Z,1739494576.037 [BackseatComponent](INFO): Join timeout helper Thread ID is 6338
2025-02-14T00:56:16.200Z,1739494576.200 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:16.201Z,1739494576.201 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.209Z,1739494576.209 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-02-14T00:56:16.209Z,1739494576.209 [logger ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.210Z,1739494576.210 [logger](INFO): Join timeout helper Thread ID is 6339
2025-02-14T00:56:16.248Z,1739494576.248 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:16.249Z,1739494576.249 [logger ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.269Z,1739494576.269 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-02-14T00:56:16.269Z,1739494576.269 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.269Z,1739494576.269 [CommandLine](INFO): Join timeout helper Thread ID is 6340
2025-02-14T00:56:16.276Z,1739494576.276 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:16.277Z,1739494576.277 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.297Z,1739494576.297 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-02-14T00:56:16.297Z,1739494576.297 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.297Z,1739494576.297 [CommandExec](INFO): Join timeout helper Thread ID is 6341
2025-02-14T00:56:16.305Z,1739494576.305 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-02-14T00:56:16.305Z,1739494576.305 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.305Z,1739494576.305 [controlThread](INFO): Join timeout helper Thread ID is 6342
2025-02-14T00:56:16.463Z,1739494576.463 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-02-14T00:56:16.463Z,1739494576.463 [controlThread](DEBUG): Uninitializing ControlThread
2025-02-14T00:56:16.463Z,1739494576.463 [AHRS_M2](INFO): Powering down
2025-02-14T00:56:16.537Z,1739494576.537 [NAL9602](INFO): Powering down
2025-02-14T00:56:16.538Z,1739494576.538 [Sonardyne_Nano](INFO): Powering down
2025-02-14T00:56:16.657Z,1739494576.657 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-02-14T00:56:16.658Z,1739494576.658 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-02-14T00:56:16.658Z,1739494576.658 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-02-14T00:56:16.659Z,1739494576.659 [MissionManager](INFO): Uninitializing Mission Default
2025-02-14T00:56:16.659Z,1739494576.659 [Default] Stopped
2025-02-14T00:56:16.659Z,1739494576.659 [Default](DEBUG): Aggregate::uninitialize Default
2025-02-14T00:56:16.659Z,1739494576.659 [Default:B.GoToSurface] Stopped
2025-02-14T00:56:16.659Z,1739494576.659 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-14T00:56:16.659Z,1739494576.659 [Default:CheckIn] Stopped
2025-02-14T00:56:16.659Z,1739494576.659 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-14T00:56:16.659Z,1739494576.659 [Default:CheckIn:Read_Iridium] Stopped
2025-02-14T00:56:16.662Z,1739494576.662 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-02-14T00:56:16.662Z,1739494576.662 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-02-14T00:56:16.663Z,1739494576.663 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-02-14T00:56:16.663Z,1739494576.663 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-02-14T00:56:16.663Z,1739494576.663 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-02-14T00:56:16.663Z,1739494576.663 [BuoyancyServo](INFO): Powering down
2025-02-14T00:56:16.676Z,1739494576.676 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-02-14T00:56:16.676Z,1739494576.676 [ElevatorServo](INFO): Powering down
2025-02-14T00:56:16.677Z,1739494576.677 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-02-14T00:56:16.677Z,1739494576.677 [MassServo](INFO): Powering down
2025-02-14T00:56:16.678Z,1739494576.678 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-02-14T00:56:16.678Z,1739494576.678 [RudderServo](INFO): Powering down
2025-02-14T00:56:16.679Z,1739494576.679 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-02-14T00:56:16.679Z,1739494576.679 [ThrusterHE](INFO): Powering down
2025-02-14T00:56:16.680Z,1739494576.680 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-02-14T00:56:16.680Z,1739494576.680 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-02-14T00:56:16.681Z,1739494576.681 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-02-14T00:56:16.681Z,1739494576.681 [CBIT](DEBUG): Powering off loads.
2025-02-14T00:56:16.692Z,1739494576.692 [CBIT](DEBUG): Disabling WDT.
2025-02-14T00:56:16.704Z,1739494576.704 [CBIT](DEBUG): Opening all GF detection circuits.
2025-02-14T00:56:16.705Z,1739494576.705 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.727Z,1739494576.727 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.730Z,1739494576.730 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.736Z,1739494576.736 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:16.778Z,1739494576.778 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:17.227Z,1739494577.227 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:17.231Z,1739494577.231 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:17.249Z,1739494577.249 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-02-14T00:56:17.319Z,1739494577.319 [logger ThreadHandler](INFO): Thread cancelled.