2025-08-29T22:26:52.700Z,1756506412.700 [Supervisor](DEBUG): Initializing supervisor.
2025-08-29T22:26:52.705Z,1756506412.705 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-08-29T22:26:52.705Z,1756506412.705 [SyncHandler](INFO): Protected caller Thread ID is 836
2025-08-29T22:26:52.706Z,1756506412.706 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-08-29T22:26:52.706Z,1756506412.706 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-08-29T22:26:52.707Z,1756506412.707 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 837
2025-08-29T22:26:52.711Z,1756506412.711 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-08-29T22:26:52.731Z,1756506412.731 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-08-29T22:26:52.732Z,1756506412.732 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-08-29T22:26:52.732Z,1756506412.732 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 838
2025-08-29T22:26:52.737Z,1756506412.737 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-08-29T22:26:52.738Z,1756506412.738 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-08-29T22:26:52.738Z,1756506412.738 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839
2025-08-29T22:26:52.741Z,1756506412.741 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-08-29T22:26:52.741Z,1756506412.741 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-08-29T22:26:52.742Z,1756506412.742 [logger ThreadHandler](INFO): Protected caller Thread ID is 840
2025-08-29T22:26:52.746Z,1756506412.746 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-08-29T22:26:52.746Z,1756506412.746 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-08-29T22:26:52.750Z,1756506412.750 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-08-29T22:26:53.309Z,1756506413.309 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-08-29T22:26:53.311Z,1756506413.311 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-08-29T22:26:53.534Z,1756506413.534 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-08-29T22:26:53.536Z,1756506413.536 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-08-29T22:26:53.636Z,1756506413.636 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-08-29T22:26:53.638Z,1756506413.638 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-08-29T22:26:53.884Z,1756506413.884 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-08-29T22:26:53.886Z,1756506413.886 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-08-29T22:26:53.976Z,1756506413.977 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-08-29T22:26:54.084Z,1756506414.084 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-08-29T22:26:54.084Z,1756506414.084 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-08-29T22:26:54.454Z,1756506414.454 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-08-29T22:26:54.455Z,1756506414.455 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-08-29T22:26:54.613Z,1756506414.613 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-08-29T22:26:54.614Z,1756506414.614 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-08-29T22:26:55.165Z,1756506415.165 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-08-29T22:26:55.167Z,1756506415.167 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-08-29T22:26:55.359Z,1756506415.359 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-08-29T22:26:55.360Z,1756506415.360 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-08-29T22:26:55.792Z,1756506415.792 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-08-29T22:26:55.793Z,1756506415.793 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-08-29T22:26:56.198Z,1756506416.198 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-08-29T22:26:56.199Z,1756506416.199 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-08-29T22:26:56.719Z,1756506416.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-08-29T22:26:56.720Z,1756506416.720 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-08-29T22:26:57.928Z,1756506417.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-08-29T22:26:57.930Z,1756506417.930 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-08-29T22:26:58.292Z,1756506418.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-08-29T22:26:58.293Z,1756506418.293 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-08-29T22:26:58.549Z,1756506418.549 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-08-29T22:26:58.550Z,1756506418.550 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2025-08-29T22:26:58.554Z,1756506418.554 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2025-08-29T22:26:58.684Z,1756506418.684 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2025-08-29T22:26:58.780Z,1756506418.780 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2025-08-29T22:26:58.927Z,1756506418.927 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2025-08-29T22:26:59.022Z,1756506419.022 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2025-08-29T22:26:59.303Z,1756506419.303 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-08-29T22:26:59.305Z,1756506419.305 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2025-08-29T22:26:59.420Z,1756506419.420 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2025-08-29T22:26:59.536Z,1756506419.536 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2025-08-29T22:26:59.646Z,1756506419.646 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2025-08-29T22:26:59.809Z,1756506419.809 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2025-08-29T22:26:59.918Z,1756506419.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2025-08-29T22:27:00.014Z,1756506420.014 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-08-29T22:27:00.027Z,1756506420.027 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-08-29T22:27:00.043Z,1756506420.043 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-08-29T22:27:00.045Z,1756506420.045 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-08-29T22:27:00.223Z,1756506420.223 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-08-29T22:27:00.224Z,1756506420.224 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-08-29T22:27:00.302Z,1756506420.302 [VerticalControl](DEBUG): Construct VerticalControl.
2025-08-29T22:27:00.365Z,1756506420.365 [VerticalControl] Loaded
2025-08-29T22:27:00.365Z,1756506420.365 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-08-29T22:27:00.368Z,1756506420.368 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-08-29T22:27:00.416Z,1756506420.416 [HorizontalControl] Loaded
2025-08-29T22:27:00.417Z,1756506420.417 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-08-29T22:27:00.419Z,1756506420.419 [SpeedControl](DEBUG): Construct SpeedControl.
2025-08-29T22:27:00.422Z,1756506420.422 [SpeedControl] Loaded
2025-08-29T22:27:00.423Z,1756506420.423 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-08-29T22:27:00.425Z,1756506420.425 [LoopControl](DEBUG): Construct LoopControl.
2025-08-29T22:27:00.426Z,1756506420.426 [LoopControl] Loaded
2025-08-29T22:27:00.426Z,1756506420.426 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-08-29T22:27:00.427Z,1756506420.427 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-08-29T22:27:00.427Z,1756506420.427 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-08-29T22:27:00.620Z,1756506420.620 [BuoyancyServo] Loaded
2025-08-29T22:27:00.620Z,1756506420.620 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-08-29T22:27:00.643Z,1756506420.643 [ElevatorServo] Loaded
2025-08-29T22:27:00.643Z,1756506420.643 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-08-29T22:27:00.665Z,1756506420.665 [MassServo] Loaded
2025-08-29T22:27:00.666Z,1756506420.666 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-08-29T22:27:00.686Z,1756506420.686 [RudderServo] Loaded
2025-08-29T22:27:00.687Z,1756506420.687 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-08-29T22:27:00.704Z,1756506420.704 [ThrusterHE] Loaded
2025-08-29T22:27:00.704Z,1756506420.704 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-08-29T22:27:00.704Z,1756506420.704 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-08-29T22:27:00.705Z,1756506420.705 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-08-29T22:27:00.780Z,1756506420.780 [DepthRateCalculator] Loaded
2025-08-29T22:27:00.781Z,1756506420.781 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-08-29T22:27:00.786Z,1756506420.786 [PitchRateCalculator] Loaded
2025-08-29T22:27:00.786Z,1756506420.786 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-08-29T22:27:00.796Z,1756506420.796 [SpeedCalculator] Loaded
2025-08-29T22:27:00.796Z,1756506420.796 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-08-29T22:27:00.800Z,1756506420.800 [YawRateCalculator] Loaded
2025-08-29T22:27:00.801Z,1756506420.801 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-08-29T22:27:00.820Z,1756506420.820 [ElevatorOffsetCalculator] Loaded
2025-08-29T22:27:00.820Z,1756506420.820 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-08-29T22:27:00.821Z,1756506420.821 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-08-29T22:27:00.822Z,1756506420.822 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-08-29T22:27:00.969Z,1756506420.969 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-08-29T22:27:00.969Z,1756506420.969 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-08-29T22:27:00.984Z,1756506420.984 [NavChart] Loaded
2025-08-29T22:27:00.984Z,1756506420.984 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-08-29T22:27:00.989Z,1756506420.989 [UniversalFixResidualReporter] Loaded
2025-08-29T22:27:00.990Z,1756506420.990 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-08-29T22:27:00.990Z,1756506420.990 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-08-29T22:27:00.991Z,1756506420.991 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-08-29T22:27:01.828Z,1756506421.828 [AHRS_M2] Loaded
2025-08-29T22:27:01.828Z,1756506421.828 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-08-29T22:27:02.082Z,1756506422.082 [BackseatComponent] Loaded
2025-08-29T22:27:02.083Z,1756506422.083 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-08-29T22:27:02.084Z,1756506422.084 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4092B4E0
2025-08-29T22:27:02.084Z,1756506422.084 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923
2025-08-29T22:27:02.087Z,1756506422.087 [LcmUniversalReporter] Loaded
2025-08-29T22:27:02.087Z,1756506422.087 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-08-29T22:27:02.094Z,1756506422.094 [BioacousticsDataBridge] Loaded
2025-08-29T22:27:02.094Z,1756506422.094 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2025-08-29T22:27:03.198Z,1756506423.198 [BPC1] Loaded
2025-08-29T22:27:03.198Z,1756506423.198 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-08-29T22:27:03.405Z,1756506423.405 [DAT] Loaded
2025-08-29T22:27:03.405Z,1756506423.405 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-08-29T22:27:03.406Z,1756506423.406 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4095B4E0
2025-08-29T22:27:03.407Z,1756506423.407 [DAT ThreadHandler](INFO): Protected caller Thread ID is 924
2025-08-29T22:27:03.551Z,1756506423.551 [DataOverHttps] Loaded
2025-08-29T22:27:03.551Z,1756506423.551 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-08-29T22:27:03.553Z,1756506423.553 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4098B4E0
2025-08-29T22:27:03.553Z,1756506423.553 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925
2025-08-29T22:27:03.577Z,1756506423.577 [Depth_Keller] Loaded
2025-08-29T22:27:03.578Z,1756506423.578 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-08-29T22:27:03.583Z,1756506423.583 [DropWeight] Loaded
2025-08-29T22:27:03.583Z,1756506423.583 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-08-29T22:27:03.649Z,1756506423.649 [NAL9602] Loaded
2025-08-29T22:27:03.649Z,1756506423.649 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-08-29T22:27:03.680Z,1756506423.680 [Onboard] Loaded
2025-08-29T22:27:03.681Z,1756506423.681 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-08-29T22:27:03.682Z,1756506423.682 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409BB4E0
2025-08-29T22:27:03.682Z,1756506423.682 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926
2025-08-29T22:27:03.697Z,1756506423.697 [Power24vConverter] Loaded
2025-08-29T22:27:03.697Z,1756506423.697 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-08-29T22:27:03.715Z,1756506423.715 [Radio_Surface] Loaded
2025-08-29T22:27:03.715Z,1756506423.715 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-08-29T22:27:03.717Z,1756506423.717 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409EB4E0
2025-08-29T22:27:03.717Z,1756506423.717 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927
2025-08-29T22:27:03.731Z,1756506423.731 [Sonardyne_Nano] Loaded
2025-08-29T22:27:03.731Z,1756506423.731 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-08-29T22:27:03.732Z,1756506423.732 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-08-29T22:27:03.733Z,1756506423.733 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-08-29T22:27:04.000Z,1756506424.000 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-08-29T22:27:04.001Z,1756506424.001 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-08-29T22:27:04.864Z,1756506424.864 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-08-29T22:27:04.865Z,1756506424.865 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-08-29T22:27:04.915Z,1756506424.915 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-08-29T22:27:04.915Z,1756506424.915 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-08-29T22:27:05.149Z,1756506425.149 [CTD_Seabird] Loaded
2025-08-29T22:27:05.149Z,1756506425.149 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-08-29T22:27:05.150Z,1756506425.150 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B344E0
2025-08-29T22:27:05.151Z,1756506425.151 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 928
2025-08-29T22:27:05.173Z,1756506425.173 [PAR_Licor] Loaded
2025-08-29T22:27:05.174Z,1756506425.174 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-08-29T22:27:05.220Z,1756506425.220 [WetLabsBB2FL] Loaded
2025-08-29T22:27:05.221Z,1756506425.221 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-08-29T22:27:05.222Z,1756506425.222 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B644E0
2025-08-29T22:27:05.222Z,1756506425.222 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 929
2025-08-29T22:27:05.223Z,1756506425.223 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-08-29T22:27:05.225Z,1756506425.225 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-08-29T22:27:05.644Z,1756506425.644 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-08-29T22:27:05.645Z,1756506425.645 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-08-29T22:27:05.847Z,1756506425.847 [SBIT](DEBUG): Construct Startup Built In Test.
2025-08-29T22:27:05.856Z,1756506425.856 [SBIT] Loaded
2025-08-29T22:27:05.857Z,1756506425.857 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-08-29T22:27:05.860Z,1756506425.860 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-08-29T22:27:05.873Z,1756506425.873 [IBIT] Loaded
2025-08-29T22:27:05.873Z,1756506425.873 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-08-29T22:27:05.879Z,1756506425.879 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-08-29T22:27:05.962Z,1756506425.962 [CBIT] Loaded
2025-08-29T22:27:05.962Z,1756506425.962 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-08-29T22:27:05.996Z,1756506425.996 [GFScanner] Loaded
2025-08-29T22:27:05.996Z,1756506425.996 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-08-29T22:27:05.997Z,1756506425.997 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-08-29T22:27:06.003Z,1756506426.003 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-08-29T22:27:06.006Z,1756506426.006 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-08-29T22:27:06.018Z,1756506426.018 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-08-29T22:27:06.019Z,1756506426.019 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
2025-08-29T22:27:06.019Z,1756506426.019 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 930
2025-08-29T22:27:06.024Z,1756506426.024 [Supervisor](INFO): Main Thread ID is 829
2025-08-29T22:27:06.024Z,1756506426.024 [Supervisor](DEBUG): Running supervisor.
2025-08-29T22:27:06.025Z,1756506426.025 [CommandExec ThreadHandler](INFO): Handler Thread ID is 931
2025-08-29T22:27:06.025Z,1756506426.025 [CommandExec](INFO): Initializing the command executive.
2025-08-29T22:27:06.027Z,1756506426.027 [CommandLine ThreadHandler](INFO): Handler Thread ID is 932
2025-08-29T22:27:06.029Z,1756506426.029 [controlThread ThreadHandler](INFO): Handler Thread ID is 933
2025-08-29T22:27:06.029Z,1756506426.029 [controlThread](DEBUG): Initializing ControlThread
2025-08-29T22:27:06.030Z,1756506426.030 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-08-29T22:27:06.032Z,1756506426.032 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-08-29T22:27:06.032Z,1756506426.032 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-08-29T22:27:06.033Z,1756506426.033 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-08-29T22:27:06.034Z,1756506426.034 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-08-29T22:27:06.035Z,1756506426.035 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-08-29T22:27:06.035Z,1756506426.035 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-08-29T22:27:06.035Z,1756506426.035 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-08-29T22:27:06.036Z,1756506426.036 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-08-29T22:27:06.037Z,1756506426.037 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-08-29T22:27:06.037Z,1756506426.037 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-08-29T22:27:06.044Z,1756506426.044 [SBIT](INFO): Initialize SBIT Component.
2025-08-29T22:27:06.045Z,1756506426.045 [SBIT](IMPORTANT): git: 2025-08-26
2025-08-29T22:27:06.045Z,1756506426.045 [SBIT](INFO): git hash: bb7b608ae095ad33f3a1ba1dc4d6b0b36a605f14
2025-08-29T22:27:06.045Z,1756506426.045 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-08-29T22:27:06.046Z,1756506426.046 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-08-29T22:27:06.047Z,1756506426.047 [SBIT](INFO): Beginning SBIT in 43.000000 seconds.
2025-08-29T22:27:06.048Z,1756506426.048 [IBIT](INFO): Initialize IBIT Component.
2025-08-29T22:27:06.049Z,1756506426.049 [CBIT](DEBUG): Initialize CBIT Component.
2025-08-29T22:27:06.050Z,1756506426.050 [logger ThreadHandler](INFO): Handler Thread ID is 934
2025-08-29T22:27:06.060Z,1756506426.060 [CBIT](DEBUG): Initialized mux pins.
2025-08-29T22:27:06.060Z,1756506426.060 [CBIT](DEBUG): Initializing the watchdog timer.
2025-08-29T22:27:06.068Z,1756506426.068 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 935
2025-08-29T22:27:06.080Z,1756506426.080 [DAT ThreadHandler](INFO): Handler Thread ID is 936
2025-08-29T22:27:06.081Z,1756506426.081 [DAT](INFO): Powering up
2025-08-29T22:27:06.081Z,1756506426.081 [DAT](DEBUG): Initializing DAT.
2025-08-29T22:27:06.084Z,1756506426.084 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-08-29T22:27:06.084Z,1756506426.084 [CBIT](DEBUG): Initializing heartbeat.
2025-08-29T22:27:06.086Z,1756506426.086 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 938
2025-08-29T22:27:06.088Z,1756506426.088 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-08-29T22:27:06.097Z,1756506426.097 [Onboard ThreadHandler](INFO): Handler Thread ID is 939
2025-08-29T22:27:06.126Z,1756506426.126 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 940
2025-08-29T22:27:06.140Z,1756506426.140 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 941
2025-08-29T22:27:06.141Z,1756506426.141 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-08-29T22:27:06.145Z,1756506426.145 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 943
2025-08-29T22:27:06.148Z,1756506426.148 [WetLabsBB2FL](INFO): Powering up
2025-08-29T22:27:06.150Z,1756506426.150 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 945
2025-08-29T22:27:06.156Z,1756506426.156 [CBIT](DEBUG): Deactivating emergency mode.
2025-08-29T22:27:06.158Z,1756506426.158 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000
2025-08-29T22:27:06.158Z,1756506426.158 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000
2025-08-29T22:27:06.158Z,1756506426.158 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QL.000
2025-08-29T22:27:06.159Z,1756506426.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QL.000
2025-08-29T22:27:06.159Z,1756506426.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QM.000
2025-08-29T22:27:06.159Z,1756506426.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QM.000
2025-08-29T22:27:06.159Z,1756506426.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2PM.000
2025-08-29T22:27:06.159Z,1756506426.159 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2PM.000
2025-08-29T22:27:06.159Z,1756506426.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI74M.000
2025-08-29T22:27:06.160Z,1756506426.160 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI74M.000
2025-08-29T22:27:06.160Z,1756506426.160 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QN.000
2025-08-29T22:27:06.160Z,1756506426.160 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QN.000
2025-08-29T22:27:06.160Z,1756506426.160 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QO.000
2025-08-29T22:27:06.161Z,1756506426.161 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QO.000
2025-08-29T22:27:06.161Z,1756506426.161 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RO.000
2025-08-29T22:27:06.161Z,1756506426.161 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RO.000
2025-08-29T22:27:06.161Z,1756506426.161 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RN.000
2025-08-29T22:27:06.161Z,1756506426.161 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RN.000
2025-08-29T22:27:06.161Z,1756506426.161 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QP.000
2025-08-29T22:27:06.162Z,1756506426.162 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QP.000
2025-08-29T22:27:06.196Z,1756506426.196 [CBIT](DEBUG): Backplane powered.
2025-08-29T22:27:06.196Z,1756506426.196 [GFScanner](DEBUG): Initializing GFScanner
2025-08-29T22:27:06.196Z,1756506426.196 [GFScanner](DEBUG): Deactivating GF circuits.
2025-08-29T22:27:06.201Z,1756506426.201 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-08-29T22:27:06.202Z,1756506426.202 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-08-29T22:27:06.202Z,1756506426.202 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-08-29T22:27:06.212Z,1756506426.212 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-08-29T22:27:06.248Z,1756506426.248 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2025-08-29T22:27:06.252Z,1756506426.252 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-29T22:27:06.298Z,1756506426.298 [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-08-29T22:27:06.299Z,1756506426.299 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-08-29T22:27:06.299Z,1756506426.299 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-08-29T22:27:06.302Z,1756506426.302 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-08-29T22:27:06.528Z,1756506426.528 [Radio_Surface](INFO): Powering up
2025-08-29T22:27:06.656Z,1756506426.656 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-08-29T22:27:06.670Z,1756506426.670 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-08-29T22:27:06.671Z,1756506426.671 [Default:A.Wait](DEBUG): Construct Wait.
2025-08-29T22:27:06.696Z,1756506426.696 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-29T22:27:06.723Z,1756506426.723 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-08-29T22:27:06.725Z,1756506426.725 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-08-29T22:27:06.747Z,1756506426.747 [Default:E.Execute](DEBUG): Construct Execute.
2025-08-29T22:27:06.750Z,1756506426.750 [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-08-29T22:27:06.776Z,1756506426.776 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-08-29T22:27:06.788Z,1756506426.788 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-08-29T22:27:06.940Z,1756506426.940 [Depth_Keller](INFO): Initializing.
2025-08-29T22:27:06.942Z,1756506426.942 [Power24vConverter](INFO): Powering up.
2025-08-29T22:27:06.942Z,1756506426.942 [Sonardyne_Nano](INFO): Initializing.
2025-08-29T22:27:06.980Z,1756506426.980 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-08-29T22:27:07.007Z,1756506427.007 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-08-29T22:27:07.012Z,1756506427.012 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-08-29T22:27:07.013Z,1756506427.013 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-29T22:27:07.020Z,1756506427.020 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-29T22:27:07.021Z,1756506427.021 [MassServo](DEBUG): Initializing EZServoServo.
2025-08-29T22:27:07.028Z,1756506427.028 [MassServo](DEBUG): Initializing MassServo.
2025-08-29T22:27:07.029Z,1756506427.029 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-29T22:27:07.036Z,1756506427.036 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-29T22:27:07.037Z,1756506427.037 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-08-29T22:27:07.044Z,1756506427.044 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-08-29T22:27:08.760Z,1756506428.760 [WetLabsBB2FL](INFO): Powering down
2025-08-29T22:27:09.210Z,1756506429.210 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-08-29T22:27:10.453Z,1756506430.453 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2025-08-29T22:27:12.685Z,1756506432.685 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-08-29T22:27:18.429Z,1756506438.429 [DAT](INFO): DAT read: 

2025-08-29T22:27:18.430Z,1756506438.430 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2025-08-29T22:27:20.193Z,1756506440.193 [DAT](INFO): DAT read: MF Frequency Band

2025-08-29T22:27:20.195Z,1756506440.195 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2025-08-29T22:27:20.195Z,1756506440.195 [DAT](INFO): DAT read: Aug 29 2025 22:27:14 

2025-08-29T22:27:21.453Z,1756506441.453 [DAT](INFO): DAT read: Features enabled [Bearing]

2025-08-29T22:27:21.454Z,1756506441.454 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2025-08-29T22:27:21.455Z,1756506441.455 [DAT](INFO): commRate: 800
2025-08-29T22:27:23.520Z,1756506443.520 [DAT](INFO): entering command mode
2025-08-29T22:27:23.720Z,1756506443.720 [DAT](INFO): DAT read: 

2025-08-29T22:27:23.721Z,1756506443.721 [DAT](INFO): DAT read: user:1>

2025-08-29T22:27:23.721Z,1756506443.721 [DAT](INFO): setting verbose to 3
2025-08-29T22:27:23.973Z,1756506443.973 [DAT](INFO): DAT read: user:1>

2025-08-29T22:27:23.974Z,1756506443.974 [DAT](INFO): DAT read: Verbose         | 3           

2025-08-29T22:27:23.974Z,1756506443.974 [DAT](INFO): set verbose to 3
2025-08-29T22:27:23.974Z,1756506443.974 [DAT](INFO): setting DatVerbose to 27440
2025-08-29T22:27:24.225Z,1756506444.225 [DAT](INFO): DAT read: user:2>

2025-08-29T22:27:24.226Z,1756506444.226 [DAT](INFO): DAT read: DatVerbose      | 27440       

2025-08-29T22:27:24.226Z,1756506444.226 [DAT](INFO): set DatVerbose to 27440
2025-08-29T22:27:24.226Z,1756506444.226 [DAT](INFO): setting transmit power to 8
2025-08-29T22:27:24.477Z,1756506444.477 [DAT](INFO): DAT read: user:3>

2025-08-29T22:27:24.478Z,1756506444.478 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2025-08-29T22:27:24.478Z,1756506444.478 [DAT](INFO): set transmit power to 8
2025-08-29T22:27:24.478Z,1756506444.478 [DAT](INFO): setting local address to 12
2025-08-29T22:27:24.729Z,1756506444.729 [DAT](INFO): DAT read: user:4>

2025-08-29T22:27:24.729Z,1756506444.729 [DAT](INFO): DAT read: LocalAddr       | 12          

2025-08-29T22:27:24.730Z,1756506444.730 [DAT](INFO): set local address to 12
2025-08-29T22:27:24.731Z,1756506444.731 [DAT](INFO): Setting time to: 22:27:24 And date to:8/29/2025
2025-08-29T22:27:24.981Z,1756506444.981 [DAT](INFO): DAT read: user:5>

2025-08-29T22:27:24.981Z,1756506444.981 [DAT](INFO): DAT read: Fri Aug 29, 2025  22:27:24  

2025-08-29T22:27:24.982Z,1756506444.982 [DAT](INFO): Local DAT time set to Fri Aug 29, 2025  22:27:24  

2025-08-29T22:27:33.861Z,1756506453.861 [NAL9602](INFO): Powering up NAL9602
2025-08-29T22:27:44.770Z,1756506464.770 [NAL9602](INFO): NAL9602 initialized
2025-08-29T22:27:49.630Z,1756506469.630 [SBIT](IMPORTANT): Beginning Startup BIT
2025-08-29T22:27:49.635Z,1756506469.635 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-29T22:27:54.152Z,1756506474.152 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.007864
CHAN A1 (24V): -0.002751
CHAN A2 (12V): -0.003828
CHAN A3 (5V): -0.004467
CHAN B0 (3.3V): -0.003523
CHAN B1 (3.15aV): -0.002512
CHAN B2 (3.15bV): -0.001982
CHAN B3 (GND): -0.001910
OPEN: 0.004603
Full Scale: +/- 1 mA
2025-08-29T22:28:43.831Z,1756506523.831 [SBIT](IMPORTANT): SBIT PASSED
2025-08-29T22:28:43.831Z,1756506523.831 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-08-29T22:28:43.841Z,1756506523.841 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;

2025-08-29T22:28:43.841Z,1756506523.841 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;

2025-08-29T22:28:43.843Z,1756506523.843 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature;

2025-08-29T22:28:43.843Z,1756506523.843 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2025-08-29T22:28:43.843Z,1756506523.843 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 1.000000 count_per_second;

2025-08-29T22:28:43.843Z,1756506523.843 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=238.866507 cubic_centimeter;

2025-08-29T22:28:43.843Z,1756506523.843 [SBIT](IMPORTANT): VerticalControl.massDefault=5.794737 millimeter;

2025-08-29T22:28:43.843Z,1756506523.843 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool;

2025-08-29T22:28:44.230Z,1756506524.230 [MissionManager](IMPORTANT): Started mission Startup
2025-08-29T22:28:44.230Z,1756506524.230 [Startup] Running Loop=1
2025-08-29T22:28:44.230Z,1756506524.230 [Startup](DEBUG): Aggregate::initialize Startup
2025-08-29T22:28:44.231Z,1756506524.231 [Startup:A.GoToSurface] Running Loop=1
2025-08-29T22:28:44.231Z,1756506524.231 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-29T22:28:44.231Z,1756506524.231 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-29T22:28:44.232Z,1756506524.232 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-29T22:28:44.232Z,1756506524.232 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-29T22:28:44.233Z,1756506524.233 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-29T22:28:44.233Z,1756506524.233 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-29T22:28:44.233Z,1756506524.233 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-29T22:28:44.235Z,1756506524.235 [Startup:StartupSatComms] Running Loop=1
2025-08-29T22:28:44.235Z,1756506524.235 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-08-29T22:28:44.235Z,1756506524.235 [Startup:StartupSatComms:A] Running Loop=1
2025-08-29T22:28:44.638Z,1756506524.638 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-08-29T22:29:44.458Z,1756506584.458 [Startup:StartupSatComms:A](INFO): Timed out from 2025-08-29T22:28:44.2Z
2025-08-29T22:29:44.459Z,1756506584.459 [Startup:StartupSatComms:A] Stopped
2025-08-29T22:29:44.459Z,1756506584.459 [Startup:StartupSatComms:B] Running Loop=1
2025-08-29T22:29:44.867Z,1756506584.867 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-29T22:29:23.523Z,1756506563.523 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004828
2025-08-29T22:29:30.772Z,1756506570.772 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250829T191802/Courier0091.lzma
2025-08-29T22:29:31.774Z,1756506571.774 [DataOverHttps](INFO): Moved sent file to Logs/20250829T191802/Courier0091.lzma.bak
2025-08-29T22:29:31.774Z,1756506571.774 [DataOverHttps](INFO): SBD MOMSN=25917089
2025-08-29T22:29:38.020Z,1756506578.020 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-29T22:29:47.345Z,1756506587.345 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250829T222652/Courier0000.lzma
2025-08-29T22:29:48.346Z,1756506588.346 [DataOverHttps](INFO): Moved sent file to Logs/20250829T222652/Courier0000.lzma.bak
2025-08-29T22:29:48.346Z,1756506588.346 [DataOverHttps](INFO): SBD MOMSN=25917091
2025-08-29T22:30:03.043Z,1756506603.043 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250829T191802/Express0092.lzma
2025-08-29T22:30:04.048Z,1756506604.048 [DataOverHttps](INFO): Moved sent file to Logs/20250829T191802/Express0092.lzma.bak
2025-08-29T22:30:04.048Z,1756506604.048 [DataOverHttps](INFO): SBD MOMSN=25917094
2025-08-29T22:30:06.229Z,1756506606.229 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-08-29T22:30:06.229Z,1756506606.229 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-29T22:30:06.261Z,1756506606.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-29T22:30:06.642Z,1756506606.642 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-29T22:30:06.642Z,1756506606.642 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-08-29T22:30:19.823Z,1756506619.823 [DataOverHttps](INFO): Sending 944 bytes from file Logs/20250829T222652/Express0001.lzma
2025-08-29T22:30:20.822Z,1756506620.822 [DataOverHttps](INFO): Moved sent file to Logs/20250829T222652/Express0001.lzma.bak
2025-08-29T22:30:20.822Z,1756506620.822 [DataOverHttps](INFO): SBD MOMSN=25917096
2025-08-29T22:30:22.374Z,1756506622.374 [Startup:StartupSatComms:B] Stopped
2025-08-29T22:30:22.374Z,1756506622.374 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-08-29T22:30:22.374Z,1756506622.374 [Startup:StartupSatComms] Stopped
2025-08-29T22:30:22.374Z,1756506622.374 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-08-29T22:30:22.375Z,1756506622.375 [Startup](INFO): Completed Startup
2025-08-29T22:30:22.377Z,1756506622.377 [MissionManager](INFO): Startup is completed.
2025-08-29T22:30:22.378Z,1756506622.378 [MissionManager](INFO): Uninitializing Mission Startup
2025-08-29T22:30:22.378Z,1756506622.378 [Startup] Stopped
2025-08-29T22:30:22.378Z,1756506622.378 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-08-29T22:30:22.379Z,1756506622.379 [Startup:A.GoToSurface] Stopped
2025-08-29T22:30:22.379Z,1756506622.379 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-29T22:30:22.782Z,1756506622.782 [MissionManager](IMPORTANT): Started mission Default
2025-08-29T22:30:22.782Z,1756506622.782 [Default] Running Loop=1
2025-08-29T22:30:22.782Z,1756506622.782 [Default](DEBUG): Aggregate::initialize Default
2025-08-29T22:30:22.782Z,1756506622.782 [Default:B.GoToSurface] Running Loop=1
2025-08-29T22:30:22.782Z,1756506622.782 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-29T22:30:22.783Z,1756506622.783 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-29T22:30:22.783Z,1756506622.783 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-29T22:30:22.783Z,1756506622.783 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-29T22:30:22.784Z,1756506622.784 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-29T22:30:22.784Z,1756506622.784 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-29T22:30:22.785Z,1756506622.785 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-29T22:30:22.785Z,1756506622.785 [Default:A.Wait] Running Loop=1
2025-08-29T22:30:22.785Z,1756506622.785 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-08-29T22:30:36.127Z,1756506636.127 [Default:A.Wait](INFO): Done Waiting.
2025-08-29T22:30:36.127Z,1756506636.127 [Default:A.Wait] Stopped
2025-08-29T22:30:36.127Z,1756506636.127 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-08-29T22:30:36.539Z,1756506636.539 [Default:CheckIn] Running Loop=1
2025-08-29T22:30:36.539Z,1756506636.539 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-29T22:30:36.539Z,1756506636.539 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-29T22:30:36.974Z,1756506636.974 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-29T22:30:43.430Z,1756506643.430 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-29T22:30:56.759Z,1756506656.759 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-29T22:31:17.419Z,1756506677.419 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-29T22:31:38.014Z,1756506698.014 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-29T22:32:48.214Z,1756506768.214 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-29T22:33:07.220Z,1756506787.220 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-08-29T22:33:07.220Z,1756506787.220 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-29T22:33:07.230Z,1756506787.230 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-29T22:33:07.644Z,1756506787.644 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-29T22:33:07.647Z,1756506787.647 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-08-29T22:33:27.062Z,1756506807.062 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-08-29T22:33:32.712Z,1756506812.712 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-08-29T22:34:59.111Z,1756506899.111 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-08-29T22:34:59.131Z,1756506899.131 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 4.
2025-08-29T22:34:59.134Z,1756506899.134 [BPC1](INFO): Received data from all battery sticks.
2025-08-29T22:35:36.712Z,1756506936.712 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-08-29T22:30:36.5Z
2025-08-29T22:35:36.712Z,1756506936.712 [Default:CheckIn:Read_GPS] Stopped
2025-08-29T22:35:36.712Z,1756506936.712 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-29T22:35:37.107Z,1756506937.107 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-29T22:35:44.136Z,1756506944.136 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250829T222652/Courier0004.lzma
2025-08-29T22:35:45.138Z,1756506945.138 [DataOverHttps](INFO): Moved sent file to Logs/20250829T222652/Courier0004.lzma.bak
2025-08-29T22:35:45.138Z,1756506945.138 [DataOverHttps](INFO): SBD MOMSN=25917110
2025-08-29T22:36:00.956Z,1756506960.956 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20250829T222652/Express0005.lzma
2025-08-29T22:36:01.958Z,1756506961.958 [DataOverHttps](INFO): Moved sent file to Logs/20250829T222652/Express0005.lzma.bak
2025-08-29T22:36:01.958Z,1756506961.958 [DataOverHttps](INFO): SBD MOMSN=25917112
2025-08-29T22:36:03.381Z,1756506963.381 [Default:CheckIn:Read_Iridium] Stopped
2025-08-29T22:36:03.381Z,1756506963.381 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-29T22:36:03.382Z,1756506963.382 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-29T22:36:08.234Z,1756506968.234 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-08-29T22:36:08.234Z,1756506968.234 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-29T22:36:08.253Z,1756506968.253 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-29T22:36:08.618Z,1756506968.618 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-29T22:36:08.618Z,1756506968.618 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-08-29T22:37:03.025Z,1756507023.025 [CommandExec](IMPORTANT): got command failComponent
2025-08-29T22:37:03.025Z,1756507023.025 [CommandExec](IMPORTANT): Failed components:
2025-08-29T22:37:03.025Z,1756507023.025 [CommandExec](IMPORTANT): No failed Components.
2025-08-29T22:37:12.925Z,1756507032.925 [CommandExec](IMPORTANT): got command gfscan
2025-08-29T22:37:13.267Z,1756507033.267 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-29T22:37:17.756Z,1756507037.756 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010634
CHAN A1 (24V): -0.002695
CHAN A2 (12V): -0.004252
CHAN A3 (5V): -0.004487
CHAN B0 (3.3V): -0.002278
CHAN B1 (3.15aV): -0.001780
CHAN B2 (3.15bV): -0.001628
CHAN B3 (GND): -0.001719
OPEN: 0.004681
Full Scale: +/- 1 mA
2025-08-29T22:37:25.861Z,1756507045.861 [CommandExec](IMPORTANT): got command quit
2025-08-29T22:37:26.864Z,1756507046.864 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2025-08-29T22:37:26.864Z,1756507046.864 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:26.864Z,1756507046.864 [CommandExec](INFO): Uninitializing the command executive.
2025-08-29T22:37:26.865Z,1756507046.865 [CommandExec](INFO): Uninitializing the command scheduler.
2025-08-29T22:37:26.865Z,1756507046.865 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:26.905Z,1756507046.905 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-08-29T22:37:26.905Z,1756507046.905 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-08-29T22:37:26.905Z,1756507046.905 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:26.906Z,1756507046.906 [NavChartDb](INFO): Join timeout helper Thread ID is 979
2025-08-29T22:37:26.912Z,1756507046.912 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:26.913Z,1756507046.913 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:26.917Z,1756507046.917 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-08-29T22:37:26.917Z,1756507046.917 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:26.917Z,1756507046.917 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 980
2025-08-29T22:37:27.136Z,1756507047.136 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:27.137Z,1756507047.137 [WetLabsBB2FL](INFO): Powering down
2025-08-29T22:37:27.137Z,1756507047.137 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:27.148Z,1756507047.148 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-08-29T22:37:27.148Z,1756507047.148 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:27.149Z,1756507047.149 [CTD_Seabird](INFO): Join timeout helper Thread ID is 981
2025-08-29T22:37:28.048Z,1756507048.048 [CTD_Seabird](INFO): Powering down
2025-08-29T22:37:28.060Z,1756507048.060 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:28.060Z,1756507048.060 [CTD_Seabird](INFO): Powering down
2025-08-29T22:37:28.072Z,1756507048.072 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:28.090Z,1756507048.090 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-08-29T22:37:28.090Z,1756507048.090 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:28.090Z,1756507048.090 [Radio_Surface](INFO): Join timeout helper Thread ID is 982
2025-08-29T22:37:28.129Z,1756507048.129 [Radio_Surface](INFO): Powering down
2025-08-29T22:37:28.129Z,1756507048.129 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:28.130Z,1756507048.130 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:28.144Z,1756507048.144 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-08-29T22:37:28.144Z,1756507048.144 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:28.144Z,1756507048.144 [Onboard](INFO): Join timeout helper Thread ID is 983
2025-08-29T22:37:28.552Z,1756507048.552 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-29T22:37:29.816Z,1756507049.816 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:29.817Z,1756507049.817 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:29.829Z,1756507049.829 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-08-29T22:37:29.829Z,1756507049.829 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:29.829Z,1756507049.829 [DataOverHttps](INFO): Join timeout helper Thread ID is 984
2025-08-29T22:37:30.560Z,1756507050.560 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:30.560Z,1756507050.560 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.577Z,1756507050.577 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-08-29T22:37:30.577Z,1756507050.577 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.577Z,1756507050.577 [DAT](INFO): Join timeout helper Thread ID is 985
2025-08-29T22:37:30.640Z,1756507050.640 [DAT](INFO): Powering down
2025-08-29T22:37:30.717Z,1756507050.717 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:30.717Z,1756507050.717 [DAT](INFO): Powering down
2025-08-29T22:37:30.718Z,1756507050.718 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.721Z,1756507050.721 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-08-29T22:37:30.721Z,1756507050.721 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.721Z,1756507050.721 [BackseatComponent](INFO): Join timeout helper Thread ID is 986
2025-08-29T22:37:30.772Z,1756507050.772 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:30.773Z,1756507050.773 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.781Z,1756507050.781 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-08-29T22:37:30.781Z,1756507050.781 [logger ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.781Z,1756507050.781 [logger](INFO): Join timeout helper Thread ID is 987
2025-08-29T22:37:30.794Z,1756507050.794 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:30.794Z,1756507050.794 [logger ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.796Z,1756507050.796 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-08-29T22:37:30.798Z,1756507050.798 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.799Z,1756507050.799 [CommandLine](INFO): Join timeout helper Thread ID is 988
2025-08-29T22:37:30.857Z,1756507050.857 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:30.857Z,1756507050.857 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.877Z,1756507050.877 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-08-29T22:37:30.877Z,1756507050.877 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.877Z,1756507050.877 [CommandExec](INFO): Join timeout helper Thread ID is 989
2025-08-29T22:37:30.878Z,1756507050.878 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-08-29T22:37:30.879Z,1756507050.879 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:30.879Z,1756507050.879 [controlThread](INFO): Join timeout helper Thread ID is 990
2025-08-29T22:37:31.004Z,1756507051.004 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-29T22:37:31.004Z,1756507051.004 [controlThread](DEBUG): Uninitializing ControlThread
2025-08-29T22:37:31.005Z,1756507051.005 [AHRS_M2](INFO): Powering down
2025-08-29T22:37:31.081Z,1756507051.081 [NAL9602](INFO): Powering down
2025-08-29T22:37:31.082Z,1756507051.082 [Sonardyne_Nano](INFO): Powering down
2025-08-29T22:37:31.288Z,1756507051.288 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-08-29T22:37:31.289Z,1756507051.289 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-08-29T22:37:31.290Z,1756507051.290 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-08-29T22:37:31.290Z,1756507051.290 [MissionManager](INFO): Uninitializing Mission Default
2025-08-29T22:37:31.290Z,1756507051.290 [Default] Stopped
2025-08-29T22:37:31.290Z,1756507051.290 [Default](DEBUG): Aggregate::uninitialize Default
2025-08-29T22:37:31.290Z,1756507051.290 [Default:B.GoToSurface] Stopped
2025-08-29T22:37:31.290Z,1756507051.290 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-29T22:37:31.290Z,1756507051.290 [Default:CheckIn] Stopped
2025-08-29T22:37:31.291Z,1756507051.291 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-29T22:37:31.291Z,1756507051.291 [Default:CheckIn:C.Wait] Stopped
2025-08-29T22:37:31.291Z,1756507051.291 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-29T22:37:31.294Z,1756507051.294 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-08-29T22:37:31.294Z,1756507051.294 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-08-29T22:37:31.294Z,1756507051.294 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-08-29T22:37:31.295Z,1756507051.295 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-08-29T22:37:31.295Z,1756507051.295 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-08-29T22:37:31.295Z,1756507051.295 [BuoyancyServo](INFO): Powering down
2025-08-29T22:37:31.308Z,1756507051.308 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-29T22:37:31.308Z,1756507051.308 [ElevatorServo](INFO): Powering down
2025-08-29T22:37:31.309Z,1756507051.309 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-08-29T22:37:31.309Z,1756507051.309 [MassServo](INFO): Powering down
2025-08-29T22:37:31.310Z,1756507051.310 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-29T22:37:31.310Z,1756507051.310 [RudderServo](INFO): Powering down
2025-08-29T22:37:31.311Z,1756507051.311 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-08-29T22:37:31.311Z,1756507051.311 [ThrusterHE](INFO): Powering down
2025-08-29T22:37:31.312Z,1756507051.312 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-08-29T22:37:31.312Z,1756507051.312 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-08-29T22:37:31.313Z,1756507051.313 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-08-29T22:37:31.313Z,1756507051.313 [CBIT](DEBUG): Powering off loads.
2025-08-29T22:37:31.324Z,1756507051.324 [CBIT](DEBUG): Disabling WDT.
2025-08-29T22:37:31.336Z,1756507051.336 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-08-29T22:37:31.336Z,1756507051.336 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-08-29T22:37:31.337Z,1756507051.337 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.399Z,1756507051.399 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.402Z,1756507051.402 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.408Z,1756507051.408 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.414Z,1756507051.414 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.456Z,1756507051.456 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.497Z,1756507051.497 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.501Z,1756507051.501 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.520Z,1756507051.520 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-08-29T22:37:31.520Z,1756507051.520 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-08-29T22:37:31.535Z,1756507051.535 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-29T22:37:31.598Z,1756507051.598 [logger ThreadHandler](INFO): Thread cancelled.