2025-09-03T23:26:24.573Z,1756941984.573 [Supervisor](DEBUG): Initializing supervisor. 2025-09-03T23:26:24.577Z,1756941984.577 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-09-03T23:26:24.578Z,1756941984.578 [SyncHandler](INFO): Protected caller Thread ID is 829 2025-09-03T23:26:24.578Z,1756941984.578 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-09-03T23:26:24.579Z,1756941984.579 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-09-03T23:26:24.579Z,1756941984.579 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 830 2025-09-03T23:26:24.583Z,1756941984.583 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-09-03T23:26:24.604Z,1756941984.604 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-09-03T23:26:24.605Z,1756941984.605 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-09-03T23:26:24.605Z,1756941984.605 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 831 2025-09-03T23:26:24.610Z,1756941984.610 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-09-03T23:26:24.611Z,1756941984.611 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-09-03T23:26:24.611Z,1756941984.611 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 832 2025-09-03T23:26:24.613Z,1756941984.613 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-09-03T23:26:24.614Z,1756941984.614 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-09-03T23:26:24.615Z,1756941984.615 [logger ThreadHandler](INFO): Protected caller Thread ID is 833 2025-09-03T23:26:24.618Z,1756941984.618 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-09-03T23:26:24.619Z,1756941984.619 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-09-03T23:26:24.624Z,1756941984.624 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-09-03T23:26:24.730Z,1756941984.730 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-09-03T23:26:24.732Z,1756941984.732 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-09-03T23:26:24.971Z,1756941984.971 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-09-03T23:26:24.973Z,1756941984.973 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-09-03T23:26:25.252Z,1756941985.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-09-03T23:26:25.254Z,1756941985.254 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-09-03T23:26:25.369Z,1756941985.369 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-09-03T23:26:25.371Z,1756941985.371 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-09-03T23:26:26.142Z,1756941986.142 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-09-03T23:26:26.144Z,1756941986.144 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-09-03T23:26:26.687Z,1756941986.687 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-09-03T23:26:26.688Z,1756941986.688 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-09-03T23:26:27.237Z,1756941987.237 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-09-03T23:26:27.237Z,1756941987.237 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-09-03T23:26:27.708Z,1756941987.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-09-03T23:26:27.709Z,1756941987.709 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-09-03T23:26:28.521Z,1756941988.521 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-09-03T23:26:28.523Z,1756941988.523 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-09-03T23:26:28.938Z,1756941988.938 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-09-03T23:26:28.940Z,1756941988.940 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-09-03T23:26:29.176Z,1756941989.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-09-03T23:26:29.178Z,1756941989.178 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-09-03T23:26:29.331Z,1756941989.331 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-09-03T23:26:29.331Z,1756941989.331 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-09-03T23:26:29.433Z,1756941989.433 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-09-03T23:26:29.434Z,1756941989.434 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-09-03T23:26:29.523Z,1756941989.523 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-09-03T23:26:29.715Z,1756941989.715 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-09-03T23:26:29.715Z,1756941989.715 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-09-03T23:26:29.971Z,1756941989.971 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-09-03T23:26:29.973Z,1756941989.973 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-09-03T23:26:29.977Z,1756941989.977 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-09-03T23:26:30.070Z,1756941990.070 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-09-03T23:26:30.352Z,1756941990.352 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-09-03T23:26:30.353Z,1756941990.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-09-03T23:26:30.447Z,1756941990.447 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-09-03T23:26:30.627Z,1756941990.627 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-09-03T23:26:30.737Z,1756941990.737 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-09-03T23:26:30.856Z,1756941990.856 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-09-03T23:26:30.977Z,1756941990.977 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-09-03T23:26:31.082Z,1756941991.082 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-09-03T23:26:31.249Z,1756941991.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-09-03T23:26:31.356Z,1756941991.356 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-09-03T23:26:31.450Z,1756941991.450 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-09-03T23:26:31.557Z,1756941991.557 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-09-03T23:26:31.652Z,1756941991.652 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-09-03T23:26:31.657Z,1756941991.657 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-09-03T23:26:31.885Z,1756941991.885 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-09-03T23:26:31.886Z,1756941991.886 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-09-03T23:26:32.086Z,1756941992.086 [BuoyancyServo] Loaded 2025-09-03T23:26:32.086Z,1756941992.086 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-09-03T23:26:32.110Z,1756941992.110 [ElevatorServo] Loaded 2025-09-03T23:26:32.110Z,1756941992.110 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-09-03T23:26:32.134Z,1756941992.134 [MassServo] Loaded 2025-09-03T23:26:32.134Z,1756941992.134 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-09-03T23:26:32.157Z,1756941992.157 [RudderServo] Loaded 2025-09-03T23:26:32.157Z,1756941992.157 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-09-03T23:26:32.175Z,1756941992.175 [ThrusterHE] Loaded 2025-09-03T23:26:32.175Z,1756941992.175 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-09-03T23:26:32.176Z,1756941992.176 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-09-03T23:26:32.178Z,1756941992.178 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-09-03T23:26:32.383Z,1756941992.383 [SBIT](DEBUG): Construct Startup Built In Test. 2025-09-03T23:26:32.398Z,1756941992.398 [SBIT] Loaded 2025-09-03T23:26:32.398Z,1756941992.398 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-09-03T23:26:32.401Z,1756941992.401 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-09-03T23:26:32.423Z,1756941992.423 [IBIT] Loaded 2025-09-03T23:26:32.423Z,1756941992.423 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-09-03T23:26:32.428Z,1756941992.428 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-09-03T23:26:32.631Z,1756941992.631 [CBIT] Loaded 2025-09-03T23:26:32.632Z,1756941992.632 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-09-03T23:26:32.664Z,1756941992.664 [GFScanner] Loaded 2025-09-03T23:26:32.664Z,1756941992.664 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-09-03T23:26:32.665Z,1756941992.665 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-09-03T23:26:32.665Z,1756941992.665 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-09-03T23:26:32.892Z,1756941992.892 [CTD_Seabird] Loaded 2025-09-03T23:26:32.892Z,1756941992.892 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-09-03T23:26:32.893Z,1756941992.893 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406874E0 2025-09-03T23:26:32.893Z,1756941992.893 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 921 2025-09-03T23:26:32.929Z,1756941992.929 [ESPComponent] Loaded 2025-09-03T23:26:32.929Z,1756941992.929 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-09-03T23:26:32.952Z,1756941992.952 [PAR_Licor] Loaded 2025-09-03T23:26:32.952Z,1756941992.952 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-09-03T23:26:32.998Z,1756941992.998 [WetLabsBB2FL] Loaded 2025-09-03T23:26:32.998Z,1756941992.998 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-09-03T23:26:32.999Z,1756941992.999 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B74E0 2025-09-03T23:26:32.000Z,1756941993.000 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 922 2025-09-03T23:26:33.000Z,1756941993.000 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-09-03T23:26:33.001Z,1756941993.001 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-09-03T23:26:33.237Z,1756941993.237 [DepthRateCalculator] Loaded 2025-09-03T23:26:33.238Z,1756941993.238 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-09-03T23:26:33.266Z,1756941993.266 [PitchRateCalculator] Loaded 2025-09-03T23:26:33.267Z,1756941993.267 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-09-03T23:26:33.292Z,1756941993.292 [SpeedCalculator] Loaded 2025-09-03T23:26:33.293Z,1756941993.293 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-09-03T23:26:33.305Z,1756941993.305 [YawRateCalculator] Loaded 2025-09-03T23:26:33.306Z,1756941993.306 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-09-03T23:26:33.392Z,1756941993.392 [ElevatorOffsetCalculator] Loaded 2025-09-03T23:26:33.392Z,1756941993.392 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-09-03T23:26:33.393Z,1756941993.393 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-09-03T23:26:33.393Z,1756941993.393 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-09-03T23:26:34.181Z,1756941994.181 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-09-03T23:26:34.181Z,1756941994.181 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-09-03T23:26:34.230Z,1756941994.230 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-09-03T23:26:34.231Z,1756941994.231 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-09-03T23:26:34.374Z,1756941994.374 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-09-03T23:26:34.375Z,1756941994.375 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-09-03T23:26:34.389Z,1756941994.389 [NavChart] Loaded 2025-09-03T23:26:34.389Z,1756941994.389 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-09-03T23:26:34.395Z,1756941994.395 [UniversalFixResidualReporter] Loaded 2025-09-03T23:26:34.396Z,1756941994.396 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-09-03T23:26:34.396Z,1756941994.396 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-09-03T23:26:34.397Z,1756941994.397 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-09-03T23:26:35.294Z,1756941995.294 [AHRS_M2] Loaded 2025-09-03T23:26:35.295Z,1756941995.295 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-09-03T23:26:35.549Z,1756941995.549 [BackseatComponent] Loaded 2025-09-03T23:26:35.549Z,1756941995.549 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-09-03T23:26:35.550Z,1756941995.550 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A854E0 2025-09-03T23:26:35.550Z,1756941995.550 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2025-09-03T23:26:35.553Z,1756941995.553 [LcmUniversalReporter] Loaded 2025-09-03T23:26:35.554Z,1756941995.554 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-09-03T23:26:36.333Z,1756941996.333 [BPC1] Loaded 2025-09-03T23:26:36.333Z,1756941996.333 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-09-03T23:26:36.437Z,1756941996.437 [DAT] Loaded 2025-09-03T23:26:36.438Z,1756941996.438 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-09-03T23:26:36.439Z,1756941996.439 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB54E0 2025-09-03T23:26:36.439Z,1756941996.439 [DAT ThreadHandler](INFO): Protected caller Thread ID is 924 2025-09-03T23:26:36.581Z,1756941996.581 [DataOverHttps] Loaded 2025-09-03T23:26:36.581Z,1756941996.581 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-09-03T23:26:36.582Z,1756941996.582 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE54E0 2025-09-03T23:26:36.583Z,1756941996.583 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925 2025-09-03T23:26:36.607Z,1756941996.607 [Depth_Keller] Loaded 2025-09-03T23:26:36.608Z,1756941996.608 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-09-03T23:26:36.613Z,1756941996.613 [DropWeight] Loaded 2025-09-03T23:26:36.613Z,1756941996.613 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-09-03T23:26:36.656Z,1756941996.656 [DVL_micro] Loaded 2025-09-03T23:26:36.656Z,1756941996.656 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-09-03T23:26:36.721Z,1756941996.721 [NAL9602] Loaded 2025-09-03T23:26:36.721Z,1756941996.721 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-09-03T23:26:36.748Z,1756941996.748 [Onboard] Loaded 2025-09-03T23:26:36.748Z,1756941996.748 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-09-03T23:26:36.749Z,1756941996.749 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B154E0 2025-09-03T23:26:36.750Z,1756941996.750 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926 2025-09-03T23:26:36.765Z,1756941996.765 [Power24vConverter] Loaded 2025-09-03T23:26:36.765Z,1756941996.765 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-09-03T23:26:36.782Z,1756941996.782 [Radio_Surface] Loaded 2025-09-03T23:26:36.782Z,1756941996.782 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-09-03T23:26:36.783Z,1756941996.783 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B454E0 2025-09-03T23:26:36.784Z,1756941996.784 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927 2025-09-03T23:26:36.800Z,1756941996.800 [Sonardyne_Nano] Loaded 2025-09-03T23:26:36.800Z,1756941996.800 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-09-03T23:26:36.801Z,1756941996.801 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-09-03T23:26:36.801Z,1756941996.801 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-09-03T23:26:36.890Z,1756941996.890 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-09-03T23:26:36.892Z,1756941996.892 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-09-03T23:26:36.966Z,1756941996.966 [VerticalControl](DEBUG): Construct VerticalControl. 2025-09-03T23:26:37.064Z,1756941997.064 [VerticalControl] Loaded 2025-09-03T23:26:37.065Z,1756941997.065 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-09-03T23:26:37.068Z,1756941997.068 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-09-03T23:26:37.113Z,1756941997.113 [HorizontalControl] Loaded 2025-09-03T23:26:37.114Z,1756941997.114 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-09-03T23:26:37.116Z,1756941997.116 [SpeedControl](DEBUG): Construct SpeedControl. 2025-09-03T23:26:37.118Z,1756941997.118 [SpeedControl] Loaded 2025-09-03T23:26:37.118Z,1756941997.118 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-09-03T23:26:37.121Z,1756941997.121 [LoopControl](DEBUG): Construct LoopControl. 2025-09-03T23:26:37.122Z,1756941997.122 [LoopControl] Loaded 2025-09-03T23:26:37.122Z,1756941997.122 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-09-03T23:26:37.122Z,1756941997.122 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-09-03T23:26:37.123Z,1756941997.123 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-09-03T23:26:37.139Z,1756941997.139 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-09-03T23:26:37.140Z,1756941997.140 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-09-03T23:26:37.560Z,1756941997.560 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-09-03T23:26:37.567Z,1756941997.567 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-09-03T23:26:37.570Z,1756941997.570 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-09-03T23:26:37.582Z,1756941997.582 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-09-03T23:26:37.583Z,1756941997.583 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0 2025-09-03T23:26:37.583Z,1756941997.583 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929 2025-09-03T23:26:37.587Z,1756941997.587 [Supervisor](INFO): Main Thread ID is 822 2025-09-03T23:26:37.587Z,1756941997.587 [Supervisor](DEBUG): Running supervisor. 2025-09-03T23:26:37.588Z,1756941997.588 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930 2025-09-03T23:26:37.589Z,1756941997.589 [CommandExec](INFO): Initializing the command executive. 2025-09-03T23:26:37.590Z,1756941997.590 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931 2025-09-03T23:26:37.592Z,1756941997.592 [controlThread ThreadHandler](INFO): Handler Thread ID is 932 2025-09-03T23:26:37.593Z,1756941997.593 [controlThread](DEBUG): Initializing ControlThread 2025-09-03T23:26:37.595Z,1756941997.595 [SBIT](INFO): Initialize SBIT Component. 2025-09-03T23:26:37.595Z,1756941997.595 [SBIT](IMPORTANT): git: 2025-08-26 2025-09-03T23:26:37.595Z,1756941997.595 [SBIT](INFO): git hash: bb7b608ae095ad33f3a1ba1dc4d6b0b36a605f14 2025-09-03T23:26:37.595Z,1756941997.595 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-09-03T23:26:37.597Z,1756941997.597 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-09-03T23:26:37.598Z,1756941997.598 [SBIT](INFO): Beginning SBIT in 107.000000 seconds. 2025-09-03T23:26:37.599Z,1756941997.599 [IBIT](INFO): Initialize IBIT Component. 2025-09-03T23:26:37.599Z,1756941997.599 [CBIT](DEBUG): Initialize CBIT Component. 2025-09-03T23:26:37.600Z,1756941997.600 [logger ThreadHandler](INFO): Handler Thread ID is 933 2025-09-03T23:26:37.612Z,1756941997.612 [CBIT](DEBUG): Initialized mux pins. 2025-09-03T23:26:37.612Z,1756941997.612 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2025-09-03T23:26:37.612Z,1756941997.612 [CBIT](DEBUG): Initializing the watchdog timer. 2025-09-03T23:26:37.620Z,1756941997.620 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 934 2025-09-03T23:26:37.621Z,1756941997.621 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-09-03T23:26:37.625Z,1756941997.625 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 936 2025-09-03T23:26:37.628Z,1756941997.628 [WetLabsBB2FL](INFO): Powering up 2025-09-03T23:26:37.629Z,1756941997.629 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 938 2025-09-03T23:26:37.636Z,1756941997.636 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-09-03T23:26:37.636Z,1756941997.636 [CBIT](DEBUG): Initializing heartbeat. 2025-09-03T23:26:37.637Z,1756941997.637 [DAT ThreadHandler](INFO): Handler Thread ID is 939 2025-09-03T23:26:37.638Z,1756941997.638 [DAT](INFO): Powering up 2025-09-03T23:26:37.638Z,1756941997.638 [DAT](DEBUG): Initializing DAT. 2025-09-03T23:26:37.641Z,1756941997.641 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 941 2025-09-03T23:26:37.643Z,1756941997.643 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-09-03T23:26:37.664Z,1756941997.664 [Onboard ThreadHandler](INFO): Handler Thread ID is 942 2025-09-03T23:26:37.681Z,1756941997.681 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 943 2025-09-03T23:26:37.708Z,1756941997.708 [CBIT](DEBUG): Deactivating emergency mode. 2025-09-03T23:26:37.709Z,1756941997.709 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 944 2025-09-03T23:26:37.716Z,1756941997.716 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-09-03T23:26:37.717Z,1756941997.717 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-09-03T23:26:37.748Z,1756941997.748 [CBIT](DEBUG): Backplane powered. 2025-09-03T23:26:37.748Z,1756941997.748 [GFScanner](DEBUG): Initializing GFScanner 2025-09-03T23:26:37.748Z,1756941997.748 [GFScanner](DEBUG): Deactivating GF circuits. 2025-09-03T23:26:37.756Z,1756941997.756 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-09-03T23:26:37.757Z,1756941997.757 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-09-03T23:26:37.757Z,1756941997.757 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-09-03T23:26:37.757Z,1756941997.757 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-09-03T23:26:37.758Z,1756941997.758 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-09-03T23:26:37.759Z,1756941997.759 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-09-03T23:26:37.759Z,1756941997.759 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-09-03T23:26:37.763Z,1756941997.763 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-09-03T23:26:37.773Z,1756941997.773 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-09-03T23:26:37.773Z,1756941997.773 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-09-03T23:26:37.774Z,1756941997.774 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-09-03T23:26:37.774Z,1756941997.774 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-09-03T23:26:37.775Z,1756941997.775 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-09-03T23:26:37.775Z,1756941997.775 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-09-03T23:26:37.784Z,1756941997.784 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-09-03T23:26:37.862Z,1756941997.862 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-09-03T23:26:37.867Z,1756941997.867 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-09-03T23:26:37.915Z,1756941997.915 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2025-09-03T23:26:37.928Z,1756941997.928 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-09-03T23:26:37.928Z,1756941997.928 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-09-03T23:26:37.933Z,1756941997.933 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-09-03T23:26:38.088Z,1756941998.088 [Radio_Surface](INFO): Powering up 2025-09-03T23:26:38.218Z,1756941998.218 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-09-03T23:26:38.256Z,1756941998.256 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-09-03T23:26:38.257Z,1756941998.257 [Default:A.Wait](DEBUG): Construct Wait. 2025-09-03T23:26:38.259Z,1756941998.259 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-09-03T23:26:38.303Z,1756941998.303 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-09-03T23:26:38.305Z,1756941998.305 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-09-03T23:26:38.327Z,1756941998.327 [Default:E.Execute](DEBUG): Construct Execute. 2025-09-03T23:26:38.330Z,1756941998.330 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2025-09-03T23:26:38.340Z,1756941998.340 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-09-03T23:26:38.351Z,1756941998.351 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-09-03T23:26:38.493Z,1756941998.493 [Depth_Keller](INFO): Initializing. 2025-09-03T23:26:38.501Z,1756941998.501 [Power24vConverter](INFO): Powering up. 2025-09-03T23:26:38.501Z,1756941998.501 [Sonardyne_Nano](INFO): Initializing. 2025-09-03T23:26:38.528Z,1756941998.528 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-09-03T23:26:38.577Z,1756941998.577 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:26:38.580Z,1756941998.580 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-09-03T23:26:38.581Z,1756941998.581 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:26:38.588Z,1756941998.588 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-09-03T23:26:38.589Z,1756941998.589 [MassServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:26:38.596Z,1756941998.596 [MassServo](DEBUG): Initializing MassServo. 2025-09-03T23:26:38.597Z,1756941998.597 [RudderServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:26:38.604Z,1756941998.604 [RudderServo](DEBUG): Initializing RudderServo. 2025-09-03T23:26:38.605Z,1756941998.605 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-09-03T23:26:38.612Z,1756941998.612 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-09-03T23:26:38.794Z,1756941998.794 [Depth_Keller](ERROR): Pressure or depth reading out of range: 947.322021 decibar, 0.000000 m 2025-09-03T23:26:38.798Z,1756941998.798 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-09-03T23:26:40.240Z,1756942000.240 [WetLabsBB2FL](INFO): Powering down 2025-09-03T23:26:40.778Z,1756942000.778 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-09-03T23:26:42.029Z,1756942002.029 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-09-03T23:26:44.269Z,1756942004.269 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-09-03T23:26:49.989Z,1756942009.989 [DAT](INFO): DAT read: 2025-09-03T23:26:49.990Z,1756942009.990 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-09-03T23:26:51.753Z,1756942011.753 [DAT](INFO): DAT read: MF Frequency Band 2025-09-03T23:26:51.754Z,1756942011.754 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-09-03T23:26:51.755Z,1756942011.755 [DAT](INFO): DAT read: Sep 3 2025 23:26:41 2025-09-03T23:26:52.761Z,1756942012.761 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-09-03T23:26:52.762Z,1756942012.762 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-09-03T23:26:52.762Z,1756942012.762 [DAT](INFO): commRate: 1200 2025-09-03T23:26:54.828Z,1756942014.828 [DAT](INFO): entering command mode 2025-09-03T23:26:55.029Z,1756942015.029 [DAT](INFO): DAT read: 2025-09-03T23:26:55.029Z,1756942015.029 [DAT](INFO): DAT read: user:1> 2025-09-03T23:26:55.030Z,1756942015.030 [DAT](INFO): setting verbose to 3 2025-09-03T23:26:55.281Z,1756942015.281 [DAT](INFO): DAT read: user:1> 2025-09-03T23:26:55.282Z,1756942015.282 [DAT](INFO): DAT read: Verbose | 3 2025-09-03T23:26:55.282Z,1756942015.282 [DAT](INFO): set verbose to 3 2025-09-03T23:26:55.282Z,1756942015.282 [DAT](INFO): setting DatVerbose to 27440 2025-09-03T23:26:55.533Z,1756942015.533 [DAT](INFO): DAT read: user:2> 2025-09-03T23:26:55.534Z,1756942015.534 [DAT](INFO): DAT read: DatVerbose | 27440 2025-09-03T23:26:55.534Z,1756942015.534 [DAT](INFO): set DatVerbose to 27440 2025-09-03T23:26:55.534Z,1756942015.534 [DAT](INFO): setting transmit power to 8 2025-09-03T23:26:55.785Z,1756942015.785 [DAT](INFO): DAT read: user:3> 2025-09-03T23:26:55.786Z,1756942015.786 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-09-03T23:26:55.786Z,1756942015.786 [DAT](INFO): set transmit power to 8 2025-09-03T23:26:55.786Z,1756942015.786 [DAT](INFO): setting local address to 5 2025-09-03T23:26:56.037Z,1756942016.037 [DAT](INFO): DAT read: user:4> 2025-09-03T23:26:56.038Z,1756942016.038 [DAT](INFO): DAT read: LocalAddr | 5 2025-09-03T23:26:56.038Z,1756942016.038 [DAT](INFO): set local address to 5 2025-09-03T23:26:56.039Z,1756942016.039 [DAT](INFO): Setting time to: 23:26:56 And date to:9/3/2025 2025-09-03T23:26:56.289Z,1756942016.289 [DAT](INFO): DAT read: user:5> 2025-09-03T23:26:56.291Z,1756942016.291 [DAT](INFO): DAT read: Wed Sep 3, 2025 23:26:56 2025-09-03T23:26:56.291Z,1756942016.291 [DAT](INFO): Local DAT time set to Wed Sep 3, 2025 23:26:56 2025-09-03T23:27:07.075Z,1756942027.075 [NAL9602](INFO): Powering up NAL9602 2025-09-03T23:27:17.959Z,1756942037.959 [NAL9602](INFO): NAL9602 initialized 2025-09-03T23:27:52.699Z,1756942072.699 [NAL9602](INFO): SBD MO Status=2, MOMSN=22866, MT Status=2, MTMSN=0 2025-09-03T23:27:52.700Z,1756942072.700 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-09-03T23:28:12.137Z,1756942092.137 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:28:25.033Z,1756942105.033 [SBIT](IMPORTANT): Beginning Startup BIT 2025-09-03T23:28:25.038Z,1756942105.038 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-09-03T23:28:29.977Z,1756942109.977 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.005829 CHAN A1 (24V): 0.014576 CHAN A2 (12V): -0.001547 CHAN A3 (5V): -0.005842 CHAN B0 (3.3V): -0.001472 CHAN B1 (3.15aV): -0.001612 CHAN B2 (3.15bV): -0.001956 CHAN B3 (GND): -0.002531 OPEN: 0.006680 Full Scale: +/- 1 mA 2025-09-03T23:28:33.502Z,1756942113.502 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004547 2025-09-03T23:28:43.534Z,1756942123.534 [ElevatorServo](FAULT): Overload Error 2025-09-03T23:28:43.534Z,1756942123.534 [ElevatorServo] Hardware Fault, FailCount= 1 2025-09-03T23:28:43.534Z,1756942123.534 [ElevatorServo](ERROR): Hardware Fault 2025-09-03T23:28:43.700Z,1756942123.700 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-09-03T23:28:43.913Z,1756942123.913 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-09-03T23:28:43.913Z,1756942123.913 [ElevatorServo](INFO): Powering down 2025-09-03T23:28:44.731Z,1756942124.731 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:28:44.849Z,1756942124.849 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-09-03T23:28:44.881Z,1756942124.881 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-09-03T23:28:44.881Z,1756942124.881 [ElevatorServo] No Fault, FailCount= 1 2025-09-03T23:28:49.998Z,1756942129.998 [ElevatorServo](FAULT): Overload Error 2025-09-03T23:28:49.998Z,1756942129.998 [ElevatorServo] Hardware Fault, FailCount= 2 2025-09-03T23:28:49.998Z,1756942129.998 [ElevatorServo](ERROR): Hardware Fault 2025-09-03T23:28:50.129Z,1756942130.129 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-09-03T23:28:50.365Z,1756942130.365 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-09-03T23:28:50.365Z,1756942130.365 [ElevatorServo](INFO): Powering down 2025-09-03T23:28:51.162Z,1756942131.162 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:28:51.281Z,1756942131.281 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-09-03T23:28:51.313Z,1756942131.313 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-09-03T23:28:51.313Z,1756942131.313 [ElevatorServo] No Fault, FailCount= 2 2025-09-03T23:28:56.440Z,1756942136.440 [ElevatorServo](FAULT): Overload Error 2025-09-03T23:28:56.440Z,1756942136.440 [ElevatorServo] Hardware Fault, FailCount= 3 2025-09-03T23:28:56.440Z,1756942136.440 [ElevatorServo](ERROR): Hardware Fault 2025-09-03T23:28:56.549Z,1756942136.549 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-09-03T23:28:56.549Z,1756942136.549 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2025-09-03T23:28:56.829Z,1756942136.829 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-09-03T23:28:56.829Z,1756942136.829 [ElevatorServo](INFO): Powering down 2025-09-03T23:28:56.833Z,1756942136.833 [CommandExec](FAULT): Scheduling is paused 2025-09-03T23:28:56.833Z,1756942136.833 [CBIT](INFO): Critical error at 20250903T232856 2025-09-03T23:28:56.833Z,1756942136.833 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-09-03T23:28:57.691Z,1756942137.691 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-09-03T23:28:57.809Z,1756942137.809 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-09-03T23:29:04.514Z,1756942144.514 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-09-03T23:29:04.515Z,1756942144.515 [SBIT](FAULT): Control surface position failure. 2025-09-03T23:29:18.264Z,1756942158.264 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-09-03T23:29:18.264Z,1756942158.264 [SBIT](FAULT): Control surface position failure. 2025-09-03T23:29:18.667Z,1756942158.667 [SBIT](CRITICAL): SBIT FAILED 2025-09-03T23:29:18.667Z,1756942158.667 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-09-03T23:29:18.669Z,1756942158.669 [CBIT](INFO): Critical error at 20250903T232918 2025-09-03T23:29:19.033Z,1756942159.033 [MissionManager](IMPORTANT): Started mission Startup 2025-09-03T23:29:19.033Z,1756942159.033 [Startup] Running Loop=1 2025-09-03T23:29:19.033Z,1756942159.033 [Startup](DEBUG): Aggregate::initialize Startup 2025-09-03T23:29:19.033Z,1756942159.033 [Startup:A.GoToSurface] Running Loop=1 2025-09-03T23:29:19.033Z,1756942159.033 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-09-03T23:29:19.034Z,1756942159.034 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-09-03T23:29:19.034Z,1756942159.034 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-09-03T23:29:19.035Z,1756942159.035 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-09-03T23:29:19.035Z,1756942159.035 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-09-03T23:29:19.035Z,1756942159.035 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-09-03T23:29:19.036Z,1756942159.036 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-09-03T23:29:19.038Z,1756942159.038 [Startup:StartupSatComms] Running Loop=1 2025-09-03T23:29:19.038Z,1756942159.038 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-09-03T23:29:19.038Z,1756942159.038 [Startup:StartupSatComms:A] Running Loop=1 2025-09-03T23:29:19.447Z,1756942159.447 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-09-03T23:29:37.671Z,1756942177.671 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:29:38.036Z,1756942178.036 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-09-03T23:29:38.036Z,1756942178.036 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-09-03T23:29:38.046Z,1756942178.046 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-09-03T23:29:38.505Z,1756942178.505 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-09-03T23:29:38.505Z,1756942178.505 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-09-03T23:30:19.236Z,1756942219.236 [Startup:StartupSatComms:A](INFO): Timed out from 2025-09-03T23:29:19.0Z 2025-09-03T23:30:19.236Z,1756942219.236 [Startup:StartupSatComms:A] Stopped 2025-09-03T23:30:19.236Z,1756942219.236 [Startup:StartupSatComms:B] Running Loop=1 2025-09-03T23:30:19.637Z,1756942219.637 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-09-03T23:30:27.804Z,1756942227.804 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250903T224626/Courier0019.lzma 2025-09-03T23:30:28.807Z,1756942228.807 [DataOverHttps](INFO): Moved sent file to Logs/20250903T224626/Courier0019.lzma.bak 2025-09-03T23:30:28.809Z,1756942228.809 [DataOverHttps](INFO): SBD MOMSN=25925233 2025-09-03T23:30:51.692Z,1756942251.692 [DataOverHttps](INFO): Sending 231 bytes from file Logs/20250903T232624/Courier0000.lzma 2025-09-03T23:30:52.695Z,1756942252.695 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0000.lzma.bak 2025-09-03T23:30:52.695Z,1756942252.695 [DataOverHttps](INFO): SBD MOMSN=25925235 2025-09-03T23:30:56.117Z,1756942256.117 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:31:01.105Z,1756942261.105 [DataOverHttps](IMPORTANT): SBD MTMSN=20250903T233047 2025-09-03T23:31:03.703Z,1756942263.703 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2025-09-03T23:31:08.468Z,1756942268.468 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250903T202251/Express0092.lzma 2025-09-03T23:31:08.470Z,1756942268.470 [DataOverHttps](INFO): Received command: strobe off 2025-09-03T23:31:08.489Z,1756942268.489 [CommandExec](IMPORTANT): got command strobe off 2025-09-03T23:31:08.490Z,1756942268.490 [CommandExec](IMPORTANT): Deactivating strobe 2025-09-03T23:31:11.070Z,1756942271.070 [DataOverHttps](INFO): Moved sent file to Logs/20250903T202251/Express0092.lzma.bak 2025-09-03T23:31:11.071Z,1756942271.071 [DataOverHttps](INFO): SBD MOMSN=25925241 2025-09-03T23:31:19.479Z,1756942279.479 [Startup:StartupSatComms:B](INFO): Timed out from 2025-09-03T23:30:19.2Z 2025-09-03T23:31:19.479Z,1756942279.479 [Startup:StartupSatComms:B] Stopped 2025-09-03T23:31:19.479Z,1756942279.479 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-09-03T23:31:19.479Z,1756942279.479 [Startup:StartupSatComms] Stopped 2025-09-03T23:31:19.479Z,1756942279.479 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-09-03T23:31:19.480Z,1756942279.480 [Startup](INFO): Completed Startup 2025-09-03T23:31:19.480Z,1756942279.480 [MissionManager](INFO): Startup is completed. 2025-09-03T23:31:19.480Z,1756942279.480 [MissionManager](INFO): Uninitializing Mission Startup 2025-09-03T23:31:19.480Z,1756942279.480 [Startup] Stopped 2025-09-03T23:31:19.481Z,1756942279.481 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-09-03T23:31:19.481Z,1756942279.481 [Startup:A.GoToSurface] Stopped 2025-09-03T23:31:19.481Z,1756942279.481 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-09-03T23:31:19.867Z,1756942279.867 [MissionManager](IMPORTANT): Started mission Default 2025-09-03T23:31:19.867Z,1756942279.867 [Default] Running Loop=1 2025-09-03T23:31:19.867Z,1756942279.867 [Default](DEBUG): Aggregate::initialize Default 2025-09-03T23:31:19.867Z,1756942279.867 [Default:B.GoToSurface] Running Loop=1 2025-09-03T23:31:19.867Z,1756942279.867 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-09-03T23:31:19.868Z,1756942279.868 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-09-03T23:31:19.868Z,1756942279.868 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-09-03T23:31:19.869Z,1756942279.869 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-09-03T23:31:19.869Z,1756942279.869 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-09-03T23:31:19.869Z,1756942279.869 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-09-03T23:31:19.870Z,1756942279.870 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-09-03T23:31:19.870Z,1756942279.870 [Default:A.Wait] Running Loop=1 2025-09-03T23:31:19.870Z,1756942279.870 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-09-03T23:31:25.891Z,1756942285.891 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250903T232624/Courier0004.lzma 2025-09-03T23:31:26.894Z,1756942286.894 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0004.lzma.bak 2025-09-03T23:31:26.894Z,1756942286.894 [DataOverHttps](INFO): SBD MOMSN=25925244 2025-09-03T23:31:28.748Z,1756942288.748 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-09-03T23:31:28.748Z,1756942288.748 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2025-09-03T23:31:33.205Z,1756942293.205 [Default:A.Wait](INFO): Done Waiting. 2025-09-03T23:31:33.205Z,1756942293.205 [Default:A.Wait] Stopped 2025-09-03T23:31:33.205Z,1756942293.205 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-09-03T23:31:33.634Z,1756942293.634 [Default:CheckIn] Running Loop=1 2025-09-03T23:31:33.634Z,1756942293.634 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-09-03T23:31:33.634Z,1756942293.634 [Default:CheckIn:Read_GPS] Running Loop=1 2025-09-03T23:31:34.034Z,1756942294.034 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-09-03T23:31:39.305Z,1756942299.305 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:31:50.238Z,1756942310.238 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:01.131Z,1756942321.131 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:07.163Z,1756942327.163 [NAL9602](INFO): SBD MO Status=2, MOMSN=22866, MT Status=2, MTMSN=0 2025-09-03T23:32:07.163Z,1756942327.163 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-09-03T23:32:12.466Z,1756942332.466 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:15.613Z,1756942335.613 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:21.275Z,1756942341.275 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-09-03T23:32:26.545Z,1756942346.545 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233210.00,A,3648.17163,N,12147.27846,W,0.194,259.48,030925,,,A*7B 2025-09-03T23:32:26.548Z,1756942346.548 [NAL9602](INFO): GPS fix at 20250903T233210: (36.802861, -121.787974) 2025-09-03T23:32:26.559Z,1756942346.559 [Default:CheckIn:Read_GPS] Stopped 2025-09-03T23:32:26.559Z,1756942346.559 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-09-03T23:32:26.994Z,1756942346.994 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:27.071Z,1756942347.071 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-09-03T23:32:27.417Z,1756942347.417 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20250903T232624/Courier0007.lzma 2025-09-03T23:32:28.174Z,1756942348.174 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0007.lzma.bak 2025-09-03T23:32:28.174Z,1756942348.174 [DataOverHttps](INFO): SBD MOMSN=25925246 2025-09-03T23:32:38.083Z,1756942358.083 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:39.327Z,1756942359.327 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:45.735Z,1756942365.735 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250903T224626/Express0020.lzma 2025-09-03T23:32:46.738Z,1756942366.738 [DataOverHttps](INFO): Moved sent file to Logs/20250903T224626/Express0020.lzma.bak 2025-09-03T23:32:46.738Z,1756942366.738 [DataOverHttps](INFO): SBD MOMSN=25925249 2025-09-03T23:32:49.368Z,1756942369.368 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:32:59.015Z,1756942379.015 [NAL9602](INFO): Not Powering down - fast GPS 2025-09-03T23:33:00.356Z,1756942380.356 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:33:03.010Z,1756942383.010 [DataOverHttps](INFO): Sending 810 bytes from file Logs/20250903T232624/Express0001.lzma 2025-09-03T23:33:04.010Z,1756942384.010 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0001.lzma.bak 2025-09-03T23:33:04.010Z,1756942384.010 [DataOverHttps](INFO): SBD MOMSN=25925251 2025-09-03T23:33:11.190Z,1756942391.190 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:33:20.096Z,1756942400.096 [DataOverHttps](INFO): Sending 164 bytes from file Logs/20250903T232624/Express0005.lzma 2025-09-03T23:33:21.098Z,1756942401.098 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0005.lzma.bak 2025-09-03T23:33:21.098Z,1756942401.098 [DataOverHttps](INFO): SBD MOMSN=25925270 2025-09-03T23:33:22.095Z,1756942402.095 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:33:31.726Z,1756942411.726 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-09-03T23:33:31.727Z,1756942411.727 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2025-09-03T23:33:37.389Z,1756942417.389 [DataOverHttps](INFO): Sending 403 bytes from file Logs/20250903T232624/Express0008.lzma 2025-09-03T23:33:38.382Z,1756942418.382 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0008.lzma.bak 2025-09-03T23:33:38.382Z,1756942418.382 [DataOverHttps](INFO): SBD MOMSN=25925275 2025-09-03T23:33:39.818Z,1756942419.818 [Default:CheckIn:Read_Iridium] Stopped 2025-09-03T23:33:39.818Z,1756942419.818 [Default:CheckIn:C.Wait] Running Loop=1 2025-09-03T23:33:39.819Z,1756942419.819 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-09-03T23:33:43.171Z,1756942423.171 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:33:54.416Z,1756942434.416 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:34:06.119Z,1756942446.119 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:35:11.977Z,1756942511.977 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:35:26.121Z,1756942526.121 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:35:36.210Z,1756942536.210 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:36:00.896Z,1756942560.896 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:36:15.772Z,1756942575.772 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-09-03T23:36:33.990Z,1756942593.990 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:37:09.540Z,1756942629.540 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:37:21.254Z,1756942641.254 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:37:46.703Z,1756942666.703 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:38:00.851Z,1756942680.851 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:38:30.346Z,1756942710.346 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:38:40.408Z,1756942720.408 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-09-03T23:38:40.408Z,1756942720.408 [Default:CheckIn:C.Wait] Stopped 2025-09-03T23:38:40.408Z,1756942720.408 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-09-03T23:38:40.408Z,1756942720.408 [Default:CheckIn:D] Running Loop=1 2025-09-03T23:38:40.808Z,1756942720.808 [Default:CheckIn:D] Stopped 2025-09-03T23:38:40.809Z,1756942720.809 [Default:CheckIn:E] Running Loop=1 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.349019 min 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn:E] Stopped 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn] Stopped 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn](INFO): Running loop #2 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn] Running Loop=2 2025-09-03T23:38:41.222Z,1756942721.222 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-09-03T23:38:41.223Z,1756942721.223 [Default:CheckIn:Read_GPS] Running Loop=1 2025-09-03T23:38:42.463Z,1756942722.463 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:38:43.260Z,1756942723.260 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233829.00,A,3648.16568,N,12147.28523,W,0.467,250.87,030925,,,A*77 2025-09-03T23:38:43.262Z,1756942723.262 [NAL9602](INFO): GPS fix at 20250903T233829: (36.802761, -121.788087) 2025-09-03T23:38:43.273Z,1756942723.273 [Default:CheckIn:Read_GPS] Stopped 2025-09-03T23:38:43.273Z,1756942723.273 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-09-03T23:38:51.163Z,1756942731.163 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250903T232624/Courier0010.lzma 2025-09-03T23:38:52.166Z,1756942732.166 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0010.lzma.bak 2025-09-03T23:38:52.166Z,1756942732.166 [DataOverHttps](INFO): SBD MOMSN=25925290 2025-09-03T23:38:55.457Z,1756942735.457 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:38:57.432Z,1756942737.432 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:39:08.357Z,1756942748.357 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20250903T232624/Express0011.lzma 2025-09-03T23:39:09.359Z,1756942749.359 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0011.lzma.bak 2025-09-03T23:39:09.359Z,1756942749.359 [DataOverHttps](INFO): SBD MOMSN=25925293 2025-09-03T23:39:10.727Z,1756942750.727 [Default:CheckIn:Read_Iridium] Stopped 2025-09-03T23:39:10.727Z,1756942750.727 [Default:CheckIn:C.Wait] Running Loop=1 2025-09-03T23:39:10.727Z,1756942750.727 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-09-03T23:39:13.934Z,1756942753.934 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-09-03T23:39:14.008Z,1756942754.008 [NAL9602](ERROR): received: +CSQ:0 OK866, 2, 0, 0, 0 OK 2025-09-03T23:39:39.498Z,1756942779.498 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:39:47.473Z,1756942787.473 [NAL9602](INFO): SBD MO Status=0, MOMSN=22866, MT Status=0, MTMSN=0 2025-09-03T23:39:47.473Z,1756942787.473 [NAL9602](INFO): No messages in MT queue 2025-09-03T23:39:53.572Z,1756942793.572 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:39:53.996Z,1756942793.996 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:40:06.504Z,1756942806.504 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:40:18.164Z,1756942818.164 [NAL9602](INFO): Not Powering down - fast GPS 2025-09-03T23:40:20.236Z,1756942820.236 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:40:59.421Z,1756942859.421 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:41:09.874Z,1756942869.874 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-09-03T23:41:09.874Z,1756942869.874 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2025-09-03T23:41:21.253Z,1756942881.253 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:41:32.158Z,1756942892.158 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:41:43.069Z,1756942903.069 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:41:49.522Z,1756942909.522 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:41:54.378Z,1756942914.378 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:42:03.667Z,1756942923.667 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:42:05.289Z,1756942925.289 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:42:16.655Z,1756942936.655 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:42:27.918Z,1756942947.918 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:42:38.413Z,1756942958.413 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:42:48.962Z,1756942968.962 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:43:00.234Z,1756942980.234 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:43:11.184Z,1756942991.184 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:43:22.047Z,1756943002.047 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:43:33.362Z,1756943013.362 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:43:47.907Z,1756943027.907 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:43:56.750Z,1756943036.750 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-09-03T23:43:56.750Z,1756943036.750 [ElevatorServo] No Fault, FailCount= 3 2025-09-03T23:44:00.021Z,1756943040.021 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:44:02.428Z,1756943042.428 [ElevatorServo](INFO): Failure count cleared after critical for ElevatorServo 2025-09-03T23:44:02.853Z,1756943042.853 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:44:11.302Z,1756943051.302 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-09-03T23:44:11.302Z,1756943051.302 [Default:CheckIn:C.Wait] Stopped 2025-09-03T23:44:11.302Z,1756943051.302 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-09-03T23:44:11.302Z,1756943051.302 [Default:CheckIn:D] Running Loop=1 2025-09-03T23:44:11.685Z,1756943051.685 [Default:CheckIn:D] Stopped 2025-09-03T23:44:11.686Z,1756943051.686 [Default:CheckIn:E] Running Loop=1 2025-09-03T23:44:12.091Z,1756943052.091 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.863635 min 2025-09-03T23:44:12.091Z,1756943052.091 [Default:CheckIn:E] Stopped 2025-09-03T23:44:12.091Z,1756943052.091 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-09-03T23:44:12.091Z,1756943052.091 [Default:CheckIn] Stopped 2025-09-03T23:44:12.092Z,1756943052.092 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-09-03T23:44:12.092Z,1756943052.092 [Default:CheckIn](INFO): Running loop #3 2025-09-03T23:44:12.092Z,1756943052.092 [Default:CheckIn] Running Loop=3 2025-09-03T23:44:12.092Z,1756943052.092 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-09-03T23:44:12.092Z,1756943052.092 [Default:CheckIn:Read_GPS] Running Loop=1 2025-09-03T23:44:14.114Z,1756943054.114 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234400.00,A,3648.16547,N,12147.28284,W,0.233,250.87,030925,,,A*77 2025-09-03T23:44:14.116Z,1756943054.116 [NAL9602](INFO): GPS fix at 20250903T234400: (36.802758, -121.788047) 2025-09-03T23:44:14.126Z,1756943054.126 [Default:CheckIn:Read_GPS] Stopped 2025-09-03T23:44:14.127Z,1756943054.127 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-09-03T23:44:22.347Z,1756943062.347 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250903T232624/Courier0013.lzma 2025-09-03T23:44:23.350Z,1756943063.350 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0013.lzma.bak 2025-09-03T23:44:23.350Z,1756943063.350 [DataOverHttps](INFO): SBD MOMSN=25925297 2025-09-03T23:44:32.746Z,1756943072.746 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:44:40.304Z,1756943080.304 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250903T232624/Express0014.lzma 2025-09-03T23:44:41.306Z,1756943081.306 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0014.lzma.bak 2025-09-03T23:44:41.306Z,1756943081.306 [DataOverHttps](INFO): SBD MOMSN=25925300 2025-09-03T23:44:42.799Z,1756943082.799 [Default:CheckIn:Read_Iridium] Stopped 2025-09-03T23:44:42.799Z,1756943082.799 [Default:CheckIn:C.Wait] Running Loop=1 2025-09-03T23:44:42.799Z,1756943082.799 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-09-03T23:44:54.923Z,1756943094.923 [NAL9602](INFO): SBD MO Status=2, MOMSN=22867, MT Status=2, MTMSN=0 2025-09-03T23:44:54.924Z,1756943094.924 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-09-03T23:45:42.637Z,1756943142.637 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:45:53.500Z,1756943153.500 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2025-09-03T23:47:18.447Z,1756943238.447 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:48:29.035Z,1756943309.035 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2025-09-03T23:49:15.892Z,1756943355.892 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-09-03T23:49:42.216Z,1756943382.216 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:49:43.379Z,1756943383.379 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-09-03T23:49:43.379Z,1756943383.379 [Default:CheckIn:C.Wait] Stopped 2025-09-03T23:49:43.379Z,1756943383.379 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-09-03T23:49:43.379Z,1756943383.379 [Default:CheckIn:D] Running Loop=1 2025-09-03T23:49:43.794Z,1756943383.794 [Default:CheckIn:D] Stopped 2025-09-03T23:49:43.794Z,1756943383.794 [Default:CheckIn:E] Running Loop=1 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.398785 min 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn:E] Stopped 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn] Stopped 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn](INFO): Running loop #4 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn] Running Loop=4 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-09-03T23:49:44.187Z,1756943384.187 [Default:CheckIn:Read_GPS] Running Loop=1 2025-09-03T23:49:46.198Z,1756943386.198 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234932.00,A,3648.16644,N,12147.28156,W,0.058,0.00,030925,,,A*70 2025-09-03T23:49:46.201Z,1756943386.201 [NAL9602](INFO): GPS fix at 20250903T234932: (36.802774, -121.788026) 2025-09-03T23:49:46.210Z,1756943386.210 [Default:CheckIn:Read_GPS] Stopped 2025-09-03T23:49:46.210Z,1756943386.210 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-09-03T23:49:53.219Z,1756943393.219 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250903T232624/Courier0016.lzma 2025-09-03T23:49:54.222Z,1756943394.222 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0016.lzma.bak 2025-09-03T23:49:54.222Z,1756943394.222 [DataOverHttps](INFO): SBD MOMSN=25925309 2025-09-03T23:49:56.363Z,1756943396.363 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:50:09.256Z,1756943409.256 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20250903T232624/Express0017.lzma 2025-09-03T23:50:10.774Z,1756943410.774 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0017.lzma.bak 2025-09-03T23:50:10.774Z,1756943410.774 [DataOverHttps](INFO): SBD MOMSN=25925312 2025-09-03T23:50:12.095Z,1756943412.095 [Default:CheckIn:Read_Iridium] Stopped 2025-09-03T23:50:12.095Z,1756943412.095 [Default:CheckIn:C.Wait] Running Loop=1 2025-09-03T23:50:12.095Z,1756943412.095 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-09-03T23:50:18.941Z,1756943418.941 [NAL9602](INFO): Not Powering down - fast GPS 2025-09-03T23:50:48.822Z,1756943448.822 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-09-03T23:50:48.822Z,1756943448.822 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2025-09-03T23:50:59.804Z,1756943459.804 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:51:10.708Z,1756943470.708 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:51:22.016Z,1756943482.016 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:51:33.733Z,1756943493.733 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:51:44.638Z,1756943504.638 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:51:55.959Z,1756943515.959 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:52:06.867Z,1756943526.867 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:52:18.250Z,1756943538.250 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:52:25.033Z,1756943545.033 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:52:29.094Z,1756943549.094 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:52:40.013Z,1756943560.013 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:52:51.300Z,1756943571.300 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:53:02.214Z,1756943582.214 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:53:09.475Z,1756943589.475 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:53:12.710Z,1756943592.710 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:53:24.057Z,1756943604.057 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:53:38.590Z,1756943618.590 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:54:05.634Z,1756943645.634 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:54:54.585Z,1756943694.585 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:55:08.729Z,1756943708.729 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:55:12.719Z,1756943712.719 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-09-03T23:55:12.719Z,1756943712.719 [Default:CheckIn:C.Wait] Stopped 2025-09-03T23:55:12.719Z,1756943712.719 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-09-03T23:55:12.720Z,1756943712.720 [Default:CheckIn:D] Running Loop=1 2025-09-03T23:55:13.127Z,1756943713.127 [Default:CheckIn:D] Stopped 2025-09-03T23:55:13.127Z,1756943713.127 [Default:CheckIn:E] Running Loop=1 2025-09-03T23:55:13.522Z,1756943713.522 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.887665 min 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn:E] Stopped 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn] Stopped 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn](INFO): Running loop #5 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn] Running Loop=5 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-09-03T23:55:13.523Z,1756943713.523 [Default:CheckIn:Read_GPS] Running Loop=1 2025-09-03T23:55:15.553Z,1756943715.553 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235502.00,A,3648.16610,N,12147.28388,W,0.136,0.00,030925,,,A*77 2025-09-03T23:55:15.555Z,1756943715.555 [NAL9602](INFO): GPS fix at 20250903T235502: (36.802768, -121.788065) 2025-09-03T23:55:15.581Z,1756943715.581 [Default:CheckIn:Read_GPS] Stopped 2025-09-03T23:55:15.581Z,1756943715.581 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-09-03T23:55:15.938Z,1756943715.938 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-09-03T23:55:15.939Z,1756943715.939 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-09-03T23:55:22.975Z,1756943722.975 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250903T232624/Courier0019.lzma 2025-09-03T23:55:23.978Z,1756943723.978 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Courier0019.lzma.bak 2025-09-03T23:55:23.978Z,1756943723.978 [DataOverHttps](INFO): SBD MOMSN=25925316 2025-09-03T23:55:34.585Z,1756943734.585 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:55:40.152Z,1756943740.152 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20250903T232624/Express0020.lzma 2025-09-03T23:55:41.154Z,1756943741.154 [DataOverHttps](INFO): Moved sent file to Logs/20250903T232624/Express0020.lzma.bak 2025-09-03T23:55:41.154Z,1756943741.154 [DataOverHttps](INFO): SBD MOMSN=25925319 2025-09-03T23:55:42.620Z,1756943742.620 [Default:CheckIn:Read_Iridium] Stopped 2025-09-03T23:55:42.620Z,1756943742.620 [Default:CheckIn:C.Wait] Running Loop=1 2025-09-03T23:55:42.620Z,1756943742.620 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-09-03T23:55:46.295Z,1756943746.295 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-09-03T23:55:46.368Z,1756943746.368 [NAL9602](ERROR): received: +CSQ:0 OK867, 2, 0, 0, 0 OK 2025-09-03T23:56:02.061Z,1756943762.061 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-09-03T23:56:12.145Z,1756943772.145 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:56:54.567Z,1756943814.567 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-09-03T23:57:24.681Z,1756943844.681 [CommandExec](IMPORTANT): got command restart system 2025-09-03T23:57:26.752Z,1756943846.752 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:26.752Z,1756943846.752 [CommandExec](INFO): Uninitializing the command executive. 2025-09-03T23:57:26.752Z,1756943846.752 [CommandExec](INFO): Uninitializing the command scheduler. 2025-09-03T23:57:26.753Z,1756943846.753 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:26.764Z,1756943846.764 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-09-03T23:57:26.764Z,1756943846.764 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-09-03T23:57:26.764Z,1756943846.764 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:26.765Z,1756943846.765 [NavChartDb](INFO): Join timeout helper Thread ID is 992 2025-09-03T23:57:27.056Z,1756943847.056 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:27.057Z,1756943847.057 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:27.068Z,1756943847.068 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-09-03T23:57:27.068Z,1756943847.068 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:27.069Z,1756943847.069 [Radio_Surface](INFO): Join timeout helper Thread ID is 993 2025-09-03T23:57:27.424Z,1756943847.424 [Radio_Surface](INFO): Powering down 2025-09-03T23:57:27.425Z,1756943847.425 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:27.425Z,1756943847.425 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:27.436Z,1756943847.436 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-09-03T23:57:27.436Z,1756943847.436 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:27.436Z,1756943847.436 [Onboard](INFO): Join timeout helper Thread ID is 994 2025-09-03T23:57:28.192Z,1756943848.192 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-09-03T23:57:29.248Z,1756943849.248 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:29.248Z,1756943849.248 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:29.264Z,1756943849.264 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-09-03T23:57:29.264Z,1756943849.264 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:29.264Z,1756943849.264 [DataOverHttps](INFO): Join timeout helper Thread ID is 995 2025-09-03T23:57:30.200Z,1756943850.200 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:30.200Z,1756943850.200 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.217Z,1756943850.217 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-09-03T23:57:30.217Z,1756943850.217 [DAT ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.218Z,1756943850.218 [DAT](INFO): Join timeout helper Thread ID is 996 2025-09-03T23:57:30.373Z,1756943850.372 [DAT](INFO): Powering down 2025-09-03T23:57:30.448Z,1756943850.448 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:30.449Z,1756943850.449 [DAT](INFO): Powering down 2025-09-03T23:57:30.449Z,1756943850.449 [DAT ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.453Z,1756943850.453 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-09-03T23:57:30.453Z,1756943850.453 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.453Z,1756943850.453 [BackseatComponent](INFO): Join timeout helper Thread ID is 997 2025-09-03T23:57:30.608Z,1756943850.608 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:30.608Z,1756943850.608 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.617Z,1756943850.617 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-09-03T23:57:30.617Z,1756943850.617 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.617Z,1756943850.617 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 998 2025-09-03T23:57:30.620Z,1756943850.620 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-09-03T23:57:30.620Z,1756943850.620 [WetLabsBB2FL](INFO): Powering down 2025-09-03T23:57:30.621Z,1756943850.621 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.665Z,1756943850.665 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-09-03T23:57:30.665Z,1756943850.665 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-09-03T23:57:30.665Z,1756943850.665 [CTD_Seabird](INFO): Join timeout helper Thread ID is 999 2025-09-03T23:57:31.385Z,1756943851.385 [CTD_Seabird](INFO): Powering down 2025-09-03T23:57:31.400Z,1756943851.400 [CTD_Seabird