2025-04-18T19:15:09.165Z,1745003709.165 [Supervisor](DEBUG): Initializing supervisor.
2025-04-18T19:15:09.170Z,1745003709.170 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-04-18T19:15:09.170Z,1745003709.170 [SyncHandler](INFO): Protected caller Thread ID is 2637
2025-04-18T19:15:09.171Z,1745003709.171 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-04-18T19:15:09.172Z,1745003709.172 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-04-18T19:15:09.172Z,1745003709.172 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2638
2025-04-18T19:15:09.176Z,1745003709.176 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-04-18T19:15:09.200Z,1745003709.200 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-04-18T19:15:09.201Z,1745003709.201 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-04-18T19:15:09.201Z,1745003709.201 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2639
2025-04-18T19:15:09.208Z,1745003709.208 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-04-18T19:15:09.209Z,1745003709.209 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-04-18T19:15:09.209Z,1745003709.209 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2640
2025-04-18T19:15:09.211Z,1745003709.211 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-04-18T19:15:09.212Z,1745003709.212 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-04-18T19:15:09.213Z,1745003709.213 [logger ThreadHandler](INFO): Protected caller Thread ID is 2641
2025-04-18T19:15:09.217Z,1745003709.217 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-04-18T19:15:09.217Z,1745003709.217 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-04-18T19:15:09.219Z,1745003709.219 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-04-18T19:15:09.723Z,1745003709.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-04-18T19:15:09.724Z,1745003709.724 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-04-18T19:15:09.955Z,1745003709.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-04-18T19:15:09.956Z,1745003709.956 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-04-18T19:15:10.052Z,1745003710.052 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-04-18T19:15:10.309Z,1745003710.309 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-04-18T19:15:10.310Z,1745003710.310 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-04-18T19:15:10.402Z,1745003710.402 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-04-18T19:15:10.514Z,1745003710.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-04-18T19:15:10.515Z,1745003710.515 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-04-18T19:15:10.895Z,1745003710.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-04-18T19:15:10.895Z,1745003710.895 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-04-18T19:15:11.044Z,1745003711.044 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-04-18T19:15:11.045Z,1745003711.045 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-04-18T19:15:11.617Z,1745003711.617 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-04-18T19:15:11.617Z,1745003711.617 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-04-18T19:15:11.821Z,1745003711.821 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-04-18T19:15:11.822Z,1745003711.822 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-04-18T19:15:12.266Z,1745003712.266 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-04-18T19:15:12.266Z,1745003712.266 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-04-18T19:15:12.575Z,1745003712.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-04-18T19:15:12.575Z,1745003712.575 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-04-18T19:15:12.700Z,1745003712.700 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-04-18T19:15:12.701Z,1745003712.701 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-04-18T19:15:13.614Z,1745003713.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-04-18T19:15:13.614Z,1745003713.614 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-04-18T19:15:13.991Z,1745003713.991 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-04-18T19:15:13.992Z,1745003713.992 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-04-18T19:15:14.532Z,1745003714.532 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-04-18T19:15:14.534Z,1745003714.534 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2025-04-18T19:15:14.535Z,1745003714.535 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2025-04-18T19:15:14.788Z,1745003714.788 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2025-04-18T19:15:15.031Z,1745003715.031 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2025-04-18T19:15:15.189Z,1745003715.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2025-04-18T19:15:15.290Z,1745003715.290 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2025-04-18T19:15:15.574Z,1745003715.574 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-04-18T19:15:15.575Z,1745003715.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2025-04-18T19:15:15.697Z,1745003715.697 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2025-04-18T19:15:15.822Z,1745003715.822 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2025-04-18T19:15:15.938Z,1745003715.938 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2025-04-18T19:15:16.109Z,1745003716.109 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2025-04-18T19:15:16.224Z,1745003716.224 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2025-04-18T19:15:16.327Z,1745003716.327 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2025-04-18T19:15:16.327Z,1745003716.327 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-04-18T19:15:16.334Z,1745003716.334 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-04-18T19:15:16.345Z,1745003716.345 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-04-18T19:15:16.346Z,1745003716.346 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-04-18T19:15:16.479Z,1745003716.479 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-04-18T19:15:16.480Z,1745003716.480 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-04-18T19:15:16.533Z,1745003716.533 [VerticalControl](DEBUG): Construct VerticalControl.
2025-04-18T19:15:16.595Z,1745003716.595 [VerticalControl] Loaded
2025-04-18T19:15:16.595Z,1745003716.595 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-04-18T19:15:16.598Z,1745003716.598 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-04-18T19:15:16.646Z,1745003716.646 [HorizontalControl] Loaded
2025-04-18T19:15:16.646Z,1745003716.646 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-04-18T19:15:16.649Z,1745003716.649 [SpeedControl](DEBUG): Construct SpeedControl.
2025-04-18T19:15:16.652Z,1745003716.652 [SpeedControl] Loaded
2025-04-18T19:15:16.652Z,1745003716.652 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-04-18T19:15:16.655Z,1745003716.655 [LoopControl](DEBUG): Construct LoopControl.
2025-04-18T19:15:16.655Z,1745003716.655 [LoopControl] Loaded
2025-04-18T19:15:16.656Z,1745003716.656 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-04-18T19:15:16.656Z,1745003716.656 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-04-18T19:15:16.656Z,1745003716.656 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-04-18T19:15:16.814Z,1745003716.814 [BuoyancyServo] Loaded
2025-04-18T19:15:16.815Z,1745003716.815 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-04-18T19:15:16.836Z,1745003716.836 [MassServo] Loaded
2025-04-18T19:15:16.836Z,1745003716.836 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-04-18T19:15:16.858Z,1745003716.858 [RudderServo] Loaded
2025-04-18T19:15:16.858Z,1745003716.858 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-04-18T19:15:16.875Z,1745003716.875 [ThrusterHE] Loaded
2025-04-18T19:15:16.875Z,1745003716.875 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-04-18T19:15:16.876Z,1745003716.876 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-04-18T19:15:16.876Z,1745003716.876 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-04-18T19:15:16.927Z,1745003716.927 [DepthRateCalculator] Loaded
2025-04-18T19:15:16.927Z,1745003716.927 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-04-18T19:15:16.932Z,1745003716.932 [PitchRateCalculator] Loaded
2025-04-18T19:15:16.932Z,1745003716.932 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-04-18T19:15:16.942Z,1745003716.942 [SpeedCalculator] Loaded
2025-04-18T19:15:16.942Z,1745003716.942 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-04-18T19:15:16.947Z,1745003716.947 [YawRateCalculator] Loaded
2025-04-18T19:15:16.947Z,1745003716.947 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-04-18T19:15:16.966Z,1745003716.966 [ElevatorOffsetCalculator] Loaded
2025-04-18T19:15:16.966Z,1745003716.966 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-04-18T19:15:16.966Z,1745003716.966 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-04-18T19:15:16.967Z,1745003716.967 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-04-18T19:15:17.081Z,1745003717.081 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-04-18T19:15:17.081Z,1745003717.081 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-04-18T19:15:17.095Z,1745003717.095 [NavChart] Loaded
2025-04-18T19:15:17.095Z,1745003717.095 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-04-18T19:15:17.101Z,1745003717.101 [UniversalFixResidualReporter] Loaded
2025-04-18T19:15:17.101Z,1745003717.101 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-04-18T19:15:17.102Z,1745003717.102 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-04-18T19:15:17.102Z,1745003717.102 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-04-18T19:15:17.581Z,1745003717.581 [AHRS_M2] Loaded
2025-04-18T19:15:17.582Z,1745003717.582 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-04-18T19:15:17.621Z,1745003717.621 [BackseatComponent] Loaded
2025-04-18T19:15:17.622Z,1745003717.622 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-04-18T19:15:17.623Z,1745003717.623 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409294E0
2025-04-18T19:15:17.623Z,1745003717.623 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2723
2025-04-18T19:15:17.626Z,1745003717.626 [LcmUniversalReporter] Loaded
2025-04-18T19:15:17.626Z,1745003717.626 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-04-18T19:15:17.633Z,1745003717.633 [BioacousticsDataBridge] Loaded
2025-04-18T19:15:17.633Z,1745003717.633 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2025-04-18T19:15:18.462Z,1745003718.462 [BPC1] Loaded
2025-04-18T19:15:18.462Z,1745003718.462 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-04-18T19:15:18.535Z,1745003718.535 [DataOverHttps] Loaded
2025-04-18T19:15:18.536Z,1745003718.536 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-04-18T19:15:18.537Z,1745003718.537 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409594E0
2025-04-18T19:15:18.537Z,1745003718.537 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2724
2025-04-18T19:15:18.560Z,1745003718.560 [Depth_Keller] Loaded
2025-04-18T19:15:18.561Z,1745003718.561 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-04-18T19:15:18.566Z,1745003718.566 [DropWeight] Loaded
2025-04-18T19:15:18.566Z,1745003718.566 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-04-18T19:15:18.631Z,1745003718.631 [NAL9602] Loaded
2025-04-18T19:15:18.632Z,1745003718.632 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-04-18T19:15:18.663Z,1745003718.663 [Onboard] Loaded
2025-04-18T19:15:18.663Z,1745003718.663 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-04-18T19:15:18.664Z,1745003718.664 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409894E0
2025-04-18T19:15:18.664Z,1745003718.664 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2725
2025-04-18T19:15:18.679Z,1745003718.679 [Power24vConverter] Loaded
2025-04-18T19:15:18.679Z,1745003718.679 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-04-18T19:15:18.695Z,1745003718.695 [Radio_Surface] Loaded
2025-04-18T19:15:18.695Z,1745003718.695 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-04-18T19:15:18.696Z,1745003718.696 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409B94E0
2025-04-18T19:15:18.697Z,1745003718.697 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2726
2025-04-18T19:15:18.713Z,1745003718.713 [Sonardyne_Nano] Loaded
2025-04-18T19:15:18.713Z,1745003718.713 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-04-18T19:15:18.714Z,1745003718.714 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-04-18T19:15:18.714Z,1745003718.714 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-04-18T19:15:18.772Z,1745003718.772 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-04-18T19:15:18.773Z,1745003718.773 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-04-18T19:15:18.951Z,1745003718.951 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-04-18T19:15:18.951Z,1745003718.951 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-04-18T19:15:18.980Z,1745003718.980 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-04-18T19:15:18.981Z,1745003718.981 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-04-18T19:15:19.308Z,1745003719.308 [CTD_Seabird] Loaded
2025-04-18T19:15:19.309Z,1745003719.309 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-04-18T19:15:19.310Z,1745003719.310 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AFE4E0
2025-04-18T19:15:19.310Z,1745003719.310 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2727
2025-04-18T19:15:19.373Z,1745003719.373 [PAR_Licor] Loaded
2025-04-18T19:15:19.373Z,1745003719.373 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-04-18T19:15:19.645Z,1745003719.645 [WetLabsBB2FL] Loaded
2025-04-18T19:15:19.645Z,1745003719.645 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-04-18T19:15:19.646Z,1745003719.646 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B2E4E0
2025-04-18T19:15:19.646Z,1745003719.646 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2728
2025-04-18T19:15:19.647Z,1745003719.647 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-04-18T19:15:19.648Z,1745003719.648 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-04-18T19:15:20.396Z,1745003720.396 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-04-18T19:15:20.397Z,1745003720.397 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-04-18T19:15:20.561Z,1745003720.561 [SBIT](DEBUG): Construct Startup Built In Test.
2025-04-18T19:15:20.570Z,1745003720.570 [SBIT] Loaded
2025-04-18T19:15:20.570Z,1745003720.570 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-04-18T19:15:20.573Z,1745003720.573 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-04-18T19:15:20.586Z,1745003720.586 [IBIT] Loaded
2025-04-18T19:15:20.586Z,1745003720.586 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-04-18T19:15:20.592Z,1745003720.592 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-04-18T19:15:20.674Z,1745003720.674 [CBIT] Loaded
2025-04-18T19:15:20.675Z,1745003720.675 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-04-18T19:15:20.707Z,1745003720.707 [GFScanner] Loaded
2025-04-18T19:15:20.707Z,1745003720.707 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-04-18T19:15:20.708Z,1745003720.708 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-04-18T19:15:20.714Z,1745003720.714 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-04-18T19:15:20.717Z,1745003720.717 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-04-18T19:15:20.729Z,1745003720.729 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-04-18T19:15:20.730Z,1745003720.730 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0
2025-04-18T19:15:20.730Z,1745003720.730 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2729
2025-04-18T19:15:20.735Z,1745003720.735 [Supervisor](INFO): Main Thread ID is 2435
2025-04-18T19:15:20.735Z,1745003720.735 [Supervisor](DEBUG): Running supervisor.
2025-04-18T19:15:20.735Z,1745003720.735 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2730
2025-04-18T19:15:20.736Z,1745003720.736 [CommandExec](INFO): Initializing the command executive.
2025-04-18T19:15:20.738Z,1745003720.738 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2731
2025-04-18T19:15:20.741Z,1745003720.741 [controlThread ThreadHandler](INFO): Handler Thread ID is 2732
2025-04-18T19:15:20.741Z,1745003720.741 [controlThread](DEBUG): Initializing ControlThread
2025-04-18T19:15:20.742Z,1745003720.742 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-04-18T19:15:20.744Z,1745003720.744 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-04-18T19:15:20.744Z,1745003720.744 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-04-18T19:15:20.745Z,1745003720.745 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-04-18T19:15:20.746Z,1745003720.746 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-04-18T19:15:20.746Z,1745003720.746 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-04-18T19:15:20.747Z,1745003720.747 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-04-18T19:15:20.747Z,1745003720.747 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-04-18T19:15:20.747Z,1745003720.747 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-04-18T19:15:20.748Z,1745003720.748 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-04-18T19:15:20.749Z,1745003720.749 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-04-18T19:15:20.755Z,1745003720.755 [SBIT](INFO): Initialize SBIT Component.
2025-04-18T19:15:20.755Z,1745003720.755 [SBIT](IMPORTANT): git: 2025-04-15
2025-04-18T19:15:20.756Z,1745003720.756 [SBIT](INFO): git hash: e5e9d680ffe788b716b2397065cfa67465e27e09
2025-04-18T19:15:20.756Z,1745003720.756 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-04-18T19:15:20.757Z,1745003720.757 [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-18T19:15:20.758Z,1745003720.758 [SBIT](INFO): Beginning SBIT in 122.000000 seconds.
2025-04-18T19:15:20.759Z,1745003720.759 [IBIT](INFO): Initialize IBIT Component.
2025-04-18T19:15:20.760Z,1745003720.760 [CBIT](DEBUG): Initialize CBIT Component.
2025-04-18T19:15:20.761Z,1745003720.761 [logger ThreadHandler](INFO): Handler Thread ID is 2733
2025-04-18T19:15:20.771Z,1745003720.771 [CBIT](DEBUG): Initialized mux pins.
2025-04-18T19:15:20.771Z,1745003720.771 [CBIT](DEBUG): Initializing the watchdog timer.
2025-04-18T19:15:20.779Z,1745003720.779 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2734
2025-04-18T19:15:20.791Z,1745003720.791 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2735
2025-04-18T19:15:20.793Z,1745003720.793 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-04-18T19:15:20.795Z,1745003720.795 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-04-18T19:15:20.795Z,1745003720.795 [CBIT](DEBUG): Initializing heartbeat.
2025-04-18T19:15:20.803Z,1745003720.803 [Onboard ThreadHandler](INFO): Handler Thread ID is 2736
2025-04-18T19:15:20.820Z,1745003720.820 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2737
2025-04-18T19:15:20.851Z,1745003720.851 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2738
2025-04-18T19:15:20.852Z,1745003720.852 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-04-18T19:15:20.859Z,1745003720.859 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2740
2025-04-18T19:15:20.863Z,1745003720.863 [WetLabsBB2FL](INFO): Powering up
2025-04-18T19:15:20.864Z,1745003720.864 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2742
2025-04-18T19:15:20.867Z,1745003720.867 [CBIT](DEBUG): Deactivating emergency mode.
2025-04-18T19:15:20.868Z,1745003720.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000
2025-04-18T19:15:20.869Z,1745003720.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000
2025-04-18T19:15:20.869Z,1745003720.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QL.000
2025-04-18T19:15:20.869Z,1745003720.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QL.000
2025-04-18T19:15:20.869Z,1745003720.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QM.000
2025-04-18T19:15:20.869Z,1745003720.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QM.000
2025-04-18T19:15:20.869Z,1745003720.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2PM.000
2025-04-18T19:15:20.870Z,1745003720.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2PM.000
2025-04-18T19:15:20.870Z,1745003720.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI74M.000
2025-04-18T19:15:20.870Z,1745003720.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI74M.000
2025-04-18T19:15:20.870Z,1745003720.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QN.000
2025-04-18T19:15:20.870Z,1745003720.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QN.000
2025-04-18T19:15:20.870Z,1745003720.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QO.000
2025-04-18T19:15:20.871Z,1745003720.871 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QO.000
2025-04-18T19:15:20.871Z,1745003720.871 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RO.000
2025-04-18T19:15:20.871Z,1745003720.871 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RO.000
2025-04-18T19:15:20.871Z,1745003720.871 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RN.000
2025-04-18T19:15:20.871Z,1745003720.871 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RN.000
2025-04-18T19:15:20.871Z,1745003720.871 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QP.000
2025-04-18T19:15:20.872Z,1745003720.872 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QP.000
2025-04-18T19:15:20.907Z,1745003720.907 [CBIT](DEBUG): Backplane powered.
2025-04-18T19:15:20.907Z,1745003720.907 [GFScanner](DEBUG): Initializing GFScanner
2025-04-18T19:15:20.907Z,1745003720.907 [GFScanner](DEBUG): Deactivating GF circuits.
2025-04-18T19:15:20.912Z,1745003720.912 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-04-18T19:15:20.912Z,1745003720.912 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-04-18T19:15:20.913Z,1745003720.913 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-04-18T19:15:20.914Z,1745003720.914 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-04-18T19:15:20.971Z,1745003720.971 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-04-18T19:15:20.991Z,1745003720.991 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-18T19:15:21.035Z,1745003721.035 [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-18T19:15:21.036Z,1745003721.036 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-04-18T19:15:21.036Z,1745003721.036 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-04-18T19:15:21.037Z,1745003721.037 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-04-18T19:15:21.227Z,1745003721.227 [Radio_Surface](INFO): Powering up
2025-04-18T19:15:21.367Z,1745003721.367 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2025-04-18T19:15:21.393Z,1745003721.393 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-04-18T19:15:21.395Z,1745003721.395 [Default:A.Wait](DEBUG): Construct Wait.
2025-04-18T19:15:21.397Z,1745003721.397 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-18T19:15:21.455Z,1745003721.455 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-04-18T19:15:21.466Z,1745003721.466 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-04-18T19:15:21.488Z,1745003721.488 [Default:E.Execute](DEBUG): Construct Execute.
2025-04-18T19:15:21.491Z,1745003721.491 [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-18T19:15:21.495Z,1745003721.495 [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,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-18T19:15:21.523Z,1745003721.523 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-18T19:15:21.587Z,1745003721.587 [Depth_Keller](INFO): Initializing.
2025-04-18T19:15:21.588Z,1745003721.588 [Power24vConverter](INFO): Powering up.
2025-04-18T19:15:21.589Z,1745003721.589 [Sonardyne_Nano](INFO): Initializing.
2025-04-18T19:15:21.635Z,1745003721.635 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-04-18T19:15:21.665Z,1745003721.665 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-04-18T19:15:21.671Z,1745003721.671 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-04-18T19:15:21.673Z,1745003721.673 [MassServo](DEBUG): Initializing EZServoServo.
2025-04-18T19:15:21.679Z,1745003721.679 [MassServo](DEBUG): Initializing MassServo.
2025-04-18T19:15:21.680Z,1745003721.680 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-18T19:15:21.687Z,1745003721.687 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-18T19:15:21.688Z,1745003721.688 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-04-18T19:15:21.695Z,1745003721.695 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-04-18T19:15:21.949Z,1745003721.949 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-04-18T19:15:21.949Z,1745003721.949 [DropWeight] Hardware Fault, FailCount= 1
2025-04-18T19:15:21.949Z,1745003721.949 [DropWeight](ERROR): Hardware Fault
2025-04-18T19:15:21.981Z,1745003721.981 [CommandExec](FAULT): Scheduling is paused
2025-04-18T19:15:21.981Z,1745003721.981 [CBIT](INFO): Critical error at 20250418T191521
2025-04-18T19:15:21.982Z,1745003721.982 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-04-18T19:15:21.992Z,1745003721.992 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-04-18T19:15:21.993Z,1745003721.993 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-04-18T19:15:22.332Z,1745003722.332 [CBIT](INFO): Critical error at 20250418T191521
2025-04-18T19:15:23.475Z,1745003723.475 [WetLabsBB2FL](INFO): Powering down
2025-04-18T19:15:23.525Z,1745003723.525 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-04-18T19:15:24.807Z,1745003724.807 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2025-04-18T19:15:27.535Z,1745003727.535 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-04-18T19:15:27.883Z,1745003727.883 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-04-18T19:15:49.032Z,1745003749.032 [NAL9602](INFO): Powering up NAL9602
2025-04-18T19:15:59.952Z,1745003759.952 [NAL9602](INFO): NAL9602 initialized
2025-04-18T19:17:23.340Z,1745003843.340 [SBIT](IMPORTANT): Beginning Startup BIT
2025-04-18T19:17:23.345Z,1745003843.345 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:17:27.771Z,1745003847.771 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.890350
CHAN A1 (24V): 0.821119
CHAN A2 (12V): 0.908667
CHAN A3 (5V): 0.521411
CHAN B0 (3.3V): 0.364492
CHAN B1 (3.15aV): 0.457162
CHAN B2 (3.15bV): 0.457686
CHAN B3 (GND): 0.011714
OPEN: 0.025307
Full Scale: +/- 1 mA
2025-04-18T19:17:36.656Z,1745003856.656 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-04-18T19:18:03.180Z,1745003883.180 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-04-18T19:18:03.180Z,1745003883.180 [SBIT](FAULT): Control surface position failure.
2025-04-18T19:18:16.922Z,1745003896.922 [SBIT](ERROR): Could not read elevatorAngleReader_.
2025-04-18T19:18:16.922Z,1745003896.922 [SBIT](FAULT): Control surface position failure.
2025-04-18T19:18:17.313Z,1745003897.313 [SBIT](CRITICAL): SBIT FAILED
2025-04-18T19:18:17.313Z,1745003897.313 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-18T19:18:17.314Z,1745003897.314 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2025-04-18T19:18:17.314Z,1745003897.314 [SBIT](IMPORTANT): BackseatComponent.missionCritical=0 bool;
2025-04-18T19:18:17.315Z,1745003897.315 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=0 bool;
2025-04-18T19:18:17.315Z,1745003897.315 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.750000 m/s;
2025-04-18T19:18:17.315Z,1745003897.315 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=161.274998 cubic_centimeter;
2025-04-18T19:18:17.315Z,1745003897.315 [SBIT](IMPORTANT): VerticalControl.massDefault=25.748476 millimeter;
2025-04-18T19:18:17.317Z,1745003897.317 [CBIT](INFO): Critical error at 20250418T191817
2025-04-18T19:18:17.727Z,1745003897.727 [MissionManager](IMPORTANT): Started mission Startup
2025-04-18T19:18:17.728Z,1745003897.728 [Startup] Running Loop=1
2025-04-18T19:18:17.728Z,1745003897.728 [Startup](DEBUG): Aggregate::initialize Startup
2025-04-18T19:18:17.728Z,1745003897.728 [Startup:A.GoToSurface] Running Loop=1
2025-04-18T19:18:17.728Z,1745003897.728 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-18T19:18:17.728Z,1745003897.728 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-18T19:18:17.729Z,1745003897.729 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-18T19:18:17.729Z,1745003897.729 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-18T19:18:17.730Z,1745003897.730 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-18T19:18:17.730Z,1745003897.730 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-18T19:18:17.730Z,1745003897.730 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-18T19:18:17.732Z,1745003897.732 [Startup:StartupSatComms] Running Loop=1
2025-04-18T19:18:17.732Z,1745003897.732 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-04-18T19:18:17.732Z,1745003897.732 [Startup:StartupSatComms:A] Running Loop=1
2025-04-18T19:18:18.117Z,1745003898.117 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-04-18T19:18:20.976Z,1745003900.976 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-18T19:18:20.976Z,1745003900.976 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-18T19:18:21.103Z,1745003901.103 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-18T19:18:21.375Z,1745003901.375 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-18T19:18:21.375Z,1745003901.375 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-18T19:18:44.372Z,1745003924.372 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:18:44.388Z,1745003924.388 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:18:48.829Z,1745003928.829 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.890556
CHAN A1 (24V): 0.820826
CHAN A2 (12V): 0.908340
CHAN A3 (5V): 0.522768
CHAN B0 (3.3V): 0.366353
CHAN B1 (3.15aV): 0.459149
CHAN B2 (3.15bV): 0.459897
CHAN B3 (GND): 0.014642
OPEN: 0.025196
Full Scale: +/- 1 mA
2025-04-18T19:18:59.146Z,1745003939.146 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005403
2025-04-18T19:19:10.072Z,1745003950.072 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3
2025-04-18T19:19:17.912Z,1745003957.912 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-18T19:18:17.7Z
2025-04-18T19:19:17.912Z,1745003957.912 [Startup:StartupSatComms:A] Stopped
2025-04-18T19:19:17.913Z,1745003957.913 [Startup:StartupSatComms:B] Running Loop=1
2025-04-18T19:19:18.322Z,1745003958.322 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-18T19:19:19.559Z,1745003959.559 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:19:19.963Z,1745003959.963 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:19:24.405Z,1745003964.405 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.032605
CHAN A1 (24V): 0.060532
CHAN A2 (12V): 0.018040
CHAN A3 (5V): -0.002854
CHAN B0 (3.3V): -0.001013
CHAN B1 (3.15aV): -0.000372
CHAN B2 (3.15bV): -0.000081
CHAN B3 (GND): -0.004597
OPEN: 0.005548
Full Scale: +/- 1 mA
2025-04-18T19:19:25.751Z,1745003965.751 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250418T184904/Courier0010.lzma
2025-04-18T19:19:27.757Z,1745003967.757 [DataOverHttps](INFO): Moved sent file to Logs/20250418T184904/Courier0010.lzma.bak
2025-04-18T19:19:27.757Z,1745003967.757 [DataOverHttps](INFO): SBD MOMSN=24687676
2025-04-18T19:19:43.367Z,1745003983.367 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20250418T191509/Courier0000.lzma
2025-04-18T19:19:44.368Z,1745003984.368 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Courier0000.lzma.bak
2025-04-18T19:19:44.369Z,1745003984.369 [DataOverHttps](INFO): SBD MOMSN=24687678
2025-04-18T19:19:48.812Z,1745003988.812 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA4
2025-04-18T19:19:51.095Z,1745003991.095 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:19:51.472Z,1745003991.472 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:19:55.955Z,1745003995.955 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.034750
CHAN A1 (24V): 0.064291
CHAN A2 (12V): 0.016066
CHAN A3 (5V): -0.003467
CHAN B0 (3.3V): -0.000184
CHAN B1 (3.15aV): 0.000184
CHAN B2 (3.15bV): 0.000499
CHAN B3 (GND): -0.005217
OPEN: 0.005748
Full Scale: +/- 1 mA
2025-04-18T19:20:00.148Z,1745004000.148 [DataOverHttps](INFO): Sending 380 bytes from file Logs/20250418T184904/Express0011.lzma
2025-04-18T19:20:01.150Z,1745004001.150 [DataOverHttps](INFO): Moved sent file to Logs/20250418T184904/Express0011.lzma.bak
2025-04-18T19:20:01.150Z,1745004001.150 [DataOverHttps](INFO): SBD MOMSN=24687684
2025-04-18T19:20:16.472Z,1745004016.472 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:16.650Z,1745004016.650 [DataOverHttps](INFO): Sending 1008 bytes from file Logs/20250418T191509/Express0001.lzma
2025-04-18T19:20:17.650Z,1745004017.650 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Express0001.lzma.bak
2025-04-18T19:20:17.650Z,1745004017.650 [DataOverHttps](INFO): SBD MOMSN=24687694
2025-04-18T19:20:17.704Z,1745004017.704 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:18.122Z,1745004018.122 [Startup:StartupSatComms:B](INFO): Timed out from 2025-04-18T19:19:17.9Z
2025-04-18T19:20:18.122Z,1745004018.122 [Startup:StartupSatComms:B] Stopped
2025-04-18T19:20:18.123Z,1745004018.123 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-04-18T19:20:18.123Z,1745004018.123 [Startup:StartupSatComms] Stopped
2025-04-18T19:20:18.123Z,1745004018.123 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-04-18T19:20:18.124Z,1745004018.124 [Startup](INFO): Completed Startup
2025-04-18T19:20:18.124Z,1745004018.124 [MissionManager](INFO): Startup is completed.
2025-04-18T19:20:18.124Z,1745004018.124 [MissionManager](INFO): Uninitializing Mission Startup
2025-04-18T19:20:18.124Z,1745004018.124 [Startup] Stopped
2025-04-18T19:20:18.124Z,1745004018.124 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-04-18T19:20:18.124Z,1745004018.124 [Startup:A.GoToSurface] Stopped
2025-04-18T19:20:18.125Z,1745004018.125 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-18T19:20:18.526Z,1745004018.526 [MissionManager](IMPORTANT): Started mission Default
2025-04-18T19:20:18.526Z,1745004018.526 [Default] Running Loop=1
2025-04-18T19:20:18.526Z,1745004018.526 [Default](DEBUG): Aggregate::initialize Default
2025-04-18T19:20:18.526Z,1745004018.526 [Default:B.GoToSurface] Running Loop=1
2025-04-18T19:20:18.527Z,1745004018.527 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-18T19:20:18.527Z,1745004018.527 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-18T19:20:18.527Z,1745004018.527 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-18T19:20:18.527Z,1745004018.527 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-18T19:20:18.529Z,1745004018.529 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-18T19:20:18.529Z,1745004018.529 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-18T19:20:18.529Z,1745004018.529 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-18T19:20:18.529Z,1745004018.529 [Default:A.Wait] Running Loop=1
2025-04-18T19:20:18.530Z,1745004018.530 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-18T19:20:23.342Z,1745004023.342 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:24.555Z,1745004024.555 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:29.253Z,1745004029.253 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:20:29.431Z,1745004029.431 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:20:31.842Z,1745004031.842 [Default:A.Wait](INFO): Done Waiting.
2025-04-18T19:20:31.842Z,1745004031.842 [Default:A.Wait] Stopped
2025-04-18T19:20:31.842Z,1745004031.842 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-18T19:20:32.260Z,1745004032.260 [Default:CheckIn] Running Loop=1
2025-04-18T19:20:32.260Z,1745004032.260 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-18T19:20:32.260Z,1745004032.260 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-18T19:20:32.651Z,1745004032.651 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-18T19:20:34.011Z,1745004034.011 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.035173
CHAN A1 (24V): 0.063917
CHAN A2 (12V): 0.016474
CHAN A3 (5V): -0.003940
CHAN B0 (3.3V): -0.000919
CHAN B1 (3.15aV): -0.001223
CHAN B2 (3.15bV): -0.000569
CHAN B3 (GND): -0.004779
OPEN: 0.005506
Full Scale: +/- 1 mA
2025-04-18T19:20:38.694Z,1745004038.694 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:39.906Z,1745004039.906 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:43.009Z,1745004043.009 [CommandExec](IMPORTANT): got command gfisolate
2025-04-18T19:20:43.179Z,1745004043.179 [GFScanner](INFO): Ground fault isolation requested
2025-04-18T19:20:43.179Z,1745004043.179 [GFScanner](IMPORTANT): Starting ground fault isolation process
2025-04-18T19:20:43.179Z,1745004043.179 [GFScanner](INFO): Using most recent scan as baseline - proceeding with component isolation
2025-04-18T19:20:43.600Z,1745004043.600 [Supervisor](DEBUG): Could not find element controlThread.loadControl
2025-04-18T19:20:43.601Z,1745004043.601 [GFScanner](DEBUG): Skipping component controlThread - no load control
2025-04-18T19:20:43.601Z,1745004043.601 [Supervisor](DEBUG): Could not find element CycleStarter.loadControl
2025-04-18T19:20:43.601Z,1745004043.601 [GFScanner](DEBUG): Skipping component CycleStarter - no load control
2025-04-18T19:20:43.602Z,1745004043.602 [Supervisor](DEBUG): Could not find element CommandExec.loadControl
2025-04-18T19:20:43.602Z,1745004043.602 [GFScanner](DEBUG): Skipping component CommandExec - no load control
2025-04-18T19:20:43.602Z,1745004043.602 [Supervisor](DEBUG): Could not find element CommandLine.loadControl
2025-04-18T19:20:43.602Z,1745004043.602 [GFScanner](DEBUG): Skipping component CommandLine - no load control
2025-04-18T19:20:43.603Z,1745004043.603 [Supervisor](DEBUG): Could not find element logger.loadControl
2025-04-18T19:20:43.603Z,1745004043.603 [GFScanner](DEBUG): Skipping component logger - no load control
2025-04-18T19:20:43.603Z,1745004043.603 [Supervisor](DEBUG): Could not find element LogSplitter.loadControl
2025-04-18T19:20:43.604Z,1745004043.604 [GFScanner](DEBUG): Skipping component LogSplitter - no load control
2025-04-18T19:20:43.604Z,1745004043.604 [Supervisor](DEBUG): Could not find element Config/vehicle.loadControl
2025-04-18T19:20:43.604Z,1745004043.604 [GFScanner](DEBUG): Skipping component Config/vehicle - no load control
2025-04-18T19:20:43.605Z,1745004043.605 [Supervisor](DEBUG): Could not find element Config/Derivation.loadControl
2025-04-18T19:20:43.605Z,1745004043.605 [GFScanner](DEBUG): Skipping component Config/Derivation - no load control
2025-04-18T19:20:43.605Z,1745004043.605 [Supervisor](DEBUG): Could not find element Config/Dock.loadControl
2025-04-18T19:20:43.605Z,1745004043.605 [GFScanner](DEBUG): Skipping component Config/Dock - no load control
2025-04-18T19:20:43.606Z,1745004043.606 [Supervisor](DEBUG): Could not find element Config/secure.loadControl
2025-04-18T19:20:43.606Z,1745004043.606 [GFScanner](DEBUG): Skipping component Config/secure - no load control
2025-04-18T19:20:43.606Z,1745004043.606 [Supervisor](DEBUG): Could not find element Config/Science.loadControl
2025-04-18T19:20:43.607Z,1745004043.607 [GFScanner](DEBUG): Skipping component Config/Science - no load control
2025-04-18T19:20:43.607Z,1745004043.607 [Supervisor](DEBUG): Could not find element Config/workSite.loadControl
2025-04-18T19:20:43.607Z,1745004043.607 [GFScanner](DEBUG): Skipping component Config/workSite - no load control
2025-04-18T19:20:43.607Z,1745004043.607 [Supervisor](DEBUG): Could not find element Config/Simulator.loadControl
2025-04-18T19:20:43.612Z,1745004043.612 [GFScanner](DEBUG): Skipping component Config/Simulator - no load control
2025-04-18T19:20:43.612Z,1745004043.612 [Supervisor](DEBUG): Could not find element Config/logger.loadControl
2025-04-18T19:20:43.613Z,1745004043.613 [GFScanner](DEBUG): Skipping component Config/logger - no load control
2025-04-18T19:20:43.613Z,1745004043.613 [Supervisor](DEBUG): Could not find element Config/Servo.loadControl
2025-04-18T19:20:43.613Z,1745004043.613 [GFScanner](DEBUG): Skipping component Config/Servo - no load control
2025-04-18T19:20:43.613Z,1745004043.613 [Supervisor](DEBUG): Could not find element Config/Navigation.loadControl
2025-04-18T19:20:43.614Z,1745004043.614 [GFScanner](DEBUG): Skipping component Config/Navigation - no load control
2025-04-18T19:20:43.614Z,1745004043.614 [Supervisor](DEBUG): Could not find element Config/Estimation.loadControl
2025-04-18T19:20:43.614Z,1745004043.614 [GFScanner](DEBUG): Skipping component Config/Estimation - no load control
2025-04-18T19:20:43.615Z,1745004043.615 [Supervisor](DEBUG): Could not find element Config/Sensor.loadControl
2025-04-18T19:20:43.615Z,1745004043.615 [GFScanner](DEBUG): Skipping component Config/Sensor - no load control
2025-04-18T19:20:43.615Z,1745004043.615 [Supervisor](DEBUG): Could not find element Config/Control.loadControl
2025-04-18T19:20:43.615Z,1745004043.615 [GFScanner](DEBUG): Skipping component Config/Control - no load control
2025-04-18T19:20:43.620Z,1745004043.620 [Supervisor](DEBUG): Could not find element Config/BIT.loadControl
2025-04-18T19:20:43.620Z,1745004043.620 [GFScanner](DEBUG): Skipping component Config/BIT - no load control
2025-04-18T19:20:43.621Z,1745004043.621 [Supervisor](DEBUG): Could not find element Config/Battery.loadControl
2025-04-18T19:20:43.621Z,1745004043.621 [GFScanner](DEBUG): Skipping component Config/Battery - no load control
2025-04-18T19:20:43.621Z,1745004043.621 [Supervisor](DEBUG): Could not find element VerticalControl.loadControl
2025-04-18T19:20:43.621Z,1745004043.621 [GFScanner](DEBUG): Skipping component VerticalControl - no load control
2025-04-18T19:20:43.622Z,1745004043.622 [Supervisor](DEBUG): Could not find element HorizontalControl.loadControl
2025-04-18T19:20:43.622Z,1745004043.622 [GFScanner](DEBUG): Skipping component HorizontalControl - no load control
2025-04-18T19:20:43.622Z,1745004043.622 [Supervisor](DEBUG): Could not find element SpeedControl.loadControl
2025-04-18T19:20:43.623Z,1745004043.623 [GFScanner](DEBUG): Skipping component SpeedControl - no load control
2025-04-18T19:20:43.623Z,1745004043.623 [Supervisor](DEBUG): Could not find element LoopControl.loadControl
2025-04-18T19:20:43.623Z,1745004043.623 [GFScanner](DEBUG): Skipping component LoopControl - no load control
2025-04-18T19:20:43.628Z,1745004043.628 [GFScanner](INFO): Testing component BuoyancyServo for ground fault isolation
2025-04-18T19:20:43.628Z,1745004043.628 [GFScanner](INFO): Component BuoyancyServo is not running, proceeding to isolation
2025-04-18T19:20:43.629Z,1745004043.629 [Supervisor](INFO): Attempting to isolate load for component: BuoyancyServo
2025-04-18T19:20:43.629Z,1745004043.629 [Supervisor](INFO): Isolating primary load control for BuoyancyServo
2025-04-18T19:20:43.634Z,1745004043.634 [Supervisor](INFO): Successfully isolated primary load for component: BuoyancyServo
2025-04-18T19:20:43.634Z,1745004043.634 [GFScanner](DEBUG): Successfully isolated load for component BuoyancyServo
2025-04-18T19:20:45.982Z,1745004045.982 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-18T19:20:45.982Z,1745004045.982 [BuoyancyServo](INFO): Powering down
2025-04-18T19:20:53.642Z,1745004053.642 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:53.691Z,1745004053.691 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:20:53.691Z,1745004053.691 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:20:55.662Z,1745004055.662 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:20:58.146Z,1745004058.146 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.034965
CHAN A1 (24V): 0.064185
CHAN A2 (12V): 0.016475
CHAN A3 (5V): -0.003216
CHAN B0 (3.3V): -0.001285
CHAN B1 (3.15aV): 0.000113
CHAN B2 (3.15bV): -0.000428
CHAN B3 (GND): -0.005342
OPEN: 0.004724
Full Scale: +/- 1 mA
2025-04-18T19:20:59.351Z,1745004059.351 [Supervisor](INFO): Attempting to de-isolate load for component: BuoyancyServo
2025-04-18T19:20:59.351Z,1745004059.351 [Supervisor](INFO): De-isolating primary load control for BuoyancyServo
2025-04-18T19:20:59.358Z,1745004059.358 [Supervisor](INFO): Successfully de-isolated primary load for component: BuoyancyServo
2025-04-18T19:20:59.358Z,1745004059.358 [GFScanner](DEBUG): Successfully de-isolated load for component BuoyancyServo
2025-04-18T19:20:59.358Z,1745004059.358 [GFScanner](INFO): Component BuoyancyServo processing complete
2025-04-18T19:20:59.758Z,1745004059.758 [GFScanner](INFO): Testing component MassServo for ground fault isolation
2025-04-18T19:20:59.759Z,1745004059.759 [GFScanner](INFO): Component MassServo is not running, proceeding to isolation
2025-04-18T19:20:59.759Z,1745004059.759 [Supervisor](INFO): Attempting to isolate load for component: MassServo
2025-04-18T19:20:59.760Z,1745004059.760 [Supervisor](INFO): Isolating primary load control for MassServo
2025-04-18T19:20:59.762Z,1745004059.762 [Supervisor](INFO): Successfully isolated primary load for component: MassServo
2025-04-18T19:20:59.763Z,1745004059.763 [GFScanner](DEBUG): Successfully isolated load for component MassServo
2025-04-18T19:21:00.547Z,1745004060.547 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-18T19:21:00.547Z,1745004060.547 [MassServo](INFO): Powering down
2025-04-18T19:21:03.761Z,1745004063.761 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-18T19:21:08.590Z,1745004068.590 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:09.849Z,1745004069.849 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:21:09.849Z,1745004069.849 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:21:10.613Z,1745004070.613 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:12.235Z,1745004072.235 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192111.00,A,3648.16568,N,12147.27340,W,0.836,0.00,180425,,,A*76
2025-04-18T19:21:12.238Z,1745004072.238 [NAL9602](INFO): GPS fix at 20250418T192111: (36.802761, -121.787890)
2025-04-18T19:21:12.251Z,1745004072.251 [Default:CheckIn:Read_GPS] Stopped
2025-04-18T19:21:12.251Z,1745004072.251 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-18T19:21:12.676Z,1745004072.676 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-18T19:21:14.282Z,1745004074.282 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.035588
CHAN A1 (24V): 0.062266
CHAN A2 (12V): 0.015577
CHAN A3 (5V): -0.003797
CHAN B0 (3.3V): -0.000460
CHAN B1 (3.15aV): -0.001359
CHAN B2 (3.15bV): 0.000346
CHAN B3 (GND): -0.005336
OPEN: 0.005455
Full Scale: +/- 1 mA
2025-04-18T19:21:15.485Z,1745004075.485 [Supervisor](INFO): Attempting to de-isolate load for component: MassServo
2025-04-18T19:21:15.486Z,1745004075.486 [Supervisor](INFO): De-isolating primary load control for MassServo
2025-04-18T19:21:15.489Z,1745004075.489 [Supervisor](INFO): Successfully de-isolated primary load for component: MassServo
2025-04-18T19:21:15.489Z,1745004075.489 [GFScanner](DEBUG): Successfully de-isolated load for component MassServo
2025-04-18T19:21:15.489Z,1745004075.489 [GFScanner](INFO): Component MassServo processing complete
2025-04-18T19:21:15.965Z,1745004075.965 [GFScanner](INFO): Testing component RudderServo for ground fault isolation
2025-04-18T19:21:15.965Z,1745004075.965 [GFScanner](INFO): Component RudderServo is not running, proceeding to isolation
2025-04-18T19:21:15.966Z,1745004075.966 [Supervisor](INFO): Attempting to isolate load for component: RudderServo
2025-04-18T19:21:15.966Z,1745004075.966 [Supervisor](INFO): Isolating primary load control for RudderServo
2025-04-18T19:21:15.973Z,1745004075.973 [Supervisor](INFO): Successfully isolated primary load for component: RudderServo
2025-04-18T19:21:15.973Z,1745004075.973 [GFScanner](DEBUG): Successfully isolated load for component RudderServo
2025-04-18T19:21:16.710Z,1745004076.710 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-18T19:21:16.710Z,1745004076.710 [RudderServo](INFO): Powering down
2025-04-18T19:21:20.200Z,1745004080.200 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20250418T191509/Courier0004.lzma
2025-04-18T19:21:21.202Z,1745004081.202 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Courier0004.lzma.bak
2025-04-18T19:21:21.202Z,1745004081.202 [DataOverHttps](INFO): SBD MOMSN=24687719
2025-04-18T19:21:23.544Z,1745004083.544 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:25.563Z,1745004085.563 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:26.036Z,1745004086.036 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:21:26.036Z,1745004086.036 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:21:30.460Z,1745004090.460 [GFScanner](INFO): No ground fault detected
mA:
CHAN A0 (Batt): 0.000271
CHAN A1 (24V): -0.000439
CHAN A2 (12V): -0.006853
CHAN A3 (5V): -0.006722
CHAN B0 (3.3V): -0.002618
CHAN B1 (3.15aV): -0.002056
CHAN B2 (3.15bV): -0.002041
CHAN B3 (GND): -0.003317
OPEN: 0.004609
Full Scale: +/- 1 mA
2025-04-18T19:21:31.262Z,1745004091.262 [GFScanner](IMPORTANT): Ground fault on channel A1 (24V) reduced by 0.053363 mA after isolating RudderServo
2025-04-18T19:21:31.262Z,1745004091.262 [GFScanner](FAULT): Ground fault identified in component: RudderServo
2025-04-18T19:21:31.264Z,1745004091.264 [GFScanner](IMPORTANT): Before isolation - Ground fault currents (mA):
CHAN A0 (Batt): 0.035173
CHAN A1 (24V): 0.063917
CHAN A2 (12V): 0.016474
CHAN A3 (5V): -0.003940
CHAN B0 (3.3V): -0.000919
CHAN B1 (3.15aV): -0.001223
CHAN B2 (3.15bV): -0.000569
CHAN B3 (GND): -0.004779
2025-04-18T19:21:31.266Z,1745004091.266 [GFScanner](IMPORTANT): After isolation - Ground fault currents (mA):
CHAN A0 (Batt): 0.000271
CHAN A1 (24V): -0.000439
CHAN A2 (12V): -0.006853
CHAN A3 (5V): -0.006722
CHAN B0 (3.3V): -0.002618
CHAN B1 (3.15aV): -0.002056
CHAN B2 (3.15bV): -0.002041
CHAN B3 (GND): -0.003317
2025-04-18T19:21:31.658Z,1745004091.658 [GFScanner](IMPORTANT): Ground fault identified in component RudderServo, leaving it isolated and continuing to next component
2025-04-18T19:21:31.658Z,1745004091.658 [RudderServo] Hardware Fault, FailCount= 1
2025-04-18T19:21:31.658Z,1745004091.658 [RudderServo](ERROR): Hardware Fault
2025-04-18T19:21:31.658Z,1745004091.658 [GFScanner](INFO): Updating baseline ground fault measurements with current values after isolating fault in RudderServo
2025-04-18T19:21:32.055Z,1745004092.055 [CBIT](ERROR): Hardware Fault in component: RudderServo
2025-04-18T19:21:32.057Z,1745004092.057 [GFScanner](INFO): Testing component ThrusterHE for ground fault isolation
2025-04-18T19:21:32.057Z,1745004092.057 [GFScanner](INFO): Component ThrusterHE is not running, proceeding to isolation
2025-04-18T19:21:32.058Z,1745004092.058 [Supervisor](INFO): Attempting to isolate load for component: ThrusterHE
2025-04-18T19:21:32.058Z,1745004092.058 [Supervisor](INFO): Isolating primary load control for ThrusterHE
2025-04-18T19:21:32.061Z,1745004092.061 [Supervisor](INFO): Successfully isolated primary load for component: ThrusterHE
2025-04-18T19:21:32.061Z,1745004092.061 [GFScanner](DEBUG): Successfully isolated load for component ThrusterHE
2025-04-18T19:21:32.859Z,1745004092.859 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-18T19:21:32.860Z,1745004092.860 [ThrusterHE](INFO): Powering down
2025-04-18T19:21:38.061Z,1745004098.061 [DataOverHttps](INFO): Sending 759 bytes from file Logs/20250418T191509/Express0005.lzma
2025-04-18T19:21:39.062Z,1745004099.062 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Express0005.lzma.bak
2025-04-18T19:21:39.062Z,1745004099.062 [DataOverHttps](INFO): SBD MOMSN=24687722
2025-04-18T19:21:39.308Z,1745004099.308 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:40.570Z,1745004100.570 [Default:CheckIn:Read_Iridium] Stopped
2025-04-18T19:21:40.570Z,1745004100.570 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-18T19:21:40.570Z,1745004100.570 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-18T19:21:40.937Z,1745004100.937 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:42.187Z,1745004102.187 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:21:42.192Z,1745004102.192 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:21:44.973Z,1745004104.973 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-18T19:21:46.611Z,1745004106.611 [GFScanner](INFO): No ground fault detected
mA:
CHAN A0 (Batt): -0.000111
CHAN A1 (24V): -0.000586
CHAN A2 (12V): -0.006111
CHAN A3 (5V): -0.006485
CHAN B0 (3.3V): -0.002382
CHAN B1 (3.15aV): -0.002747
CHAN B2 (3.15bV): -0.001873
CHAN B3 (GND): -0.002670
OPEN: 0.004729
Full Scale: +/- 1 mA
2025-04-18T19:21:47.828Z,1745004107.828 [Supervisor](INFO): Attempting to de-isolate load for component: ThrusterHE
2025-04-18T19:21:47.829Z,1745004107.829 [Supervisor](INFO): De-isolating primary load control for ThrusterHE
2025-04-18T19:21:47.834Z,1745004107.834 [Supervisor](INFO): Successfully de-isolated primary load for component: ThrusterHE
2025-04-18T19:21:47.834Z,1745004107.834 [GFScanner](DEBUG): Successfully de-isolated load for component ThrusterHE
2025-04-18T19:21:47.834Z,1745004107.834 [GFScanner](INFO): Component ThrusterHE processing complete
2025-04-18T19:21:48.210Z,1745004108.210 [Supervisor](DEBUG): Could not find element DepthRateCalculator.loadControl
2025-04-18T19:21:48.210Z,1745004108.210 [GFScanner](DEBUG): Skipping component DepthRateCalculator - no load control
2025-04-18T19:21:48.211Z,1745004108.211 [Supervisor](DEBUG): Could not find element PitchRateCalculator.loadControl
2025-04-18T19:21:48.211Z,1745004108.211 [GFScanner](DEBUG): Skipping component PitchRateCalculator - no load control
2025-04-18T19:21:48.211Z,1745004108.211 [Supervisor](DEBUG): Could not find element SpeedCalculator.loadControl
2025-04-18T19:21:48.212Z,1745004108.212 [GFScanner](DEBUG): Skipping component SpeedCalculator - no load control
2025-04-18T19:21:48.212Z,1745004108.212 [Supervisor](DEBUG): Could not find element YawRateCalculator.loadControl
2025-04-18T19:21:48.212Z,1745004108.212 [GFScanner](DEBUG): Skipping component YawRateCalculator - no load control
2025-04-18T19:21:48.213Z,1745004108.213 [Supervisor](DEBUG): Could not find element ElevatorOffsetCalculator.loadControl
2025-04-18T19:21:48.213Z,1745004108.213 [GFScanner](DEBUG): Skipping component ElevatorOffsetCalculator - no load control
2025-04-18T19:21:48.213Z,1745004108.213 [Supervisor](DEBUG): Could not find element DeadReckonUsingMultipleVelocitySources.loadControl
2025-04-18T19:21:48.214Z,1745004108.214 [GFScanner](DEBUG): Skipping component DeadReckonUsingMultipleVelocitySources - no load control
2025-04-18T19:21:48.214Z,1745004108.214 [Supervisor](DEBUG): Could not find element NavChart.loadControl
2025-04-18T19:21:48.214Z,1745004108.214 [GFScanner](DEBUG): Skipping component NavChart - no load control
2025-04-18T19:21:48.214Z,1745004108.214 [Supervisor](DEBUG): Could not find element UniversalFixResidualReporter.loadControl
2025-04-18T19:21:48.215Z,1745004108.215 [GFScanner](DEBUG): Skipping component UniversalFixResidualReporter - no load control
2025-04-18T19:21:48.215Z,1745004108.215 [GFScanner](INFO): Testing component AHRS_M2 for ground fault isolation
2025-04-18T19:21:48.215Z,1745004108.215 [GFScanner](INFO): Stopping component AHRS_M2 for ground fault isolation test
2025-04-18T19:21:48.582Z,1745004108.582 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:49.011Z,1745004109.011 [Supervisor](INFO): Attempting to isolate load for component: AHRS_M2
2025-04-18T19:21:49.012Z,1745004109.012 [Supervisor](INFO): Isolating primary load control for AHRS_M2
2025-04-18T19:21:49.014Z,1745004109.014 [Supervisor](INFO): Successfully isolated primary load for component: AHRS_M2
2025-04-18T19:21:49.014Z,1745004109.014 [GFScanner](DEBUG): Successfully isolated load for component AHRS_M2
2025-04-18T19:21:49.794Z,1745004109.794 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:51.006Z,1745004111.006 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:51.633Z,1745004111.633 [CommandExec](IMPORTANT): got command stop
2025-04-18T19:21:51.633Z,1745004111.633 [CommandExec](IMPORTANT): Scheduling is paused
2025-04-18T19:21:52.218Z,1745004112.218 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:53.430Z,1745004113.430 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:54.240Z,1745004114.240 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:54.642Z,1745004114.642 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:55.854Z,1745004115.854 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:55.856Z,1745004115.856 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:21:57.066Z,1745004117.066 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:58.278Z,1745004118.278 [AHRS_M2](INFO): Powering down
2025-04-18T19:21:59.110Z,1745004119.110 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:21:59.110Z,1745004119.110 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:21:59.490Z,1745004119.490 [AHRS_M2](INFO): Powering down
2025-04-18T19:22:00.703Z,1745004120.703 [AHRS_M2](INFO): Powering down
2025-04-18T19:22:01.914Z,1745004121.914 [AHRS_M2](INFO): Powering down
2025-04-18T19:22:03.126Z,1745004123.126 [AHRS_M2](INFO): Powering down
2025-04-18T19:22:03.558Z,1745004123.558 [GFScanner](INFO): No ground fault detected
mA:
CHAN A0 (Batt): 0.000255
CHAN A1 (24V): -0.001238
CHAN A2 (12V): -0.006849
CHAN A3 (5V): -0.005967
CHAN B0 (3.3V): -0.003074
CHAN B1 (3.15aV): -0.001708
CHAN B2 (3.15bV): -0.001187
CHAN B3 (GND): -0.002193
OPEN: 0.004103
Full Scale: +/- 1 mA
2025-04-18T19:22:04.338Z,1745004124.338 [AHRS_M2](INFO): Powering down
2025-04-18T19:22:04.767Z,1745004124.767 [Supervisor](INFO): Attempting to de-isolate load for component: AHRS_M2
2025-04-18T19:22:04.768Z,1745004124.768 [Supervisor](INFO): De-isolating primary load control for AHRS_M2
2025-04-18T19:22:04.770Z,1745004124.770 [Supervisor](INFO): Successfully de-isolated primary load for component: AHRS_M2
2025-04-18T19:22:04.771Z,1745004124.771 [GFScanner](DEBUG): Successfully de-isolated load for component AHRS_M2
2025-04-18T19:22:04.771Z,1745004124.771 [GFScanner](INFO): Restarting component AHRS_M2 after ground fault isolation test
2025-04-18T19:22:05.146Z,1745004125.146 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-04-18T19:22:05.174Z,1745004125.174 [GFScanner](INFO): Component AHRS_M2 processing complete
2025-04-18T19:22:05.580Z,1745004125.580 [GFScanner](INFO): Testing component BackseatComponent for ground fault isolation
2025-04-18T19:22:05.580Z,1745004125.580 [GFScanner](INFO): Component BackseatComponent is not running, proceeding to isolation
2025-04-18T19:22:05.581Z,1745004125.581 [Supervisor](INFO): Attempting to isolate load for component: BackseatComponent
2025-04-18T19:22:05.581Z,1745004125.581 [Supervisor](INFO): Isolating primary load control for BackseatComponent
2025-04-18T19:22:05.620Z,1745004125.620 [Supervisor](INFO): Successfully isolated primary load for component: BackseatComponent
2025-04-18T19:22:05.620Z,1745004125.620 [GFScanner](DEBUG): Successfully isolated load for component BackseatComponent
2025-04-18T19:22:09.206Z,1745004129.206 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:22:10.298Z,1745004130.298 [CommandExec](IMPORTANT): got command schedule resume
2025-04-18T19:22:10.298Z,1745004130.298 [CommandExec](IMPORTANT): Scheduling is resumed
2025-04-18T19:22:11.216Z,1745004131.216 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:22:15.691Z,1745004135.691 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:22:15.691Z,1745004135.691 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:22:20.161Z,1745004140.161 [GFScanner](INFO): No ground fault detected
mA:
CHAN A0 (Batt): -0.000316
CHAN A1 (24V): -0.001390
CHAN A2 (12V): -0.005682
CHAN A3 (5V): -0.006536
CHAN B0 (3.3V): -0.002723
CHAN B1 (3.15aV): -0.001780
CHAN B2 (3.15bV): -0.001684
CHAN B3 (GND): -0.002501
OPEN: 0.004567
Full Scale: +/- 1 mA
2025-04-18T19:22:21.365Z,1745004141.365 [Supervisor](INFO): Attempting to de-isolate load for component: BackseatComponent
2025-04-18T19:22:21.366Z,1745004141.366 [Supervisor](INFO): De-isolating primary load control for BackseatComponent
2025-04-18T19:22:21.373Z,1745004141.373 [Supervisor](INFO): Successfully de-isolated primary load for component: BackseatComponent
2025-04-18T19:22:21.373Z,1745004141.373 [GFScanner](DEBUG): Successfully de-isolated load for component BackseatComponent
2025-04-18T19:22:21.373Z,1745004141.373 [GFScanner](INFO): Component BackseatComponent processing complete
2025-04-18T19:22:21.784Z,1745004141.784 [Supervisor](DEBUG): Could not find element LcmUniversalReporter.loadControl
2025-04-18T19:22:21.784Z,1745004141.784 [GFScanner](DEBUG): Skipping component LcmUniversalReporter - no load control
2025-04-18T19:22:21.785Z,1745004141.785 [Supervisor](DEBUG): Could not find element BioacousticsDataBridge.loadControl
2025-04-18T19:22:21.785Z,1745004141.785 [GFScanner](DEBUG): Skipping component BioacousticsDataBridge - no load control
2025-04-18T19:22:21.785Z,1745004141.785 [Supervisor](DEBUG): Could not find element BPC1.loadControl
2025-04-18T19:22:21.785Z,1745004141.785 [GFScanner](DEBUG): Skipping component BPC1 - no load control
2025-04-18T19:22:21.786Z,1745004141.786 [Supervisor](DEBUG): Could not find element DataOverHttps.loadControl
2025-04-18T19:22:21.786Z,1745004141.786 [GFScanner](DEBUG): Skipping component DataOverHttps - no load control
2025-04-18T19:22:21.786Z,1745004141.786 [GFScanner](INFO): Testing component Depth_Keller for ground fault isolation
2025-04-18T19:22:21.787Z,1745004141.787 [GFScanner](INFO): Stopping component Depth_Keller for ground fault isolation test
2025-04-18T19:22:22.155Z,1745004142.155 [Supervisor](INFO): Attempting to isolate load for component: Depth_Keller
2025-04-18T19:22:22.155Z,1745004142.155 [Supervisor](INFO): Isolating primary load control for Depth_Keller
2025-04-18T19:22:22.158Z,1745004142.158 [Supervisor](INFO): Successfully isolated primary load for component: Depth_Keller
2025-04-18T19:22:22.158Z,1745004142.158 [GFScanner](DEBUG): Successfully isolated load for component Depth_Keller
2025-04-18T19:22:22.532Z,1745004142.532 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:23.340Z,1745004143.340 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:24.143Z,1745004144.143 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-18T19:22:24.176Z,1745004144.176 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:24.969Z,1745004144.969 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:25.762Z,1745004145.762 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:26.567Z,1745004146.567 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-18T19:22:26.577Z,1745004146.577 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:27.397Z,1745004147.397 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:28.189Z,1745004148.189 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:29.006Z,1745004149.006 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:29.803Z,1745004149.803 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:30.622Z,1745004150.622 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:31.424Z,1745004151.424 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:32.227Z,1745004152.227 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:32.267Z,1745004152.267 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:22:32.267Z,1745004152.267 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:22:33.035Z,1745004153.035 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:33.845Z,1745004153.845 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:34.665Z,1745004154.665 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:35.476Z,1745004155.476 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:36.267Z,1745004156.267 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:36.697Z,1745004156.697 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890726
CHAN A1 (24V): 0.821502
CHAN A2 (12V): 0.909082
CHAN A3 (5V): 0.522149
CHAN B0 (3.3V): 0.365670
CHAN B1 (3.15aV): 0.457957
CHAN B2 (3.15bV): 0.458376
CHAN B3 (GND): 0.015399
OPEN: 0.025311
Full Scale: +/- 1 mA
2025-04-18T19:22:37.080Z,1745004157.080 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:37.883Z,1745004157.883 [Depth_Keller](INFO): Initializing.
2025-04-18T19:22:37.906Z,1745004157.906 [Supervisor](INFO): Attempting to de-isolate load for component: Depth_Keller
2025-04-18T19:22:37.906Z,1745004157.906 [Supervisor](INFO): De-isolating primary load control for Depth_Keller
2025-04-18T19:22:37.909Z,1745004157.909 [Supervisor](INFO): Successfully de-isolated primary load for component: Depth_Keller
2025-04-18T19:22:37.909Z,1745004157.909 [GFScanner](DEBUG): Successfully de-isolated load for component Depth_Keller
2025-04-18T19:22:37.909Z,1745004157.909 [GFScanner](INFO): Restarting component Depth_Keller after ground fault isolation test
2025-04-18T19:22:38.320Z,1745004158.320 [GFScanner](INFO): Component Depth_Keller processing complete
2025-04-18T19:22:38.734Z,1745004158.734 [Supervisor](DEBUG): Could not find element DropWeight.loadControl
2025-04-18T19:22:38.735Z,1745004158.735 [GFScanner](DEBUG): Skipping component DropWeight - no load control
2025-04-18T19:22:38.735Z,1745004158.735 [GFScanner](INFO): Testing component NAL9602 for ground fault isolation
2025-04-18T19:22:38.735Z,1745004158.735 [GFScanner](INFO): Component NAL9602 is not running, proceeding to isolation
2025-04-18T19:22:38.740Z,1745004158.740 [Supervisor](INFO): Attempting to isolate load for component: NAL9602
2025-04-18T19:22:38.741Z,1745004158.741 [Supervisor](INFO): Isolating primary load control for NAL9602
2025-04-18T19:22:38.743Z,1745004158.743 [Supervisor](INFO): Successfully isolated primary load for component: NAL9602
2025-04-18T19:22:38.743Z,1745004158.743 [GFScanner](DEBUG): Successfully isolated load for component NAL9602
2025-04-18T19:22:39.510Z,1745004159.510 [BPC1](INFO): Calculating totals. Valid battery stick count: 46. Valid reserve battery stick count: 5.
2025-04-18T19:22:39.513Z,1745004159.513 [BPC1](INFO): Received data from all battery sticks.
2025-04-18T19:22:39.515Z,1745004159.515 [NAL9602](INFO): Powering down
2025-04-18T19:22:48.815Z,1745004168.815 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:22:48.815Z,1745004168.815 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:22:53.293Z,1745004173.293 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890544
CHAN A1 (24V): 0.820995
CHAN A2 (12V): 0.908795
CHAN A3 (5V): 0.521873
CHAN B0 (3.3V): 0.365829
CHAN B1 (3.15aV): 0.458084
CHAN B2 (3.15bV): 0.458710
CHAN B3 (GND): 0.015055
OPEN: 0.025502
Full Scale: +/- 1 mA
2025-04-18T19:22:54.488Z,1745004174.488 [Supervisor](INFO): Attempting to de-isolate load for component: NAL9602
2025-04-18T19:22:54.489Z,1745004174.489 [Supervisor](INFO): De-isolating primary load control for NAL9602
2025-04-18T19:22:54.491Z,1745004174.491 [Supervisor](INFO): Successfully de-isolated primary load for component: NAL9602
2025-04-18T19:22:54.491Z,1745004174.491 [GFScanner](DEBUG): Successfully de-isolated load for component NAL9602
2025-04-18T19:22:54.516Z,1745004174.516 [GFScanner](INFO): Component NAL9602 processing complete
2025-04-18T19:22:54.899Z,1745004174.899 [Supervisor](DEBUG): Could not find element Onboard.loadControl
2025-04-18T19:22:54.912Z,1745004174.912 [GFScanner](DEBUG): Skipping component Onboard - no load control
2025-04-18T19:22:54.912Z,1745004174.912 [GFScanner](INFO): Testing component Power24vConverter for ground fault isolation
2025-04-18T19:22:54.913Z,1745004174.913 [GFScanner](INFO): Stopping component Power24vConverter for ground fault isolation test
2025-04-18T19:22:55.257Z,1745004175.257 [Power24vConverter](INFO): Powering down.
2025-04-18T19:22:55.716Z,1745004175.716 [Supervisor](INFO): Attempting to isolate load for component: Power24vConverter
2025-04-18T19:22:55.717Z,1745004175.717 [Supervisor](INFO): Isolating primary load control for Power24vConverter
2025-04-18T19:22:55.719Z,1745004175.719 [Supervisor](INFO): Successfully isolated primary load for component: Power24vConverter
2025-04-18T19:22:55.719Z,1745004175.719 [GFScanner](DEBUG): Successfully isolated load for component Power24vConverter
2025-04-18T19:23:05.781Z,1745004185.781 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:23:05.782Z,1745004185.782 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:23:07.010Z,1745004187.010 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:23:10.246Z,1745004190.246 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890696
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.909651
CHAN A3 (5V): 0.521707
CHAN B0 (3.3V): 0.365790
CHAN B1 (3.15aV): 0.458219
CHAN B2 (3.15bV): 0.458814
CHAN B3 (GND): 0.014740
OPEN: 0.025351
Full Scale: +/- 1 mA
2025-04-18T19:23:11.435Z,1745004191.435 [Supervisor](INFO): Attempting to de-isolate load for component: Power24vConverter
2025-04-18T19:23:11.436Z,1745004191.436 [Supervisor](INFO): De-isolating primary load control for Power24vConverter
2025-04-18T19:23:11.439Z,1745004191.439 [Supervisor](INFO): Successfully de-isolated primary load for component: Power24vConverter
2025-04-18T19:23:11.439Z,1745004191.439 [GFScanner](DEBUG): Successfully de-isolated load for component Power24vConverter
2025-04-18T19:23:11.439Z,1745004191.439 [GFScanner](INFO): Restarting component Power24vConverter after ground fault isolation test
2025-04-18T19:23:11.828Z,1745004191.828 [Power24vConverter](INFO): Powering up.
2025-04-18T19:23:11.847Z,1745004191.847 [GFScanner](INFO): Component Power24vConverter processing complete
2025-04-18T19:23:12.264Z,1745004192.264 [GFScanner](INFO): Testing component Radio_Surface for ground fault isolation
2025-04-18T19:23:12.265Z,1745004192.265 [GFScanner](INFO): Stopping component Radio_Surface for ground fault isolation test
2025-04-18T19:23:12.512Z,1745004192.512 [Radio_Surface](INFO): Powering down
2025-04-18T19:23:12.824Z,1745004192.824 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-18T19:23:13.058Z,1745004193.058 [Supervisor](INFO): Attempting to isolate load for component: Radio_Surface
2025-04-18T19:23:13.058Z,1745004193.058 [Supervisor](INFO): Isolating primary load control for Radio_Surface
2025-04-18T19:23:13.061Z,1745004193.061 [Supervisor](INFO): Successfully isolated primary load for component: Radio_Surface
2025-04-18T19:23:13.061Z,1745004193.061 [GFScanner](DEBUG): Successfully isolated load for component Radio_Surface
2025-04-18T19:23:18.572Z,1745004198.572 [Radio_Surface](INFO): Powering down
2025-04-18T19:23:23.168Z,1745004203.168 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:23:23.169Z,1745004203.169 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:23:24.632Z,1745004204.632 [Radio_Surface](INFO): Powering down
2025-04-18T19:23:27.603Z,1745004207.603 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890401
CHAN A1 (24V): 0.821040
CHAN A2 (12V): 0.908908
CHAN A3 (5V): 0.522334
CHAN B0 (3.3V): 0.365716
CHAN B1 (3.15aV): 0.458266
CHAN B2 (3.15bV): 0.459008
CHAN B3 (GND): 0.014796
OPEN: 0.025358
Full Scale: +/- 1 mA
2025-04-18T19:23:28.831Z,1745004208.831 [Supervisor](INFO): Attempting to de-isolate load for component: Radio_Surface
2025-04-18T19:23:28.831Z,1745004208.831 [Supervisor](INFO): De-isolating primary load control for Radio_Surface
2025-04-18T19:23:28.835Z,1745004208.835 [Supervisor](INFO): Successfully de-isolated primary load for component: Radio_Surface
2025-04-18T19:23:28.835Z,1745004208.835 [GFScanner](DEBUG): Successfully de-isolated load for component Radio_Surface
2025-04-18T19:23:28.835Z,1745004208.835 [GFScanner](INFO): Restarting component Radio_Surface after ground fault isolation test
2025-04-18T19:23:29.076Z,1745004209.076 [Radio_Surface](INFO): Powering up
2025-04-18T19:23:29.217Z,1745004209.217 [GFScanner](INFO): Component Radio_Surface processing complete
2025-04-18T19:23:29.622Z,1745004209.622 [GFScanner](INFO): Testing component Sonardyne_Nano for ground fault isolation
2025-04-18T19:23:29.622Z,1745004209.622 [GFScanner](INFO): Stopping component Sonardyne_Nano for ground fault isolation test
2025-04-18T19:23:30.001Z,1745004210.001 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:30.420Z,1745004210.420 [Supervisor](INFO): Attempting to isolate load for component: Sonardyne_Nano
2025-04-18T19:23:30.421Z,1745004210.421 [Supervisor](INFO): Isolating primary load control for Sonardyne_Nano
2025-04-18T19:23:30.423Z,1745004210.423 [Supervisor](INFO): Successfully isolated primary load for component: Sonardyne_Nano
2025-04-18T19:23:30.440Z,1745004210.440 [GFScanner](DEBUG): Successfully isolated load for component Sonardyne_Nano
2025-04-18T19:23:31.209Z,1745004211.209 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:32.429Z,1745004212.429 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:33.634Z,1745004213.634 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:34.853Z,1745004214.853 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:34.924Z,1745004214.924 [DataOverHttps](INFO): Radio surface powered ON.
2025-04-18T19:23:36.057Z,1745004216.057 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:37.281Z,1745004217.281 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:38.489Z,1745004218.489 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:39.697Z,1745004219.697 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:40.527Z,1745004220.527 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:23:40.528Z,1745004220.528 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:23:40.909Z,1745004220.909 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:42.125Z,1745004222.125 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:43.337Z,1745004223.337 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:44.545Z,1745004224.545 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:44.967Z,1745004224.967 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890815
CHAN A1 (24V): 0.821011
CHAN A2 (12V): 0.908821
CHAN A3 (5V): 0.522220
CHAN B0 (3.3V): 0.365923
CHAN B1 (3.15aV): 0.457952
CHAN B2 (3.15bV): 0.458814
CHAN B3 (GND): 0.015732
OPEN: 0.025632
Full Scale: +/- 1 mA
2025-04-18T19:23:45.757Z,1745004225.757 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:23:46.181Z,1745004226.181 [Supervisor](INFO): Attempting to de-isolate load for component: Sonardyne_Nano
2025-04-18T19:23:46.182Z,1745004226.182 [Supervisor](INFO): De-isolating primary load control for Sonardyne_Nano
2025-04-18T19:23:46.185Z,1745004226.185 [Supervisor](INFO): Successfully de-isolated primary load for component: Sonardyne_Nano
2025-04-18T19:23:46.185Z,1745004226.185 [GFScanner](DEBUG): Successfully de-isolated load for component Sonardyne_Nano
2025-04-18T19:23:46.185Z,1745004226.185 [GFScanner](INFO): Restarting component Sonardyne_Nano after ground fault isolation test
2025-04-18T19:23:46.566Z,1745004226.566 [Sonardyne_Nano](INFO): Initializing.
2025-04-18T19:23:46.608Z,1745004226.608 [GFScanner](INFO): Component Sonardyne_Nano processing complete
2025-04-18T19:23:46.999Z,1745004226.999 [GFScanner](INFO): Testing component CTD_Seabird for ground fault isolation
2025-04-18T19:23:46.999Z,1745004226.999 [GFScanner](INFO): Component CTD_Seabird is not running, proceeding to isolation
2025-04-18T19:23:46.000Z,1745004227.000 [Supervisor](INFO): Attempting to isolate load for component: CTD_Seabird
2025-04-18T19:23:47.000Z,1745004227.000 [Supervisor](INFO): Isolating primary load control for CTD_Seabird
2025-04-18T19:23:47.003Z,1745004227.003 [Supervisor](INFO): Successfully isolated primary load for component: CTD_Seabird
2025-04-18T19:23:47.003Z,1745004227.003 [GFScanner](DEBUG): Successfully isolated load for component CTD_Seabird
2025-04-18T19:23:47.804Z,1745004227.804 [CTD_Seabird](INFO): Powering down
2025-04-18T19:23:48.582Z,1745004228.582 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-04-18T19:23:57.088Z,1745004237.088 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:23:57.088Z,1745004237.088 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:23:59.020Z,1745004239.020 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.251465
2025-04-18T19:24:01.547Z,1745004241.547 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890653
CHAN A1 (24V): 0.821419
CHAN A2 (12V): 0.908838
CHAN A3 (5V): 0.522443
CHAN B0 (3.3V): 0.365611
CHAN B1 (3.15aV): 0.457916
CHAN B2 (3.15bV): 0.459026
CHAN B3 (GND): 0.014969
OPEN: 0.025673
Full Scale: +/- 1 mA
2025-04-18T19:24:02.743Z,1745004242.743 [Supervisor](INFO): Attempting to de-isolate load for component: CTD_Seabird
2025-04-18T19:24:02.744Z,1745004242.744 [Supervisor](INFO): De-isolating primary load control for CTD_Seabird
2025-04-18T19:24:02.747Z,1745004242.747 [Supervisor](INFO): Successfully de-isolated primary load for component: CTD_Seabird
2025-04-18T19:24:02.747Z,1745004242.747 [GFScanner](DEBUG): Successfully de-isolated load for component CTD_Seabird
2025-04-18T19:24:02.747Z,1745004242.747 [GFScanner](INFO): Component CTD_Seabird processing complete
2025-04-18T19:24:03.152Z,1745004243.152 [GFScanner](INFO): Testing component PAR_Licor for ground fault isolation
2025-04-18T19:24:03.153Z,1745004243.153 [GFScanner](INFO): Stopping component PAR_Licor for ground fault isolation test
2025-04-18T19:24:08.405Z,1745004248.405 [Supervisor](INFO): Attempting to isolate load for component: PAR_Licor
2025-04-18T19:24:08.405Z,1745004248.405 [Supervisor](INFO): Isolating primary load control for PAR_Licor
2025-04-18T19:24:08.409Z,1745004248.409 [Supervisor](INFO): Successfully isolated primary load for component: PAR_Licor
2025-04-18T19:24:08.409Z,1745004248.409 [GFScanner](DEBUG): Successfully isolated load for component PAR_Licor
2025-04-18T19:24:18.519Z,1745004258.519 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:24:18.519Z,1745004258.519 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:24:22.952Z,1745004262.952 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890240
CHAN A1 (24V): 0.820802
CHAN A2 (12V): 0.908545
CHAN A3 (5V): 0.521837
CHAN B0 (3.3V): 0.365909
CHAN B1 (3.15aV): 0.457995
CHAN B2 (3.15bV): 0.458929
CHAN B3 (GND): 0.015500
OPEN: 0.025360
Full Scale: +/- 1 mA
2025-04-18T19:24:24.164Z,1745004264.164 [Supervisor](INFO): Attempting to de-isolate load for component: PAR_Licor
2025-04-18T19:24:24.164Z,1745004264.164 [Supervisor](INFO): De-isolating primary load control for PAR_Licor
2025-04-18T19:24:24.167Z,1745004264.167 [Supervisor](INFO): Successfully de-isolated primary load for component: PAR_Licor
2025-04-18T19:24:24.167Z,1745004264.167 [GFScanner](DEBUG): Successfully de-isolated load for component PAR_Licor
2025-04-18T19:24:24.167Z,1745004264.167 [GFScanner](INFO): Restarting component PAR_Licor after ground fault isolation test
2025-04-18T19:24:29.426Z,1745004269.426 [GFScanner](INFO): Component PAR_Licor processing complete
2025-04-18T19:24:29.809Z,1745004269.809 [GFScanner](INFO): Testing component WetLabsBB2FL for ground fault isolation
2025-04-18T19:24:29.809Z,1745004269.809 [GFScanner](INFO): Component WetLabsBB2FL is not running, proceeding to isolation
2025-04-18T19:24:29.810Z,1745004269.810 [Supervisor](INFO): Attempting to isolate load for component: WetLabsBB2FL
2025-04-18T19:24:29.810Z,1745004269.810 [Supervisor](INFO): Isolating primary load control for WetLabsBB2FL
2025-04-18T19:24:29.813Z,1745004269.813 [Supervisor](INFO): Successfully isolated primary load for component: WetLabsBB2FL
2025-04-18T19:24:29.813Z,1745004269.813 [GFScanner](DEBUG): Successfully isolated load for component WetLabsBB2FL
2025-04-18T19:24:39.916Z,1745004279.916 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-18T19:24:39.916Z,1745004279.916 [GFScanner](INFO): Beginning ground fault scan
2025-04-18T19:24:40.184Z,1745004280.184 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-18T19:24:44.355Z,1745004284.355 [GFScanner](INFO): Ground fault detected
mA:
CHAN A0 (Batt): 0.890485
CHAN A1 (24V): 0.821163
CHAN A2 (12V): 0.908461
CHAN A3 (5V): 0.521973
CHAN B0 (3.3V): 0.365869
CHAN B1 (3.15aV): 0.457702
CHAN B2 (3.15bV): 0.458685
CHAN B3 (GND): 0.015208
OPEN: 0.025625
Full Scale: +/- 1 mA
2025-04-18T19:24:45.564Z,1745004285.564 [Supervisor](INFO): Attempting to de-isolate load for component: WetLabsBB2FL
2025-04-18T19:24:45.565Z,1745004285.565 [Supervisor](INFO): De-isolating primary load control for WetLabsBB2FL
2025-04-18T19:24:45.567Z,1745004285.567 [Supervisor](INFO): Successfully de-isolated primary load for component: WetLabsBB2FL
2025-04-18T19:24:45.568Z,1745004285.568 [GFScanner](DEBUG): Successfully de-isolated load for component WetLabsBB2FL
2025-04-18T19:24:45.568Z,1745004285.568 [GFScanner](INFO): Component WetLabsBB2FL processing complete
2025-04-18T19:24:45.973Z,1745004285.973 [Supervisor](DEBUG): Could not find element SBIT.loadControl
2025-04-18T19:24:45.973Z,1745004285.973 [GFScanner](DEBUG): Skipping component SBIT - no load control
2025-04-18T19:24:45.973Z,1745004285.973 [Supervisor](DEBUG): Could not find element IBIT.loadControl
2025-04-18T19:24:45.974Z,1745004285.974 [GFScanner](DEBUG): Skipping component IBIT - no load control
2025-04-18T19:24:45.974Z,1745004285.974 [Supervisor](DEBUG): Could not find element CBIT.loadControl
2025-04-18T19:24:45.974Z,1745004285.974 [GFScanner](DEBUG): Skipping component CBIT - no load control
2025-04-18T19:24:45.974Z,1745004285.974 [Supervisor](DEBUG): Could not find element GFScanner.loadControl
2025-04-18T19:24:45.975Z,1745004285.975 [GFScanner](DEBUG): Skipping component GFScanner - no load control
2025-04-18T19:24:45.975Z,1745004285.975 [Supervisor](DEBUG): Could not find element MissionManager.loadControl
2025-04-18T19:24:45.975Z,1745004285.975 [GFScanner](DEBUG): Skipping component MissionManager - no load control
2025-04-18T19:24:45.976Z,1745004285.976 [Supervisor](DEBUG): Could not find element Reporter.loadControl
2025-04-18T19:24:45.976Z,1745004285.976 [GFScanner](DEBUG): Skipping component Reporter - no load control
2025-04-18T19:24:45.976Z,1745004285.976 [Supervisor](DEBUG): Could not find element NavChartDb.loadControl
2025-04-18T19:24:45.977Z,1745004285.977 [GFScanner](DEBUG): Skipping component NavChartDb - no load control
2025-04-18T19:24:45.977Z,1745004285.977 [GFScanner](IMPORTANT): Ground fault isolation complete. Any identified components with ground faults have been left isolated.
2025-04-18T19:24:45.977Z,1745004285.977 [GFScanner](INFO): All components tested for ground fault isolation
2025-04-18T19:24:46.381Z,1745004286.381 [GFScanner](IMPORTANT): Ground fault isolation process complete
2025-04-18T19:24:46.777Z,1745004286.777 [CBIT](INFO): Clearing failed state for component RudderServo
2025-04-18T19:24:46.777Z,1745004286.777 [RudderServo] No Fault, FailCount= 1
2025-04-18T19:24:47.187Z,1745004287.187 [RudderServo](DEBUG): Initializing EZServoServo.
2025-04-18T19:24:47.189Z,1745004287.189 [RudderServo](DEBUG): Initializing RudderServo.
2025-04-18T19:25:15.324Z,1745004315.324 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-18T19:25:50.464Z,1745004350.464 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-18T19:26:25.608Z,1745004385.608 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-18T19:26:41.098Z,1745004401.098 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-18T19:26:41.098Z,1745004401.098 [Default:CheckIn:C.Wait] Stopped
2025-04-18T19:26:41.098Z,1745004401.098 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-18T19:26:41.098Z,1745004401.098 [Default:CheckIn:D] Running Loop=1
2025-04-18T19:26:41.510Z,1745004401.510 [Default:CheckIn:D] Stopped
2025-04-18T19:26:41.510Z,1745004401.510 [Default:CheckIn:E] Running Loop=1
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.383064 min
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn:E] Stopped
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn] Stopped
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn](INFO): Running loop #2
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn] Running Loop=2
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-18T19:26:41.919Z,1745004401.919 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-18T19:26:43.111Z,1745004403.111 [NAL9602](INFO): Powering up NAL9602
2025-04-18T19:26:54.021Z,1745004414.021 [NAL9602](INFO): NAL9602 initialized
2025-04-18T19:26:59.112Z,1745004419.112 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003017
2025-04-18T19:27:38.661Z,1745004458.661 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:27:38.999Z,1745004458.999 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:27:43.381Z,1745004463.381 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.889811
CHAN A1 (24V): 0.820211
CHAN A2 (12V): 0.908123
CHAN A3 (5V): 0.522868
CHAN B0 (3.3V): 0.366297
CHAN B1 (3.15aV): 0.459128
CHAN B2 (3.15bV): 0.459728
CHAN B3 (GND): 0.014430
OPEN: 0.025622
Full Scale: +/- 1 mA
2025-04-18T19:28:03.637Z,1745004483.637 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3
2025-04-18T19:28:05.846Z,1745004485.846 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:28:05.965Z,1745004485.965 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:28:10.399Z,1745004490.399 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.036465
CHAN A1 (24V): 0.066931
CHAN A2 (12V): 0.018275
CHAN A3 (5V): -0.002933
CHAN B0 (3.3V): -0.000527
CHAN B1 (3.15aV): 0.000495
CHAN B2 (3.15bV): -0.000225
CHAN B3 (GND): -0.003887
OPEN: 0.005650
Full Scale: +/- 1 mA
2025-04-18T19:28:24.289Z,1745004504.289 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA3
2025-04-18T19:28:26.176Z,1745004506.176 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:28:26.565Z,1745004506.565 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:28:31.004Z,1745004511.004 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000052
CHAN A1 (24V): -0.001469
CHAN A2 (12V): -0.006023
CHAN A3 (5V): -0.005777
CHAN B0 (3.3V): -0.003605
CHAN B1 (3.15aV): -0.002083
CHAN B2 (3.15bV): -0.002903
CHAN B3 (GND): -0.002997
OPEN: 0.004455
Full Scale: +/- 1 mA
2025-04-18T19:29:50.426Z,1745004590.426 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:29:50.595Z,1745004590.595 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:29:55.058Z,1745004595.058 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000685
CHAN A1 (24V): -0.001736
CHAN A2 (12V): -0.006031
CHAN A3 (5V): -0.006436
CHAN B0 (3.3V): -0.002599
CHAN B1 (3.15aV): -0.002685
CHAN B2 (3.15bV): -0.002391
CHAN B3 (GND): -0.002304
OPEN: 0.004590
Full Scale: +/- 1 mA
2025-04-18T19:30:22.124Z,1745004622.124 [CBIT](INFO): Clearing failed state for component DropWeight
2025-04-18T19:30:22.124Z,1745004622.124 [DropWeight] No Fault, FailCount= 1
2025-04-18T19:30:38.156Z,1745004638.156 [CommandExec](IMPORTANT): got command failComponent
2025-04-18T19:30:38.157Z,1745004638.157 [CommandExec](IMPORTANT): Failed components:
2025-04-18T19:30:38.158Z,1745004638.158 [CommandExec](IMPORTANT): No failed Components.
2025-04-18T19:31:11.384Z,1745004671.384 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:31:11.400Z,1745004671.400 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:31:15.849Z,1745004675.849 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000572
CHAN A1 (24V): -0.000392
CHAN A2 (12V): -0.005716
CHAN A3 (5V): -0.005380
CHAN B0 (3.3V): -0.002175
CHAN B1 (3.15aV): -0.002398
CHAN B2 (3.15bV): -0.001721
CHAN B3 (GND): -0.002151
OPEN: 0.004587
Full Scale: +/- 1 mA
2025-04-18T19:31:20.864Z,1745004680.864 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:31:21.112Z,1745004681.112 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:31:25.538Z,1745004685.538 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000784
CHAN A1 (24V): -0.001133
CHAN A2 (12V): -0.005067
CHAN A3 (5V): -0.006780
CHAN B0 (3.3V): -0.002918
CHAN B1 (3.15aV): -0.002111
CHAN B2 (3.15bV): -0.002244
CHAN B3 (GND): -0.002529
OPEN: 0.004576
Full Scale: +/- 1 mA
2025-04-18T19:31:42.082Z,1745004702.082 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-18T19:26:41.9Z
2025-04-18T19:31:42.082Z,1745004702.082 [Default:CheckIn:Read_GPS] Stopped
2025-04-18T19:31:42.082Z,1745004702.082 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-18T19:31:49.907Z,1745004709.907 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250418T191509/Courier0007.lzma
2025-04-18T19:31:50.909Z,1745004710.909 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Courier0007.lzma.bak
2025-04-18T19:31:50.909Z,1745004710.909 [DataOverHttps](INFO): SBD MOMSN=24687747
2025-04-18T19:31:55.410Z,1745004715.410 [NAL9602](INFO): SBD MO Status=0, MOMSN=8199, MT Status=0, MTMSN=0
2025-04-18T19:31:55.410Z,1745004715.410 [NAL9602](INFO): No messages in MT queue
2025-04-18T19:32:06.617Z,1745004726.617 [DataOverHttps](INFO): Sending 1037 bytes from file Logs/20250418T191509/Express0008.lzma
2025-04-18T19:32:07.618Z,1745004727.618 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Express0008.lzma.bak
2025-04-18T19:32:07.618Z,1745004727.618 [DataOverHttps](INFO): SBD MOMSN=24687749
2025-04-18T19:32:08.753Z,1745004728.753 [Default:CheckIn:Read_Iridium] Stopped
2025-04-18T19:32:08.753Z,1745004728.753 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-18T19:32:08.753Z,1745004728.753 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-18T19:32:26.117Z,1745004746.117 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-18T19:32:56.952Z,1745004776.952 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:32:57.251Z,1745004777.251 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:33:01.721Z,1745004781.721 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000431
CHAN A1 (24V): -0.001251
CHAN A2 (12V): -0.005906
CHAN A3 (5V): -0.006397
CHAN B0 (3.3V): -0.002394
CHAN B1 (3.15aV): -0.002018
CHAN B2 (3.15bV): -0.001264
CHAN B3 (GND): -0.002679
OPEN: 0.004768
Full Scale: +/- 1 mA
2025-04-18T19:33:12.990Z,1745004792.990 [Power24vConverter](INFO): Powering down.
2025-04-18T19:33:33.045Z,1745004813.045 [CommandExec](IMPORTANT): got command ! echo d > /dev/loadC3
2025-04-18T19:33:34.916Z,1745004814.916 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:33:35.225Z,1745004815.225 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:33:36.456Z,1745004816.456 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:33:39.685Z,1745004819.685 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000955
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.004110
CHAN A3 (5V): -0.005361
CHAN B0 (3.3V): -0.002659
CHAN B1 (3.15aV): -0.002258
CHAN B2 (3.15bV): -0.001767
CHAN B3 (GND): -0.002183
OPEN: 0.004655
Full Scale: +/- 1 mA
2025-04-18T19:33:45.344Z,1745004825.344 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:33:45.739Z,1745004825.739 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:33:46.947Z,1745004826.947 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:33:50.174Z,1745004830.174 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000505
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.003631
CHAN A3 (5V): -0.005132
CHAN B0 (3.3V): -0.002871
CHAN B1 (3.15aV): -0.002012
CHAN B2 (3.15bV): -0.001800
CHAN B3 (GND): -0.002434
OPEN: 0.004890
Full Scale: +/- 1 mA
2025-04-18T19:33:55.776Z,1745004835.776 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:33:55.852Z,1745004835.852 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:33:57.061Z,1745004837.061 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:34:00.330Z,1745004840.330 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000099
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.003805
CHAN A3 (5V): -0.005653
CHAN B0 (3.3V): -0.002352
CHAN B1 (3.15aV): -0.001435
CHAN B2 (3.15bV): -0.002223
CHAN B3 (GND): -0.002366
OPEN: 0.004830
Full Scale: +/- 1 mA
2025-04-18T19:34:05.868Z,1745004845.868 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:34:05.989Z,1745004845.989 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:34:07.141Z,1745004847.141 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:34:10.380Z,1745004850.380 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000602
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.003168
CHAN A3 (5V): -0.005076
CHAN B0 (3.3V): -0.001737
CHAN B1 (3.15aV): -0.001452
CHAN B2 (3.15bV): -0.002664
CHAN B3 (GND): -0.002585
OPEN: 0.004867
Full Scale: +/- 1 mA
2025-04-18T19:34:13.180Z,1745004853.180 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:34:13.202Z,1745004853.202 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:34:14.411Z,1745004854.411 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:34:17.649Z,1745004857.649 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000346
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.003103
CHAN A3 (5V): -0.004240
CHAN B0 (3.3V): -0.002087
CHAN B1 (3.15aV): -0.002085
CHAN B2 (3.15bV): -0.001146
CHAN B3 (GND): -0.002414
OPEN: 0.004747
Full Scale: +/- 1 mA
2025-04-18T19:34:21.768Z,1745004861.768 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:34:22.096Z,1745004862.096 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:34:23.301Z,1745004863.301 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:34:26.533Z,1745004866.533 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000500
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.003695
CHAN A3 (5V): -0.004759
CHAN B0 (3.3V): -0.002493
CHAN B1 (3.15aV): -0.001373
CHAN B2 (3.15bV): -0.001994
CHAN B3 (GND): -0.003167
OPEN: 0.004624
Full Scale: +/- 1 mA
2025-04-18T19:34:52.206Z,1745004892.206 [CommandExec](IMPORTANT): got command gfscan
2025-04-18T19:34:52.394Z,1745004892.394 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-18T19:34:53.623Z,1745004893.623 [GFScanner](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-04-18T19:34:56.856Z,1745004896.856 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000308
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.002922
CHAN A3 (5V): -0.004993
CHAN B0 (3.3V): -0.002050
CHAN B1 (3.15aV): -0.001379
CHAN B2 (3.15bV): -0.001918
CHAN B3 (GND): -0.001942
OPEN: 0.004958
Full Scale: +/- 1 mA
2025-04-18T19:37:09.337Z,1745005029.337 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-18T19:37:09.338Z,1745005029.338 [Default:CheckIn:C.Wait] Stopped
2025-04-18T19:37:09.338Z,1745005029.338 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-18T19:37:09.338Z,1745005029.338 [Default:CheckIn:D] Running Loop=1
2025-04-18T19:37:09.739Z,1745005029.739 [Default:CheckIn:D] Stopped
2025-04-18T19:37:09.739Z,1745005029.739 [Default:CheckIn:E] Running Loop=1
2025-04-18T19:37:10.153Z,1745005030.153 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.853549 min
2025-04-18T19:37:10.153Z,1745005030.153 [Default:CheckIn:E] Stopped
2025-04-18T19:37:10.153Z,1745005030.153 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-18T19:37:10.153Z,1745005030.153 [Default:CheckIn] Stopped
2025-04-18T19:37:10.153Z,1745005030.153 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-18T19:37:10.153Z,1745005030.153 [Default:CheckIn](INFO): Running loop #3
2025-04-18T19:37:10.154Z,1745005030.154 [Default:CheckIn] Running Loop=3
2025-04-18T19:37:10.154Z,1745005030.154 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-18T19:37:10.154Z,1745005030.154 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-18T19:37:11.758Z,1745005031.758 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-04-18T19:37:11.758Z,1745005031.758 [NAL9602] Data Fault, FailCount= 1
2025-04-18T19:37:11.758Z,1745005031.758 [NAL9602](ERROR): Data Fault
2025-04-18T19:37:11.778Z,1745005031.778 [CBIT](ERROR): Data Fault in component: NAL9602
2025-04-18T19:37:12.152Z,1745005032.152 [NAL9602](INFO): Powering down
2025-04-18T19:37:12.986Z,1745005032.986 [CBIT](INFO): Clearing failed state for component NAL9602
2025-04-18T19:37:12.986Z,1745005032.986 [NAL9602] No Fault, FailCount= 1
2025-04-18T19:37:42.453Z,1745005062.453 [NAL9602](INFO): Powering up NAL9602
2025-04-18T19:37:53.368Z,1745005073.368 [NAL9602](INFO): NAL9602 initialized
2025-04-18T19:42:10.499Z,1745005330.499 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-18T19:37:10.2Z
2025-04-18T19:42:10.499Z,1745005330.499 [Default:CheckIn:Read_GPS] Stopped
2025-04-18T19:42:10.499Z,1745005330.499 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-18T19:42:18.083Z,1745005338.083 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250418T191509/Courier0010.lzma
2025-04-18T19:42:19.086Z,1745005339.086 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Courier0010.lzma.bak
2025-04-18T19:42:19.086Z,1745005339.086 [DataOverHttps](INFO): SBD MOMSN=24687799
2025-04-18T19:42:35.069Z,1745005355.069 [DataOverHttps](INFO): Sending 682 bytes from file Logs/20250418T191509/Express0011.lzma
2025-04-18T19:42:36.070Z,1745005356.070 [DataOverHttps](INFO): Moved sent file to Logs/20250418T191509/Express0011.lzma.bak
2025-04-18T19:42:36.070Z,1745005356.070 [DataOverHttps](INFO): SBD MOMSN=24687801
2025-04-18T19:42:37.560Z,1745005357.560 [Default:CheckIn:Read_Iridium] Stopped
2025-04-18T19:42:37.578Z,1745005357.578 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-18T19:42:37.578Z,1745005357.578 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-18T19:42:56.925Z,1745005376.925 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-18T19:43:27.625Z,1745005407.625 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-18T19:47:38.130Z,1745005658.130 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-18T19:47:38.130Z,1745005658.130 [Default:CheckIn:C.Wait] Stopped
2025-04-18T19:47:38.130Z,1745005658.130 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-18T19:47:38.131Z,1745005658.131 [Default:CheckIn:D] Running Loop=1
2025-04-18T19:47:38.534Z,1745005658.534 [Default:CheckIn:D] Stopped
2025-04-18T19:47:38.534Z,1745005658.534 [Default:CheckIn:E] Running Loop=1
2025-04-18T19:47:38.982Z,1745005658.982 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.333455 min
2025-04-18T19:47:38.982Z,1745005658.982 [Default:CheckIn:E] Stopped
2025-04-18T19:47:38.982Z,1745005658.982 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-18T19:47:38.982Z,1745005658.982 [Default:CheckIn] Stopped
2025-04-18T19:47:38.982Z,1745005658.982 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-18T19:47:38.982Z,1745005658.982 [Default:CheckIn](INFO): Running loop #4
2025-04-18T19:47:38.983Z,1745005658.983 [Default:CheckIn] Running Loop=4
2025-04-18T19:47:38.983Z,1745005658.983 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-18T19:47:38.983Z,1745005658.983 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-18T19:47:53.385Z,1745005673.385 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-04-18T19:47:53.402Z,1745005673.402 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2025-04-18T19:47:53.525Z,1745005673.525 [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,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-04-18T19:48:22.452Z,1745005702.452 [CommandExec](IMPORTANT): got command report mod platform_elevator_angle degree
2025-04-18T19:48:40.469Z,1745005720.469 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-04-18T19:48:53.065Z,1745005733.065 [CommandExec](IMPORTANT): got command failComponent
2025-04-18T19:48:53.065Z,1745005733.065 [CommandExec](IMPORTANT): Failed components:
2025-04-18T19:48:53.065Z,1745005733.065 [CommandExec](IMPORTANT): No failed Components.
2025-04-18T19:49:07.525Z,1745005747.525 [CommandExec](IMPORTANT): got command get platform_elevator_angle
2025-04-18T19:49:07.525Z,1745005747.525 [CommandExec](FAULT): Element has no value
2025-04-18T19:49:18.658Z,1745005758.658 [CommandExec](IMPORTANT): got command show variable elevator
2025-04-18T19:49:18.760Z,1745005758.760 [CommandExec](IMPORTANT): ElevatorServo.loadControl (none)
2025-04-18T19:49:18.760Z,1745005758.760 [CommandExec](IMPORTANT): ElevatorServo.uart (none)
2025-04-18T19:49:18.761Z,1745005758.761 [CommandExec](IMPORTANT): ElevatorServo.baud (bit_per_second)
2025-04-18T19:49:18.771Z,1745005758.771 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup (bool)
2025-04-18T19:49:18.771Z,1745005758.771 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.targetConfidenceLevel (percent)
2025-04-18T19:49:18.771Z,1745005758.771 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.targetErrorBound (degree)
2025-04-18T19:49:18.772Z,1745005758.772 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.verbosity (count)
2025-04-18T19:49:18.899Z,1745005758.899 [CommandExec](IMPORTANT): ElevatorServo.loadAtStartup (bool)
2025-04-18T19:49:18.900Z,1745005758.900 [CommandExec](IMPORTANT): ElevatorServo.simulateHardware (bool)
2025-04-18T19:49:18.904Z,1745005758.904 [CommandExec](IMPORTANT): ElevatorServo.countsPerDeg (count_per_angular_degree)
2025-04-18T19:49:18.905Z,1745005758.905 [CommandExec](IMPORTANT): ElevatorServo.currLimit (percent)
2025-04-18T19:49:18.905Z,1745005758.905 [CommandExec](IMPORTANT): ElevatorServo.deviationAngle (angular_degree)
2025-04-18T19:49:18.905Z,1745005758.905 [CommandExec](IMPORTANT): ElevatorServo.limitHi (count)
2025-04-18T19:49:18.906Z,1745005758.906 [CommandExec](IMPORTANT): ElevatorServo.limitLo (count)
2025-04-18T19:49:18.906Z,1745005758.906 [CommandExec](IMPORTANT): ElevatorServo.mtrCenter (count)
2025-04-18T19:49:18.906Z,1745005758.906 [CommandExec](IMPORTANT): ElevatorServo.offsetAngle (degree)
2025-04-18T19:49:18.907Z,1745005758.907 [CommandExec](IMPORTANT): ElevatorServo.pidW (count)
2025-04-18T19:49:18.907Z,1745005758.907 [CommandExec](IMPORTANT): ElevatorServo.pidX (count)
2025-04-18T19:49:18.907Z,1745005758.907 [CommandExec](IMPORTANT): ElevatorServo.pidY (count)
2025-04-18T19:49:18.912Z,1745005758.912 [CommandExec](IMPORTANT): ElevatorServo.powerOnTimeout (second)
2025-04-18T19:49:19.013Z,1745005759.013 [CommandExec](IMPORTANT): VerticalControl.kdPitchElevator (second)
2025-04-18T19:49:19.014Z,1745005759.014 [CommandExec](IMPORTANT): VerticalControl.kiPitchElevator (reciprocal_second)
2025-04-18T19:49:19.015Z,1745005759.015 [CommandExec](IMPORTANT): VerticalControl.kpPitchElevator (none)
2025-04-18T19:49:19.038Z,1745005759.038 [CommandExec](IMPORTANT): VerticalControl.maxPitchElevatorInt (angular_degree)
2025-04-18T19:49:19.066Z,1745005759.066 [CommandExec](IMPORTANT): VerticalControl.elevatorAngleCmd (radian)
2025-04-18T19:49:19.068Z,1745005759.068 [CommandExec](IMPORTANT): VerticalControl.elevatorIntegralInternal (radian)
2025-04-18T19:49:19.077Z,1745005759.077 [CommandExec](IMPORTANT): VerticalControl.elevatorAngleAction (radian)
2025-04-18T19:49:19.102Z,1745005759.102 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.enableBroadcast (bool)
2025-04-18T19:49:19.103Z,1745005759.103 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_average (radian)
2025-04-18T19:49:19.103Z,1745005759.103 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_variance (radian)
2025-04-18T19:49:19.103Z,1745005759.103 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_error_bound (radian)
2025-04-18T19:49:19.104Z,1745005759.104 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_speed_identifier (meter_per_second)
2025-04-18T19:49:19.128Z,1745005759.128 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_pitch_identifier (radian)
2025-04-18T19:49:19.129Z,1745005759.129 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_mass_position_identifier (meter)
2025-04-18T19:49:19.243Z,1745005759.243 [CommandExec](IMPORTANT): Maintain_VerticalControl.elevatorAngleAction.enableBroadcast (bool)
2025-04-18T19:51:38.743Z,1745005898.743 [CommandExec](IMPORTANT): got command maintain control
2025-04-18T19:51:38.744Z,1745005898.744 [CommandExec](FAULT): Incomplete syntax. Try: help maintain
2025-04-18T19:51:56.345Z,1745005916.345 [CommandExec](IMPORTANT): got command configSet list
2025-04-18T19:51:56.345Z,1745005916.345 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-04-18T19:51:56.346Z,1745005916.346 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2025-04-18T19:51:56.347Z,1745005916.347 [CommandExec](IMPORTANT): BackseatComponent.missionCritical=0 bool;
2025-04-18T19:51:56.347Z,1745005916.347 [CommandExec](IMPORTANT): ElevatorServo.loadAtStartup=0 bool;
2025-04-18T19:51:56.384Z,1745005916.384 [CommandExec](IMPORTANT): SpeedControl.rollOptimum=0.750000 m/s;
2025-04-18T19:51:56.385Z,1745005916.385 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=161.274998 cubic_centimeter;
2025-04-18T19:51:56.386Z,1745005916.386 [CommandExec](IMPORTANT): VerticalControl.massDefault=25.748476 millimeter;
2025-04-18T19:52:19.006Z,1745005939.006 [CommandExec](IMPORTANT): got command configSet ElevatorServo.loadAtStartup 1 bool persist
2025-04-18T19:52:19.006Z,1745005939.006 [CommandExec](IMPORTANT): configSet ElevatorServo.loadAtStartup requires a restart to take effect.
2025-04-18T19:52:25.574Z,1745005945.574 [CommandExec](IMPORTANT): got command restart application
2025-04-18T19:52:26.576Z,1745005946.576 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:26.576Z,1745005946.576 [CommandExec](INFO): Uninitializing the command executive.
2025-04-18T19:52:26.576Z,1745005946.576 [CommandExec](INFO): Uninitializing the command scheduler.
2025-04-18T19:52:26.577Z,1745005946.577 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:26.664Z,1745005946.664 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-04-18T19:52:26.664Z,1745005946.664 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-04-18T19:52:26.664Z,1745005946.664 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:26.665Z,1745005946.665 [NavChartDb](INFO): Join timeout helper Thread ID is 2888
2025-04-18T19:52:26.880Z,1745005946.880 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:26.880Z,1745005946.880 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:26.884Z,1745005946.884 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-04-18T19:52:26.884Z,1745005946.884 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:26.885Z,1745005946.885 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2889
2025-04-18T19:52:27.056Z,1745005947.056 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:27.056Z,1745005947.056 [WetLabsBB2FL](INFO): Powering down
2025-04-18T19:52:27.057Z,1745005947.057 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:27.064Z,1745005947.064 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-04-18T19:52:27.064Z,1745005947.064 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:27.064Z,1745005947.064 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2890
2025-04-18T19:52:27.100Z,1745005947.100 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:27.101Z,1745005947.101 [CTD_Seabird](INFO): Powering down
2025-04-18T19:52:27.112Z,1745005947.112 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:27.128Z,1745005947.128 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-04-18T19:52:27.128Z,1745005947.128 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:27.128Z,1745005947.128 [Radio_Surface](INFO): Join timeout helper Thread ID is 2891
2025-04-18T19:52:27.516Z,1745005947.516 [Radio_Surface](INFO): Powering down
2025-04-18T19:52:27.517Z,1745005947.517 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:27.517Z,1745005947.517 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:27.528Z,1745005947.528 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-04-18T19:52:27.528Z,1745005947.528 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:27.528Z,1745005947.528 [Onboard](INFO): Join timeout helper Thread ID is 2892
2025-04-18T19:52:28.232Z,1745005948.232 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-18T19:52:31.621Z,1745005951.621 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:31.622Z,1745005951.622 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:31.637Z,1745005951.637 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-04-18T19:52:31.637Z,1745005951.637 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:31.637Z,1745005951.637 [DataOverHttps](INFO): Join timeout helper Thread ID is 2893
2025-04-18T19:52:32.249Z,1745005952.249 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:32.250Z,1745005952.250 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.265Z,1745005952.265 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-04-18T19:52:32.265Z,1745005952.265 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.265Z,1745005952.265 [BackseatComponent](INFO): Join timeout helper Thread ID is 2894
2025-04-18T19:52:32.304Z,1745005952.304 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:32.305Z,1745005952.305 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.325Z,1745005952.325 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-04-18T19:52:32.325Z,1745005952.325 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.325Z,1745005952.325 [logger](INFO): Join timeout helper Thread ID is 2895
2025-04-18T19:52:32.345Z,1745005952.345 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:32.345Z,1745005952.345 [logger ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.365Z,1745005952.365 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-04-18T19:52:32.365Z,1745005952.365 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.365Z,1745005952.365 [CommandLine](INFO): Join timeout helper Thread ID is 2896
2025-04-18T19:52:32.448Z,1745005952.448 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:32.449Z,1745005952.449 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.465Z,1745005952.465 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-04-18T19:52:32.465Z,1745005952.465 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.465Z,1745005952.465 [CommandExec](INFO): Join timeout helper Thread ID is 2897
2025-04-18T19:52:32.466Z,1745005952.466 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-04-18T19:52:32.466Z,1745005952.466 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:32.467Z,1745005952.467 [controlThread](INFO): Join timeout helper Thread ID is 2898
2025-04-18T19:52:32.620Z,1745005952.620 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-04-18T19:52:32.620Z,1745005952.620 [controlThread](DEBUG): Uninitializing ControlThread
2025-04-18T19:52:32.621Z,1745005952.621 [AHRS_M2](INFO): Powering down
2025-04-18T19:52:32.693Z,1745005952.693 [NAL9602](INFO): Powering down
2025-04-18T19:52:32.695Z,1745005952.695 [Sonardyne_Nano](INFO): Powering down
2025-04-18T19:52:32.900Z,1745005952.900 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-04-18T19:52:32.901Z,1745005952.901 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-04-18T19:52:32.902Z,1745005952.902 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-04-18T19:52:32.902Z,1745005952.902 [MissionManager](INFO): Uninitializing Mission Default
2025-04-18T19:52:32.902Z,1745005952.902 [Default] Stopped
2025-04-18T19:52:32.902Z,1745005952.902 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-18T19:52:32.902Z,1745005952.902 [Default:B.GoToSurface] Stopped
2025-04-18T19:52:32.902Z,1745005952.902 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-18T19:52:32.902Z,1745005952.902 [Default:CheckIn] Stopped
2025-04-18T19:52:32.903Z,1745005952.903 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-18T19:52:32.903Z,1745005952.903 [Default:CheckIn:Read_GPS] Stopped
2025-04-18T19:52:32.906Z,1745005952.906 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-04-18T19:52:32.906Z,1745005952.906 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-04-18T19:52:32.906Z,1745005952.906 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-04-18T19:52:32.907Z,1745005952.907 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-04-18T19:52:32.907Z,1745005952.907 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-04-18T19:52:32.907Z,1745005952.907 [BuoyancyServo](INFO): Powering down
2025-04-18T19:52:32.920Z,1745005952.920 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-04-18T19:52:32.920Z,1745005952.920 [MassServo](INFO): Powering down
2025-04-18T19:52:32.921Z,1745005952.921 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-04-18T19:52:32.921Z,1745005952.921 [RudderServo](INFO): Powering down
2025-04-18T19:52:32.922Z,1745005952.922 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-04-18T19:52:32.922Z,1745005952.922 [ThrusterHE](INFO): Powering down
2025-04-18T19:52:32.923Z,1745005952.923 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-04-18T19:52:32.923Z,1745005952.923 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-04-18T19:52:32.923Z,1745005952.923 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-04-18T19:52:32.923Z,1745005952.923 [CBIT](DEBUG): Powering off loads.
2025-04-18T19:52:32.936Z,1745005952.936 [CBIT](DEBUG): Disabling WDT.
2025-04-18T19:52:32.948Z,1745005952.948 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-18T19:52:32.948Z,1745005952.948 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-18T19:52:32.949Z,1745005952.949 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.010Z,1745005953.010 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.013Z,1745005953.013 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.020Z,1745005953.020 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.065Z,1745005953.065 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.109Z,1745005953.109 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.114Z,1745005953.114 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.136Z,1745005953.136 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-04-18T19:52:33.136Z,1745005953.136 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-04-18T19:52:33.152Z,1745005953.152 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-04-18T19:52:33.221Z,1745005953.221 [logger ThreadHandler](INFO): Thread cancelled.