2024-11-19T23:00:57.925Z,1732057257.925 [Supervisor](DEBUG): Initializing supervisor. 2024-11-19T23:00:57.929Z,1732057257.929 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-11-19T23:00:57.930Z,1732057257.930 [SyncHandler](INFO): Protected caller Thread ID is 1486 2024-11-19T23:00:57.930Z,1732057257.930 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-11-19T23:00:57.931Z,1732057257.931 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-11-19T23:00:57.931Z,1732057257.931 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1487 2024-11-19T23:00:57.935Z,1732057257.935 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-11-19T23:00:57.952Z,1732057257.952 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-11-19T23:00:57.953Z,1732057257.953 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-11-19T23:00:57.954Z,1732057257.954 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1488 2024-11-19T23:00:57.958Z,1732057257.958 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-11-19T23:00:57.959Z,1732057257.959 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-11-19T23:00:57.959Z,1732057257.959 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1489 2024-11-19T23:00:57.961Z,1732057257.961 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-11-19T23:00:57.962Z,1732057257.962 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-11-19T23:00:57.963Z,1732057257.963 [logger ThreadHandler](INFO): Protected caller Thread ID is 1490 2024-11-19T23:00:57.966Z,1732057257.966 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-11-19T23:00:57.967Z,1732057257.967 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-11-19T23:00:57.968Z,1732057257.968 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-11-19T23:00:58.371Z,1732057258.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-11-19T23:00:58.372Z,1732057258.372 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-11-19T23:00:58.465Z,1732057258.465 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-11-19T23:00:58.584Z,1732057258.584 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-11-19T23:00:58.585Z,1732057258.585 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-11-19T23:00:58.726Z,1732057258.726 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-11-19T23:00:58.726Z,1732057258.726 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-11-19T23:00:59.082Z,1732057259.082 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-11-19T23:00:59.082Z,1732057259.082 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-11-19T23:00:59.191Z,1732057259.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-11-19T23:00:59.191Z,1732057259.191 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-11-19T23:00:59.618Z,1732057259.618 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-11-19T23:00:59.618Z,1732057259.618 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-11-19T23:00:59.841Z,1732057259.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-11-19T23:00:59.842Z,1732057259.842 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-11-19T23:00:59.934Z,1732057259.934 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-11-19T23:01:00.194Z,1732057260.194 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-11-19T23:01:00.195Z,1732057260.195 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-11-19T23:01:00.426Z,1732057260.426 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-11-19T23:01:00.427Z,1732057260.427 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-11-19T23:01:00.963Z,1732057260.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-11-19T23:01:00.963Z,1732057260.963 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-11-19T23:01:01.160Z,1732057261.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-11-19T23:01:01.161Z,1732057261.161 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-11-19T23:01:01.456Z,1732057261.456 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-11-19T23:01:01.456Z,1732057261.456 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-11-19T23:01:02.324Z,1732057262.324 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-11-19T23:01:02.324Z,1732057262.324 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-11-19T23:01:02.979Z,1732057262.979 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-11-19T23:01:02.981Z,1732057262.981 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2024-11-19T23:01:02.982Z,1732057262.982 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2024-11-19T23:01:03.173Z,1732057263.173 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2024-11-19T23:01:03.301Z,1732057263.301 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2024-11-19T23:01:03.396Z,1732057263.396 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2024-11-19T23:01:03.516Z,1732057263.516 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2024-11-19T23:01:03.614Z,1732057263.614 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2024-11-19T23:01:03.882Z,1732057263.882 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-11-19T23:01:03.883Z,1732057263.883 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2024-11-19T23:01:04.003Z,1732057264.003 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2024-11-19T23:01:04.112Z,1732057264.112 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2024-11-19T23:01:04.263Z,1732057264.263 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2024-11-19T23:01:04.362Z,1732057264.362 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 2024-11-19T23:01:04.362Z,1732057264.362 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-11-19T23:01:04.376Z,1732057264.376 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-11-19T23:01:04.517Z,1732057264.517 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-11-19T23:01:04.517Z,1732057264.517 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-11-19T23:01:04.572Z,1732057264.572 [VerticalControl](DEBUG): Construct VerticalControl. 2024-11-19T23:01:04.630Z,1732057264.630 [VerticalControl] Loaded 2024-11-19T23:01:04.630Z,1732057264.630 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-11-19T23:01:04.633Z,1732057264.633 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-11-19T23:01:04.679Z,1732057264.679 [HorizontalControl] Loaded 2024-11-19T23:01:04.679Z,1732057264.679 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-11-19T23:01:04.682Z,1732057264.682 [SpeedControl](DEBUG): Construct SpeedControl. 2024-11-19T23:01:04.684Z,1732057264.684 [SpeedControl] Loaded 2024-11-19T23:01:04.685Z,1732057264.685 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-11-19T23:01:04.687Z,1732057264.687 [LoopControl](DEBUG): Construct LoopControl. 2024-11-19T23:01:04.688Z,1732057264.688 [LoopControl] Loaded 2024-11-19T23:01:04.688Z,1732057264.688 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-11-19T23:01:04.688Z,1732057264.688 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-11-19T23:01:04.689Z,1732057264.689 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-11-19T23:01:04.748Z,1732057264.748 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-11-19T23:01:04.749Z,1732057264.749 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-11-19T23:01:05.214Z,1732057265.214 [AHRS_M2] Loaded 2024-11-19T23:01:05.214Z,1732057265.214 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-11-19T23:01:05.253Z,1732057265.253 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC4 2024-11-19T23:01:05.253Z,1732057265.253 [BackseatComponent] Loaded 2024-11-19T23:01:05.254Z,1732057265.254 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-11-19T23:01:05.255Z,1732057265.255 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408B54E0 2024-11-19T23:01:05.255Z,1732057265.255 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1570 2024-11-19T23:01:05.258Z,1732057265.258 [LcmUniversalReporter] Loaded 2024-11-19T23:01:05.258Z,1732057265.258 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-11-19T23:01:06.076Z,1732057266.076 [BPC1] Loaded 2024-11-19T23:01:06.076Z,1732057266.076 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-11-19T23:01:06.171Z,1732057266.171 [DAT] Loaded 2024-11-19T23:01:06.172Z,1732057266.172 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-11-19T23:01:06.173Z,1732057266.173 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408E54E0 2024-11-19T23:01:06.173Z,1732057266.173 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1571 2024-11-19T23:01:06.247Z,1732057266.247 [DataOverHttps] Loaded 2024-11-19T23:01:06.247Z,1732057266.247 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-11-19T23:01:06.248Z,1732057266.248 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409154E0 2024-11-19T23:01:06.248Z,1732057266.248 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1572 2024-11-19T23:01:06.271Z,1732057266.271 [Depth_Keller] Loaded 2024-11-19T23:01:06.271Z,1732057266.271 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-11-19T23:01:06.276Z,1732057266.276 [DropWeight] Loaded 2024-11-19T23:01:06.276Z,1732057266.276 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-11-19T23:01:06.341Z,1732057266.341 [NAL9602] Loaded 2024-11-19T23:01:06.341Z,1732057266.341 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-11-19T23:01:06.371Z,1732057266.371 [Onboard] Loaded 2024-11-19T23:01:06.371Z,1732057266.371 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-11-19T23:01:06.372Z,1732057266.372 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409454E0 2024-11-19T23:01:06.372Z,1732057266.372 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1573 2024-11-19T23:01:06.386Z,1732057266.386 [Power24vConverter] Loaded 2024-11-19T23:01:06.387Z,1732057266.387 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-11-19T23:01:06.402Z,1732057266.402 [Radio_Surface] Loaded 2024-11-19T23:01:06.403Z,1732057266.403 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-11-19T23:01:06.403Z,1732057266.403 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409754E0 2024-11-19T23:01:06.404Z,1732057266.404 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1574 2024-11-19T23:01:06.419Z,1732057266.419 [Sonardyne_Nano] Loaded 2024-11-19T23:01:06.420Z,1732057266.420 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-11-19T23:01:06.444Z,1732057266.444 [Waterlinked] Loaded 2024-11-19T23:01:06.444Z,1732057266.444 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-11-19T23:01:06.444Z,1732057266.444 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-11-19T23:01:06.445Z,1732057266.445 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-11-19T23:01:06.455Z,1732057266.455 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-11-19T23:01:06.456Z,1732057266.456 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-11-19T23:01:06.497Z,1732057266.497 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-11-19T23:01:06.499Z,1732057266.499 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-11-19T23:01:06.665Z,1732057266.665 [SBIT](DEBUG): Construct Startup Built In Test. 2024-11-19T23:01:06.674Z,1732057266.674 [SBIT] Loaded 2024-11-19T23:01:06.674Z,1732057266.674 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-11-19T23:01:06.677Z,1732057266.677 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-11-19T23:01:06.689Z,1732057266.689 [IBIT] Loaded 2024-11-19T23:01:06.690Z,1732057266.690 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-11-19T23:01:06.695Z,1732057266.695 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-11-19T23:01:06.797Z,1732057266.797 [CBIT] Loaded 2024-11-19T23:01:06.798Z,1732057266.798 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-11-19T23:01:06.798Z,1732057266.798 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-11-19T23:01:06.799Z,1732057266.799 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-11-19T23:01:07.150Z,1732057267.150 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-11-19T23:01:07.151Z,1732057267.151 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-11-19T23:01:07.201Z,1732057267.201 [DepthRateCalculator] Loaded 2024-11-19T23:01:07.202Z,1732057267.202 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-11-19T23:01:07.206Z,1732057267.206 [PitchRateCalculator] Loaded 2024-11-19T23:01:07.207Z,1732057267.207 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-11-19T23:01:07.218Z,1732057267.218 [SpeedCalculator] Loaded 2024-11-19T23:01:07.218Z,1732057267.218 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-11-19T23:01:07.222Z,1732057267.222 [YawRateCalculator] Loaded 2024-11-19T23:01:07.222Z,1732057267.222 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-11-19T23:01:07.241Z,1732057267.241 [ElevatorOffsetCalculator] Loaded 2024-11-19T23:01:07.241Z,1732057267.241 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-11-19T23:01:07.242Z,1732057267.242 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-11-19T23:01:07.242Z,1732057267.242 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-11-19T23:01:07.421Z,1732057267.421 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-11-19T23:01:07.421Z,1732057267.421 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-11-19T23:01:07.534Z,1732057267.534 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-11-19T23:01:07.534Z,1732057267.534 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-11-19T23:01:07.548Z,1732057267.548 [NavChart] Loaded 2024-11-19T23:01:07.548Z,1732057267.548 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-11-19T23:01:07.554Z,1732057267.554 [UniversalFixResidualReporter] Loaded 2024-11-19T23:01:07.554Z,1732057267.554 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-11-19T23:01:07.554Z,1732057267.554 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-11-19T23:01:07.555Z,1732057267.555 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-11-19T23:01:07.693Z,1732057267.693 [BuoyancyServo] Loaded 2024-11-19T23:01:07.694Z,1732057267.694 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-11-19T23:01:07.716Z,1732057267.716 [ElevatorServo] Loaded 2024-11-19T23:01:07.716Z,1732057267.716 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-11-19T23:01:07.738Z,1732057267.738 [MassServo] Loaded 2024-11-19T23:01:07.738Z,1732057267.738 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-11-19T23:01:07.759Z,1732057267.759 [RudderServo] Loaded 2024-11-19T23:01:07.759Z,1732057267.759 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-11-19T23:01:07.775Z,1732057267.775 [ThrusterHE] Loaded 2024-11-19T23:01:07.776Z,1732057267.776 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-11-19T23:01:07.776Z,1732057267.776 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-11-19T23:01:07.777Z,1732057267.777 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-11-19T23:01:07.927Z,1732057267.927 [ESPComponent] Loaded 2024-11-19T23:01:07.927Z,1732057267.927 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-11-19T23:01:07.950Z,1732057267.950 [PAR_Licor] Loaded 2024-11-19T23:01:07.950Z,1732057267.950 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-11-19T23:01:07.995Z,1732057267.995 [WetLabsBB2FL] Loaded 2024-11-19T23:01:07.996Z,1732057267.996 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-11-19T23:01:07.997Z,1732057267.997 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BF04E0 2024-11-19T23:01:07.997Z,1732057267.997 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1575 2024-11-19T23:01:07.998Z,1732057267.998 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-11-19T23:01:08.013Z,1732057268.013 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-11-19T23:01:08.019Z,1732057268.019 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-11-19T23:01:08.033Z,1732057268.033 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-11-19T23:01:08.034Z,1732057268.034 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C204E0 2024-11-19T23:01:08.035Z,1732057268.035 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1576 2024-11-19T23:01:08.039Z,1732057268.039 [Supervisor](INFO): Main Thread ID is 1485 2024-11-19T23:01:08.039Z,1732057268.039 [Supervisor](DEBUG): Running supervisor. 2024-11-19T23:01:08.040Z,1732057268.040 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1577 2024-11-19T23:01:08.040Z,1732057268.040 [CommandExec](INFO): Initializing the command executive. 2024-11-19T23:01:08.042Z,1732057268.042 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1578 2024-11-19T23:01:08.044Z,1732057268.044 [controlThread ThreadHandler](INFO): Handler Thread ID is 1579 2024-11-19T23:01:08.045Z,1732057268.045 [controlThread](DEBUG): Initializing ControlThread 2024-11-19T23:01:08.045Z,1732057268.045 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-11-19T23:01:08.047Z,1732057268.047 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-11-19T23:01:08.048Z,1732057268.048 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-11-19T23:01:08.048Z,1732057268.048 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-11-19T23:01:08.056Z,1732057268.056 [SBIT](INFO): Initialize SBIT Component. 2024-11-19T23:01:08.056Z,1732057268.056 [SBIT](IMPORTANT): git: 2024-11-04-5-g6604a5c8b 2024-11-19T23:01:08.056Z,1732057268.056 [SBIT](INFO): git hash: 6604a5c8b5e1b5f21bbf7a474c112824b1898be0 2024-11-19T23:01:08.057Z,1732057268.057 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-11-19T23:01:08.058Z,1732057268.058 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2024-11-19T23:01:08.059Z,1732057268.059 [SBIT](INFO): Beginning SBIT in 79.000000 seconds. 2024-11-19T23:01:08.059Z,1732057268.059 [IBIT](INFO): Initialize IBIT Component. 2024-11-19T23:01:08.060Z,1732057268.060 [CBIT](DEBUG): Initialize CBIT Component. 2024-11-19T23:01:08.061Z,1732057268.061 [logger ThreadHandler](INFO): Handler Thread ID is 1580 2024-11-19T23:01:08.074Z,1732057268.074 [CBIT](DEBUG): Initialized mux pins. 2024-11-19T23:01:08.074Z,1732057268.074 [CBIT](DEBUG): Initializing the watchdog timer. 2024-11-19T23:01:08.078Z,1732057268.078 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1581 2024-11-19T23:01:08.086Z,1732057268.086 [DAT ThreadHandler](INFO): Handler Thread ID is 1582 2024-11-19T23:01:08.087Z,1732057268.087 [DAT](INFO): Powering up 2024-11-19T23:01:08.087Z,1732057268.087 [DAT](DEBUG): Initializing DAT. 2024-11-19T23:01:08.091Z,1732057268.091 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1584 2024-11-19T23:01:08.093Z,1732057268.093 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-11-19T23:01:08.098Z,1732057268.098 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-11-19T23:01:08.098Z,1732057268.098 [CBIT](DEBUG): Initializing heartbeat. 2024-11-19T23:01:08.106Z,1732057268.106 [Onboard ThreadHandler](INFO): Handler Thread ID is 1585 2024-11-19T23:01:08.124Z,1732057268.124 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1586 2024-11-19T23:01:08.154Z,1732057268.154 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1587 2024-11-19T23:01:08.156Z,1732057268.156 [WetLabsBB2FL](INFO): Powering up 2024-11-19T23:01:08.162Z,1732057268.162 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1589 2024-11-19T23:01:08.165Z,1732057268.165 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-11-19T23:01:08.165Z,1732057268.165 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-11-19T23:01:08.165Z,1732057268.165 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-11-19T23:01:08.165Z,1732057268.165 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-11-19T23:01:08.165Z,1732057268.165 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-11-19T23:01:08.166Z,1732057268.166 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-11-19T23:01:08.166Z,1732057268.166 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-11-19T23:01:08.166Z,1732057268.166 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-11-19T23:01:08.169Z,1732057268.169 [CBIT](DEBUG): Deactivating GF circuits. 2024-11-19T23:01:08.170Z,1732057268.170 [CBIT](DEBUG): Deactivating emergency mode. 2024-11-19T23:01:08.209Z,1732057268.209 [CBIT](DEBUG): Backplane powered. 2024-11-19T23:01:08.210Z,1732057268.210 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-11-19T23:01:08.210Z,1732057268.210 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-11-19T23:01:08.211Z,1732057268.211 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-11-19T23:01:08.211Z,1732057268.211 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-11-19T23:01:08.211Z,1732057268.211 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-11-19T23:01:08.212Z,1732057268.212 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-11-19T23:01:08.213Z,1732057268.213 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-11-19T23:01:08.218Z,1732057268.218 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-11-19T23:01:08.219Z,1732057268.219 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-11-19T23:01:08.219Z,1732057268.219 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-11-19T23:01:08.222Z,1732057268.222 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-11-19T23:01:08.270Z,1732057268.270 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-11-19T23:01:08.291Z,1732057268.291 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-19T23:01:08.322Z,1732057268.322 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-11-19T23:01:08.323Z,1732057268.323 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-11-19T23:01:08.323Z,1732057268.323 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-11-19T23:01:08.339Z,1732057268.339 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-11-19T23:01:08.530Z,1732057268.530 [Radio_Surface](INFO): Powering up 2024-11-19T23:01:08.629Z,1732057268.629 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-11-19T23:01:08.635Z,1732057268.635 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-11-19T23:01:08.636Z,1732057268.636 [Default:A.Wait](DEBUG): Construct Wait. 2024-11-19T23:01:08.650Z,1732057268.650 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-19T23:01:08.688Z,1732057268.688 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-11-19T23:01:08.703Z,1732057268.703 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-11-19T23:01:08.719Z,1732057268.719 [Default:E.Execute](DEBUG): Construct Execute. 2024-11-19T23:01:08.722Z,1732057268.722 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-11-19T23:01:08.734Z,1732057268.734 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-11-19T23:01:08.742Z,1732057268.742 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-11-19T23:01:08.816Z,1732057268.816 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2024-11-19T23:01:08.817Z,1732057268.817 [Power24vConverter](INFO): Powering up. 2024-11-19T23:01:08.818Z,1732057268.818 [Sonardyne_Nano](INFO): Initializing. 2024-11-19T23:01:08.890Z,1732057268.890 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-11-19T23:01:08.916Z,1732057268.916 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-11-19T23:01:08.922Z,1732057268.922 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-11-19T23:01:08.923Z,1732057268.923 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-19T23:01:08.930Z,1732057268.930 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-19T23:01:08.931Z,1732057268.931 [MassServo](DEBUG): Initializing EZServoServo. 2024-11-19T23:01:08.938Z,1732057268.938 [MassServo](DEBUG): Initializing MassServo. 2024-11-19T23:01:08.939Z,1732057268.939 [RudderServo](DEBUG): Initializing EZServoServo. 2024-11-19T23:01:08.946Z,1732057268.946 [RudderServo](DEBUG): Initializing RudderServo. 2024-11-19T23:01:08.947Z,1732057268.947 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-11-19T23:01:08.954Z,1732057268.954 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-11-19T23:01:09.187Z,1732057269.187 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-11-19T23:01:09.187Z,1732057269.187 [DropWeight] Hardware Fault, FailCount= 1 2024-11-19T23:01:09.187Z,1732057269.187 [DropWeight](ERROR): Hardware Fault 2024-11-19T23:01:09.220Z,1732057269.220 [CommandExec](FAULT): Scheduling is paused 2024-11-19T23:01:09.220Z,1732057269.220 [CBIT](INFO): Critical error at 20241119T230109 2024-11-19T23:01:09.221Z,1732057269.221 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-11-19T23:01:09.231Z,1732057269.231 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-11-19T23:01:09.232Z,1732057269.232 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-11-19T23:01:09.571Z,1732057269.571 [CBIT](INFO): Critical error at 20241119T230109 2024-11-19T23:01:10.266Z,1732057270.266 [WetLabsBB2FL](INFO): Powering down 2024-11-19T23:01:10.764Z,1732057270.764 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-11-19T23:01:12.050Z,1732057272.050 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2024-11-19T23:01:14.782Z,1732057274.782 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-11-19T23:01:20.438Z,1732057280.438 [DAT](INFO): DAT read: 2024-11-19T23:01:20.440Z,1732057280.440 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-11-19T23:01:22.203Z,1732057282.203 [DAT](INFO): DAT read: MF Frequency Band 2024-11-19T23:01:22.204Z,1732057282.204 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-11-19T23:01:22.204Z,1732057282.204 [DAT](INFO): DAT read: Nov 18 2024 21:27:29 2024-11-19T23:01:23.211Z,1732057283.211 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-11-19T23:01:23.212Z,1732057283.212 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-11-19T23:01:23.212Z,1732057283.212 [DAT](INFO): commRate: 800 2024-11-19T23:01:25.278Z,1732057285.278 [DAT](INFO): entering command mode 2024-11-19T23:01:25.478Z,1732057285.478 [DAT](INFO): DAT read: 2024-11-19T23:01:25.479Z,1732057285.479 [DAT](INFO): DAT read: user:1> 2024-11-19T23:01:25.479Z,1732057285.479 [DAT](INFO): setting verbose to 3 2024-11-19T23:01:25.730Z,1732057285.730 [DAT](INFO): DAT read: user:1> 2024-11-19T23:01:25.731Z,1732057285.731 [DAT](INFO): DAT read: Verbose | 3 2024-11-19T23:01:25.732Z,1732057285.732 [DAT](INFO): set verbose to 3 2024-11-19T23:01:25.732Z,1732057285.732 [DAT](INFO): setting DatVerbose to 27440 2024-11-19T23:01:25.982Z,1732057285.982 [DAT](INFO): DAT read: user:2> 2024-11-19T23:01:25.983Z,1732057285.983 [DAT](INFO): DAT read: DatVerbose | 27440 2024-11-19T23:01:25.984Z,1732057285.984 [DAT](INFO): set DatVerbose to 27440 2024-11-19T23:01:25.984Z,1732057285.984 [DAT](INFO): setting transmit power to 8 2024-11-19T23:01:26.234Z,1732057286.234 [DAT](INFO): DAT read: user:3> 2024-11-19T23:01:26.235Z,1732057286.235 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-11-19T23:01:26.236Z,1732057286.236 [DAT](INFO): set transmit power to 8 2024-11-19T23:01:26.236Z,1732057286.236 [DAT](INFO): setting local address to 1 2024-11-19T23:01:26.486Z,1732057286.486 [DAT](INFO): DAT read: user:4> 2024-11-19T23:01:26.487Z,1732057286.487 [DAT](INFO): DAT read: LocalAddr | 1 2024-11-19T23:01:26.488Z,1732057286.488 [DAT](INFO): set local address to 1 2024-11-19T23:01:26.489Z,1732057286.489 [DAT](INFO): Setting time to: 23:1:26 And date to:11/19/2024 2024-11-19T23:01:26.738Z,1732057286.739 [DAT](INFO): DAT read: user:5> 2024-11-19T23:01:26.739Z,1732057286.739 [DAT](INFO): DAT read: Tue Nov 19, 2024 23:01:26 2024-11-19T23:01:26.740Z,1732057286.740 [DAT](INFO): Local DAT time set to Tue Nov 19, 2024 23:01:26 2024-11-19T23:01:36.711Z,1732057296.711 [NAL9602](INFO): Powering up NAL9602 2024-11-19T23:01:37.138Z,1732057297.138 [Waterlinked](ERROR): DVL uart error: serial timeout 2024-11-19T23:01:37.138Z,1732057297.138 [Waterlinked] Communications Fault, FailCount= 1 2024-11-19T23:01:37.138Z,1732057297.138 [Waterlinked](ERROR): Communications Fault 2024-11-19T23:01:37.217Z,1732057297.217 [CBIT](ERROR): Communications Fault in component: Waterlinked 2024-11-19T23:01:37.558Z,1732057297.558 [Waterlinked](INFO): Powering down 2024-11-19T23:01:38.363Z,1732057298.363 [CBIT](INFO): Clearing failed state for component Waterlinked 2024-11-19T23:01:38.363Z,1732057298.363 [Waterlinked] No Fault, FailCount= 1 2024-11-19T23:01:47.587Z,1732057307.587 [NAL9602](INFO): NAL9602 initialized 2024-11-19T23:02:15.455Z,1732057335.455 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-11-19T23:02:16.370Z,1732057336.370 [Waterlinked](INFO): Powering down 2024-11-19T23:02:27.596Z,1732057347.596 [SBIT](IMPORTANT): Beginning Startup BIT 2024-11-19T23:02:27.601Z,1732057347.601 [CBIT](IMPORTANT): Beginning ground fault scan 2024-11-19T23:02:29.639Z,1732057349.639 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-19T23:02:39.458Z,1732057359.458 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003198 CHAN A1 (24V): 0.000959 CHAN A2 (12V): 0.000431 CHAN A3 (5V): -0.001818 CHAN B0 (3.3V): 0.000132 CHAN B1 (3.15aV): -0.000360 CHAN B2 (3.15bV): -0.000516 CHAN B3 (GND): -0.000727 OPEN: 0.007024 Full Scale: +/- 1 mA 2024-11-19T23:02:44.192Z,1732057364.192 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-19T23:02:47.917Z,1732057367.917 [CommandExec](IMPORTANT): got command failComponent 2024-11-19T23:02:47.918Z,1732057367.918 [CommandExec](IMPORTANT): Failed components: 2024-11-19T23:02:47.920Z,1732057367.920 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2024-11-19T23:02:51.870Z,1732057371.870 [CommandExec](IMPORTANT): got command quit 2024-11-19T23:02:52.874Z,1732057372.874 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:52.874Z,1732057372.874 [CommandExec](INFO): Uninitializing the command executive. 2024-11-19T23:02:52.874Z,1732057372.874 [CommandExec](INFO): Uninitializing the command scheduler. 2024-11-19T23:02:52.874Z,1732057372.874 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:52.965Z,1732057372.965 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-11-19T23:02:52.966Z,1732057372.966 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-11-19T23:02:52.966Z,1732057372.966 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:52.966Z,1732057372.966 [NavChartDb](INFO): Join timeout helper Thread ID is 1603 2024-11-19T23:02:53.350Z,1732057373.350 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:53.350Z,1732057373.350 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:53.354Z,1732057373.354 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-11-19T23:02:53.354Z,1732057373.354 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:53.354Z,1732057373.354 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1604 2024-11-19T23:02:53.526Z,1732057373.526 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:53.526Z,1732057373.526 [WetLabsBB2FL](INFO): Powering down 2024-11-19T23:02:53.527Z,1732057373.527 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:53.542Z,1732057373.542 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-11-19T23:02:53.542Z,1732057373.542 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:53.542Z,1732057373.542 [Radio_Surface](INFO): Join timeout helper Thread ID is 1605 2024-11-19T23:02:53.578Z,1732057373.578 [Radio_Surface](INFO): Powering down 2024-11-19T23:02:53.579Z,1732057373.579 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:53.579Z,1732057373.579 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:53.583Z,1732057373.583 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-11-19T23:02:53.583Z,1732057373.583 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:53.583Z,1732057373.583 [Onboard](INFO): Join timeout helper Thread ID is 1606 2024-11-19T23:02:58.194Z,1732057378.194 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:58.194Z,1732057378.194 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.223Z,1732057378.223 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-11-19T23:02:58.223Z,1732057378.223 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.224Z,1732057378.224 [DataOverHttps](INFO): Join timeout helper Thread ID is 1607 2024-11-19T23:02:58.570Z,1732057378.570 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:58.570Z,1732057378.570 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.574Z,1732057378.574 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-11-19T23:02:58.575Z,1732057378.575 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.575Z,1732057378.575 [DAT](INFO): Join timeout helper Thread ID is 1608 2024-11-19T23:02:58.790Z,1732057378.790 [DAT](INFO): Powering down 2024-11-19T23:02:58.862Z,1732057378.862 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:58.862Z,1732057378.862 [DAT](INFO): Powering down 2024-11-19T23:02:58.863Z,1732057378.863 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.878Z,1732057378.878 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-11-19T23:02:58.878Z,1732057378.878 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.879Z,1732057378.879 [BackseatComponent](INFO): Join timeout helper Thread ID is 1609 2024-11-19T23:02:58.954Z,1732057378.954 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:58.954Z,1732057378.954 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.962Z,1732057378.962 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-11-19T23:02:58.962Z,1732057378.962 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:58.963Z,1732057378.963 [logger](INFO): Join timeout helper Thread ID is 1610 2024-11-19T23:02:59.002Z,1732057379.002 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:59.002Z,1732057379.002 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.022Z,1732057379.022 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-11-19T23:02:59.022Z,1732057379.022 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.023Z,1732057379.023 [CommandLine](INFO): Join timeout helper Thread ID is 1611 2024-11-19T23:02:59.094Z,1732057379.094 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:59.094Z,1732057379.094 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.102Z,1732057379.102 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-11-19T23:02:59.103Z,1732057379.103 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.103Z,1732057379.103 [CommandExec](INFO): Join timeout helper Thread ID is 1612 2024-11-19T23:02:59.110Z,1732057379.110 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-11-19T23:02:59.110Z,1732057379.110 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.111Z,1732057379.111 [controlThread](INFO): Join timeout helper Thread ID is 1613 2024-11-19T23:02:59.135Z,1732057379.135 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-11-19T23:02:59.308Z,1732057379.308 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-19T23:02:59.308Z,1732057379.308 [controlThread](DEBUG): Uninitializing ControlThread 2024-11-19T23:02:59.308Z,1732057379.308 [AHRS_M2](INFO): Powering down 2024-11-19T23:02:59.379Z,1732057379.379 [NAL9602](INFO): Powering down 2024-11-19T23:02:59.380Z,1732057379.380 [Sonardyne_Nano](INFO): Powering down 2024-11-19T23:02:59.498Z,1732057379.498 [Waterlinked](INFO): Powering down 2024-11-19T23:02:59.501Z,1732057379.501 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-11-19T23:02:59.501Z,1732057379.501 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-11-19T23:02:59.502Z,1732057379.502 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-11-19T23:02:59.502Z,1732057379.502 [MissionManager](INFO): Uninitializing Mission Default 2024-11-19T23:02:59.505Z,1732057379.505 [MissionManager](INFO): Uninitializing Mission Startup 2024-11-19T23:02:59.507Z,1732057379.507 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-11-19T23:02:59.507Z,1732057379.507 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-11-19T23:02:59.508Z,1732057379.508 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-11-19T23:02:59.508Z,1732057379.508 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-11-19T23:02:59.508Z,1732057379.508 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-11-19T23:02:59.508Z,1732057379.508 [BuoyancyServo](INFO): Powering down 2024-11-19T23:02:59.522Z,1732057379.522 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-19T23:02:59.522Z,1732057379.522 [ElevatorServo](INFO): Powering down 2024-11-19T23:02:59.523Z,1732057379.523 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-11-19T23:02:59.523Z,1732057379.523 [MassServo](INFO): Powering down 2024-11-19T23:02:59.524Z,1732057379.524 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-11-19T23:02:59.524Z,1732057379.524 [RudderServo](INFO): Powering down 2024-11-19T23:02:59.525Z,1732057379.525 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-11-19T23:02:59.525Z,1732057379.525 [ThrusterHE](INFO): Powering down 2024-11-19T23:02:59.526Z,1732057379.526 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-11-19T23:02:59.526Z,1732057379.526 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-11-19T23:02:59.526Z,1732057379.526 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-11-19T23:02:59.526Z,1732057379.526 [CBIT](DEBUG): Powering off loads. 2024-11-19T23:02:59.537Z,1732057379.537 [CBIT](DEBUG): Disabling WDT. 2024-11-19T23:02:59.549Z,1732057379.549 [CBIT](DEBUG): Opening all GF detection circuits. 2024-11-19T23:02:59.551Z,1732057379.551 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.581Z,1732057379.581 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.583Z,1732057379.583 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.589Z,1732057379.589 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.595Z,1732057379.595 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.636Z,1732057379.636 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.838Z,1732057379.838 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.849Z,1732057379.849 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-19T23:02:59.913Z,1732057379.913 [logger ThreadHandler](INFO): Thread cancelled.