2025-04-17T21:53:50.369Z,1744926830.369 [Supervisor](DEBUG): Initializing supervisor.
2025-04-17T21:53:50.374Z,1744926830.374 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-17T21:53:50.375Z,1744926830.375 [SyncHandler](INFO): Protected caller Thread ID is 7905
2025-04-17T21:53:50.375Z,1744926830.375 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-17T21:53:50.376Z,1744926830.376 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-17T21:53:50.377Z,1744926830.377 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7906
2025-04-17T21:53:50.381Z,1744926830.381 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-17T21:53:50.398Z,1744926830.398 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-17T21:53:50.399Z,1744926830.399 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-17T21:53:50.400Z,1744926830.400 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7907
2025-04-17T21:53:50.404Z,1744926830.404 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-17T21:53:50.405Z,1744926830.405 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-17T21:53:50.405Z,1744926830.405 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7908
2025-04-17T21:53:50.407Z,1744926830.407 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-17T21:53:50.408Z,1744926830.408 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-17T21:53:50.408Z,1744926830.408 [logger ThreadHandler](INFO): Protected caller Thread ID is 7909
2025-04-17T21:53:50.412Z,1744926830.412 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-17T21:53:50.412Z,1744926830.412 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-17T21:53:50.414Z,1744926830.414 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-17T21:53:50.901Z,1744926830.901 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-17T21:53:50.902Z,1744926830.902 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-17T21:53:51.123Z,1744926831.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-17T21:53:51.123Z,1744926831.123 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-17T21:53:51.216Z,1744926831.216 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-17T21:53:51.461Z,1744926831.461 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-17T21:53:51.461Z,1744926831.461 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-17T21:53:51.551Z,1744926831.551 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-17T21:53:51.658Z,1744926831.658 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-17T21:53:51.658Z,1744926831.658 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-17T21:53:52.021Z,1744926832.021 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-17T21:53:52.021Z,1744926832.021 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-17T21:53:52.166Z,1744926832.166 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-17T21:53:52.167Z,1744926832.167 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-17T21:53:52.710Z,1744926832.710 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-17T21:53:52.711Z,1744926832.711 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-17T21:53:52.902Z,1744926832.902 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-17T21:53:52.902Z,1744926832.902 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-17T21:53:53.325Z,1744926833.325 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-17T21:53:53.326Z,1744926833.326 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-17T21:53:53.619Z,1744926833.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-17T21:53:53.620Z,1744926833.620 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-17T21:53:53.740Z,1744926833.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-17T21:53:53.741Z,1744926833.741 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-17T21:53:54.665Z,1744926834.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-17T21:53:54.665Z,1744926834.665 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-17T21:53:55.303Z,1744926835.303 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-17T21:53:55.303Z,1744926835.303 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-17T21:53:55.934Z,1744926835.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-17T21:53:55.936Z,1744926835.936 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2025-04-17T21:53:55.937Z,1744926835.937 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2025-04-17T21:53:56.065Z,1744926836.065 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2025-04-17T21:53:56.161Z,1744926836.161 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2025-04-17T21:53:56.307Z,1744926836.307 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2025-04-17T21:53:56.404Z,1744926836.404 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2025-04-17T21:53:56.679Z,1744926836.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-17T21:53:56.679Z,1744926836.679 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2025-04-17T21:53:56.794Z,1744926836.794 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2025-04-17T21:53:56.912Z,1744926836.912 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2025-04-17T21:53:57.022Z,1744926837.022 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2025-04-17T21:53:57.181Z,1744926837.181 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2025-04-17T21:53:57.291Z,1744926837.291 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2025-04-17T21:53:57.388Z,1744926837.388 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-17T21:53:57.393Z,1744926837.393 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-17T21:53:57.404Z,1744926837.404 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-17T21:53:57.404Z,1744926837.404 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-17T21:53:57.535Z,1744926837.535 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-17T21:53:57.535Z,1744926837.535 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-17T21:53:57.587Z,1744926837.587 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-17T21:53:57.645Z,1744926837.645 [VerticalControl] Loaded
2025-04-17T21:53:57.646Z,1744926837.646 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-17T21:53:57.648Z,1744926837.648 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-17T21:53:57.696Z,1744926837.696 [HorizontalControl] Loaded
2025-04-17T21:53:57.696Z,1744926837.696 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-17T21:53:57.698Z,1744926837.698 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-17T21:53:57.701Z,1744926837.701 [SpeedControl] Loaded
2025-04-17T21:53:57.701Z,1744926837.701 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-17T21:53:57.704Z,1744926837.704 [LoopControl](DEBUG): Construct LoopControl.
2025-04-17T21:53:57.705Z,1744926837.705 [LoopControl] Loaded
2025-04-17T21:53:57.705Z,1744926837.705 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-17T21:53:57.705Z,1744926837.705 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-17T21:53:57.706Z,1744926837.706 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-17T21:53:57.862Z,1744926837.862 [BuoyancyServo] Loaded
2025-04-17T21:53:57.862Z,1744926837.862 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-17T21:53:57.884Z,1744926837.884 [ElevatorServo] Loaded
2025-04-17T21:53:57.884Z,1744926837.884 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-04-17T21:53:57.905Z,1744926837.905 [MassServo] Loaded
2025-04-17T21:53:57.905Z,1744926837.905 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-17T21:53:57.925Z,1744926837.925 [RudderServo] Loaded
2025-04-17T21:53:57.925Z,1744926837.925 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-17T21:53:57.942Z,1744926837.942 [ThrusterHE] Loaded
2025-04-17T21:53:57.942Z,1744926837.942 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-17T21:53:57.943Z,1744926837.943 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-17T21:53:57.943Z,1744926837.943 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-17T21:53:57.993Z,1744926837.993 [DepthRateCalculator] Loaded
2025-04-17T21:53:57.993Z,1744926837.993 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-17T21:53:57.997Z,1744926837.997 [PitchRateCalculator] Loaded
2025-04-17T21:53:57.998Z,1744926837.998 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-17T21:53:58.007Z,1744926838.007 [SpeedCalculator] Loaded
2025-04-17T21:53:58.007Z,1744926838.007 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-17T21:53:58.012Z,1744926838.012 [YawRateCalculator] Loaded
2025-04-17T21:53:58.012Z,1744926838.012 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-17T21:53:58.030Z,1744926838.030 [ElevatorOffsetCalculator] Loaded
2025-04-17T21:53:58.031Z,1744926838.031 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-17T21:53:58.031Z,1744926838.031 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-17T21:53:58.032Z,1744926838.032 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-17T21:53:58.143Z,1744926838.143 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-17T21:53:58.143Z,1744926838.143 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-17T21:53:58.157Z,1744926838.157 [NavChart] Loaded
2025-04-17T21:53:58.157Z,1744926838.157 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-17T21:53:58.162Z,1744926838.162 [UniversalFixResidualReporter] Loaded
2025-04-17T21:53:58.163Z,1744926838.163 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-17T21:53:58.163Z,1744926838.163 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-17T21:53:58.164Z,1744926838.164 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-17T21:53:58.645Z,1744926838.645 [AHRS_M2] Loaded
2025-04-17T21:53:58.645Z,1744926838.645 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-17T21:53:58.684Z,1744926838.684 [BackseatComponent] Loaded
2025-04-17T21:53:58.684Z,1744926838.684 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-17T21:53:58.686Z,1744926838.686 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0
2025-04-17T21:53:58.686Z,1744926838.686 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7991
2025-04-17T21:53:58.689Z,1744926838.689 [LcmUniversalReporter] Loaded
2025-04-17T21:53:58.689Z,1744926838.689 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-17T21:53:58.695Z,1744926838.695 [BioacousticsDataBridge] Loaded
2025-04-17T21:53:58.696Z,1744926838.696 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2025-04-17T21:53:59.533Z,1744926839.533 [BPC1] Loaded
2025-04-17T21:53:59.533Z,1744926839.533 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-04-17T21:53:59.604Z,1744926839.604 [DataOverHttps] Loaded
2025-04-17T21:53:59.604Z,1744926839.604 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-17T21:53:59.605Z,1744926839.605 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0
2025-04-17T21:53:59.605Z,1744926839.605 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7992
2025-04-17T21:53:59.628Z,1744926839.628 [Depth_Keller] Loaded
2025-04-17T21:53:59.629Z,1744926839.629 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-04-17T21:53:59.633Z,1744926839.633 [DropWeight] Loaded
2025-04-17T21:53:59.634Z,1744926839.634 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-04-17T21:53:59.698Z,1744926839.698 [NAL9602] Loaded
2025-04-17T21:53:59.698Z,1744926839.698 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-17T21:53:59.728Z,1744926839.728 [Onboard] Loaded
2025-04-17T21:53:59.728Z,1744926839.728 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-17T21:53:59.729Z,1744926839.729 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0
2025-04-17T21:53:59.729Z,1744926839.729 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7993
2025-04-17T21:53:59.743Z,1744926839.743 [Power24vConverter] Loaded
2025-04-17T21:53:59.744Z,1744926839.744 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-17T21:53:59.760Z,1744926839.760 [Radio_Surface] Loaded
2025-04-17T21:53:59.760Z,1744926839.760 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-17T21:53:59.761Z,1744926839.761 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409CB4E0
2025-04-17T21:53:59.761Z,1744926839.761 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7994
2025-04-17T21:53:59.777Z,1744926839.777 [Sonardyne_Nano] Loaded
2025-04-17T21:53:59.777Z,1744926839.777 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-04-17T21:53:59.777Z,1744926839.777 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-17T21:53:59.778Z,1744926839.778 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-17T21:53:59.947Z,1744926839.947 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-17T21:53:59.948Z,1744926839.948 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-17T21:54:00.563Z,1744926840.563 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-17T21:54:00.564Z,1744926840.564 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-17T21:54:00.596Z,1744926840.596 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-17T21:54:00.597Z,1744926840.597 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-17T21:54:00.769Z,1744926840.769 [CTD_Seabird] Loaded
2025-04-17T21:54:00.769Z,1744926840.769 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-17T21:54:00.770Z,1744926840.770 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B0F4E0
2025-04-17T21:54:00.771Z,1744926840.771 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7995
2025-04-17T21:54:00.793Z,1744926840.793 [PAR_Licor] Loaded
2025-04-17T21:54:00.793Z,1744926840.793 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-04-17T21:54:00.838Z,1744926840.838 [WetLabsBB2FL] Loaded
2025-04-17T21:54:00.838Z,1744926840.838 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-04-17T21:54:00.839Z,1744926840.839 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B3F4E0
2025-04-17T21:54:00.839Z,1744926840.839 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7996
2025-04-17T21:54:00.840Z,1744926840.840 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-17T21:54:00.841Z,1744926840.841 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-17T21:54:01.172Z,1744926841.172 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-17T21:54:01.173Z,1744926841.173 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-17T21:54:01.314Z,1744926841.314 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-17T21:54:01.323Z,1744926841.323 [SBIT] Loaded
2025-04-17T21:54:01.324Z,1744926841.324 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-17T21:54:01.326Z,1744926841.326 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-17T21:54:01.339Z,1744926841.339 [IBIT] Loaded
2025-04-17T21:54:01.339Z,1744926841.339 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-17T21:54:01.345Z,1744926841.345 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-17T21:54:01.448Z,1744926841.448 [CBIT] Loaded
2025-04-17T21:54:01.448Z,1744926841.448 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-17T21:54:01.449Z,1744926841.449 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-17T21:54:01.455Z,1744926841.455 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-17T21:54:01.458Z,1744926841.458 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-17T21:54:01.469Z,1744926841.469 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-17T21:54:01.470Z,1744926841.470 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C3B4E0
2025-04-17T21:54:01.470Z,1744926841.470 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7997
2025-04-17T21:54:01.475Z,1744926841.475 [Supervisor](INFO): Main Thread ID is 5258
2025-04-17T21:54:01.475Z,1744926841.475 [Supervisor](DEBUG): Running supervisor.
2025-04-17T21:54:01.475Z,1744926841.475 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7998
2025-04-17T21:54:01.476Z,1744926841.476 [CommandExec](INFO): Initializing the command executive.
2025-04-17T21:54:01.477Z,1744926841.477 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7999
2025-04-17T21:54:01.480Z,1744926841.480 [controlThread ThreadHandler](INFO): Handler Thread ID is 8000
2025-04-17T21:54:01.480Z,1744926841.480 [controlThread](DEBUG): Initializing ControlThread
2025-04-17T21:54:01.481Z,1744926841.481 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-17T21:54:01.483Z,1744926841.483 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-17T21:54:01.483Z,1744926841.483 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-17T21:54:01.484Z,1744926841.484 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-17T21:54:01.485Z,1744926841.485 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-17T21:54:01.485Z,1744926841.485 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-17T21:54:01.486Z,1744926841.486 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-17T21:54:01.486Z,1744926841.486 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-17T21:54:01.487Z,1744926841.487 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-17T21:54:01.488Z,1744926841.488 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-17T21:54:01.488Z,1744926841.488 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-17T21:54:01.495Z,1744926841.495 [SBIT](INFO): Initialize SBIT Component.
2025-04-17T21:54:01.495Z,1744926841.495 [SBIT](IMPORTANT): git: 2024-12-16_A-129-gdfc4b4cb1
2025-04-17T21:54:01.495Z,1744926841.495 [SBIT](INFO): git hash: dfc4b4cb1f964e05e7aa12596fa9f50e33a9d75d
2025-04-17T21:54:01.496Z,1744926841.496 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-17T21:54:01.497Z,1744926841.497 [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-04-17T21:54:01.498Z,1744926841.498 [SBIT](INFO): Beginning SBIT in 66.000000 seconds.
2025-04-17T21:54:01.499Z,1744926841.499 [IBIT](INFO): Initialize IBIT Component.
2025-04-17T21:54:01.500Z,1744926841.500 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-17T21:54:01.501Z,1744926841.501 [logger ThreadHandler](INFO): Handler Thread ID is 8001
2025-04-17T21:54:01.510Z,1744926841.510 [CBIT](DEBUG): Initialized mux pins.
2025-04-17T21:54:01.511Z,1744926841.511 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-17T21:54:01.519Z,1744926841.519 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8002
2025-04-17T21:54:01.531Z,1744926841.531 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8003
2025-04-17T21:54:01.533Z,1744926841.533 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-17T21:54:01.535Z,1744926841.535 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-17T21:54:01.535Z,1744926841.535 [CBIT](DEBUG): Initializing heartbeat.
2025-04-17T21:54:01.543Z,1744926841.543 [Onboard ThreadHandler](INFO): Handler Thread ID is 8004
2025-04-17T21:54:01.561Z,1744926841.561 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8005
2025-04-17T21:54:01.583Z,1744926841.583 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8006
2025-04-17T21:54:01.584Z,1744926841.584 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-17T21:54:01.588Z,1744926841.588 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8008
2025-04-17T21:54:01.591Z,1744926841.591 [WetLabsBB2FL](INFO): Powering up
2025-04-17T21:54:01.592Z,1744926841.592 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8010
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QL.000
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QL.000
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QM.000
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QM.000
2025-04-17T21:54:01.596Z,1744926841.596 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2PM.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2PM.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI74M.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI74M.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QN.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QN.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QO.000
2025-04-17T21:54:01.597Z,1744926841.597 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QO.000
2025-04-17T21:54:01.598Z,1744926841.598 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RO.000
2025-04-17T21:54:01.598Z,1744926841.598 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RO.000
2025-04-17T21:54:01.598Z,1744926841.598 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RN.000
2025-04-17T21:54:01.598Z,1744926841.598 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RN.000
2025-04-17T21:54:01.599Z,1744926841.599 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QP.000
2025-04-17T21:54:01.599Z,1744926841.599 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QP.000
2025-04-17T21:54:01.607Z,1744926841.606 [CBIT](DEBUG): Deactivating GF circuits.
2025-04-17T21:54:01.607Z,1744926841.607 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-17T21:54:01.646Z,1744926841.646 [CBIT](DEBUG): Backplane powered.
2025-04-17T21:54:01.647Z,1744926841.647 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-17T21:54:01.648Z,1744926841.648 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-17T21:54:01.648Z,1744926841.648 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-17T21:54:01.649Z,1744926841.649 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-17T21:54:01.693Z,1744926841.693 [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-04-17T21:54:01.697Z,1744926841.697 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-17T21:54:01.742Z,1744926841.742 [MissionManager](DEBUG): 
#   Copyright (c) 2024 MBARI
#   MBARI Proprietary Information. Confidential. All Rights Reserved
#   Unauthorized copying or distribution of this file via any medium is strictly
#   prohibited.
#
#   WARNING - This file contains information whose export is restricted by the
#   Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
#   amended. Violations of these export laws are subject to severe civil and/or
#   criminal penalties.

mission Startup {
  behavior Guidance:GoToSurface {
    run in progression
  }

  aggregate StartupSatComms {
    run in sequence

    readDatum {
      timeout duration=P1M

      Universal:latitude_fix
    }

    readDatum {
      timeout duration=P1M

      Universal:platform_communications
    }
  }
}


2025-04-17T21:54:01.743Z,1744926841.743 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-17T21:54:01.743Z,1744926841.743 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-17T21:54:01.744Z,1744926841.744 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-17T21:54:01.967Z,1744926841.967 [Radio_Surface](INFO): Powering up
2025-04-17T21:54:02.059Z,1744926842.059 [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-04-17T21:54:02.065Z,1744926842.065 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-17T21:54:02.066Z,1744926842.066 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-17T21:54:02.088Z,1744926842.088 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-17T21:54:02.142Z,1744926842.142 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-17T21:54:02.145Z,1744926842.145 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-17T21:54:02.188Z,1744926842.188 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-17T21:54:02.191Z,1744926842.191 [MissionManager](DEBUG): 
#   Copyright (c) 2024 MBARI
#   MBARI Proprietary Information. Confidential. All Rights Reserved
#   Unauthorized copying or distribution of this file via any medium is strictly
#   prohibited.
#
#   WARNING - This file contains information whose export is restricted by the
#   Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
#   amended. Violations of these export laws are subject to severe civil and/or
#   criminal penalties.

mission Default {
  arguments {
    ElapsedSinceDefaultStarted = 0 minute
  }

  behavior Guidance:Wait {
    """
    Wait a moment to see if the scheduler starts a new mission before
    starting to actually run Default.
    """

    run in sequence

    set duration = 13 second
  }

  behavior Guidance:GoToSurface {
    run in progression
  }

  aggregate CheckIn {
    run in sequence repeat=288

    readDatum id="Read_GPS" {
      timeout duration=P5M

      Universal:time_fix
    }

    readDatum id="Read_Iridium" {
      timeout duration=P4H {
        behavior Guidance:Execute {
          run in sequence

          set command = "Burn on"
        }

        syslog critical "Dropped weight due to communications timeout."
      }

      Universal:platform_communications
    }

    behavior Guidance:Wait {
      run in sequence

      set duration = 5 minute
    }

    assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )

    syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
  }

  syslog important "Restarting logs and Default mission."

  behavior Guidance:Execute {
    run in sequence

    set command = "restart logs"
  }
}


2025-04-17T21:54:02.203Z,1744926842.203 [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,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-17T21:54:02.214Z,1744926842.214 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-17T21:54:02.277Z,1744926842.277 [Power24vConverter](INFO): Powering up.
2025-04-17T21:54:02.278Z,1744926842.278 [Sonardyne_Nano](INFO): Initializing.
2025-04-17T21:54:02.368Z,1744926842.368 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-17T21:54:02.375Z,1744926842.375 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-17T21:54:02.376Z,1744926842.376 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-04-17T21:54:02.383Z,1744926842.383 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-04-17T21:54:02.384Z,1744926842.384 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-17T21:54:02.391Z,1744926842.391 [MassServo](DEBUG): Initializing MassServo.
2025-04-17T21:54:02.392Z,1744926842.392 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-17T21:54:02.399Z,1744926842.399 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-17T21:54:02.400Z,1744926842.400 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-17T21:54:02.407Z,1744926842.407 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-17T21:54:04.203Z,1744926844.203 [WetLabsBB2FL](INFO): Powering down
2025-04-17T21:54:04.233Z,1744926844.233 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-04-17T21:54:05.519Z,1744926845.519 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2025-04-17T21:54:08.243Z,1744926848.243 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-04-17T21:54:29.736Z,1744926869.736 [NAL9602](INFO): Powering up NAL9602
2025-04-17T21:54:40.644Z,1744926880.644 [NAL9602](INFO): NAL9602 initialized
2025-04-17T21:55:08.280Z,1744926908.280 [SBIT](IMPORTANT): Beginning Startup BIT
2025-04-17T21:55:08.284Z,1744926908.284 [CBIT](IMPORTANT): Beginning ground fault scan
2025-04-17T21:55:08.520Z,1744926908.520 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:55:13.388Z,1744926913.388 [CommandExec](IMPORTANT): got command strobe off
2025-04-17T21:55:13.388Z,1744926913.388 [CommandExec](IMPORTANT): Deactivating strobe
2025-04-17T21:55:19.045Z,1744926919.045 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.056070
CHAN A1 (24V): 0.274736
CHAN A2 (12V): 0.076698
CHAN A3 (5V): 0.014840
CHAN B0 (3.3V): 0.007956
CHAN B1 (3.15aV): 0.008067
CHAN B2 (3.15bV): 0.007955
CHAN B3 (GND): -0.003352
OPEN: 0.005127
Full Scale: +/- 1 mA
2025-04-17T21:55:21.036Z,1744926921.036 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:55:33.595Z,1744926933.595 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:55:45.715Z,1744926945.715 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:55:58.272Z,1744926958.272 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:56:02.135Z,1744926962.135 [SBIT](IMPORTANT): SBIT PASSED
2025-04-17T21:56:02.136Z,1744926962.136 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-17T21:56:02.136Z,1744926962.136 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;

2025-04-17T21:56:02.137Z,1744926962.137 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=88 cubic_centimeter;

2025-04-17T21:56:02.137Z,1744926962.137 [SBIT](IMPORTANT): VerticalControl.massDefault=11.670039 millimeter;

2025-04-17T21:56:02.372Z,1744926962.372 [MissionManager](IMPORTANT): Started mission Startup
2025-04-17T21:56:02.372Z,1744926962.372 [Startup] Running Loop=1
2025-04-17T21:56:02.372Z,1744926962.372 [Startup](DEBUG): Aggregate::initialize Startup
2025-04-17T21:56:02.372Z,1744926962.372 [Startup:A.GoToSurface] Running Loop=1
2025-04-17T21:56:02.372Z,1744926962.372 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-17T21:56:02.373Z,1744926962.373 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-17T21:56:02.373Z,1744926962.373 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-17T21:56:02.374Z,1744926962.374 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-17T21:56:02.374Z,1744926962.374 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-17T21:56:02.379Z,1744926962.379 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-17T21:56:02.379Z,1744926962.379 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-17T21:56:02.381Z,1744926962.381 [Startup:StartupSatComms] Running Loop=1
2025-04-17T21:56:02.381Z,1744926962.381 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-04-17T21:56:02.381Z,1744926962.381 [Startup:StartupSatComms:A] Running Loop=1
2025-04-17T21:56:02.755Z,1744926962.755 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-04-17T21:56:10.392Z,1744926970.392 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:56:22.512Z,1744926982.512 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:56:29.329Z,1744926989.329 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005055
2025-04-17T21:57:01.763Z,1744927021.763 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-17T21:57:01.763Z,1744927021.763 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-17T21:57:01.778Z,1744927021.778 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-17T21:57:02.273Z,1744927022.273 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-17T21:57:02.273Z,1744927022.273 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-17T21:57:02.561Z,1744927022.561 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-17T21:56:02.4Z
2025-04-17T21:57:02.561Z,1744927022.561 [Startup:StartupSatComms:A] Stopped
2025-04-17T21:57:02.561Z,1744927022.561 [Startup:StartupSatComms:B] Running Loop=1
2025-04-17T21:57:02.977Z,1744927022.977 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-17T21:57:04.990Z,1744927024.990 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250417T212625/Courier0013.lzma
2025-04-17T21:57:05.985Z,1744927025.985 [DataOverHttps](INFO): Moved sent file to Logs/20250417T212625/Courier0013.lzma.bak
2025-04-17T21:57:05.985Z,1744927025.985 [DataOverHttps](INFO): SBD MOMSN=24683211
2025-04-17T21:57:21.838Z,1744927041.838 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250417T215350/Courier0000.lzma
2025-04-17T21:57:22.840Z,1744927042.840 [DataOverHttps](INFO): Moved sent file to Logs/20250417T215350/Courier0000.lzma.bak
2025-04-17T21:57:22.840Z,1744927042.840 [DataOverHttps](INFO): SBD MOMSN=24683213
2025-04-17T21:57:38.490Z,1744927058.490 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20250417T212625/Express0014.lzma
2025-04-17T21:57:39.494Z,1744927059.494 [DataOverHttps](INFO): Moved sent file to Logs/20250417T212625/Express0014.lzma.bak
2025-04-17T21:57:39.494Z,1744927059.494 [DataOverHttps](INFO): SBD MOMSN=24683216
2025-04-17T21:57:54.932Z,1744927074.932 [DataOverHttps](INFO): Sending 834 bytes from file Logs/20250417T215350/Express0001.lzma
2025-04-17T21:57:55.932Z,1744927075.932 [DataOverHttps](INFO): Moved sent file to Logs/20250417T215350/Express0001.lzma.bak
2025-04-17T21:57:55.932Z,1744927075.932 [DataOverHttps](INFO): SBD MOMSN=24683221
2025-04-17T21:57:57.209Z,1744927077.209 [Startup:StartupSatComms:B] Stopped
2025-04-17T21:57:57.209Z,1744927077.209 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-04-17T21:57:57.209Z,1744927077.209 [Startup:StartupSatComms] Stopped
2025-04-17T21:57:57.209Z,1744927077.209 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-04-17T21:57:57.210Z,1744927077.210 [Startup](INFO): Completed Startup
2025-04-17T21:57:57.210Z,1744927077.210 [MissionManager](INFO): Startup is completed.
2025-04-17T21:57:57.210Z,1744927077.210 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-17T21:57:57.210Z,1744927077.210 [Startup] Stopped
2025-04-17T21:57:57.211Z,1744927077.211 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-04-17T21:57:57.211Z,1744927077.211 [Startup:A.GoToSurface] Stopped
2025-04-17T21:57:57.211Z,1744927077.211 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-17T21:57:57.616Z,1744927077.616 [MissionManager](IMPORTANT): Started mission Default
2025-04-17T21:57:57.617Z,1744927077.617 [Default] Running Loop=1
2025-04-17T21:57:57.617Z,1744927077.617 [Default](DEBUG): Aggregate::initialize Default
2025-04-17T21:57:57.617Z,1744927077.617 [Default:B.GoToSurface] Running Loop=1
2025-04-17T21:57:57.617Z,1744927077.617 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-17T21:57:57.617Z,1744927077.617 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-17T21:57:57.617Z,1744927077.617 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-17T21:57:57.618Z,1744927077.618 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-17T21:57:57.618Z,1744927077.618 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-17T21:57:57.619Z,1744927077.619 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-17T21:57:57.619Z,1744927077.619 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-17T21:57:57.619Z,1744927077.619 [Default:A.Wait] Running Loop=1
2025-04-17T21:57:57.619Z,1744927077.619 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-17T21:58:10.925Z,1744927090.925 [Default:A.Wait](INFO): Done Waiting.
2025-04-17T21:58:10.925Z,1744927090.925 [Default:A.Wait] Stopped
2025-04-17T21:58:10.926Z,1744927090.926 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-17T21:58:11.328Z,1744927091.328 [Default:CheckIn] Running Loop=1
2025-04-17T21:58:11.329Z,1744927091.329 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-17T21:58:11.329Z,1744927091.329 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-17T21:58:11.734Z,1744927091.734 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-17T21:58:57.368Z,1744927137.368 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:01.828Z,1744927141.828 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:04.236Z,1744927144.236 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:14.740Z,1744927154.740 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:20.396Z,1744927160.396 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:27.671Z,1744927167.671 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:36.152Z,1744927176.152 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:40.596Z,1744927180.596 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:44.237Z,1744927184.237 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-17T21:59:51.103Z,1744927191.103 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T21:59:53.524Z,1744927193.524 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:02.833Z,1744927202.833 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-04-17T22:00:02.833Z,1744927202.833 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-17T22:00:02.844Z,1744927202.844 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-17T22:00:03.256Z,1744927203.256 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-17T22:00:03.257Z,1744927203.257 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-04-17T22:00:06.047Z,1744927206.047 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:06.463Z,1744927206.463 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:18.976Z,1744927218.976 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:21.401Z,1744927221.401 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:31.501Z,1744927231.501 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:36.752Z,1744927236.752 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:44.428Z,1744927244.428 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:52.104Z,1744927252.104 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T22:00:57.760Z,1744927257.760 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:01:08.277Z,1744927268.277 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-17T22:01:10.292Z,1744927270.292 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-17T22:01:23.469Z,1744927283.469 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5.
2025-04-17T22:01:23.508Z,1744927283.508 [BPC1](INFO): Received data from all battery sticks.
2025-04-17T22:01:36.557Z,1744927296.557 [CommandExec](IMPORTANT): got command get 
2025-04-17T22:01:36.557Z,1744927296.557 [CommandExec](FAULT): Incomplete syntax. Try: help get
2025-04-17T22:01:50.679Z,1744927310.679 [CommandExec](IMPORTANT): got command get BackseatComponent.needs24v
2025-04-17T22:01:50.679Z,1744927310.679 [CommandExec](IMPORTANT): BackseatComponent.needs24v 1 bool
2025-04-17T22:02:01.613Z,1744927321.613 [CommandExec](IMPORTANT): got command get BackseatComponent.loadControl
2025-04-17T22:02:01.613Z,1744927321.613 [CommandExec](IMPORTANT): BackseatComponent.loadControl /dev/loadC3
2025-04-17T22:03:03.880Z,1744927383.880 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-04-17T22:03:03.880Z,1744927383.880 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-17T22:03:03.891Z,1744927383.891 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-17T22:03:04.289Z,1744927384.289 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-17T22:03:04.289Z,1744927384.289 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-04-17T22:03:11.566Z,1744927391.566 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-17T21:58:11.3Z
2025-04-17T22:03:11.566Z,1744927391.566 [Default:CheckIn:Read_GPS] Stopped
2025-04-17T22:03:11.566Z,1744927391.566 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-17T22:03:11.945Z,1744927391.945 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-17T22:03:19.595Z,1744927399.595 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250417T215350/Courier0004.lzma
2025-04-17T22:03:20.595Z,1744927400.595 [DataOverHttps](INFO): Moved sent file to Logs/20250417T215350/Courier0004.lzma.bak
2025-04-17T22:03:20.595Z,1744927400.595 [DataOverHttps](INFO): SBD MOMSN=24683252
2025-04-17T22:03:36.663Z,1744927416.663 [DataOverHttps](INFO): Sending 320 bytes from file Logs/20250417T215350/Express0005.lzma
2025-04-17T22:03:37.664Z,1744927417.664 [DataOverHttps](INFO): Moved sent file to Logs/20250417T215350/Express0005.lzma.bak
2025-04-17T22:03:37.664Z,1744927417.664 [DataOverHttps](INFO): SBD MOMSN=24683254
2025-04-17T22:03:39.036Z,1744927419.036 [Default:CheckIn:Read_Iridium] Stopped
2025-04-17T22:03:39.037Z,1744927419.037 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-17T22:03:39.037Z,1744927419.037 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-17T22:04:03.249Z,1744927443.249 [Power24vConverter](INFO): Powering down.
2025-04-17T22:04:41.624Z,1744927481.624 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-17T22:04:41.624Z,1744927481.624 [NAL9602] Data Fault, FailCount= 1
2025-04-17T22:04:41.625Z,1744927481.625 [NAL9602](ERROR): Data Fault
2025-04-17T22:04:41.666Z,1744927481.666 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-17T22:04:42.028Z,1744927482.028 [NAL9602](INFO): Powering down
2025-04-17T22:04:42.869Z,1744927482.869 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-17T22:04:42.869Z,1744927482.869 [NAL9602] No Fault, FailCount= 1
2025-04-17T22:05:12.332Z,1744927512.332 [NAL9602](INFO): Powering up NAL9602
2025-04-17T22:05:22.735Z,1744927522.735 [CommandExec](IMPORTANT): got command get BackseatComponent.missionCritical
2025-04-17T22:05:22.736Z,1744927522.736 [CommandExec](IMPORTANT): BackseatComponent.missionCritical 0 bool
2025-04-17T22:05:23.257Z,1744927523.257 [NAL9602](INFO): NAL9602 initialized
2025-04-17T22:05:31.192Z,1744927531.192 [CommandExec](IMPORTANT): got command configSet BackseatComponent.missionCritical 1 bool persist
2025-04-17T22:05:31.192Z,1744927531.192 [CommandExec](IMPORTANT): configSet BackseatComponent.missionCritical requires a restart to take effect.
2025-04-17T22:06:04.892Z,1744927564.892 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-04-17T22:06:04.892Z,1744927564.892 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-17T22:06:04.911Z,1744927564.911 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-17T22:06:05.351Z,1744927565.351 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-17T22:06:05.352Z,1744927565.352 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-04-17T22:06:08.409Z,1744927568.409 [CommandExec](IMPORTANT): got command restart system
2025-04-17T22:06:10.474Z,1744927570.474 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2025-04-17T22:06:10.475Z,1744927570.475 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:10.475Z,1744927570.475 [CommandExec](INFO): Uninitializing the command executive.
2025-04-17T22:06:10.475Z,1744927570.475 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-17T22:06:10.476Z,1744927570.476 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:10.658Z,1744927570.658 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-04-17T22:06:10.659Z,1744927570.659 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-17T22:06:10.659Z,1744927570.659 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:10.659Z,1744927570.659 [NavChartDb](INFO): Join timeout helper Thread ID is 8101
2025-04-17T22:06:10.731Z,1744927570.731 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:10.731Z,1744927570.731 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:10.738Z,1744927570.738 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-04-17T22:06:10.739Z,1744927570.739 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:10.739Z,1744927570.739 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8102
2025-04-17T22:06:10.799Z,1744927570.799 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:10.799Z,1744927570.799 [WetLabsBB2FL](INFO): Powering down
2025-04-17T22:06:10.800Z,1744927570.800 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:10.819Z,1744927570.819 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-17T22:06:10.819Z,1744927570.819 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:10.819Z,1744927570.819 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8103
2025-04-17T22:06:11.655Z,1744927571.655 [CTD_Seabird](INFO): Powering down
2025-04-17T22:06:11.666Z,1744927571.666 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:11.667Z,1744927571.667 [CTD_Seabird](INFO): Powering down
2025-04-17T22:06:11.678Z,1744927571.678 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:11.691Z,1744927571.691 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-17T22:06:11.691Z,1744927571.691 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:11.691Z,1744927571.691 [Radio_Surface](INFO): Join timeout helper Thread ID is 8104
2025-04-17T22:06:11.847Z,1744927571.847 [Radio_Surface](INFO): Powering down
2025-04-17T22:06:11.848Z,1744927571.848 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:11.848Z,1744927571.848 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:11.859Z,1744927571.859 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-17T22:06:11.859Z,1744927571.859 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:11.859Z,1744927571.859 [Onboard](INFO): Join timeout helper Thread ID is 8105
2025-04-17T22:06:12.187Z,1744927572.187 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:12.187Z,1744927572.187 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.203Z,1744927572.203 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-17T22:06:12.204Z,1744927572.204 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.204Z,1744927572.204 [DataOverHttps](INFO): Join timeout helper Thread ID is 8106
2025-04-17T22:06:12.283Z,1744927572.283 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:12.283Z,1744927572.283 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.299Z,1744927572.299 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-17T22:06:12.299Z,1744927572.299 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.300Z,1744927572.300 [BackseatComponent](INFO): Join timeout helper Thread ID is 8107
2025-04-17T22:06:12.443Z,1744927572.443 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:12.443Z,1744927572.443 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.447Z,1744927572.447 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-17T22:06:12.447Z,1744927572.447 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.448Z,1744927572.448 [logger](INFO): Join timeout helper Thread ID is 8108
2025-04-17T22:06:12.459Z,1744927572.459 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:12.459Z,1744927572.459 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.467Z,1744927572.467 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-17T22:06:12.467Z,1744927572.467 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.468Z,1744927572.468 [CommandLine](INFO): Join timeout helper Thread ID is 8109
2025-04-17T22:06:12.563Z,1744927572.563 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:12.563Z,1744927572.563 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.567Z,1744927572.567 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-17T22:06:12.567Z,1744927572.567 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.568Z,1744927572.568 [CommandExec](INFO): Join timeout helper Thread ID is 8110
2025-04-17T22:06:12.569Z,1744927572.569 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-17T22:06:12.569Z,1744927572.569 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:12.569Z,1744927572.569 [controlThread](INFO): Join timeout helper Thread ID is 8111
2025-04-17T22:06:12.935Z,1744927572.935 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-17T22:06:12.935Z,1744927572.935 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-17T22:06:12.935Z,1744927572.935 [AHRS_M2](INFO): Powering down
2025-04-17T22:06:13.008Z,1744927573.008 [NAL9602](INFO): Powering down
2025-04-17T22:06:13.009Z,1744927573.009 [Sonardyne_Nano](INFO): Powering down
2025-04-17T22:06:13.123Z,1744927573.123 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-17T22:06:13.124Z,1744927573.124 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-17T22:06:13.125Z,1744927573.125 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-17T22:06:13.125Z,1744927573.125 [MissionManager](INFO): Uninitializing Mission Default
2025-04-17T22:06:13.125Z,1744927573.125 [Default] Stopped
2025-04-17T22:06:13.125Z,1744927573.125 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-17T22:06:13.125Z,1744927573.125 [Default:B.GoToSurface] Stopped
2025-04-17T22:06:13.125Z,1744927573.125 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-17T22:06:13.126Z,1744927573.126 [Default:CheckIn] Stopped
2025-04-17T22:06:13.126Z,1744927573.126 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-17T22:06:13.126Z,1744927573.126 [Default:CheckIn:C.Wait] Stopped
2025-04-17T22:06:13.126Z,1744927573.126 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-17T22:06:13.129Z,1744927573.129 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-17T22:06:13.129Z,1744927573.129 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-17T22:06:13.129Z,1744927573.129 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-17T22:06:13.130Z,1744927573.130 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-17T22:06:13.130Z,1744927573.130 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-17T22:06:13.130Z,1744927573.130 [BuoyancyServo](INFO): Powering down
2025-04-17T22:06:13.143Z,1744927573.143 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-04-17T22:06:13.143Z,1744927573.143 [ElevatorServo](INFO): Powering down
2025-04-17T22:06:13.144Z,1744927573.144 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-17T22:06:13.144Z,1744927573.144 [MassServo](INFO): Powering down
2025-04-17T22:06:13.145Z,1744927573.145 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-17T22:06:13.145Z,1744927573.145 [RudderServo](INFO): Powering down
2025-04-17T22:06:13.146Z,1744927573.146 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-17T22:06:13.146Z,1744927573.146 [ThrusterHE](INFO): Powering down
2025-04-17T22:06:13.147Z,1744927573.147 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-17T22:06:13.147Z,1744927573.147 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-17T22:06:13.147Z,1744927573.147 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-17T22:06:13.147Z,1744927573.147 [CBIT](DEBUG): Powering off loads.
2025-04-17T22:06:13.158Z,1744927573.158 [CBIT](DEBUG): Disabling WDT.
2025-04-17T22:06:13.170Z,1744927573.170 [CBIT](DEBUG): Opening all GF detection circuits.
2025-04-17T22:06:13.172Z,1744927573.172 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.247Z,1744927573.247 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.250Z,1744927573.250 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.256Z,1744927573.256 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.304Z,1744927573.304 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.371Z,1744927573.371 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.376Z,1744927573.376 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.417Z,1744927573.417 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-17T22:06:13.467Z,1744927573.467 [logger ThreadHandler](INFO): Thread cancelled.