2025-04-24T20:29:15.256Z,1745526555.256 [Supervisor](DEBUG): Initializing supervisor. 2025-04-24T20:29:15.260Z,1745526555.260 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-04-24T20:29:15.261Z,1745526555.261 [SyncHandler](INFO): Protected caller Thread ID is 837 2025-04-24T20:29:15.261Z,1745526555.261 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-04-24T20:29:15.262Z,1745526555.262 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-04-24T20:29:15.262Z,1745526555.262 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838 2025-04-24T20:29:15.266Z,1745526555.266 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-04-24T20:29:15.287Z,1745526555.287 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-04-24T20:29:15.288Z,1745526555.288 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-04-24T20:29:15.288Z,1745526555.288 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839 2025-04-24T20:29:15.292Z,1745526555.292 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-04-24T20:29:15.293Z,1745526555.293 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-04-24T20:29:15.294Z,1745526555.294 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840 2025-04-24T20:29:15.296Z,1745526555.296 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-04-24T20:29:15.297Z,1745526555.297 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-04-24T20:29:15.297Z,1745526555.297 [logger ThreadHandler](INFO): Protected caller Thread ID is 841 2025-04-24T20:29:15.301Z,1745526555.301 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-04-24T20:29:15.301Z,1745526555.301 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-04-24T20:29:15.306Z,1745526555.306 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-04-24T20:29:15.528Z,1745526555.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-04-24T20:29:15.530Z,1745526555.530 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-04-24T20:29:15.647Z,1745526555.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-04-24T20:29:15.648Z,1745526555.648 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-04-24T20:29:15.753Z,1745526555.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-04-24T20:29:15.755Z,1745526555.755 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-04-24T20:29:16.286Z,1745526556.286 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-04-24T20:29:16.286Z,1745526556.286 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-04-24T20:29:16.648Z,1745526556.648 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-04-24T20:29:16.649Z,1745526556.649 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-04-24T20:29:17.006Z,1745526557.006 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-04-24T20:29:17.007Z,1745526557.007 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-04-24T20:29:17.206Z,1745526557.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-04-24T20:29:17.207Z,1745526557.207 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-04-24T20:29:17.299Z,1745526557.299 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-04-24T20:29:17.391Z,1745526557.391 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-04-24T20:29:17.837Z,1745526557.837 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-04-24T20:29:17.838Z,1745526557.838 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-04-24T20:29:18.154Z,1745526558.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-04-24T20:29:18.155Z,1745526558.155 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-04-24T20:29:18.725Z,1745526558.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-04-24T20:29:19.309Z,1745526559.309 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-04-24T20:29:19.786Z,1745526559.786 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-04-24T20:29:19.787Z,1745526559.787 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-04-24T20:29:20.042Z,1745526560.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-04-24T20:29:20.044Z,1745526560.044 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-04-24T20:29:20.195Z,1745526560.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-04-24T20:29:20.196Z,1745526560.196 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-04-24T20:29:21.083Z,1745526561.083 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-04-24T20:29:21.085Z,1745526561.085 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2025-04-24T20:29:21.088Z,1745526561.088 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2025-04-24T20:29:21.183Z,1745526561.183 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2025-04-24T20:29:21.326Z,1745526561.326 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2025-04-24T20:29:21.605Z,1745526561.605 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-04-24T20:29:21.606Z,1745526561.606 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2025-04-24T20:29:21.740Z,1745526561.740 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2025-04-24T20:29:21.847Z,1745526561.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2025-04-24T20:29:21.950Z,1745526561.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2025-04-24T20:29:22.068Z,1745526562.068 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2025-04-24T20:29:22.162Z,1745526562.162 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2025-04-24T20:29:22.259Z,1745526562.259 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2025-04-24T20:29:22.361Z,1745526562.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2025-04-24T20:29:22.539Z,1745526562.539 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-04-24T20:29:22.554Z,1745526562.554 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-04-24T20:29:22.626Z,1745526562.626 [DepthRateCalculator] Loaded 2025-04-24T20:29:22.627Z,1745526562.627 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-04-24T20:29:22.632Z,1745526562.632 [PitchRateCalculator] Loaded 2025-04-24T20:29:22.632Z,1745526562.632 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-04-24T20:29:22.643Z,1745526562.643 [SpeedCalculator] Loaded 2025-04-24T20:29:22.643Z,1745526562.643 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-04-24T20:29:22.648Z,1745526562.648 [YawRateCalculator] Loaded 2025-04-24T20:29:22.648Z,1745526562.648 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-04-24T20:29:22.670Z,1745526562.670 [ElevatorOffsetCalculator] Loaded 2025-04-24T20:29:22.670Z,1745526562.670 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-04-24T20:29:22.671Z,1745526562.671 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-04-24T20:29:22.671Z,1745526562.671 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-04-24T20:29:22.719Z,1745526562.719 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-04-24T20:29:22.720Z,1745526562.720 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-04-24T20:29:22.736Z,1745526562.736 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-04-24T20:29:22.736Z,1745526562.736 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-04-24T20:29:23.703Z,1745526563.703 [AHRS_M2] Loaded 2025-04-24T20:29:23.703Z,1745526563.703 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-04-24T20:29:23.958Z,1745526563.958 [BackseatComponent] Loaded 2025-04-24T20:29:23.958Z,1745526563.958 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-04-24T20:29:23.959Z,1745526563.959 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0 2025-04-24T20:29:23.960Z,1745526563.960 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 925 2025-04-24T20:29:23.963Z,1745526563.963 [LcmUniversalReporter] Loaded 2025-04-24T20:29:23.963Z,1745526563.963 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-04-24T20:29:25.165Z,1745526565.165 [BPC1] Loaded 2025-04-24T20:29:25.165Z,1745526565.165 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-04-24T20:29:25.261Z,1745526565.261 [DAT] Loaded 2025-04-24T20:29:25.262Z,1745526565.262 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-04-24T20:29:25.263Z,1745526565.263 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0 2025-04-24T20:29:25.263Z,1745526565.263 [DAT ThreadHandler](INFO): Protected caller Thread ID is 926 2025-04-24T20:29:25.408Z,1745526565.408 [DataOverHttps] Loaded 2025-04-24T20:29:25.408Z,1745526565.408 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-04-24T20:29:25.409Z,1745526565.409 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0 2025-04-24T20:29:25.410Z,1745526565.410 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 927 2025-04-24T20:29:25.432Z,1745526565.432 [Depth_Keller] Loaded 2025-04-24T20:29:25.433Z,1745526565.433 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-04-24T20:29:25.437Z,1745526565.437 [DropWeight] Loaded 2025-04-24T20:29:25.438Z,1745526565.438 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-04-24T20:29:25.459Z,1745526565.459 [MultiRay](INFO): Found secondary power supply at: /dev/loadC7 2025-04-24T20:29:25.459Z,1745526565.459 [MultiRay] Loaded 2025-04-24T20:29:25.459Z,1745526565.459 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2025-04-24T20:29:25.523Z,1745526565.523 [NAL9602] Loaded 2025-04-24T20:29:25.523Z,1745526565.523 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-04-24T20:29:25.553Z,1745526565.553 [Onboard] Loaded 2025-04-24T20:29:25.553Z,1745526565.553 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-04-24T20:29:25.554Z,1745526565.554 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0 2025-04-24T20:29:25.555Z,1745526565.555 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 928 2025-04-24T20:29:25.560Z,1745526565.560 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2025-04-24T20:29:25.574Z,1745526565.574 [PowerOnly] Loaded 2025-04-24T20:29:25.574Z,1745526565.574 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-04-24T20:29:25.587Z,1745526565.587 [Power24vConverter] Loaded 2025-04-24T20:29:25.588Z,1745526565.588 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-04-24T20:29:25.605Z,1745526565.605 [Radio_Surface] Loaded 2025-04-24T20:29:25.605Z,1745526565.605 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-04-24T20:29:25.606Z,1745526565.606 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0 2025-04-24T20:29:25.606Z,1745526565.606 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 929 2025-04-24T20:29:25.608Z,1745526565.608 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-04-24T20:29:25.608Z,1745526565.608 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-04-24T20:29:25.746Z,1745526565.746 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-04-24T20:29:25.747Z,1745526565.747 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-04-24T20:29:25.761Z,1745526565.761 [NavChart] Loaded 2025-04-24T20:29:25.761Z,1745526565.761 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-04-24T20:29:25.767Z,1745526565.767 [UniversalFixResidualReporter] Loaded 2025-04-24T20:29:25.767Z,1745526565.767 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-04-24T20:29:25.767Z,1745526565.767 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-04-24T20:29:25.768Z,1745526565.768 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-04-24T20:29:25.968Z,1745526565.968 [SBIT](DEBUG): Construct Startup Built In Test. 2025-04-24T20:29:25.982Z,1745526565.982 [SBIT] Loaded 2025-04-24T20:29:25.982Z,1745526565.982 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-04-24T20:29:25.985Z,1745526565.985 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-04-24T20:29:25.998Z,1745526565.998 [IBIT] Loaded 2025-04-24T20:29:25.998Z,1745526565.998 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-04-24T20:29:26.004Z,1745526566.003 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-04-24T20:29:26.083Z,1745526566.083 [CBIT] Loaded 2025-04-24T20:29:26.084Z,1745526566.084 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-04-24T20:29:26.115Z,1745526566.115 [GFScanner] Loaded 2025-04-24T20:29:26.115Z,1745526566.115 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-04-24T20:29:26.116Z,1745526566.116 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-04-24T20:29:26.116Z,1745526566.116 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-04-24T20:29:26.334Z,1745526566.334 [CTD_Seabird] Loaded 2025-04-24T20:29:26.334Z,1745526566.334 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-04-24T20:29:26.335Z,1745526566.335 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0 2025-04-24T20:29:26.336Z,1745526566.336 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 930 2025-04-24T20:29:26.359Z,1745526566.359 [PAR_Licor] Loaded 2025-04-24T20:29:26.359Z,1745526566.359 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-04-24T20:29:26.404Z,1745526566.404 [WetLabsBB2FL] Loaded 2025-04-24T20:29:26.405Z,1745526566.405 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-04-24T20:29:26.406Z,1745526566.406 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0 2025-04-24T20:29:26.406Z,1745526566.406 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 931 2025-04-24T20:29:26.407Z,1745526566.407 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-04-24T20:29:26.408Z,1745526566.408 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-04-24T20:29:26.577Z,1745526566.577 [BuoyancyServo] Loaded 2025-04-24T20:29:26.577Z,1745526566.577 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-04-24T20:29:26.600Z,1745526566.600 [MassServo] Loaded 2025-04-24T20:29:26.600Z,1745526566.600 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-04-24T20:29:26.623Z,1745526566.623 [RudderServo] Loaded 2025-04-24T20:29:26.623Z,1745526566.623 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-04-24T20:29:26.641Z,1745526566.641 [ThrusterHE] Loaded 2025-04-24T20:29:26.642Z,1745526566.642 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-04-24T20:29:26.642Z,1745526566.642 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-04-24T20:29:26.643Z,1745526566.643 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-04-24T20:29:26.715Z,1745526566.715 [VerticalControl](DEBUG): Construct VerticalControl. 2025-04-24T20:29:26.768Z,1745526566.768 [VerticalControl] Loaded 2025-04-24T20:29:26.769Z,1745526566.769 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-04-24T20:29:26.772Z,1745526566.772 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-04-24T20:29:26.816Z,1745526566.816 [HorizontalControl] Loaded 2025-04-24T20:29:26.816Z,1745526566.816 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-04-24T20:29:26.819Z,1745526566.819 [SpeedControl](DEBUG): Construct SpeedControl. 2025-04-24T20:29:26.820Z,1745526566.820 [SpeedControl] Loaded 2025-04-24T20:29:26.821Z,1745526566.821 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-04-24T20:29:26.823Z,1745526566.823 [LoopControl](DEBUG): Construct LoopControl. 2025-04-24T20:29:26.824Z,1745526566.824 [LoopControl] Loaded 2025-04-24T20:29:26.824Z,1745526566.824 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-04-24T20:29:26.825Z,1745526566.825 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-04-24T20:29:26.825Z,1745526566.825 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-04-24T20:29:26.993Z,1745526566.993 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-04-24T20:29:26.994Z,1745526566.994 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-04-24T20:29:27.213Z,1745526567.213 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-04-24T20:29:27.214Z,1745526567.214 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-04-24T20:29:27.628Z,1745526567.628 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-04-24T20:29:27.628Z,1745526567.628 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-04-24T20:29:27.716Z,1745526567.716 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-04-24T20:29:27.722Z,1745526567.722 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-04-24T20:29:27.725Z,1745526567.725 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-04-24T20:29:27.737Z,1745526567.737 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-04-24T20:29:27.738Z,1745526567.738 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2025-04-24T20:29:27.738Z,1745526567.738 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 932 2025-04-24T20:29:27.742Z,1745526567.742 [Supervisor](INFO): Main Thread ID is 829 2025-04-24T20:29:27.743Z,1745526567.743 [Supervisor](DEBUG): Running supervisor. 2025-04-24T20:29:27.743Z,1745526567.743 [CommandExec ThreadHandler](INFO): Handler Thread ID is 933 2025-04-24T20:29:27.744Z,1745526567.744 [CommandExec](INFO): Initializing the command executive. 2025-04-24T20:29:27.745Z,1745526567.745 [CommandLine ThreadHandler](INFO): Handler Thread ID is 934 2025-04-24T20:29:27.747Z,1745526567.747 [controlThread ThreadHandler](INFO): Handler Thread ID is 935 2025-04-24T20:29:27.748Z,1745526567.748 [controlThread](DEBUG): Initializing ControlThread 2025-04-24T20:29:27.749Z,1745526567.749 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-04-24T20:29:27.749Z,1745526567.749 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-04-24T20:29:27.749Z,1745526567.749 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-04-24T20:29:27.750Z,1745526567.750 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-04-24T20:29:27.750Z,1745526567.750 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-04-24T20:29:27.754Z,1745526567.754 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-04-24T20:29:27.755Z,1745526567.755 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-04-24T20:29:27.755Z,1745526567.755 [SBIT](INFO): Initialize SBIT Component. 2025-04-24T20:29:27.756Z,1745526567.756 [SBIT](IMPORTANT): git: 2025-04-17_A-3-g239178f06 2025-04-24T20:29:27.756Z,1745526567.756 [SBIT](INFO): git hash: 239178f06e1908a99dae6b6ac2766c36a0a1292c 2025-04-24T20:29:27.756Z,1745526567.756 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-04-24T20:29:27.757Z,1745526567.757 [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-04-24T20:29:27.758Z,1745526567.758 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2025-04-24T20:29:27.759Z,1745526567.759 [IBIT](INFO): Initialize IBIT Component. 2025-04-24T20:29:27.760Z,1745526567.760 [CBIT](DEBUG): Initialize CBIT Component. 2025-04-24T20:29:27.761Z,1745526567.761 [logger ThreadHandler](INFO): Handler Thread ID is 936 2025-04-24T20:29:27.774Z,1745526567.774 [CBIT](DEBUG): Initialized mux pins. 2025-04-24T20:29:27.774Z,1745526567.774 [CBIT](DEBUG): Initializing the watchdog timer. 2025-04-24T20:29:27.787Z,1745526567.787 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 937 2025-04-24T20:29:27.798Z,1745526567.798 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-04-24T20:29:27.799Z,1745526567.799 [CBIT](DEBUG): Initializing heartbeat. 2025-04-24T20:29:27.799Z,1745526567.799 [DAT ThreadHandler](INFO): Handler Thread ID is 938 2025-04-24T20:29:27.800Z,1745526567.800 [DAT](INFO): Powering up 2025-04-24T20:29:27.800Z,1745526567.800 [DAT](DEBUG): Initializing DAT. 2025-04-24T20:29:27.804Z,1745526567.804 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 940 2025-04-24T20:29:27.805Z,1745526567.805 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-04-24T20:29:27.827Z,1745526567.827 [Onboard ThreadHandler](INFO): Handler Thread ID is 941 2025-04-24T20:29:27.844Z,1745526567.844 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 942 2025-04-24T20:29:27.862Z,1745526567.862 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 943 2025-04-24T20:29:27.863Z,1745526567.863 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:29:27.870Z,1745526567.870 [CBIT](DEBUG): Deactivating emergency mode. 2025-04-24T20:29:27.872Z,1745526567.872 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 945 2025-04-24T20:29:27.875Z,1745526567.875 [WetLabsBB2FL](INFO): Powering up 2025-04-24T20:29:27.876Z,1745526567.876 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 947 2025-04-24T20:29:27.883Z,1745526567.883 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-04-24T20:29:27.883Z,1745526567.883 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-04-24T20:29:27.884Z,1745526567.884 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-04-24T20:29:27.884Z,1745526567.884 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-04-24T20:29:27.884Z,1745526567.884 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-04-24T20:29:27.884Z,1745526567.884 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-04-24T20:29:27.884Z,1745526567.884 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-04-24T20:29:27.884Z,1745526567.884 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-04-24T20:29:27.910Z,1745526567.910 [CBIT](DEBUG): Backplane powered. 2025-04-24T20:29:27.910Z,1745526567.910 [GFScanner](DEBUG): Initializing GFScanner 2025-04-24T20:29:27.911Z,1745526567.911 [GFScanner](DEBUG): Deactivating GF circuits. 2025-04-24T20:29:27.919Z,1745526567.919 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-04-24T20:29:27.921Z,1745526567.921 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-04-24T20:29:27.922Z,1745526567.922 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-04-24T20:29:27.922Z,1745526567.922 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-04-24T20:29:27.923Z,1745526567.923 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-04-24T20:29:27.924Z,1745526567.924 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-04-24T20:29:27.924Z,1745526567.924 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-04-24T20:29:27.928Z,1745526567.928 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-04-24T20:29:28.006Z,1745526568.006 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-04-24T20:29:28.010Z,1745526568.010 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-24T20:29:28.024Z,1745526568.024 [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-04-24T20:29:28.025Z,1745526568.025 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-04-24T20:29:28.025Z,1745526568.025 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-04-24T20:29:28.032Z,1745526568.032 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-04-24T20:29:28.250Z,1745526568.250 [Radio_Surface](INFO): Powering up 2025-04-24T20:29:28.256Z,1745526568.256 [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-04-24T20:29:28.266Z,1745526568.266 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-04-24T20:29:28.279Z,1745526568.279 [Default:A.Wait](DEBUG): Construct Wait. 2025-04-24T20:29:28.281Z,1745526568.281 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-24T20:29:28.298Z,1745526568.298 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-04-24T20:29:28.304Z,1745526568.304 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-04-24T20:29:28.320Z,1745526568.320 [Default:E.Execute](DEBUG): Construct Execute. 2025-04-24T20:29:28.323Z,1745526568.323 [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-04-24T20:29:28.328Z,1745526568.328 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-04-24T20:29:28.346Z,1745526568.346 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-24T20:29:28.463Z,1745526568.463 [Depth_Keller](INFO): Initializing. 2025-04-24T20:29:28.464Z,1745526568.464 [MultiRay](INFO): Powering up MultiRay Lights 2025-04-24T20:29:28.464Z,1745526568.464 [MultiRay](INFO): Powering up secondary power supply. 2025-04-24T20:29:28.500Z,1745526568.500 [Power24vConverter](INFO): Powering up. 2025-04-24T20:29:28.507Z,1745526568.507 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-24T20:29:28.525Z,1745526568.525 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-04-24T20:29:28.530Z,1745526568.530 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-04-24T20:29:28.532Z,1745526568.532 [MassServo](DEBUG): Initializing EZServoServo. 2025-04-24T20:29:28.543Z,1745526568.543 [MassServo](DEBUG): Initializing MassServo. 2025-04-24T20:29:28.544Z,1745526568.544 [RudderServo](DEBUG): Initializing EZServoServo. 2025-04-24T20:29:28.551Z,1745526568.551 [RudderServo](DEBUG): Initializing RudderServo. 2025-04-24T20:29:28.551Z,1745526568.551 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-04-24T20:29:28.559Z,1745526568.559 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-04-24T20:29:28.780Z,1745526568.780 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-04-24T20:29:28.780Z,1745526568.780 [DropWeight] Hardware Fault, FailCount= 1 2025-04-24T20:29:28.780Z,1745526568.780 [DropWeight](ERROR): Hardware Fault 2025-04-24T20:29:28.843Z,1745526568.843 [CommandExec](FAULT): Scheduling is paused 2025-04-24T20:29:28.844Z,1745526568.844 [CBIT](INFO): Critical error at 20250424T202928 2025-04-24T20:29:28.844Z,1745526568.844 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-04-24T20:29:28.851Z,1745526568.851 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-04-24T20:29:28.851Z,1745526568.851 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-04-24T20:29:29.163Z,1745526569.163 [CBIT](INFO): Critical error at 20250424T202928 2025-04-24T20:29:29.547Z,1745526569.547 [MultiRay](INFO): Powering down 2025-04-24T20:29:29.666Z,1745526569.666 [MultiRay](INFO): Powering down LCB2 2025-04-24T20:29:30.502Z,1745526570.502 [WetLabsBB2FL](INFO): Powering down 2025-04-24T20:29:34.199Z,1745526574.199 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-04-24T20:29:40.155Z,1745526580.155 [DAT](INFO): DAT read: 2025-04-24T20:29:40.156Z,1745526580.156 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-24T20:29:40.914Z,1745526580.914 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:29:40.915Z,1745526580.915 [CTD_Seabird] Communications Fault, FailCount= 1 2025-04-24T20:29:40.915Z,1745526580.915 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:29:40.923Z,1745526580.923 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:29:41.320Z,1745526581.320 [CTD_Seabird](INFO): Powering down 2025-04-24T20:29:41.673Z,1745526581.673 [DAT](INFO): DAT read: MF Frequency Band 2025-04-24T20:29:41.674Z,1745526581.674 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-04-24T20:29:41.675Z,1745526581.675 [DAT](INFO): DAT read: Apr 24 2025 20:29:28 2025-04-24T20:29:42.550Z,1745526582.550 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:29:42.550Z,1745526582.550 [CTD_Seabird] No Fault, FailCount= 1 2025-04-24T20:29:42.662Z,1745526582.662 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:29:42.679Z,1745526582.679 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-24T20:29:42.681Z,1745526582.681 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-04-24T20:29:42.681Z,1745526582.681 [DAT](INFO): commRate: 800 2025-04-24T20:29:44.751Z,1745526584.751 [DAT](INFO): entering command mode 2025-04-24T20:29:44.951Z,1745526584.951 [DAT](INFO): DAT read: 2025-04-24T20:29:44.951Z,1745526584.951 [DAT](INFO): DAT read: user:1> 2025-04-24T20:29:44.952Z,1745526584.952 [DAT](INFO): setting verbose to 3 2025-04-24T20:29:45.205Z,1745526585.205 [DAT](INFO): DAT read: user:1> 2025-04-24T20:29:45.209Z,1745526585.209 [DAT](INFO): DAT read: Verbose | 3 2025-04-24T20:29:45.209Z,1745526585.209 [DAT](INFO): set verbose to 3 2025-04-24T20:29:45.209Z,1745526585.209 [DAT](INFO): setting DatVerbose to 27440 2025-04-24T20:29:45.455Z,1745526585.455 [DAT](INFO): DAT read: user:2> 2025-04-24T20:29:45.456Z,1745526585.456 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-24T20:29:45.456Z,1745526585.456 [DAT](INFO): set DatVerbose to 27440 2025-04-24T20:29:45.457Z,1745526585.457 [DAT](INFO): setting transmit power to 8 2025-04-24T20:29:45.709Z,1745526585.709 [DAT](INFO): DAT read: user:3> 2025-04-24T20:29:45.710Z,1745526585.710 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-24T20:29:45.710Z,1745526585.710 [DAT](INFO): set transmit power to 8 2025-04-24T20:29:45.711Z,1745526585.711 [DAT](INFO): setting local address to 9 2025-04-24T20:29:45.963Z,1745526585.963 [DAT](INFO): DAT read: user:4> 2025-04-24T20:29:45.964Z,1745526585.964 [DAT](INFO): DAT read: LocalAddr | 9 2025-04-24T20:29:45.964Z,1745526585.964 [DAT](INFO): set local address to 9 2025-04-24T20:29:45.965Z,1745526585.965 [DAT](INFO): Setting time to: 20:29:45 And date to:4/24/2025 2025-04-24T20:29:46.215Z,1745526586.215 [DAT](INFO): DAT read: user:5> 2025-04-24T20:29:46.216Z,1745526586.216 [DAT](INFO): DAT read: Thu Apr 24, 2025 20:29:45 2025-04-24T20:29:46.216Z,1745526586.216 [DAT](INFO): Local DAT time set to Thu Apr 24, 2025 20:29:45 2025-04-24T20:29:48.188Z,1745526588.188 [SBIT](IMPORTANT): Beginning Startup BIT 2025-04-24T20:29:48.192Z,1745526588.192 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-04-24T20:29:52.661Z,1745526592.661 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.005833 CHAN A1 (24V): 0.000810 CHAN A2 (12V): -0.005528 CHAN A3 (5V): -0.002855 CHAN B0 (3.3V): -0.000820 CHAN B1 (3.15aV): -0.001340 CHAN B2 (3.15bV): -0.001000 CHAN B3 (GND): -0.000856 OPEN: 0.004641 Full Scale: +/- 1 mA 2025-04-24T20:29:55.722Z,1745526595.722 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:29:55.722Z,1745526595.722 [CTD_Seabird] Communications Fault, FailCount= 2 2025-04-24T20:29:55.722Z,1745526595.722 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:29:55.820Z,1745526595.820 [NAL9602](INFO): Powering up NAL9602 2025-04-24T20:29:55.888Z,1745526595.888 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:29:56.127Z,1745526596.127 [CTD_Seabird](INFO): Powering down 2025-04-24T20:29:57.095Z,1745526597.095 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:29:57.095Z,1745526597.095 [CTD_Seabird] No Fault, FailCount= 2 2025-04-24T20:29:57.502Z,1745526597.502 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:30:01.516Z,1745526601.516 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-04-24T20:30:01.516Z,1745526601.516 [SBIT](ERROR): Could not read massPosReader_. 2025-04-24T20:30:06.733Z,1745526606.733 [NAL9602](INFO): NAL9602 initialized 2025-04-24T20:30:10.554Z,1745526610.554 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:30:10.554Z,1745526610.554 [CTD_Seabird] Communications Fault, FailCount= 3 2025-04-24T20:30:10.555Z,1745526610.555 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:30:10.815Z,1745526610.815 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:30:10.815Z,1745526610.815 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-04-24T20:30:10.958Z,1745526610.958 [CTD_Seabird](INFO): Powering down 2025-04-24T20:30:28.180Z,1745526628.180 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-04-24T20:30:28.180Z,1745526628.180 [SBIT](ERROR): Could not read massPosReader_. 2025-04-24T20:30:28.180Z,1745526628.180 [SBIT](FAULT): Control surface position failure. 2025-04-24T20:30:39.518Z,1745526639.518 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:30:41.928Z,1745526641.928 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-04-24T20:30:41.928Z,1745526641.928 [SBIT](ERROR): Could not read massPosReader_. 2025-04-24T20:30:41.928Z,1745526641.928 [SBIT](FAULT): Control surface position failure. 2025-04-24T20:30:42.316Z,1745526642.316 [SBIT](CRITICAL): SBIT FAILED 2025-04-24T20:30:42.317Z,1745526642.317 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-04-24T20:30:42.317Z,1745526642.317 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=0 bool; 2025-04-24T20:30:42.318Z,1745526642.318 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-04-24T20:30:42.318Z,1745526642.318 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2025-04-24T20:30:42.318Z,1745526642.318 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-04-24T20:30:42.319Z,1745526642.319 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-04-24T20:30:42.319Z,1745526642.319 [SBIT](IMPORTANT): MultiRay.brightnessWhite=100 none; 2025-04-24T20:30:42.319Z,1745526642.319 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2025-04-24T20:30:42.320Z,1745526642.320 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool; 2025-04-24T20:30:42.320Z,1745526642.320 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool; 2025-04-24T20:30:42.320Z,1745526642.320 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=297.568711 cubic_centimeter; 2025-04-24T20:30:42.321Z,1745526642.321 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2025-04-24T20:30:42.326Z,1745526642.326 [CBIT](INFO): Critical error at 20250424T203042 2025-04-24T20:30:42.698Z,1745526642.698 [MissionManager](IMPORTANT): Started mission Startup 2025-04-24T20:30:42.698Z,1745526642.698 [Startup] Running Loop=1 2025-04-24T20:30:42.698Z,1745526642.698 [Startup](DEBUG): Aggregate::initialize Startup 2025-04-24T20:30:42.699Z,1745526642.699 [Startup:A.GoToSurface] Running Loop=1 2025-04-24T20:30:42.699Z,1745526642.699 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-24T20:30:42.699Z,1745526642.699 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-24T20:30:42.700Z,1745526642.700 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-24T20:30:42.700Z,1745526642.700 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-24T20:30:42.700Z,1745526642.700 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-24T20:30:42.701Z,1745526642.701 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-24T20:30:42.701Z,1745526642.701 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-24T20:30:42.703Z,1745526642.703 [Startup:StartupSatComms] Running Loop=1 2025-04-24T20:30:42.704Z,1745526642.704 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-04-24T20:30:42.704Z,1745526642.704 [Startup:StartupSatComms:A] Running Loop=1 2025-04-24T20:30:43.115Z,1745526643.115 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-04-24T20:30:50.019Z,1745526650.019 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:31:00.952Z,1745526660.952 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:31:11.551Z,1745526671.551 [CommandExec](IMPORTANT): got command failComponent 2025-04-24T20:31:11.551Z,1745526671.551 [CommandExec](IMPORTANT): Failed components: 2025-04-24T20:31:11.551Z,1745526671.551 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-04-24T20:31:11.552Z,1745526671.552 [CommandExec](IMPORTANT): CTD_Seabird: Communications Fault 2025-04-24T20:31:11.838Z,1745526671.838 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:31:37.685Z,1745526697.685 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:31:42.892Z,1745526702.892 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-24T20:30:42.7Z 2025-04-24T20:31:42.893Z,1745526702.893 [Startup:StartupSatComms:A] Stopped 2025-04-24T20:31:42.893Z,1745526702.893 [Startup:StartupSatComms:B] Running Loop=1 2025-04-24T20:31:43.293Z,1745526703.293 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-24T20:31:49.011Z,1745526709.011 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:31:54.869Z,1745526714.869 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004912 2025-04-24T20:31:53.601Z,1745526713.601 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250424T202141/Courier0004.lzma 2025-04-24T20:31:54.603Z,1745526714.603 [DataOverHttps](INFO): Moved sent file to Logs/20250424T202141/Courier0004.lzma.bak 2025-04-24T20:31:54.603Z,1745526714.603 [DataOverHttps](INFO): SBD MOMSN=24724708 2025-04-24T20:31:56.697Z,1745526716.697 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:07.636Z,1745526727.636 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:10.784Z,1745526730.784 [DataOverHttps](INFO): Sending 263 bytes from file Logs/20250424T202915/Courier0000.lzma 2025-04-24T20:32:11.783Z,1745526731.783 [DataOverHttps](INFO): Moved sent file to Logs/20250424T202915/Courier0000.lzma.bak 2025-04-24T20:32:11.783Z,1745526731.783 [DataOverHttps](INFO): SBD MOMSN=24724713 2025-04-24T20:32:18.510Z,1745526738.510 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:25.035Z,1745526745.035 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:27.725Z,1745526747.725 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250424T202141/Express0005.lzma 2025-04-24T20:32:27.758Z,1745526747.758 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-04-24T20:32:27.758Z,1745526747.758 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-24T20:32:27.794Z,1745526747.794 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-24T20:32:28.217Z,1745526748.217 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-24T20:32:28.217Z,1745526748.217 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-04-24T20:32:28.727Z,1745526748.727 [DataOverHttps](INFO): Moved sent file to Logs/20250424T202141/Express0005.lzma.bak 2025-04-24T20:32:28.728Z,1745526748.728 [DataOverHttps](INFO): SBD MOMSN=24724719 2025-04-24T20:32:29.416Z,1745526749.416 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:40.775Z,1745526760.775 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:40.852Z,1745526760.852 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:32:40.852Z,1745526760.852 [CTD_Seabird] No Fault, FailCount= 3 2025-04-24T20:32:41.149Z,1745526761.149 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:32:43.102Z,1745526763.102 [Startup:StartupSatComms:B](INFO): Timed out from 2025-04-24T20:31:42.9Z 2025-04-24T20:32:43.103Z,1745526763.103 [Startup:StartupSatComms:B] Stopped 2025-04-24T20:32:43.103Z,1745526763.103 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-04-24T20:32:43.103Z,1745526763.103 [Startup:StartupSatComms] Stopped 2025-04-24T20:32:43.103Z,1745526763.103 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-04-24T20:32:43.104Z,1745526763.104 [Startup](INFO): Completed Startup 2025-04-24T20:32:43.104Z,1745526763.104 [MissionManager](INFO): Startup is completed. 2025-04-24T20:32:43.104Z,1745526763.104 [MissionManager](INFO): Uninitializing Mission Startup 2025-04-24T20:32:43.104Z,1745526763.104 [Startup] Stopped 2025-04-24T20:32:43.104Z,1745526763.104 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-04-24T20:32:43.104Z,1745526763.104 [Startup:A.GoToSurface] Stopped 2025-04-24T20:32:43.104Z,1745526763.104 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-24T20:32:43.510Z,1745526763.510 [MissionManager](IMPORTANT): Started mission Default 2025-04-24T20:32:43.510Z,1745526763.510 [Default] Running Loop=1 2025-04-24T20:32:43.510Z,1745526763.510 [Default](DEBUG): Aggregate::initialize Default 2025-04-24T20:32:43.510Z,1745526763.510 [Default:B.GoToSurface] Running Loop=1 2025-04-24T20:32:43.510Z,1745526763.510 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-24T20:32:43.511Z,1745526763.511 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-24T20:32:43.511Z,1745526763.511 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-24T20:32:43.511Z,1745526763.511 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-24T20:32:43.512Z,1745526763.512 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-24T20:32:43.512Z,1745526763.512 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-24T20:32:43.512Z,1745526763.512 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-24T20:32:43.512Z,1745526763.512 [Default:A.Wait] Running Loop=1 2025-04-24T20:32:43.512Z,1745526763.512 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-04-24T20:32:45.239Z,1745526765.239 [DataOverHttps](INFO): Sending 1084 bytes from file Logs/20250424T202915/Express0001.lzma 2025-04-24T20:32:46.239Z,1745526766.239 [DataOverHttps](INFO): Moved sent file to Logs/20250424T202915/Express0001.lzma.bak 2025-04-24T20:32:46.239Z,1745526766.239 [DataOverHttps](INFO): SBD MOMSN=24724721 2025-04-24T20:32:51.142Z,1745526771.142 [CommandExec](IMPORTANT): got command get platform_elevator_angle 2025-04-24T20:32:51.142Z,1745526771.142 [CommandExec](FAULT): Element has no value 2025-04-24T20:32:51.690Z,1745526771.690 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:32:54.202Z,1745526774.202 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:32:54.203Z,1745526774.203 [CTD_Seabird] Communications Fault, FailCount= 1 2025-04-24T20:32:54.203Z,1745526774.203 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:32:54.466Z,1745526774.466 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:32:54.606Z,1745526774.606 [CTD_Seabird](INFO): Powering down 2025-04-24T20:32:55.685Z,1745526775.685 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:32:55.685Z,1745526775.685 [CTD_Seabird] No Fault, FailCount= 1 2025-04-24T20:32:55.950Z,1745526775.950 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:32:56.831Z,1745526776.831 [Default:A.Wait](INFO): Done Waiting. 2025-04-24T20:32:56.831Z,1745526776.831 [Default:A.Wait] Stopped 2025-04-24T20:32:56.831Z,1745526776.831 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-24T20:32:57.247Z,1745526777.247 [Default:CheckIn] Running Loop=1 2025-04-24T20:32:57.247Z,1745526777.247 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-04-24T20:32:57.247Z,1745526777.247 [Default:CheckIn:Read_GPS] Running Loop=1 2025-04-24T20:32:57.643Z,1745526777.643 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-24T20:33:02.552Z,1745526782.552 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:33:03.566Z,1745526783.566 [CommandExec](IMPORTANT): got command get platform_rudder_angle 2025-04-24T20:33:03.567Z,1745526783.567 [CommandExec](IMPORTANT): platform_rudder_angle 0.052514 rad 2025-04-24T20:33:09.001Z,1745526789.001 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:33:09.001Z,1745526789.001 [CTD_Seabird] Communications Fault, FailCount= 2 2025-04-24T20:33:09.001Z,1745526789.001 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:33:09.398Z,1745526789.398 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:33:09.405Z,1745526789.405 [CTD_Seabird](INFO): Powering down 2025-04-24T20:33:10.625Z,1745526790.625 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:33:10.625Z,1745526790.625 [CTD_Seabird] No Fault, FailCount= 2 2025-04-24T20:33:10.749Z,1745526790.749 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:33:13.451Z,1745526793.451 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:33:23.801Z,1745526803.801 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:33:23.801Z,1745526803.801 [CTD_Seabird] Communications Fault, FailCount= 3 2025-04-24T20:33:23.801Z,1745526803.801 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:33:23.934Z,1745526803.934 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:33:23.935Z,1745526803.935 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-04-24T20:33:24.205Z,1745526804.205 [CTD_Seabird](INFO): Powering down 2025-04-24T20:33:24.364Z,1745526804.364 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:33:35.269Z,1745526815.269 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:33:45.771Z,1745526825.771 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:33:56.277Z,1745526836.277 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:34:06.779Z,1745526846.779 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:34:17.686Z,1745526857.686 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:34:25.755Z,1745526865.755 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:34:29.002Z,1745526869.002 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:34:39.907Z,1745526879.907 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:34:51.224Z,1745526891.224 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:35:02.128Z,1745526902.128 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:35:09.747Z,1745526909.747 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-24T20:35:13.092Z,1745526913.092 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:35:23.942Z,1745526923.942 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:35:28.767Z,1745526928.767 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-04-24T20:35:28.767Z,1745526928.767 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-24T20:35:28.818Z,1745526928.818 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-24T20:35:29.185Z,1745526929.185 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-24T20:35:29.185Z,1745526929.185 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-04-24T20:35:34.859Z,1745526934.859 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:35:45.759Z,1745526945.759 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:35:53.848Z,1745526953.848 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:35:53.848Z,1745526953.848 [CTD_Seabird] No Fault, FailCount= 3 2025-04-24T20:35:53.905Z,1745526953.905 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:35:57.074Z,1745526957.074 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:36:06.350Z,1745526966.350 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:36:06.969Z,1745526966.969 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:36:06.969Z,1745526966.969 [CTD_Seabird] Communications Fault, FailCount= 1 2025-04-24T20:36:06.969Z,1745526966.969 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:36:07.190Z,1745526967.190 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:36:07.373Z,1745526967.373 [CTD_Seabird](INFO): Powering down 2025-04-24T20:36:07.982Z,1745526967.982 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:36:08.391Z,1745526968.391 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:36:08.391Z,1745526968.391 [CTD_Seabird] No Fault, FailCount= 1 2025-04-24T20:36:08.717Z,1745526968.717 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:36:18.885Z,1745526978.885 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:36:21.774Z,1745526981.774 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:36:21.774Z,1745526981.774 [CTD_Seabird] Communications Fault, FailCount= 2 2025-04-24T20:36:21.774Z,1745526981.774 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:36:22.129Z,1745526982.129 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:36:22.177Z,1745526982.177 [CTD_Seabird](INFO): Powering down 2025-04-24T20:36:23.329Z,1745526983.329 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-24T20:36:23.329Z,1745526983.329 [CTD_Seabird] No Fault, FailCount= 2 2025-04-24T20:36:23.521Z,1745526983.521 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-24T20:36:36.574Z,1745526996.574 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-24T20:36:36.574Z,1745526996.574 [CTD_Seabird] Communications Fault, FailCount= 3 2025-04-24T20:36:36.574Z,1745526996.574 [CTD_Seabird](ERROR): Communications Fault 2025-04-24T20:36:36.652Z,1745526996.652 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-24T20:36:36.652Z,1745526996.652 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-04-24T20:36:36.977Z,1745526996.977 [CTD_Seabird](INFO): Powering down 2025-04-24T20:37:19.872Z,1745527039.872 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:37:57.418Z,1745527077.418 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-24T20:32:57.2Z 2025-04-24T20:37:57.419Z,1745527077.419 [Default:CheckIn:Read_GPS] Stopped 2025-04-24T20:37:57.419Z,1745527077.419 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-04-24T20:37:57.836Z,1745527077.836 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-24T20:38:04.681Z,1745527084.681 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250424T202915/Courier0004.lzma 2025-04-24T20:38:05.683Z,1745527085.683 [DataOverHttps](INFO): Moved sent file to Logs/20250424T202915/Courier0004.lzma.bak 2025-04-24T20:38:05.683Z,1745527085.683 [DataOverHttps](INFO): SBD MOMSN=24724760 2025-04-24T20:38:07.548Z,1745527087.548 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:38:07.963Z,1745527087.963 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-24T20:38:18.911Z,1745527098.911 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:38:21.630Z,1745527101.630 [DataOverHttps](INFO): Sending 373 bytes from file Logs/20250424T202915/Express0005.lzma 2025-04-24T20:38:22.631Z,1745527102.631 [DataOverHttps](INFO): Moved sent file to Logs/20250424T202915/Express0005.lzma.bak 2025-04-24T20:38:22.631Z,1745527102.631 [DataOverHttps](INFO): SBD MOMSN=24724762 2025-04-24T20:38:24.107Z,1745527104.107 [Default:CheckIn:Read_Iridium] Stopped 2025-04-24T20:38:24.107Z,1745527104.107 [Default:CheckIn:C.Wait] Running Loop=1 2025-04-24T20:38:24.107Z,1745527104.107 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-04-24T20:38:29.807Z,1745527109.807 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:38:29.816Z,1745527109.816 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-04-24T20:38:29.816Z,1745527109.816 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-24T20:38:29.865Z,1745527109.865 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-24T20:38:30.209Z,1745527110.209 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-24T20:38:30.209Z,1745527110.209 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-04-24T20:38:40.341Z,1745527120.341 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:38:51.218Z,1745527131.218 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-04-24T20:38:54.627Z,1745527134.627 [CommandExec](IMPORTANT): got command configSet ElevatorServo.loadAtStartup 1 bool persist 2025-04-24T20:38:54.627Z,1745527134.627 [CommandExec](IMPORTANT): configSet ElevatorServo.loadAtStartup requires a restart to take effect. 2025-04-24T20:38:54.631Z,1745527134.631 [CommandExec](IMPORTANT): got command restart application 2025-04-24T20:38:55.633Z,1745527135.633 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:38:55.634Z,1745527135.634 [CommandExec](INFO): Uninitializing the command executive. 2025-04-24T20:38:55.634Z,1745527135.634 [CommandExec](INFO): Uninitializing the command scheduler. 2025-04-24T20:38:55.634Z,1745527135.634 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:55.769Z,1745527135.769 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-04-24T20:38:55.769Z,1745527135.769 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-04-24T20:38:55.769Z,1745527135.769 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:55.770Z,1745527135.770 [NavChartDb](INFO): Join timeout helper Thread ID is 979 2025-04-24T20:38:55.782Z,1745527135.782 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:38:55.782Z,1745527135.782 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:55.791Z,1745527135.791 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-04-24T20:38:55.791Z,1745527135.791 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:55.792Z,1745527135.792 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 980 2025-04-24T20:38:56.169Z,1745527136.169 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:38:56.170Z,1745527136.170 [WetLabsBB2FL](INFO): Powering down 2025-04-24T20:38:56.170Z,1745527136.170 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:56.191Z,1745527136.191 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-04-24T20:38:56.191Z,1745527136.191 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:56.191Z,1745527136.191 [CTD_Seabird](INFO): Join timeout helper Thread ID is 981 2025-04-24T20:38:56.537Z,1745527136.537 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:38:56.538Z,1745527136.538 [CTD_Seabird](INFO): Powering down 2025-04-24T20:38:56.549Z,1745527136.549 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:56.553Z,1745527136.553 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-04-24T20:38:56.553Z,1745527136.553 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:56.554Z,1745527136.554 [Radio_Surface](INFO): Join timeout helper Thread ID is 982 2025-04-24T20:38:56.921Z,1745527136.921 [Radio_Surface](INFO): Powering down 2025-04-24T20:38:56.922Z,1745527136.922 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:38:56.922Z,1745527136.922 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:56.929Z,1745527136.929 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-04-24T20:38:56.929Z,1745527136.929 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:38:56.930Z,1745527136.930 [Onboard](INFO): Join timeout helper Thread ID is 983 2025-04-24T20:38:57.266Z,1745527137.266 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-04-24T20:39:00.301Z,1745527140.301 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:00.302Z,1745527140.302 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:00.318Z,1745527140.318 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-04-24T20:39:00.318Z,1745527140.318 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:00.318Z,1745527140.318 [DataOverHttps](INFO): Join timeout helper Thread ID is 984 2025-04-24T20:39:01.281Z,1745527141.281 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:01.282Z,1745527141.282 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.295Z,1745527141.295 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-04-24T20:39:01.295Z,1745527141.295 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.296Z,1745527141.296 [DAT](INFO): Join timeout helper Thread ID is 985 2025-04-24T20:39:01.358Z,1745527141.358 [DAT](INFO): Powering down 2025-04-24T20:39:01.430Z,1745527141.430 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:01.430Z,1745527141.430 [DAT](INFO): Powering down 2025-04-24T20:39:01.431Z,1745527141.431 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.434Z,1745527141.434 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-04-24T20:39:01.434Z,1745527141.434 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.434Z,1745527141.434 [BackseatComponent](INFO): Join timeout helper Thread ID is 986 2025-04-24T20:39:01.545Z,1745527141.545 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:01.546Z,1745527141.546 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.562Z,1745527141.562 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-04-24T20:39:01.562Z,1745527141.562 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.562Z,1745527141.562 [logger](INFO): Join timeout helper Thread ID is 987 2025-04-24T20:39:01.593Z,1745527141.593 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:01.594Z,1745527141.594 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.602Z,1745527141.602 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-04-24T20:39:01.602Z,1745527141.602 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.602Z,1745527141.602 [CommandLine](INFO): Join timeout helper Thread ID is 988 2025-04-24T20:39:01.645Z,1745527141.645 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:01.646Z,1745527141.646 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.662Z,1745527141.662 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-04-24T20:39:01.662Z,1745527141.662 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.662Z,1745527141.662 [CommandExec](INFO): Join timeout helper Thread ID is 989 2025-04-24T20:39:01.664Z,1745527141.664 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-04-24T20:39:01.664Z,1745527141.664 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.664Z,1745527141.664 [controlThread](INFO): Join timeout helper Thread ID is 990 2025-04-24T20:39:01.723Z,1745527141.723 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-24T20:39:01.723Z,1745527141.723 [controlThread](DEBUG): Uninitializing ControlThread 2025-04-24T20:39:01.724Z,1745527141.724 [AHRS_M2](INFO): Powering down 2025-04-24T20:39:01.802Z,1745527141.802 [MultiRay](INFO): Powering down LCB2 2025-04-24T20:39:01.802Z,1745527141.802 [MultiRay](INFO): Powering down. 2025-04-24T20:39:01.803Z,1745527141.803 [NAL9602](INFO): Powering down 2025-04-24T20:39:01.866Z,1745527141.866 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-04-24T20:39:01.866Z,1745527141.866 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-04-24T20:39:01.867Z,1745527141.867 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-04-24T20:39:01.867Z,1745527141.867 [MissionManager](INFO): Uninitializing Mission Default 2025-04-24T20:39:01.867Z,1745527141.867 [Default] Stopped 2025-04-24T20:39:01.867Z,1745527141.867 [Default](DEBUG): Aggregate::uninitialize Default 2025-04-24T20:39:01.868Z,1745527141.868 [Default:B.GoToSurface] Stopped 2025-04-24T20:39:01.868Z,1745527141.868 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-24T20:39:01.868Z,1745527141.868 [Default:CheckIn] Stopped 2025-04-24T20:39:01.868Z,1745527141.868 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-04-24T20:39:01.868Z,1745527141.868 [Default:CheckIn:C.Wait] Stopped 2025-04-24T20:39:01.868Z,1745527141.868 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-04-24T20:39:01.871Z,1745527141.871 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-04-24T20:39:01.871Z,1745527141.871 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-04-24T20:39:01.872Z,1745527141.872 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-04-24T20:39:01.872Z,1745527141.872 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-04-24T20:39:01.872Z,1745527141.872 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-04-24T20:39:01.873Z,1745527141.873 [BuoyancyServo](INFO): Powering down 2025-04-24T20:39:01.885Z,1745527141.885 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-04-24T20:39:01.885Z,1745527141.885 [MassServo](INFO): Powering down 2025-04-24T20:39:01.886Z,1745527141.886 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-04-24T20:39:01.886Z,1745527141.886 [RudderServo](INFO): Powering down 2025-04-24T20:39:01.887Z,1745527141.887 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-04-24T20:39:01.887Z,1745527141.887 [ThrusterHE](INFO): Powering down 2025-04-24T20:39:01.888Z,1745527141.888 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-04-24T20:39:01.888Z,1745527141.888 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-04-24T20:39:01.889Z,1745527141.889 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-04-24T20:39:01.889Z,1745527141.889 [CBIT](DEBUG): Powering off loads. 2025-04-24T20:39:01.901Z,1745527141.901 [CBIT](DEBUG): Disabling WDT. 2025-04-24T20:39:01.913Z,1745527141.913 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-04-24T20:39:01.913Z,1745527141.913 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-04-24T20:39:01.914Z,1745527141.914 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.939Z,1745527141.939 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.943Z,1745527141.943 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.950Z,1745527141.950 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.956Z,1745527141.956 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:01.999Z,1745527141.999 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:02.034Z,1745527142.034 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-04-24T20:39:02.034Z,1745527142.034 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-04-24T20:39:02.049Z,1745527142.049 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:02.054Z,1745527142.054 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:02.235Z,1745527142.235 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-24T20:39:02.283Z,1745527142.283 [logger ThreadHandler](INFO): Thread cancelled.