2023-03-27T23:32:50.268Z,1679959970.268 [Supervisor](DEBUG): Initializing supervisor.
2023-03-27T23:32:50.273Z,1679959970.273 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-03-27T23:32:50.273Z,1679959970.273 [SyncHandler](INFO): Protected caller Thread ID is 5371
2023-03-27T23:32:50.274Z,1679959970.274 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-03-27T23:32:50.275Z,1679959970.275 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-03-27T23:32:50.276Z,1679959970.276 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5372
2023-03-27T23:32:50.280Z,1679959970.280 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-03-27T23:32:50.298Z,1679959970.298 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-03-27T23:32:50.299Z,1679959970.299 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-03-27T23:32:50.299Z,1679959970.299 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5373
2023-03-27T23:32:50.303Z,1679959970.303 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-03-27T23:32:50.304Z,1679959970.304 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-03-27T23:32:50.304Z,1679959970.304 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5374
2023-03-27T23:32:50.307Z,1679959970.307 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-03-27T23:32:50.307Z,1679959970.307 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-03-27T23:32:50.308Z,1679959970.308 [logger ThreadHandler](INFO): Protected caller Thread ID is 5375
2023-03-27T23:32:50.311Z,1679959970.311 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-03-27T23:32:50.312Z,1679959970.312 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-03-27T23:32:50.313Z,1679959970.313 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-03-27T23:32:50.829Z,1679959970.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-03-27T23:32:50.830Z,1679959970.830 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-03-27T23:32:51.036Z,1679959971.036 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-03-27T23:32:51.037Z,1679959971.037 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-03-27T23:32:51.117Z,1679959971.117 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-03-27T23:32:51.333Z,1679959971.333 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-03-27T23:32:51.334Z,1679959971.334 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-03-27T23:32:51.413Z,1679959971.413 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-03-27T23:32:51.508Z,1679959971.508 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-03-27T23:32:51.509Z,1679959971.509 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-03-27T23:32:51.840Z,1679959971.840 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-03-27T23:32:51.841Z,1679959971.841 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-03-27T23:32:51.971Z,1679959971.971 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-03-27T23:32:51.971Z,1679959971.971 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-03-27T23:32:52.454Z,1679959972.454 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-03-27T23:32:52.455Z,1679959972.455 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-03-27T23:32:52.637Z,1679959972.637 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-03-27T23:32:52.638Z,1679959972.638 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-03-27T23:32:53.031Z,1679959973.031 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-03-27T23:32:53.032Z,1679959973.032 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-03-27T23:32:53.307Z,1679959973.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-03-27T23:32:53.308Z,1679959973.308 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-03-27T23:32:53.419Z,1679959973.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-03-27T23:32:53.420Z,1679959973.420 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-03-27T23:32:54.335Z,1679959974.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-03-27T23:32:54.335Z,1679959974.335 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-03-27T23:32:55.386Z,1679959975.386 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-03-27T23:32:55.387Z,1679959975.387 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-03-27T23:32:55.604Z,1679959975.604 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-03-27T23:32:55.606Z,1679959975.606 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2023-03-27T23:32:55.607Z,1679959975.607 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2023-03-27T23:32:55.792Z,1679959975.792 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2023-03-27T23:32:55.874Z,1679959975.874 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2023-03-27T23:32:56.007Z,1679959976.007 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2023-03-27T23:32:56.091Z,1679959976.091 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2023-03-27T23:32:56.354Z,1679959976.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-03-27T23:32:56.355Z,1679959976.355 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2023-03-27T23:32:56.458Z,1679959976.458 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2023-03-27T23:32:56.563Z,1679959976.563 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2023-03-27T23:32:56.674Z,1679959976.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2023-03-27T23:32:56.814Z,1679959976.814 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2023-03-27T23:32:56.911Z,1679959976.911 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2023-03-27T23:32:57.005Z,1679959977.005 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2023-03-27T23:32:57.005Z,1679959977.005 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-03-27T23:32:57.017Z,1679959977.017 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-03-27T23:32:57.028Z,1679959977.028 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-03-27T23:32:57.029Z,1679959977.029 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-03-27T23:32:57.126Z,1679959977.126 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-03-27T23:32:57.127Z,1679959977.127 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-03-27T23:32:57.176Z,1679959977.176 [VerticalControl](DEBUG): Construct VerticalControl.
2023-03-27T23:32:57.237Z,1679959977.237 [VerticalControl] Loaded
2023-03-27T23:32:57.237Z,1679959977.237 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-03-27T23:32:57.240Z,1679959977.240 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-03-27T23:32:57.281Z,1679959977.281 [HorizontalControl] Loaded
2023-03-27T23:32:57.281Z,1679959977.281 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-03-27T23:32:57.283Z,1679959977.283 [SpeedControl](DEBUG): Construct SpeedControl.
2023-03-27T23:32:57.286Z,1679959977.286 [SpeedControl] Loaded
2023-03-27T23:32:57.287Z,1679959977.287 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-03-27T23:32:57.289Z,1679959977.289 [LoopControl](DEBUG): Construct LoopControl.
2023-03-27T23:32:57.290Z,1679959977.290 [LoopControl] Loaded
2023-03-27T23:32:57.290Z,1679959977.290 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-03-27T23:32:57.290Z,1679959977.290 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-03-27T23:32:57.291Z,1679959977.291 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-03-27T23:32:57.442Z,1679959977.442 [BuoyancyServo] Loaded
2023-03-27T23:32:57.442Z,1679959977.442 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-03-27T23:32:57.462Z,1679959977.462 [ElevatorServo] Loaded
2023-03-27T23:32:57.463Z,1679959977.463 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-03-27T23:32:57.482Z,1679959977.482 [MassServo] Loaded
2023-03-27T23:32:57.482Z,1679959977.482 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-03-27T23:32:57.501Z,1679959977.501 [RudderServo] Loaded
2023-03-27T23:32:57.501Z,1679959977.501 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-03-27T23:32:57.516Z,1679959977.516 [ThrusterHE] Loaded
2023-03-27T23:32:57.516Z,1679959977.516 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-03-27T23:32:57.516Z,1679959977.516 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-03-27T23:32:57.517Z,1679959977.517 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-03-27T23:32:57.567Z,1679959977.567 [DepthRateCalculator] Loaded
2023-03-27T23:32:57.568Z,1679959977.568 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-03-27T23:32:57.573Z,1679959977.573 [PitchRateCalculator] Loaded
2023-03-27T23:32:57.573Z,1679959977.573 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-03-27T23:32:57.583Z,1679959977.583 [SpeedCalculator] Loaded
2023-03-27T23:32:57.583Z,1679959977.583 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-03-27T23:32:57.587Z,1679959977.587 [YawRateCalculator] Loaded
2023-03-27T23:32:57.587Z,1679959977.587 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-03-27T23:32:57.605Z,1679959977.605 [ElevatorOffsetCalculator] Loaded
2023-03-27T23:32:57.605Z,1679959977.605 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-03-27T23:32:57.606Z,1679959977.606 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-03-27T23:32:57.606Z,1679959977.606 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-03-27T23:32:57.718Z,1679959977.718 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-03-27T23:32:57.718Z,1679959977.718 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-03-27T23:32:57.732Z,1679959977.732 [NavChart] Loaded
2023-03-27T23:32:57.732Z,1679959977.732 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-03-27T23:32:57.738Z,1679959977.738 [UniversalFixResidualReporter] Loaded
2023-03-27T23:32:57.738Z,1679959977.738 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-03-27T23:32:57.738Z,1679959977.738 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-03-27T23:32:57.739Z,1679959977.739 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-03-27T23:32:58.171Z,1679959978.171 [AHRS_M2] Loaded
2023-03-27T23:32:58.172Z,1679959978.172 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-03-27T23:32:58.207Z,1679959978.207 [BackseatComponent] Loaded
2023-03-27T23:32:58.207Z,1679959978.207 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-03-27T23:32:58.209Z,1679959978.209 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408E04E0
2023-03-27T23:32:58.209Z,1679959978.209 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5457
2023-03-27T23:32:58.212Z,1679959978.212 [LcmUniversalReporter] Loaded
2023-03-27T23:32:58.212Z,1679959978.212 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-03-27T23:32:59.049Z,1679959979.049 [BPC1] Loaded
2023-03-27T23:32:59.049Z,1679959979.049 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-03-27T23:32:59.124Z,1679959979.124 [DataOverHttps] Loaded
2023-03-27T23:32:59.124Z,1679959979.124 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-03-27T23:32:59.125Z,1679959979.125 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409104E0
2023-03-27T23:32:59.126Z,1679959979.126 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5458
2023-03-27T23:32:59.146Z,1679959979.146 [Depth_Keller] Loaded
2023-03-27T23:32:59.147Z,1679959979.147 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-03-27T23:32:59.152Z,1679959979.152 [DropWeight] Loaded
2023-03-27T23:32:59.152Z,1679959979.152 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-03-27T23:32:59.170Z,1679959979.170 [MultiRay] Loaded
2023-03-27T23:32:59.171Z,1679959979.171 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-03-27T23:32:59.232Z,1679959979.232 [NAL9602] Loaded
2023-03-27T23:32:59.233Z,1679959979.233 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-03-27T23:32:59.263Z,1679959979.263 [Onboard] Loaded
2023-03-27T23:32:59.263Z,1679959979.263 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-03-27T23:32:59.264Z,1679959979.264 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409404E0
2023-03-27T23:32:59.264Z,1679959979.264 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5459
2023-03-27T23:32:59.277Z,1679959979.277 [Power24vConverter] Loaded
2023-03-27T23:32:59.277Z,1679959979.277 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-03-27T23:32:59.290Z,1679959979.290 [Radio_Surface] Loaded
2023-03-27T23:32:59.291Z,1679959979.291 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-03-27T23:32:59.292Z,1679959979.292 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409704E0
2023-03-27T23:32:59.292Z,1679959979.292 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5460
2023-03-27T23:32:59.386Z,1679959979.386 [DAT] Loaded
2023-03-27T23:32:59.386Z,1679959979.386 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-03-27T23:32:59.387Z,1679959979.387 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409A04E0
2023-03-27T23:32:59.387Z,1679959979.387 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5461
2023-03-27T23:32:59.388Z,1679959979.388 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-03-27T23:32:59.388Z,1679959979.388 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-03-27T23:32:59.630Z,1679959979.630 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-03-27T23:32:59.631Z,1679959979.631 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-03-27T23:33:00.017Z,1679959980.017 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-03-27T23:33:00.017Z,1679959980.017 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-03-27T23:33:00.265Z,1679959980.265 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-03-27T23:33:00.266Z,1679959980.266 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-03-27T23:33:00.433Z,1679959980.433 [CTD_Seabird] Loaded
2023-03-27T23:33:00.433Z,1679959980.433 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-03-27T23:33:00.434Z,1679959980.434 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ACB4E0
2023-03-27T23:33:00.434Z,1679959980.434 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5462
2023-03-27T23:33:00.467Z,1679959980.467 [ESPComponent] Loaded
2023-03-27T23:33:00.467Z,1679959980.467 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-03-27T23:33:00.488Z,1679959980.488 [PAR_Licor] Loaded
2023-03-27T23:33:00.488Z,1679959980.488 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-03-27T23:33:00.520Z,1679959980.520 [WetLabsBB2FL] Loaded
2023-03-27T23:33:00.520Z,1679959980.520 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-03-27T23:33:00.521Z,1679959980.521 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AFB4E0
2023-03-27T23:33:00.522Z,1679959980.522 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5463
2023-03-27T23:33:00.522Z,1679959980.522 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-03-27T23:33:00.523Z,1679959980.523 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-03-27T23:33:00.827Z,1679959980.827 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-03-27T23:33:00.828Z,1679959980.828 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-03-27T23:33:00.964Z,1679959980.964 [SBIT](DEBUG): Construct Startup Built In Test.
2023-03-27T23:33:00.973Z,1679959980.973 [SBIT] Loaded
2023-03-27T23:33:00.973Z,1679959980.973 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-03-27T23:33:00.976Z,1679959980.976 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-03-27T23:33:00.989Z,1679959980.989 [IBIT] Loaded
2023-03-27T23:33:00.989Z,1679959980.989 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-03-27T23:33:00.995Z,1679959980.995 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-03-27T23:33:01.100Z,1679959981.100 [CBIT] Loaded
2023-03-27T23:33:01.100Z,1679959981.100 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-03-27T23:33:01.100Z,1679959981.100 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-03-27T23:33:01.107Z,1679959981.107 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-03-27T23:33:01.110Z,1679959981.110 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-03-27T23:33:01.121Z,1679959981.121 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-03-27T23:33:01.122Z,1679959981.122 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BDE4E0
2023-03-27T23:33:01.122Z,1679959981.122 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5464
2023-03-27T23:33:01.126Z,1679959981.126 [Supervisor](INFO): Main Thread ID is 4795
2023-03-27T23:33:01.127Z,1679959981.127 [Supervisor](DEBUG): Running supervisor.
2023-03-27T23:33:01.127Z,1679959981.127 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5465
2023-03-27T23:33:01.128Z,1679959981.128 [CommandExec](INFO): Initializing the command executive.
2023-03-27T23:33:01.129Z,1679959981.129 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5466
2023-03-27T23:33:01.131Z,1679959981.131 [controlThread ThreadHandler](INFO): Handler Thread ID is 5467
2023-03-27T23:33:01.132Z,1679959981.132 [controlThread](DEBUG): Initializing ControlThread
2023-03-27T23:33:01.132Z,1679959981.132 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-03-27T23:33:01.134Z,1679959981.134 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-03-27T23:33:01.135Z,1679959981.135 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-03-27T23:33:01.135Z,1679959981.135 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-03-27T23:33:01.137Z,1679959981.137 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-03-27T23:33:01.137Z,1679959981.137 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-03-27T23:33:01.138Z,1679959981.138 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-03-27T23:33:01.138Z,1679959981.138 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-03-27T23:33:01.138Z,1679959981.138 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-03-27T23:33:01.139Z,1679959981.139 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-03-27T23:33:01.140Z,1679959981.140 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-03-27T23:33:01.147Z,1679959981.147 [SBIT](INFO): Initialize SBIT Component.
2023-03-27T23:33:01.147Z,1679959981.147 [SBIT](IMPORTANT): git: 2023-03-21-1-gfa82814f5
2023-03-27T23:33:01.147Z,1679959981.147 [SBIT](INFO): git hash: fa82814f549957091247350f51543011fb624050
2023-03-27T23:33:01.148Z,1679959981.148 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-03-27T23:33:01.149Z,1679959981.149 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-03-27T23:33:01.150Z,1679959981.150 [SBIT](INFO): Beginning SBIT in 81.000000 seconds.
2023-03-27T23:33:01.151Z,1679959981.151 [IBIT](INFO): Initialize IBIT Component.
2023-03-27T23:33:01.151Z,1679959981.151 [CBIT](DEBUG): Initialize CBIT Component.
2023-03-27T23:33:01.152Z,1679959981.152 [logger ThreadHandler](INFO): Handler Thread ID is 5468
2023-03-27T23:33:01.162Z,1679959981.162 [CBIT](DEBUG): Initialized mux pins.
2023-03-27T23:33:01.163Z,1679959981.163 [CBIT](DEBUG): Initializing the watchdog timer.
2023-03-27T23:33:01.171Z,1679959981.171 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5469
2023-03-27T23:33:01.183Z,1679959981.183 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5470
2023-03-27T23:33:01.184Z,1679959981.184 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-03-27T23:33:01.186Z,1679959981.186 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-03-27T23:33:01.187Z,1679959981.187 [CBIT](DEBUG): Initializing heartbeat.
2023-03-27T23:33:01.195Z,1679959981.195 [Onboard ThreadHandler](INFO): Handler Thread ID is 5471
2023-03-27T23:33:01.212Z,1679959981.212 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5472
2023-03-27T23:33:01.235Z,1679959981.235 [DAT ThreadHandler](INFO): Handler Thread ID is 5473
2023-03-27T23:33:01.236Z,1679959981.236 [DAT](INFO): Powering up
2023-03-27T23:33:01.236Z,1679959981.236 [DAT](DEBUG): Initializing DAT.
2023-03-27T23:33:01.240Z,1679959981.240 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5475
2023-03-27T23:33:01.240Z,1679959981.240 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-03-27T23:33:01.244Z,1679959981.244 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5477
2023-03-27T23:33:01.247Z,1679959981.247 [WetLabsBB2FL](INFO): Powering up
2023-03-27T23:33:01.249Z,1679959981.249 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5479
2023-03-27T23:33:01.252Z,1679959981.252 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-03-27T23:33:01.253Z,1679959981.253 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-03-27T23:33:01.253Z,1679959981.253 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-03-27T23:33:01.253Z,1679959981.253 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-03-27T23:33:01.253Z,1679959981.253 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-03-27T23:33:01.253Z,1679959981.253 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-03-27T23:33:01.253Z,1679959981.253 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-03-27T23:33:01.254Z,1679959981.254 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-03-27T23:33:01.258Z,1679959981.258 [CBIT](DEBUG): Deactivating GF circuits.
2023-03-27T23:33:01.259Z,1679959981.259 [CBIT](DEBUG): Deactivating emergency mode.
2023-03-27T23:33:01.298Z,1679959981.298 [CBIT](DEBUG): Backplane powered.
2023-03-27T23:33:01.299Z,1679959981.299 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-03-27T23:33:01.312Z,1679959981.312 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-27T23:33:01.335Z,1679959981.335 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2023-03-27T23:33:01.336Z,1679959981.336 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-03-27T23:33:01.415Z,1679959981.415 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-03-27T23:33:01.416Z,1679959981.416 [Default:A.Wait](DEBUG): Construct Wait.
2023-03-27T23:33:01.449Z,1679959981.449 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-27T23:33:01.477Z,1679959981.477 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-03-27T23:33:01.501Z,1679959981.501 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-03-27T23:33:01.522Z,1679959981.522 [Default:E.Execute](DEBUG): Construct Execute.
2023-03-27T23:33:01.526Z,1679959981.526 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2023-03-27T23:33:01.531Z,1679959981.531 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-03-27T23:33:01.540Z,1679959981.540 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-03-27T23:33:01.618Z,1679959981.618 [Radio_Surface](INFO): Powering up
2023-03-27T23:33:01.621Z,1679959981.621 [MultiRay](INFO): Powering up MultiRay Lights
2023-03-27T23:33:01.660Z,1679959981.660 [Power24vConverter](INFO): Powering up.
2023-03-27T23:33:01.712Z,1679959981.712 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:01.719Z,1679959981.719 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-03-27T23:33:01.720Z,1679959981.720 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:01.727Z,1679959981.727 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-03-27T23:33:01.728Z,1679959981.728 [MassServo](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:01.735Z,1679959981.735 [MassServo](DEBUG): Initializing MassServo.
2023-03-27T23:33:01.736Z,1679959981.736 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:01.747Z,1679959981.747 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-27T23:33:01.748Z,1679959981.748 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:01.755Z,1679959981.755 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-03-27T23:33:01.988Z,1679959981.988 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-27T23:33:01.988Z,1679959981.988 [DropWeight] Hardware Fault, FailCount= 1
2023-03-27T23:33:01.988Z,1679959981.988 [DropWeight](ERROR): Hardware Fault
2023-03-27T23:33:02.064Z,1679959982.064 [CommandExec](FAULT): Scheduling is paused
2023-03-27T23:33:02.065Z,1679959982.065 [CBIT](INFO): Critical error at 20230327T233301
2023-03-27T23:33:02.065Z,1679959982.065 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-03-27T23:33:02.075Z,1679959982.075 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-27T23:33:02.076Z,1679959982.076 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-27T23:33:02.690Z,1679959982.690 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-03-27T23:33:02.691Z,1679959982.691 [RudderServo](FAULT): Rudder failed to initialize
2023-03-27T23:33:02.691Z,1679959982.691 [RudderServo] Communications Fault, FailCount= 1
2023-03-27T23:33:02.691Z,1679959982.691 [RudderServo](ERROR): Communications Fault
2023-03-27T23:33:02.693Z,1679959982.693 [CBIT](INFO): Critical error at 20230327T233302
2023-03-27T23:33:02.695Z,1679959982.695 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-03-27T23:33:03.163Z,1679959983.163 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-27T23:33:03.164Z,1679959983.164 [RudderServo](INFO): Powering down
2023-03-27T23:33:03.355Z,1679959983.355 [WetLabsBB2FL](INFO): Powering down
2023-03-27T23:33:03.613Z,1679959983.613 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:03.732Z,1679959983.732 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-27T23:33:03.736Z,1679959983.736 [CBIT](INFO): Clearing failed state for component RudderServo
2023-03-27T23:33:03.736Z,1679959983.736 [RudderServo] No Fault, FailCount= 1
2023-03-27T23:33:07.483Z,1679959987.483 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-03-27T23:33:13.351Z,1679959993.351 [DAT](INFO): DAT read: 

2023-03-27T23:33:13.353Z,1679959993.353 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-03-27T23:33:15.115Z,1679959995.115 [DAT](INFO): DAT read: MF Frequency Band

2023-03-27T23:33:15.116Z,1679959995.116 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-03-27T23:33:15.117Z,1679959995.117 [DAT](INFO): DAT read: Mar 27 2023 23:33:09 

2023-03-27T23:33:16.123Z,1679959996.123 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-03-27T23:33:16.125Z,1679959996.125 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-03-27T23:33:16.125Z,1679959996.125 [DAT](INFO): commRate: 800
2023-03-27T23:33:18.191Z,1679959998.191 [DAT](INFO): entering command mode
2023-03-27T23:33:18.391Z,1679959998.391 [DAT](INFO): DAT read: 

2023-03-27T23:33:18.391Z,1679959998.391 [DAT](INFO): DAT read: user:1>

2023-03-27T23:33:18.392Z,1679959998.392 [DAT](INFO): setting verbose to 3
2023-03-27T23:33:18.643Z,1679959998.643 [DAT](INFO): DAT read: user:1>

2023-03-27T23:33:18.644Z,1679959998.644 [DAT](INFO): DAT read: Verbose         | 3           

2023-03-27T23:33:18.645Z,1679959998.645 [DAT](INFO): set verbose to 3
2023-03-27T23:33:18.645Z,1679959998.645 [DAT](INFO): setting DatVerbose to 27440
2023-03-27T23:33:18.895Z,1679959998.895 [DAT](INFO): DAT read: user:2>

2023-03-27T23:33:18.896Z,1679959998.896 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-03-27T23:33:18.896Z,1679959998.896 [DAT](INFO): set DatVerbose to 27440
2023-03-27T23:33:18.897Z,1679959998.897 [DAT](INFO): setting transmit power to 8
2023-03-27T23:33:19.147Z,1679959999.147 [DAT](INFO): DAT read: user:3>

2023-03-27T23:33:19.148Z,1679959999.148 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-03-27T23:33:19.148Z,1679959999.148 [DAT](INFO): set transmit power to 8
2023-03-27T23:33:19.149Z,1679959999.149 [DAT](INFO): setting local address to 5
2023-03-27T23:33:19.399Z,1679959999.399 [DAT](INFO): DAT read: user:4>

2023-03-27T23:33:19.400Z,1679959999.400 [DAT](INFO): DAT read: LocalAddr       | 5           

2023-03-27T23:33:19.401Z,1679959999.401 [DAT](INFO): set local address to 5
2023-03-27T23:33:19.402Z,1679959999.402 [DAT](INFO): Setting time to: 23:33:19 And date to:3/27/2023
2023-03-27T23:33:19.651Z,1679959999.651 [DAT](INFO): DAT read: user:5>

2023-03-27T23:33:19.652Z,1679959999.652 [DAT](INFO): DAT read: Mon Mar 27, 2023  23:33:19  

2023-03-27T23:33:19.652Z,1679959999.652 [DAT](INFO): Local DAT time set to Mon Mar 27, 2023  23:33:19  

2023-03-27T23:33:25.394Z,1679960005.394 [MassServo](ERROR): getPosition uart error serial timeout
2023-03-27T23:33:25.395Z,1679960005.395 [MassServo](FAULT): Invalid EZ Servo response:""
2023-03-27T23:33:25.395Z,1679960005.395 [MassServo] Communications Fault, FailCount= 1
2023-03-27T23:33:25.395Z,1679960005.395 [MassServo](ERROR): Communications Fault
2023-03-27T23:33:25.399Z,1679960005.399 [CBIT](ERROR): Communications Fault in component: MassServo
2023-03-27T23:33:25.471Z,1679960005.471 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-03-27T23:33:25.471Z,1679960005.471 [MassServo](INFO): Powering down
2023-03-27T23:33:26.281Z,1679960006.281 [MassServo](DEBUG): Initializing EZServoServo.
2023-03-27T23:33:26.399Z,1679960006.399 [MassServo](DEBUG): Initializing MassServo.
2023-03-27T23:33:26.404Z,1679960006.404 [CBIT](INFO): Clearing failed state for component MassServo
2023-03-27T23:33:26.404Z,1679960006.404 [MassServo] No Fault, FailCount= 1
2023-03-27T23:33:29.452Z,1679960009.452 [NAL9602](INFO): Powering up NAL9602
2023-03-27T23:33:40.364Z,1679960020.364 [NAL9602](INFO): NAL9602 initialized
2023-03-27T23:34:09.051Z,1679960049.051 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:34:09.060Z,1679960049.060 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:34:22.443Z,1679960062.443 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:34:22.783Z,1679960062.783 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:34:22.818Z,1679960062.818 [SBIT](IMPORTANT): Beginning Startup BIT
2023-03-27T23:34:22.843Z,1679960062.843 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-27T23:34:33.729Z,1679960073.729 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006913
CHAN A1 (24V): -0.007752
CHAN A2 (12V): -0.005028
CHAN A3 (5V): -0.003136
CHAN B0 (3.3V): -0.001588
CHAN B1 (3.15aV): -0.000713
CHAN B2 (3.15bV): -0.000960
CHAN B3 (GND): 0.000143
OPEN: 0.004540
Full Scale: +/- 1 mA
2023-03-27T23:34:35.792Z,1679960075.792 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:34:36.119Z,1679960076.119 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:34:48.288Z,1679960088.288 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-03-27T23:34:49.850Z,1679960089.850 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:01.970Z,1679960101.970 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:03.586Z,1679960103.586 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:15.707Z,1679960115.707 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:16.546Z,1679960116.546 [SBIT](IMPORTANT): SBIT PASSED
2023-03-27T23:35:16.546Z,1679960116.546 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-03-27T23:35:16.547Z,1679960116.547 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2023-03-27T23:35:16.547Z,1679960116.547 [SBIT](IMPORTANT): BackseatComponent.alwaysOn=0 bool;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=10 minute;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): Express linearApproximation platform_roll_angle 5.000000 degree;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=184.896478 cubic_centimeter;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 angular_degree;

2023-03-27T23:35:16.548Z,1679960116.548 [SBIT](IMPORTANT): VerticalControl.massDefault=15.484465 millimeter;

2023-03-27T23:35:16.984Z,1679960116.984 [MissionManager](IMPORTANT): Started mission Startup
2023-03-27T23:35:16.985Z,1679960116.985 [Startup] Running Loop=1
2023-03-27T23:35:16.985Z,1679960116.985 [Startup](DEBUG): Aggregate::initialize Startup
2023-03-27T23:35:16.985Z,1679960116.985 [Startup:A.GoToSurface] Running Loop=1
2023-03-27T23:35:16.985Z,1679960116.985 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-27T23:35:16.986Z,1679960116.986 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-27T23:35:17.005Z,1679960117.005 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-27T23:35:17.006Z,1679960117.006 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-27T23:35:17.006Z,1679960117.006 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-27T23:35:17.007Z,1679960117.007 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-27T23:35:17.008Z,1679960117.008 [Startup:StartupSatComms] Running Loop=1
2023-03-27T23:35:17.008Z,1679960117.008 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-03-27T23:35:17.009Z,1679960117.009 [Startup:StartupSatComms:A] Running Loop=1
2023-03-27T23:35:17.322Z,1679960117.322 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:17.374Z,1679960117.374 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-03-27T23:35:29.039Z,1679960129.039 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:35:29.039Z,1679960129.039 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:29.053Z,1679960129.053 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005001
2023-03-27T23:35:31.058Z,1679960131.058 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:42.769Z,1679960142.769 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:35:42.775Z,1679960142.775 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:35:42.775Z,1679960142.775 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:44.794Z,1679960144.794 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:56.505Z,1679960156.505 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:35:56.511Z,1679960156.511 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:35:56.511Z,1679960156.511 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:35:57.739Z,1679960157.739 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:01.401Z,1679960161.401 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-27T23:36:01.401Z,1679960161.401 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:36:01.424Z,1679960161.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:36:01.815Z,1679960161.815 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:36:01.815Z,1679960161.815 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-27T23:36:10.241Z,1679960170.241 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:10.248Z,1679960170.248 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:10.248Z,1679960170.248 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:11.458Z,1679960171.458 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:17.125Z,1679960177.125 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-27T23:35:17.0Z
2023-03-27T23:36:17.125Z,1679960177.125 [Startup:StartupSatComms:A] Stopped
2023-03-27T23:36:17.125Z,1679960177.125 [Startup:StartupSatComms:B] Running Loop=1
2023-03-27T23:36:17.529Z,1679960177.529 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-27T23:36:23.977Z,1679960183.977 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:24.003Z,1679960184.003 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:24.003Z,1679960184.003 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:24.854Z,1679960184.854 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T162407/Courier0127.lzma
2023-03-27T23:36:25.203Z,1679960185.203 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:25.857Z,1679960185.857 [DataOverHttps](INFO): Moved sent file to Logs/20230327T162407/Courier0127.lzma.bak
2023-03-27T23:36:25.857Z,1679960185.857 [DataOverHttps](INFO): SBD MOMSN=17694587
2023-03-27T23:36:37.713Z,1679960197.713 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:37.719Z,1679960197.719 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:37.719Z,1679960197.719 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:38.539Z,1679960198.539 [BPC1](INFO): SQS: setting charging to 1
2023-03-27T23:36:41.506Z,1679960201.506 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20230327T233250/Courier0000.lzma
2023-03-27T23:36:42.508Z,1679960202.508 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Courier0000.lzma.bak
2023-03-27T23:36:42.508Z,1679960202.508 [DataOverHttps](INFO): SBD MOMSN=17694589
2023-03-27T23:36:51.452Z,1679960211.452 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:51.458Z,1679960211.458 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:36:51.458Z,1679960211.458 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:36:52.262Z,1679960212.262 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:36:58.358Z,1679960218.358 [DataOverHttps](INFO): Sending 101 bytes from file Logs/20230327T162407/Express0128.lzma
2023-03-27T23:36:59.361Z,1679960219.361 [DataOverHttps](INFO): Moved sent file to Logs/20230327T162407/Express0128.lzma.bak
2023-03-27T23:36:59.361Z,1679960219.361 [DataOverHttps](INFO): SBD MOMSN=17694594
2023-03-27T23:37:04.781Z,1679960224.781 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:04.787Z,1679960224.787 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:04.787Z,1679960224.787 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:05.594Z,1679960225.594 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:15.167Z,1679960235.167 [DataOverHttps](INFO): Sending 1076 bytes from file Logs/20230327T233250/Express0001.lzma
2023-03-27T23:37:16.168Z,1679960236.168 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Express0001.lzma.bak
2023-03-27T23:37:16.168Z,1679960236.168 [DataOverHttps](INFO): SBD MOMSN=17694598
2023-03-27T23:37:17.329Z,1679960237.329 [Startup:StartupSatComms:B](INFO): Timed out from 2023-03-27T23:36:17.1Z
2023-03-27T23:37:17.329Z,1679960237.329 [Startup:StartupSatComms:B] Stopped
2023-03-27T23:37:17.329Z,1679960237.329 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-03-27T23:37:17.329Z,1679960237.329 [Startup:StartupSatComms] Stopped
2023-03-27T23:37:17.330Z,1679960237.330 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-03-27T23:37:17.335Z,1679960237.335 [Startup](INFO): Completed Startup
2023-03-27T23:37:17.335Z,1679960237.335 [MissionManager](INFO): Startup is completed.
2023-03-27T23:37:17.335Z,1679960237.335 [MissionManager](INFO): Uninitializing Mission Startup
2023-03-27T23:37:17.335Z,1679960237.335 [Startup] Stopped
2023-03-27T23:37:17.335Z,1679960237.335 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-03-27T23:37:17.336Z,1679960237.336 [Startup:A.GoToSurface] Stopped
2023-03-27T23:37:17.336Z,1679960237.336 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-27T23:37:17.874Z,1679960237.874 [MissionManager](IMPORTANT): Started mission Default
2023-03-27T23:37:17.874Z,1679960237.874 [Default] Running Loop=1
2023-03-27T23:37:17.874Z,1679960237.874 [Default](DEBUG): Aggregate::initialize Default
2023-03-27T23:37:17.874Z,1679960237.874 [Default:B.GoToSurface] Running Loop=1
2023-03-27T23:37:17.899Z,1679960237.899 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-27T23:37:17.899Z,1679960237.899 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-27T23:37:17.899Z,1679960237.899 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-27T23:37:17.900Z,1679960237.900 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-27T23:37:17.900Z,1679960237.900 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-27T23:37:17.900Z,1679960237.900 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-27T23:37:17.901Z,1679960237.901 [Default:A.Wait] Running Loop=1
2023-03-27T23:37:17.901Z,1679960237.901 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:37:18.113Z,1679960238.113 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:18.120Z,1679960238.120 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:18.121Z,1679960238.121 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:18.930Z,1679960238.930 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:31.062Z,1679960251.062 [Default:A.Wait](INFO): Done Waiting.
2023-03-27T23:37:31.062Z,1679960251.062 [Default:A.Wait] Stopped
2023-03-27T23:37:31.063Z,1679960251.063 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T23:37:31.532Z,1679960251.532 [Default:CheckIn] Running Loop=1
2023-03-27T23:37:31.532Z,1679960251.532 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T23:37:31.532Z,1679960251.532 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T23:37:31.912Z,1679960251.912 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:31.918Z,1679960251.918 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:31.918Z,1679960251.918 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:31.929Z,1679960251.929 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-03-27T23:37:32.269Z,1679960252.269 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:45.186Z,1679960265.186 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:45.188Z,1679960265.188 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:45.194Z,1679960265.194 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-27T23:37:45.194Z,1679960265.194 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:58.522Z,1679960278.522 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:37:58.529Z,1679960278.529 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:11.850Z,1679960291.850 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:12.265Z,1679960292.265 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:25.586Z,1679960305.586 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:25.610Z,1679960305.610 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:38.919Z,1679960318.919 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:38.927Z,1679960318.927 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:44.168Z,1679960324.168 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-03-27T23:38:52.318Z,1679960332.318 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:38:52.661Z,1679960332.661 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:02.353Z,1679960342.353 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-27T23:39:02.353Z,1679960342.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:39:02.364Z,1679960342.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:39:02.773Z,1679960342.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:39:02.773Z,1679960342.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-27T23:39:05.583Z,1679960345.583 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:05.590Z,1679960345.590 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:18.977Z,1679960358.977 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:19.318Z,1679960359.318 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:32.715Z,1679960372.715 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:33.056Z,1679960373.056 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:45.983Z,1679960385.983 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:45.990Z,1679960385.990 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:59.379Z,1679960399.379 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:39:59.718Z,1679960399.718 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:40:13.121Z,1679960413.121 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:40:13.454Z,1679960413.454 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:40:25.170Z,1679960425.170 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:40:25.978Z,1679960425.978 [BPC1](INFO): SQS: setting charging to 0
2023-03-27T23:40:25.991Z,1679960425.991 [BPC1](INFO): SQS: Battery stick #1 status code: 0x0080
2023-03-27T23:40:25.991Z,1679960425.991 [BPC1](INFO): SQS: Battery stick #2 status code: 0x0080
2023-03-27T23:40:25.992Z,1679960425.992 [BPC1](INFO): SQS: Battery stick #3 status code: 0x0080
2023-03-27T23:40:25.992Z,1679960425.992 [BPC1](INFO): SQS: Battery stick #4 status code: 0x0080
2023-03-27T23:40:25.992Z,1679960425.992 [BPC1](INFO): SQS: Battery stick #5 status code: 0x0080
2023-03-27T23:40:25.992Z,1679960425.992 [BPC1](INFO): SQS: Battery stick #6 status code: 0x0080
2023-03-27T23:40:25.993Z,1679960425.993 [BPC1](INFO): SQS: Battery stick #7 status code: 0x0080
2023-03-27T23:40:25.993Z,1679960425.993 [BPC1](INFO): SQS: Battery stick #8 status code: 0x00C0
2023-03-27T23:40:25.993Z,1679960425.993 [BPC1](INFO): SQS: Battery stick #9 status code: 0x00C0
2023-03-27T23:40:25.994Z,1679960425.994 [BPC1](INFO): SQS: Battery stick #10 status code: 0x00C0
2023-03-27T23:40:25.994Z,1679960425.994 [BPC1](INFO): SQS: Battery stick #11 status code: 0x00C0
2023-03-27T23:40:25.994Z,1679960425.994 [BPC1](INFO): SQS: Battery stick #12 status code: 0x00C0
2023-03-27T23:40:25.995Z,1679960425.995 [BPC1](INFO): SQS: Battery stick #13 status code: 0x00C0
2023-03-27T23:40:25.995Z,1679960425.995 [BPC1](INFO): SQS: Battery stick #14 status code: 0x00C0
2023-03-27T23:40:25.995Z,1679960425.995 [BPC1](INFO): SQS: Battery stick #15 status code: 0x00C0
2023-03-27T23:40:25.996Z,1679960425.996 [BPC1](INFO): SQS: Battery stick #16 status code: 0x00C0
2023-03-27T23:40:25.996Z,1679960425.996 [BPC1](INFO): SQS: Battery stick #17 status code: 0x00C0
2023-03-27T23:40:25.996Z,1679960425.996 [BPC1](INFO): SQS: Battery stick #18 status code: 0x00C0
2023-03-27T23:40:25.997Z,1679960425.997 [BPC1](INFO): SQS: Battery stick #19 status code: 0x00C0
2023-03-27T23:40:25.997Z,1679960425.997 [BPC1](INFO): SQS: Battery stick #20 status code: 0x00C0
2023-03-27T23:40:25.997Z,1679960425.997 [BPC1](INFO): SQS: Battery stick #21 status code: 0x00C0
2023-03-27T23:40:25.998Z,1679960425.998 [BPC1](INFO): SQS: Battery stick #22 status code: 0x00C0
2023-03-27T23:40:25.998Z,1679960425.998 [BPC1](INFO): SQS: Battery stick #23 status code: 0x00C0
2023-03-27T23:40:25.998Z,1679960425.998 [BPC1](INFO): SQS: Battery stick #24 status code: 0x00C0
2023-03-27T23:40:25.999Z,1679960425.999 [BPC1](INFO): SQS: Battery stick #25 status code: 0x00C0
2023-03-27T23:40:25.999Z,1679960425.999 [BPC1](INFO): SQS: Battery stick #26 status code: 0x00C0
2023-03-27T23:40:25.999Z,1679960425.999 [BPC1](INFO): SQS: Battery stick #27 status code: 0x00C0
2023-03-27T23:40:25.000Z,1679960426.000 [BPC1](INFO): SQS: Battery stick #28 status code: 0x00C0
2023-03-27T23:40:26.000Z,1679960426.000 [BPC1](INFO): SQS: Battery stick #29 status code: 0x00C0
2023-03-27T23:40:26.000Z,1679960426.000 [BPC1](INFO): SQS: Battery stick #30 status code: 0x00C0
2023-03-27T23:40:26.001Z,1679960426.001 [BPC1](INFO): SQS: Battery stick #31 status code: 0x00C0
2023-03-27T23:40:26.001Z,1679960426.001 [BPC1](INFO): SQS: Battery stick #32 status code: 0x0080
2023-03-27T23:40:26.001Z,1679960426.001 [BPC1](INFO): SQS: Battery stick #33 status code: 0x0080
2023-03-27T23:40:26.002Z,1679960426.002 [BPC1](INFO): SQS: Battery stick #34 status code: 0x00C0
2023-03-27T23:40:26.002Z,1679960426.002 [BPC1](INFO): SQS: Battery stick #35 status code: 0x0080
2023-03-27T23:40:26.002Z,1679960426.002 [BPC1](INFO): SQS: Battery stick #36 status code: 0x0080
2023-03-27T23:40:26.003Z,1679960426.003 [BPC1](INFO): SQS: Battery stick #37 status code: 0x0080
2023-03-27T23:40:26.003Z,1679960426.003 [BPC1](INFO): SQS: Battery stick #38 status code: 0x0080
2023-03-27T23:40:26.003Z,1679960426.003 [BPC1](INFO): SQS: Battery stick #39 status code: 0x00C0
2023-03-27T23:40:26.004Z,1679960426.004 [BPC1](INFO): SQS: Battery stick #40 status code: 0x00C0
2023-03-27T23:40:26.004Z,1679960426.004 [BPC1](INFO): SQS: Battery stick #41 status code: 0x0000
2023-03-27T23:40:26.004Z,1679960426.004 [BPC1](INFO): SQS: Battery stick #42 status code: 0x00C0
2023-03-27T23:40:26.005Z,1679960426.005 [BPC1](INFO): SQS: Battery stick #43 status code: 0x00C0
2023-03-27T23:40:26.005Z,1679960426.005 [BPC1](INFO): SQS: Battery stick #44 status code: 0x00C0
2023-03-27T23:40:26.005Z,1679960426.005 [BPC1](INFO): SQS: Battery stick #45 status code: 0x00C0
2023-03-27T23:40:26.006Z,1679960426.006 [BPC1](INFO): SQS: Battery stick #46 status code: 0x00C0
2023-03-27T23:40:26.006Z,1679960426.006 [BPC1](INFO): SQS: Battery stick #47 status code: 0x0000
2023-03-27T23:40:26.006Z,1679960426.006 [BPC1](INFO): SQS: Battery stick #48 status code: 0x00C0
2023-03-27T23:40:26.007Z,1679960426.007 [BPC1](INFO): SQS: Battery stick #49 status code: 0x00C0
2023-03-27T23:40:26.007Z,1679960426.007 [BPC1](INFO): SQS: Battery stick #50 status code: 0x00C0
2023-03-27T23:40:26.007Z,1679960426.007 [BPC1](INFO): SQS: Battery stick #51 status code: 0x00C0
2023-03-27T23:40:26.008Z,1679960426.008 [BPC1](INFO): SQS: Battery stick #52 status code: 0x00C0
2023-03-27T23:40:26.008Z,1679960426.008 [BPC1](INFO): SQS: Battery stick #53 status code: 0x00C0
2023-03-27T23:40:26.008Z,1679960426.008 [BPC1](INFO): SQS: Battery stick #54 status code: 0x00C0
2023-03-27T23:40:26.009Z,1679960426.009 [BPC1](INFO): SQS: Battery stick #55 status code: 0x00C0
2023-03-27T23:40:26.009Z,1679960426.009 [BPC1](INFO): SQS: Battery stick #56 status code: 0x00C0
2023-03-27T23:40:26.009Z,1679960426.009 [BPC1](INFO): SQS: Battery stick #57 status code: 0x00C0
2023-03-27T23:40:26.010Z,1679960426.010 [BPC1](INFO): SQS: Battery stick #58 status code: 0x00C0
2023-03-27T23:40:26.010Z,1679960426.010 [BPC1](INFO): SQS: Battery stick #59 status code: 0x00C0
2023-03-27T23:40:26.027Z,1679960426.027 [BPC1](INFO): SQS: Battery stick #60 status code: 0x00C0
2023-03-27T23:40:26.027Z,1679960426.027 [BPC1](INFO): SQS: Battery stick #61 status code: 0x00C0
2023-03-27T23:40:26.027Z,1679960426.027 [BPC1](INFO): SQS: Battery stick #62 status code: 0x00C0
2023-03-27T23:40:26.028Z,1679960426.028 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5. Charging stick count: 13
2023-03-27T23:40:26.035Z,1679960426.035 [BPC1](INFO): Received data from all battery sticks.
2023-03-27T23:42:03.351Z,1679960523.351 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-03-27T23:42:03.351Z,1679960523.351 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:42:03.361Z,1679960523.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:42:03.784Z,1679960523.784 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:42:03.784Z,1679960523.784 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-03-27T23:42:31.633Z,1679960551.633 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T23:37:31.5Z
2023-03-27T23:42:31.633Z,1679960551.633 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T23:42:31.634Z,1679960551.634 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T23:42:32.037Z,1679960552.037 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-27T23:42:39.202Z,1679960559.202 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20230327T233250/Courier0004.lzma
2023-03-27T23:42:40.204Z,1679960560.204 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Courier0004.lzma.bak
2023-03-27T23:42:40.204Z,1679960560.204 [DataOverHttps](INFO): SBD MOMSN=17694986
2023-03-27T23:42:55.702Z,1679960575.702 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20230327T233250/Express0005.lzma
2023-03-27T23:42:56.704Z,1679960576.704 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Express0005.lzma.bak
2023-03-27T23:42:56.705Z,1679960576.705 [DataOverHttps](INFO): SBD MOMSN=17694988
2023-03-27T23:42:58.764Z,1679960578.764 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T23:42:58.764Z,1679960578.764 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T23:42:58.764Z,1679960578.764 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:43:43.192Z,1679960623.192 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T23:43:43.192Z,1679960623.192 [NAL9602] Data Fault, FailCount= 1
2023-03-27T23:43:43.192Z,1679960623.192 [NAL9602](ERROR): Data Fault
2023-03-27T23:43:43.242Z,1679960623.242 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T23:43:43.596Z,1679960623.596 [NAL9602](INFO): Powering down
2023-03-27T23:43:44.488Z,1679960624.488 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T23:43:44.488Z,1679960624.488 [NAL9602] No Fault, FailCount= 1
2023-03-27T23:44:13.896Z,1679960653.896 [NAL9602](INFO): Powering up NAL9602
2023-03-27T23:44:24.804Z,1679960664.804 [NAL9602](INFO): NAL9602 initialized
2023-03-27T23:45:04.408Z,1679960704.408 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-03-27T23:45:04.408Z,1679960704.408 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:45:04.419Z,1679960704.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:45:04.841Z,1679960704.841 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:45:04.841Z,1679960704.841 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-03-27T23:47:59.344Z,1679960879.344 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T23:47:59.344Z,1679960879.344 [Default:CheckIn:C.Wait] Stopped
2023-03-27T23:47:59.344Z,1679960879.344 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T23:47:59.344Z,1679960879.344 [Default:CheckIn:D] Running Loop=1
2023-03-27T23:47:59.768Z,1679960879.768 [Default:CheckIn:D] Stopped
2023-03-27T23:47:59.768Z,1679960879.768 [Default:CheckIn:E] Running Loop=1
2023-03-27T23:48:00.177Z,1679960880.177 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.698235 min 
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn:E] Stopped
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn] Stopped
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn](INFO): Running loop #2
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn] Running Loop=2
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T23:48:00.178Z,1679960880.178 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-27T23:48:02.189Z,1679960882.189 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-27T23:48:02.189Z,1679960882.189 [DropWeight] No Fault, FailCount= 1
2023-03-27T23:48:05.408Z,1679960885.408 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-03-27T23:48:05.408Z,1679960885.408 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:48:05.419Z,1679960885.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:48:05.840Z,1679960885.840 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:48:05.840Z,1679960885.840 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-03-27T23:51:06.426Z,1679961066.426 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-03-27T23:51:06.426Z,1679961066.426 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:51:06.436Z,1679961066.436 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:51:06.812Z,1679961066.812 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:51:06.812Z,1679961066.812 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-03-27T23:53:00.399Z,1679961180.399 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T23:48:00.2Z
2023-03-27T23:53:00.399Z,1679961180.399 [Default:CheckIn:Read_GPS] Stopped
2023-03-27T23:53:00.399Z,1679961180.399 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-27T23:53:07.718Z,1679961187.718 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T233250/Courier0007.lzma
2023-03-27T23:53:09.442Z,1679961189.442 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Courier0007.lzma.bak
2023-03-27T23:53:09.442Z,1679961189.442 [DataOverHttps](INFO): SBD MOMSN=17695394
2023-03-27T23:53:24.282Z,1679961204.282 [DataOverHttps](INFO): Sending 193 bytes from file Logs/20230327T233250/Express0008.lzma
2023-03-27T23:53:25.284Z,1679961205.284 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Express0008.lzma.bak
2023-03-27T23:53:25.284Z,1679961205.284 [DataOverHttps](INFO): SBD MOMSN=17695396
2023-03-27T23:53:27.064Z,1679961207.064 [Default:CheckIn:Read_Iridium] Stopped
2023-03-27T23:53:27.064Z,1679961207.064 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-27T23:53:27.064Z,1679961207.064 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-27T23:54:07.478Z,1679961247.478 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-03-27T23:54:07.478Z,1679961247.478 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:54:07.502Z,1679961247.502 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:54:07.908Z,1679961247.908 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:54:07.908Z,1679961247.908 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-03-27T23:54:25.637Z,1679961265.637 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-27T23:54:25.637Z,1679961265.637 [NAL9602] Data Fault, FailCount= 2
2023-03-27T23:54:25.637Z,1679961265.637 [NAL9602](ERROR): Data Fault
2023-03-27T23:54:25.654Z,1679961265.654 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-27T23:54:26.033Z,1679961266.033 [NAL9602](INFO): Powering down
2023-03-27T23:54:26.861Z,1679961266.861 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-27T23:54:26.861Z,1679961266.861 [NAL9602] No Fault, FailCount= 2
2023-03-27T23:54:56.336Z,1679961296.336 [NAL9602](INFO): Powering up NAL9602
2023-03-27T23:55:07.246Z,1679961307.246 [NAL9602](INFO): NAL9602 initialized
2023-03-27T23:57:08.451Z,1679961428.451 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-03-27T23:57:08.452Z,1679961428.452 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-27T23:57:08.462Z,1679961428.462 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-27T23:57:08.867Z,1679961428.867 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-27T23:57:08.867Z,1679961428.867 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-03-27T23:58:27.638Z,1679961507.638 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-27T23:58:27.638Z,1679961507.638 [Default:CheckIn:C.Wait] Stopped
2023-03-27T23:58:27.639Z,1679961507.639 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-27T23:58:27.639Z,1679961507.639 [Default:CheckIn:D] Running Loop=1
2023-03-27T23:58:28.041Z,1679961508.041 [Default:CheckIn:D] Stopped
2023-03-27T23:58:28.041Z,1679961508.041 [Default:CheckIn:E] Running Loop=1
2023-03-27T23:58:28.446Z,1679961508.446 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.169446 min 
2023-03-27T23:58:28.446Z,1679961508.446 [Default:CheckIn:E] Stopped
2023-03-27T23:58:28.446Z,1679961508.446 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-27T23:58:28.446Z,1679961508.446 [Default:CheckIn] Stopped
2023-03-27T23:58:28.446Z,1679961508.446 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-27T23:58:28.447Z,1679961508.447 [Default:CheckIn](INFO): Running loop #3
2023-03-27T23:58:28.447Z,1679961508.447 [Default:CheckIn] Running Loop=3
2023-03-27T23:58:28.447Z,1679961508.447 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-27T23:58:28.447Z,1679961508.447 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-28T00:00:09.470Z,1679961609.470 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-03-28T00:00:09.470Z,1679961609.470 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:00:09.480Z,1679961609.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:00:09.873Z,1679961609.873 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:00:09.873Z,1679961609.873 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-03-28T00:03:10.483Z,1679961790.483 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-03-28T00:03:10.483Z,1679961790.483 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:03:10.498Z,1679961790.498 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:03:10.903Z,1679961790.903 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:03:10.903Z,1679961790.903 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-03-28T00:03:28.641Z,1679961808.641 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-27T23:58:28.4Z
2023-03-28T00:03:28.641Z,1679961808.641 [Default:CheckIn:Read_GPS] Stopped
2023-03-28T00:03:28.641Z,1679961808.641 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-28T00:03:34.375Z,1679961814.375 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T233250/Courier0010.lzma
2023-03-28T00:03:35.376Z,1679961815.376 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Courier0010.lzma.bak
2023-03-28T00:03:35.377Z,1679961815.377 [DataOverHttps](INFO): SBD MOMSN=17695780
2023-03-28T00:03:50.874Z,1679961830.874 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20230327T233250/Express0011.lzma
2023-03-28T00:03:51.876Z,1679961831.876 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Express0011.lzma.bak
2023-03-28T00:03:51.876Z,1679961831.876 [DataOverHttps](INFO): SBD MOMSN=17695782
2023-03-28T00:03:53.689Z,1679961833.689 [Default:CheckIn:Read_Iridium] Stopped
2023-03-28T00:03:53.689Z,1679961833.689 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-28T00:03:53.689Z,1679961833.689 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-28T00:05:09.232Z,1679961909.232 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-28T00:05:09.232Z,1679961909.232 [NAL9602] Data Fault, FailCount= 3
2023-03-28T00:05:09.232Z,1679961909.232 [NAL9602](ERROR): Data Fault
2023-03-28T00:05:09.266Z,1679961909.266 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-28T00:05:09.624Z,1679961909.624 [NAL9602](INFO): Powering down
2023-03-28T00:05:10.451Z,1679961910.451 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-28T00:05:10.451Z,1679961910.451 [NAL9602] No Fault, FailCount= 3
2023-03-28T00:05:39.928Z,1679961939.928 [NAL9602](INFO): Powering up NAL9602
2023-03-28T00:05:50.836Z,1679961950.836 [NAL9602](INFO): NAL9602 initialized
2023-03-28T00:06:11.457Z,1679961971.457 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-03-28T00:06:11.457Z,1679961971.457 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:06:11.468Z,1679961971.468 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:06:11.884Z,1679961971.884 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:06:11.884Z,1679961971.884 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-03-28T00:08:54.281Z,1679962134.281 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-28T00:08:54.281Z,1679962134.281 [Default:CheckIn:C.Wait] Stopped
2023-03-28T00:08:54.281Z,1679962134.281 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-28T00:08:54.281Z,1679962134.281 [Default:CheckIn:D] Running Loop=1
2023-03-28T00:08:54.689Z,1679962134.689 [Default:CheckIn:D] Stopped
2023-03-28T00:08:54.689Z,1679962134.689 [Default:CheckIn:E] Running Loop=1
2023-03-28T00:08:55.068Z,1679962135.068 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.613584 min 
2023-03-28T00:08:55.068Z,1679962135.068 [Default:CheckIn:E] Stopped
2023-03-28T00:08:55.068Z,1679962135.068 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-28T00:08:55.068Z,1679962135.068 [Default:CheckIn] Stopped
2023-03-28T00:08:55.068Z,1679962135.068 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-28T00:08:55.069Z,1679962135.069 [Default:CheckIn](INFO): Running loop #4
2023-03-28T00:08:55.069Z,1679962135.069 [Default:CheckIn] Running Loop=4
2023-03-28T00:08:55.069Z,1679962135.069 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-28T00:08:55.069Z,1679962135.069 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-28T00:09:12.439Z,1679962152.439 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-03-28T00:09:12.439Z,1679962152.439 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:09:12.473Z,1679962152.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:09:12.886Z,1679962152.886 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:09:12.886Z,1679962152.886 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-03-28T00:12:13.448Z,1679962333.448 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-03-28T00:12:13.448Z,1679962333.448 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:12:13.466Z,1679962333.466 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:12:13.872Z,1679962333.872 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:12:13.872Z,1679962333.872 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-03-28T00:13:55.273Z,1679962435.273 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-28T00:08:55.1Z
2023-03-28T00:13:55.273Z,1679962435.273 [Default:CheckIn:Read_GPS] Stopped
2023-03-28T00:13:55.273Z,1679962435.273 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-28T00:14:01.238Z,1679962441.238 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230327T233250/Courier0013.lzma
2023-03-28T00:14:02.240Z,1679962442.240 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Courier0013.lzma.bak
2023-03-28T00:14:02.240Z,1679962442.240 [DataOverHttps](INFO): SBD MOMSN=17696161
2023-03-28T00:14:17.650Z,1679962457.650 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20230327T233250/Express0014.lzma
2023-03-28T00:14:18.652Z,1679962458.652 [DataOverHttps](INFO): Moved sent file to Logs/20230327T233250/Express0014.lzma.bak
2023-03-28T00:14:18.652Z,1679962458.652 [DataOverHttps](INFO): SBD MOMSN=17696163
2023-03-28T00:14:20.341Z,1679962460.341 [Default:CheckIn:Read_Iridium] Stopped
2023-03-28T00:14:20.341Z,1679962460.341 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-28T00:14:20.341Z,1679962460.341 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-28T00:15:14.459Z,1679962514.459 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2023-03-28T00:15:14.459Z,1679962514.459 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:15:14.469Z,1679962514.469 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:15:14.881Z,1679962514.881 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:15:14.881Z,1679962514.881 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2023-03-28T00:15:52.832Z,1679962552.832 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-28T00:15:52.832Z,1679962552.832 [NAL9602] Data Fault, FailCount= 4
2023-03-28T00:15:52.832Z,1679962552.832 [NAL9602](ERROR): Data Fault
2023-03-28T00:15:52.849Z,1679962552.849 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-28T00:15:53.232Z,1679962553.232 [NAL9602](INFO): Powering down
2023-03-28T00:15:54.060Z,1679962554.060 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-28T00:15:54.060Z,1679962554.060 [NAL9602] No Fault, FailCount= 4
2023-03-28T00:16:23.541Z,1679962583.541 [NAL9602](INFO): Powering up NAL9602
2023-03-28T00:16:34.444Z,1679962594.444 [NAL9602](INFO): NAL9602 initialized
2023-03-28T00:18:03.724Z,1679962683.724 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-28T00:18:03.724Z,1679962683.724 [DropWeight] Hardware Fault, FailCount= 1
2023-03-28T00:18:03.724Z,1679962683.724 [DropWeight](ERROR): Hardware Fault
2023-03-28T00:18:03.740Z,1679962683.740 [CBIT](INFO): Critical error at 20230328T001803
2023-03-28T00:18:03.743Z,1679962683.743 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-28T00:18:03.743Z,1679962683.743 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-28T00:18:04.167Z,1679962684.167 [CBIT](INFO): Critical error at 20230328T001803
2023-03-28T00:18:15.475Z,1679962695.475 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2023-03-28T00:18:15.475Z,1679962695.475 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:18:15.485Z,1679962695.485 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:18:15.885Z,1679962695.885 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:18:15.885Z,1679962695.885 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2023-03-28T00:19:20.896Z,1679962760.896 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-28T00:19:20.896Z,1679962760.896 [Default:CheckIn:C.Wait] Stopped
2023-03-28T00:19:20.896Z,1679962760.896 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-28T00:19:20.896Z,1679962760.896 [Default:CheckIn:D] Running Loop=1
2023-03-28T00:19:21.305Z,1679962761.305 [Default:CheckIn:D] Stopped
2023-03-28T00:19:21.305Z,1679962761.305 [Default:CheckIn:E] Running Loop=1
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.057182 min 
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn:E] Stopped
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn] Stopped
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn](INFO): Running loop #5
2023-03-28T00:19:21.713Z,1679962761.713 [Default:CheckIn] Running Loop=5
2023-03-28T00:19:21.714Z,1679962761.714 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-28T00:19:21.714Z,1679962761.714 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-28T00:21:16.443Z,1679962876.443 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2023-03-28T00:21:16.443Z,1679962876.443 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-28T00:21:16.475Z,1679962876.475 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-28T00:21:16.855Z,1679962876.855 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-28T00:21:16.855Z,1679962876.855 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2023-03-28T00:21:30.455Z,1679962890.455 [CommandExec](IMPORTANT): got command quit
2023-03-28T00:21:31.459Z,1679962891.459 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:31.459Z,1679962891.459 [CommandExec](INFO): Uninitializing the command executive.
2023-03-28T00:21:31.459Z,1679962891.459 [CommandExec](INFO): Uninitializing the command scheduler.
2023-03-28T00:21:31.459Z,1679962891.459 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:31.602Z,1679962891.602 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-03-28T00:21:31.602Z,1679962891.602 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-03-28T00:21:31.603Z,1679962891.603 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:31.603Z,1679962891.603 [NavChartDb](INFO): Join timeout helper Thread ID is 5518
2023-03-28T00:21:31.899Z,1679962891.899 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:31.900Z,1679962891.900 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:31.906Z,1679962891.906 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-03-28T00:21:31.906Z,1679962891.906 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:31.907Z,1679962891.907 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5519
2023-03-28T00:21:31.943Z,1679962891.943 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:31.944Z,1679962891.944 [WetLabsBB2FL](INFO): Powering down
2023-03-28T00:21:31.944Z,1679962891.944 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:31.946Z,1679962891.946 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-03-28T00:21:31.946Z,1679962891.946 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:31.947Z,1679962891.947 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5520
2023-03-28T00:21:32.355Z,1679962892.355 [CTD_Seabird](INFO): Powering down
2023-03-28T00:21:32.372Z,1679962892.372 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:32.379Z,1679962892.379 [CTD_Seabird](INFO): Powering down
2023-03-28T00:21:32.390Z,1679962892.390 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:32.398Z,1679962892.398 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-03-28T00:21:32.399Z,1679962892.399 [DAT ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:32.399Z,1679962892.399 [DAT](INFO): Join timeout helper Thread ID is 5521
2023-03-28T00:21:32.447Z,1679962892.447 [DAT](INFO): Powering down
2023-03-28T00:21:32.519Z,1679962892.519 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:32.519Z,1679962892.519 [DAT](INFO): Powering down
2023-03-28T00:21:32.520Z,1679962892.520 [DAT ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:32.526Z,1679962892.526 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-03-28T00:21:32.526Z,1679962892.526 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:32.527Z,1679962892.527 [Radio_Surface](INFO): Join timeout helper Thread ID is 5522
2023-03-28T00:21:32.707Z,1679962892.707 [Radio_Surface](INFO): Powering down
2023-03-28T00:21:32.707Z,1679962892.707 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:32.708Z,1679962892.708 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:32.723Z,1679962892.723 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-03-28T00:21:32.723Z,1679962892.723 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:32.724Z,1679962892.724 [Onboard](INFO): Join timeout helper Thread ID is 5523
2023-03-28T00:21:33.015Z,1679962893.015 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-03-28T00:21:33.607Z,1679962893.607 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:33.607Z,1679962893.607 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:33.625Z,1679962893.625 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-03-28T00:21:33.625Z,1679962893.625 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:33.625Z,1679962893.625 [DataOverHttps](INFO): Join timeout helper Thread ID is 5524
2023-03-28T00:21:34.018Z,1679962894.018 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:34.019Z,1679962894.019 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.027Z,1679962894.027 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-03-28T00:21:34.027Z,1679962894.027 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.028Z,1679962894.028 [BackseatComponent](INFO): Join timeout helper Thread ID is 5525
2023-03-28T00:21:34.219Z,1679962894.219 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:34.219Z,1679962894.219 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.231Z,1679962894.231 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-03-28T00:21:34.231Z,1679962894.231 [logger ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.232Z,1679962894.232 [logger](INFO): Join timeout helper Thread ID is 5526
2023-03-28T00:21:34.247Z,1679962894.247 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:34.247Z,1679962894.247 [logger ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.255Z,1679962894.255 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-03-28T00:21:34.255Z,1679962894.255 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.256Z,1679962894.256 [CommandLine](INFO): Join timeout helper Thread ID is 5527
2023-03-28T00:21:34.259Z,1679962894.259 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:34.259Z,1679962894.259 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.262Z,1679962894.262 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-03-28T00:21:34.262Z,1679962894.262 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.263Z,1679962894.263 [CommandExec](INFO): Join timeout helper Thread ID is 5528
2023-03-28T00:21:34.264Z,1679962894.264 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-03-28T00:21:34.264Z,1679962894.264 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.265Z,1679962894.265 [controlThread](INFO): Join timeout helper Thread ID is 5529
2023-03-28T00:21:34.598Z,1679962894.598 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-28T00:21:34.599Z,1679962894.599 [controlThread](DEBUG): Uninitializing ControlThread
2023-03-28T00:21:34.599Z,1679962894.599 [AHRS_M2](INFO): Powering down
2023-03-28T00:21:34.671Z,1679962894.671 [MultiRay](INFO): Powering down.
2023-03-28T00:21:34.672Z,1679962894.672 [NAL9602](INFO): Powering down
2023-03-28T00:21:34.674Z,1679962894.674 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-03-28T00:21:34.675Z,1679962894.675 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-03-28T00:21:34.675Z,1679962894.675 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-03-28T00:21:34.676Z,1679962894.676 [MissionManager](INFO): Uninitializing Mission Default
2023-03-28T00:21:34.676Z,1679962894.676 [Default] Stopped
2023-03-28T00:21:34.676Z,1679962894.676 [Default](DEBUG): Aggregate::uninitialize Default
2023-03-28T00:21:34.676Z,1679962894.676 [Default:B.GoToSurface] Stopped
2023-03-28T00:21:34.676Z,1679962894.676 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-28T00:21:34.676Z,1679962894.676 [Default:CheckIn] Stopped
2023-03-28T00:21:34.676Z,1679962894.676 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-28T00:21:34.677Z,1679962894.677 [Default:CheckIn:Read_GPS] Stopped
2023-03-28T00:21:34.679Z,1679962894.679 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-03-28T00:21:34.680Z,1679962894.680 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-03-28T00:21:34.680Z,1679962894.680 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-03-28T00:21:34.680Z,1679962894.680 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-03-28T00:21:34.680Z,1679962894.680 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-03-28T00:21:34.681Z,1679962894.681 [BuoyancyServo](INFO): Powering down
2023-03-28T00:21:34.695Z,1679962894.695 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-03-28T00:21:34.695Z,1679962894.695 [ElevatorServo](INFO): Powering down
2023-03-28T00:21:34.695Z,1679962894.695 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-03-28T00:21:34.696Z,1679962894.696 [MassServo](INFO): Powering down
2023-03-28T00:21:34.696Z,1679962894.696 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-28T00:21:34.697Z,1679962894.697 [RudderServo](INFO): Powering down
2023-03-28T00:21:34.697Z,1679962894.697 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-03-28T00:21:34.697Z,1679962894.697 [ThrusterHE](INFO): Powering down
2023-03-28T00:21:34.698Z,1679962894.698 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-03-28T00:21:34.699Z,1679962894.699 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-03-28T00:21:34.699Z,1679962894.699 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-03-28T00:21:34.699Z,1679962894.699 [CBIT](DEBUG): Powering off loads.
2023-03-28T00:21:34.710Z,1679962894.710 [CBIT](DEBUG): Disabling WDT.
2023-03-28T00:21:34.722Z,1679962894.722 [CBIT](DEBUG): Opening all GF detection circuits.
2023-03-28T00:21:34.723Z,1679962894.723 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.781Z,1679962894.781 [DAT ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.786Z,1679962894.786 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.788Z,1679962894.788 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.795Z,1679962894.795 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.844Z,1679962894.844 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.881Z,1679962894.881 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.885Z,1679962894.885 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.917Z,1679962894.917 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-28T00:21:34.974Z,1679962894.974 [logger ThreadHandler](INFO): Thread cancelled.