2025-06-04T18:49:52.770Z,1749062992.770 [Supervisor](DEBUG): Initializing supervisor. 2025-06-04T18:49:52.775Z,1749062992.775 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-06-04T18:49:52.775Z,1749062992.775 [SyncHandler](INFO): Protected caller Thread ID is 5361 2025-06-04T18:49:52.776Z,1749062992.776 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-06-04T18:49:52.777Z,1749062992.777 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-06-04T18:49:52.777Z,1749062992.777 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5362 2025-06-04T18:49:52.782Z,1749062992.782 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-06-04T18:49:52.802Z,1749062992.802 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-06-04T18:49:52.802Z,1749062992.802 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-06-04T18:49:52.803Z,1749062992.803 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5363 2025-06-04T18:49:52.807Z,1749062992.807 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-06-04T18:49:52.808Z,1749062992.808 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-06-04T18:49:52.809Z,1749062992.809 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5364 2025-06-04T18:49:52.811Z,1749062992.811 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-06-04T18:49:52.812Z,1749062992.812 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-06-04T18:49:52.812Z,1749062992.812 [logger ThreadHandler](INFO): Protected caller Thread ID is 5365 2025-06-04T18:49:52.816Z,1749062992.816 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-06-04T18:49:52.816Z,1749062992.816 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-06-04T18:49:52.818Z,1749062992.818 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-06-04T18:49:53.057Z,1749062993.057 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-06-04T18:49:53.058Z,1749062993.058 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-06-04T18:49:53.284Z,1749062993.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-06-04T18:49:53.284Z,1749062993.284 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-06-04T18:49:53.393Z,1749062993.393 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-06-04T18:49:53.393Z,1749062993.393 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-06-04T18:49:53.588Z,1749062993.588 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-06-04T18:49:53.589Z,1749062993.589 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-06-04T18:49:54.096Z,1749062994.096 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-06-04T18:49:54.097Z,1749062994.097 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-06-04T18:49:54.217Z,1749062994.217 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-06-04T18:49:54.217Z,1749062994.217 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-06-04T18:49:54.496Z,1749062994.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-06-04T18:49:54.497Z,1749062994.497 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-06-04T18:49:54.729Z,1749062994.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-06-04T18:49:54.729Z,1749062994.729 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-06-04T18:49:55.335Z,1749062995.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-06-04T18:49:55.336Z,1749062995.336 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-06-04T18:49:55.757Z,1749062995.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-06-04T18:49:55.757Z,1749062995.757 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-06-04T18:49:55.849Z,1749062995.849 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-06-04T18:49:56.239Z,1749062996.239 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-06-04T18:49:56.240Z,1749062996.240 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-06-04T18:49:56.391Z,1749062996.391 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-06-04T18:49:56.391Z,1749062996.391 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-06-04T18:49:57.303Z,1749062997.303 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-06-04T18:49:57.304Z,1749062997.304 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-06-04T18:49:57.662Z,1749062997.662 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-06-04T18:49:57.662Z,1749062997.662 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-06-04T18:49:57.808Z,1749062997.808 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-06-04T18:49:57.810Z,1749062997.810 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2025-06-04T18:49:57.811Z,1749062997.811 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2025-06-04T18:49:57.907Z,1749062997.907 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2025-06-04T18:49:58.024Z,1749062998.024 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2025-06-04T18:49:58.141Z,1749062998.141 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2025-06-04T18:49:58.162Z,1749062998.162 [Config/BIT](CRITICAL): Could not parse value: GFScanner.gf24Offset 2025-06-04T18:49:58.241Z,1749062998.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2025-06-04T18:49:58.339Z,1749062998.339 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2025-06-04T18:49:58.454Z,1749062998.454 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2025-06-04T18:49:58.608Z,1749062998.608 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2025-06-04T18:49:58.805Z,1749062998.805 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2025-06-04T18:49:58.911Z,1749062998.911 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2025-06-04T18:49:59.188Z,1749062999.188 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-06-04T18:49:59.189Z,1749062999.189 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/ 2025-06-04T18:49:59.190Z,1749062999.190 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-06-04T18:49:59.198Z,1749062999.198 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-06-04T18:49:59.574Z,1749062999.574 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-06-04T18:49:59.574Z,1749062999.574 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-06-04T18:50:00.082Z,1749063000.082 [AHRS_M2] Loaded 2025-06-04T18:50:00.082Z,1749063000.082 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-06-04T18:50:00.121Z,1749063000.121 [BackseatComponent] Loaded 2025-06-04T18:50:00.122Z,1749063000.122 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-06-04T18:50:00.123Z,1749063000.123 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408A94E0 2025-06-04T18:50:00.123Z,1749063000.123 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5444 2025-06-04T18:50:00.126Z,1749063000.126 [LcmUniversalReporter] Loaded 2025-06-04T18:50:00.126Z,1749063000.126 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-06-04T18:50:00.132Z,1749063000.132 [BioacousticsDataBridge] Loaded 2025-06-04T18:50:00.133Z,1749063000.133 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2025-06-04T18:50:00.954Z,1749063000.954 [BPC1] Loaded 2025-06-04T18:50:00.955Z,1749063000.955 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-06-04T18:50:01.051Z,1749063001.051 [DAT] Loaded 2025-06-04T18:50:01.051Z,1749063001.051 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-06-04T18:50:01.052Z,1749063001.052 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408D94E0 2025-06-04T18:50:01.052Z,1749063001.052 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5445 2025-06-04T18:50:01.125Z,1749063001.125 [DataOverHttps] Loaded 2025-06-04T18:50:01.126Z,1749063001.126 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-06-04T18:50:01.127Z,1749063001.127 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409094E0 2025-06-04T18:50:01.127Z,1749063001.127 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5446 2025-06-04T18:50:01.149Z,1749063001.149 [Depth_Keller] Loaded 2025-06-04T18:50:01.150Z,1749063001.150 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-06-04T18:50:01.154Z,1749063001.154 [DropWeight] Loaded 2025-06-04T18:50:01.155Z,1749063001.155 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-06-04T18:50:01.219Z,1749063001.219 [NAL9602] Loaded 2025-06-04T18:50:01.219Z,1749063001.219 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-06-04T18:50:01.249Z,1749063001.249 [Onboard] Loaded 2025-06-04T18:50:01.249Z,1749063001.249 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-06-04T18:50:01.250Z,1749063001.250 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409394E0 2025-06-04T18:50:01.250Z,1749063001.250 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5447 2025-06-04T18:50:01.264Z,1749063001.264 [Power24vConverter] Loaded 2025-06-04T18:50:01.265Z,1749063001.265 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-06-04T18:50:01.281Z,1749063001.281 [Radio_Surface] Loaded 2025-06-04T18:50:01.282Z,1749063001.282 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-06-04T18:50:01.283Z,1749063001.283 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409694E0 2025-06-04T18:50:01.283Z,1749063001.283 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5448 2025-06-04T18:50:01.299Z,1749063001.299 [Sonardyne_Nano] Loaded 2025-06-04T18:50:01.299Z,1749063001.299 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-06-04T18:50:01.299Z,1749063001.299 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-06-04T18:50:01.300Z,1749063001.300 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-06-04T18:50:01.459Z,1749063001.459 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-06-04T18:50:01.459Z,1749063001.459 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-06-04T18:50:01.513Z,1749063001.513 [VerticalControl](DEBUG): Construct VerticalControl. 2025-06-04T18:50:01.573Z,1749063001.573 [VerticalControl] Loaded 2025-06-04T18:50:01.573Z,1749063001.573 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-06-04T18:50:01.576Z,1749063001.576 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-06-04T18:50:01.624Z,1749063001.624 [HorizontalControl] Loaded 2025-06-04T18:50:01.624Z,1749063001.624 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-06-04T18:50:01.627Z,1749063001.627 [SpeedControl](DEBUG): Construct SpeedControl. 2025-06-04T18:50:01.630Z,1749063001.630 [SpeedControl] Loaded 2025-06-04T18:50:01.630Z,1749063001.630 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-06-04T18:50:01.633Z,1749063001.633 [LoopControl](DEBUG): Construct LoopControl. 2025-06-04T18:50:01.633Z,1749063001.633 [LoopControl] Loaded 2025-06-04T18:50:01.634Z,1749063001.634 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-06-04T18:50:01.634Z,1749063001.634 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-06-04T18:50:01.634Z,1749063001.634 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-06-04T18:50:01.645Z,1749063001.645 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-06-04T18:50:01.645Z,1749063001.645 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-06-04T18:50:01.675Z,1749063001.675 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-06-04T18:50:01.675Z,1749063001.675 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-06-04T18:50:01.790Z,1749063001.790 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-06-04T18:50:01.790Z,1749063001.790 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-06-04T18:50:01.804Z,1749063001.804 [NavChart] Loaded 2025-06-04T18:50:01.804Z,1749063001.804 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-06-04T18:50:01.810Z,1749063001.810 [UniversalFixResidualReporter] Loaded 2025-06-04T18:50:01.810Z,1749063001.810 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-06-04T18:50:01.811Z,1749063001.811 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-06-04T18:50:01.811Z,1749063001.811 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-06-04T18:50:01.980Z,1749063001.980 [SBIT](DEBUG): Construct Startup Built In Test. 2025-06-04T18:50:01.990Z,1749063001.990 [SBIT] Loaded 2025-06-04T18:50:01.990Z,1749063001.990 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-06-04T18:50:01.993Z,1749063001.993 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-06-04T18:50:02.006Z,1749063002.006 [IBIT] Loaded 2025-06-04T18:50:02.006Z,1749063002.006 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-06-04T18:50:02.011Z,1749063002.011 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-06-04T18:50:02.092Z,1749063002.092 [CBIT] Loaded 2025-06-04T18:50:02.092Z,1749063002.092 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-06-04T18:50:02.125Z,1749063002.125 [GFScanner] Loaded 2025-06-04T18:50:02.125Z,1749063002.125 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-06-04T18:50:02.126Z,1749063002.126 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-06-04T18:50:02.126Z,1749063002.126 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-06-04T18:50:02.308Z,1749063002.308 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-06-04T18:50:02.309Z,1749063002.309 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-06-04T18:50:02.454Z,1749063002.454 [BuoyancyServo] Loaded 2025-06-04T18:50:02.454Z,1749063002.454 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-06-04T18:50:02.478Z,1749063002.478 [ElevatorServo] Loaded 2025-06-04T18:50:02.478Z,1749063002.478 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-06-04T18:50:02.500Z,1749063002.500 [MassServo] Loaded 2025-06-04T18:50:02.500Z,1749063002.500 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-06-04T18:50:02.521Z,1749063002.521 [RudderServo] Loaded 2025-06-04T18:50:02.521Z,1749063002.521 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-06-04T18:50:02.538Z,1749063002.538 [ThrusterHE] Loaded 2025-06-04T18:50:02.539Z,1749063002.539 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-06-04T18:50:02.539Z,1749063002.539 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-06-04T18:50:02.540Z,1749063002.540 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-06-04T18:50:02.712Z,1749063002.712 [CTD_Seabird] Loaded 2025-06-04T18:50:02.713Z,1749063002.713 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-06-04T18:50:02.714Z,1749063002.714 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BAC4E0 2025-06-04T18:50:02.714Z,1749063002.714 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5449 2025-06-04T18:50:02.750Z,1749063002.750 [ESPComponent] Loaded 2025-06-04T18:50:02.751Z,1749063002.751 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-06-04T18:50:02.772Z,1749063002.772 [PAR_Licor] Loaded 2025-06-04T18:50:02.773Z,1749063002.773 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-06-04T18:50:02.818Z,1749063002.818 [WetLabsBB2FL] Loaded 2025-06-04T18:50:02.818Z,1749063002.818 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-06-04T18:50:02.819Z,1749063002.819 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BDC4E0 2025-06-04T18:50:02.820Z,1749063002.820 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5450 2025-06-04T18:50:02.821Z,1749063002.821 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-06-04T18:50:02.821Z,1749063002.821 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-06-04T18:50:02.872Z,1749063002.872 [DepthRateCalculator] Loaded 2025-06-04T18:50:02.873Z,1749063002.873 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-06-04T18:50:02.878Z,1749063002.878 [PitchRateCalculator] Loaded 2025-06-04T18:50:02.878Z,1749063002.878 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-06-04T18:50:02.887Z,1749063002.887 [SpeedCalculator] Loaded 2025-06-04T18:50:02.887Z,1749063002.887 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-06-04T18:50:02.892Z,1749063002.892 [YawRateCalculator] Loaded 2025-06-04T18:50:02.892Z,1749063002.892 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-06-04T18:50:02.912Z,1749063002.912 [ElevatorOffsetCalculator] Loaded 2025-06-04T18:50:02.912Z,1749063002.912 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-06-04T18:50:02.912Z,1749063002.912 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-06-04T18:50:02.913Z,1749063002.913 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-06-04T18:50:02.973Z,1749063002.973 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-06-04T18:50:02.980Z,1749063002.980 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-06-04T18:50:02.982Z,1749063002.982 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-06-04T18:50:02.994Z,1749063002.994 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-06-04T18:50:02.995Z,1749063002.995 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C694E0 2025-06-04T18:50:02.995Z,1749063002.995 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5451 2025-06-04T18:50:02.000Z,1749063003.000 [Supervisor](INFO): Main Thread ID is 4530 2025-06-04T18:50:02.000Z,1749063003.000 [Supervisor](DEBUG): Running supervisor. 2025-06-04T18:50:03.001Z,1749063003.001 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5452 2025-06-04T18:50:03.001Z,1749063003.001 [CommandExec](INFO): Initializing the command executive. 2025-06-04T18:50:03.003Z,1749063003.003 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5453 2025-06-04T18:50:03.005Z,1749063003.005 [controlThread ThreadHandler](INFO): Handler Thread ID is 5454 2025-06-04T18:50:03.005Z,1749063003.005 [controlThread](DEBUG): Initializing ControlThread 2025-06-04T18:50:03.009Z,1749063003.009 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-06-04T18:50:03.011Z,1749063003.011 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-06-04T18:50:03.011Z,1749063003.011 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-06-04T18:50:03.012Z,1749063003.012 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-06-04T18:50:03.013Z,1749063003.013 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-06-04T18:50:03.013Z,1749063003.013 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-06-04T18:50:03.013Z,1749063003.013 [SBIT](INFO): Initialize SBIT Component. 2025-06-04T18:50:03.014Z,1749063003.014 [SBIT](IMPORTANT): git: 2025-06-02-8-g5f2fbbaf7 2025-06-04T18:50:03.014Z,1749063003.014 [SBIT](INFO): git hash: 5f2fbbaf7c8ce9036d9689900aaed778fab87320 2025-06-04T18:50:03.014Z,1749063003.014 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-06-04T18:50:03.015Z,1749063003.015 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Dec 4 01:17:04 UTC 2024 2025-06-04T18:50:03.017Z,1749063003.017 [SBIT](INFO): Beginning SBIT in 66.000000 seconds. 2025-06-04T18:50:03.017Z,1749063003.017 [IBIT](INFO): Initialize IBIT Component. 2025-06-04T18:50:03.018Z,1749063003.018 [CBIT](DEBUG): Initialize CBIT Component. 2025-06-04T18:50:03.019Z,1749063003.019 [logger ThreadHandler](INFO): Handler Thread ID is 5455 2025-06-04T18:50:03.031Z,1749063003.031 [CBIT](DEBUG): Initialized mux pins. 2025-06-04T18:50:03.031Z,1749063003.031 [CBIT](DEBUG): Initializing the watchdog timer. 2025-06-04T18:50:03.044Z,1749063003.044 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5456 2025-06-04T18:50:03.055Z,1749063003.055 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-06-04T18:50:03.056Z,1749063003.056 [CBIT](DEBUG): Initializing heartbeat. 2025-06-04T18:50:03.056Z,1749063003.056 [DAT ThreadHandler](INFO): Handler Thread ID is 5457 2025-06-04T18:50:03.057Z,1749063003.057 [DAT](INFO): Powering up 2025-06-04T18:50:03.057Z,1749063003.057 [DAT](DEBUG): Initializing DAT. 2025-06-04T18:50:03.061Z,1749063003.061 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5459 2025-06-04T18:50:03.063Z,1749063003.063 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-06-04T18:50:03.084Z,1749063003.084 [Onboard ThreadHandler](INFO): Handler Thread ID is 5460 2025-06-04T18:50:03.101Z,1749063003.101 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5461 2025-06-04T18:50:03.114Z,1749063003.114 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5462 2025-06-04T18:50:03.114Z,1749063003.114 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-06-04T18:50:03.128Z,1749063003.128 [CBIT](DEBUG): Deactivating emergency mode. 2025-06-04T18:50:03.128Z,1749063003.128 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5464 2025-06-04T18:50:03.132Z,1749063003.132 [WetLabsBB2FL](INFO): Powering up 2025-06-04T18:50:03.133Z,1749063003.133 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5466 2025-06-04T18:50:03.135Z,1749063003.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-06-04T18:50:03.136Z,1749063003.136 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-06-04T18:50:03.136Z,1749063003.136 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-06-04T18:50:03.136Z,1749063003.136 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-06-04T18:50:03.136Z,1749063003.136 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-06-04T18:50:03.136Z,1749063003.136 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-06-04T18:50:03.136Z,1749063003.136 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-06-04T18:50:03.137Z,1749063003.137 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-06-04T18:50:03.167Z,1749063003.167 [CBIT](DEBUG): Backplane powered. 2025-06-04T18:50:03.168Z,1749063003.168 [GFScanner](DEBUG): Initializing GFScanner 2025-06-04T18:50:03.168Z,1749063003.168 [GFScanner](DEBUG): Deactivating GF circuits. 2025-06-04T18:50:03.176Z,1749063003.176 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-06-04T18:50:03.176Z,1749063003.176 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-06-04T18:50:03.177Z,1749063003.177 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-06-04T18:50:03.177Z,1749063003.177 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-06-04T18:50:03.177Z,1749063003.177 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-06-04T18:50:03.178Z,1749063003.178 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-06-04T18:50:03.179Z,1749063003.179 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-06-04T18:50:03.179Z,1749063003.179 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-06-04T18:50:03.181Z,1749063003.181 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-06-04T18:50:03.247Z,1749063003.247 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-06-04T18:50:03.268Z,1749063003.268 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-04T18:50:03.328Z,1749063003.328 [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-06-04T18:50:03.329Z,1749063003.329 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-06-04T18:50:03.329Z,1749063003.329 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-06-04T18:50:03.330Z,1749063003.330 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-06-04T18:50:03.515Z,1749063003.515 [Radio_Surface](INFO): Powering up 2025-06-04T18:50:03.647Z,1749063003.647 [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-06-04T18:50:03.677Z,1749063003.677 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-06-04T18:50:03.678Z,1749063003.678 [Default:A.Wait](DEBUG): Construct Wait. 2025-06-04T18:50:03.688Z,1749063003.688 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-04T18:50:03.710Z,1749063003.710 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-06-04T18:50:03.737Z,1749063003.737 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-06-04T18:50:03.742Z,1749063003.742 [Default:E.Execute](DEBUG): Construct Execute. 2025-06-04T18:50:03.762Z,1749063003.762 [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-06-04T18:50:03.767Z,1749063003.767 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-06-04T18:50:03.790Z,1749063003.790 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-04T18:50:03.848Z,1749063003.848 [Depth_Keller](INFO): Initializing. 2025-06-04T18:50:03.849Z,1749063003.849 [Power24vConverter](INFO): Powering up. 2025-06-04T18:50:03.850Z,1749063003.850 [Sonardyne_Nano](INFO): Initializing. 2025-06-04T18:50:03.896Z,1749063003.896 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-06-04T18:50:03.922Z,1749063003.922 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-04T18:50:03.928Z,1749063003.928 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-04T18:50:03.929Z,1749063003.929 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-04T18:50:03.936Z,1749063003.936 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-04T18:50:03.937Z,1749063003.937 [MassServo](DEBUG): Initializing EZServoServo. 2025-06-04T18:50:03.944Z,1749063003.944 [MassServo](DEBUG): Initializing MassServo. 2025-06-04T18:50:03.944Z,1749063003.944 [RudderServo](DEBUG): Initializing EZServoServo. 2025-06-04T18:50:03.952Z,1749063003.952 [RudderServo](DEBUG): Initializing RudderServo. 2025-06-04T18:50:03.953Z,1749063003.953 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-06-04T18:50:03.960Z,1749063003.960 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-06-04T18:50:03.962Z,1749063003.962 [CommandExec](FAULT): Scheduling is paused 2025-06-04T18:50:03.962Z,1749063003.962 [CBIT](INFO): Critical error at 20250604T184958 2025-06-04T18:50:03.962Z,1749063003.962 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-06-04T18:50:04.241Z,1749063004.241 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-06-04T18:50:04.241Z,1749063004.241 [DropWeight] Hardware Fault, FailCount= 1 2025-06-04T18:50:04.241Z,1749063004.241 [DropWeight](ERROR): Hardware Fault 2025-06-04T18:50:04.320Z,1749063004.320 [CBIT](INFO): Critical error at 20250604T185004 2025-06-04T18:50:04.323Z,1749063004.323 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-06-04T18:50:04.336Z,1749063004.336 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-06-04T18:50:04.618Z,1749063004.618 [CBIT](INFO): Critical error at 20250604T185004 2025-06-04T18:50:05.239Z,1749063005.239 [WetLabsBB2FL](INFO): Powering down 2025-06-04T18:50:05.793Z,1749063005.793 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-04T18:50:07.081Z,1749063007.081 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409 2025-06-04T18:50:07.451Z,1749063007.451 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-06-04T18:50:09.796Z,1749063009.796 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-06-04T18:50:14.648Z,1749063014.648 [DAT](INFO): DAT read: 2025-06-04T18:50:14.649Z,1749063014.649 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-04T18:50:16.160Z,1749063016.160 [DAT](INFO): DAT read: MF Frequency Band 2025-06-04T18:50:16.162Z,1749063016.162 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-04T18:50:16.162Z,1749063016.162 [DAT](INFO): DAT read: Jun 4 2025 18:50:11 2025-06-04T18:50:17.421Z,1749063017.421 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-06-04T18:50:17.422Z,1749063017.422 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-06-04T18:50:17.422Z,1749063017.422 [DAT](INFO): commRate: 800 2025-06-04T18:50:19.487Z,1749063019.487 [DAT](INFO): entering command mode 2025-06-04T18:50:19.688Z,1749063019.688 [DAT](INFO): DAT read: 2025-06-04T18:50:19.689Z,1749063019.689 [DAT](INFO): DAT read: user:1> 2025-06-04T18:50:19.689Z,1749063019.689 [DAT](INFO): setting verbose to 3 2025-06-04T18:50:19.940Z,1749063019.940 [DAT](INFO): DAT read: user:1> 2025-06-04T18:50:19.941Z,1749063019.941 [DAT](INFO): DAT read: Verbose | 3 2025-06-04T18:50:19.942Z,1749063019.942 [DAT](INFO): set verbose to 3 2025-06-04T18:50:19.942Z,1749063019.942 [DAT](INFO): setting DatVerbose to 27440 2025-06-04T18:50:20.192Z,1749063020.192 [DAT](INFO): DAT read: user:2> 2025-06-04T18:50:20.193Z,1749063020.193 [DAT](INFO): DAT read: DatVerbose | 27440 2025-06-04T18:50:20.193Z,1749063020.193 [DAT](INFO): set DatVerbose to 27440 2025-06-04T18:50:20.194Z,1749063020.194 [DAT](INFO): setting transmit power to 8 2025-06-04T18:50:20.444Z,1749063020.444 [DAT](INFO): DAT read: user:3> 2025-06-04T18:50:20.445Z,1749063020.445 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-06-04T18:50:20.446Z,1749063020.446 [DAT](INFO): set transmit power to 8 2025-06-04T18:50:20.446Z,1749063020.446 [DAT](INFO): setting local address to 2 2025-06-04T18:50:20.698Z,1749063020.698 [DAT](INFO): DAT read: user:4> 2025-06-04T18:50:20.699Z,1749063020.699 [DAT](INFO): DAT read: LocalAddr | 2 2025-06-04T18:50:20.700Z,1749063020.700 [DAT](INFO): set local address to 2 2025-06-04T18:50:20.701Z,1749063020.701 [DAT](INFO): Setting time to: 18:50:20 And date to:6/4/2025 2025-06-04T18:50:20.948Z,1749063020.948 [DAT](INFO): DAT read: user:5> 2025-06-04T18:50:20.949Z,1749063020.949 [DAT](INFO): DAT read: Wed Jun 4, 2025 18:50:20 2025-06-04T18:50:20.950Z,1749063020.950 [DAT](INFO): Local DAT time set to Wed Jun 4, 2025 18:50:20 2025-06-04T18:50:31.293Z,1749063031.293 [NAL9602](INFO): Powering up NAL9602 2025-06-04T18:50:42.202Z,1749063042.202 [NAL9602](INFO): NAL9602 initialized 2025-06-04T18:51:09.679Z,1749063069.679 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:51:09.696Z,1749063069.696 [SBIT](IMPORTANT): Beginning Startup BIT 2025-06-04T18:51:09.700Z,1749063069.700 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-04T18:51:14.225Z,1749063074.225 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.016019 CHAN A1 (24V): 0.054449 CHAN A2 (12V): 0.000043 CHAN A3 (5V): -0.002557 CHAN B0 (3.3V): -0.000678 CHAN B1 (3.15aV): -0.001170 CHAN B2 (3.15bV): -0.001190 CHAN B3 (GND): -0.001967 OPEN: 0.004771 Full Scale: +/- 1 mA 2025-06-04T18:51:20.590Z,1749063080.590 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-06-04T18:51:35.219Z,1749063095.219 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T18:51:49.729Z,1749063109.729 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-06-04T18:51:49.925Z,1749063109.925 [CommandExec](IMPORTANT): got command gfisolate 2025-06-04T18:51:50.180Z,1749063110.180 [GFScanner](INFO): Ground fault isolation requested 2025-06-04T18:51:50.180Z,1749063110.180 [GFScanner](IMPORTANT): Starting ground fault isolation process 2025-06-04T18:51:50.180Z,1749063110.180 [GFScanner](INFO): Using most recent scan as baseline - proceeding with component isolation 2025-06-04T18:51:50.584Z,1749063110.584 [Supervisor](DEBUG): Could not find element controlThread.loadControl 2025-06-04T18:51:50.584Z,1749063110.584 [GFScanner](DEBUG): Skipping component controlThread - no load control 2025-06-04T18:51:50.584Z,1749063110.584 [Supervisor](DEBUG): Could not find element CycleStarter.loadControl 2025-06-04T18:51:50.585Z,1749063110.585 [GFScanner](DEBUG): Skipping component CycleStarter - no load control 2025-06-04T18:51:50.585Z,1749063110.585 [Supervisor](DEBUG): Could not find element CommandExec.loadControl 2025-06-04T18:51:50.585Z,1749063110.585 [GFScanner](DEBUG): Skipping component CommandExec - no load control 2025-06-04T18:51:50.586Z,1749063110.586 [Supervisor](DEBUG): Could not find element CommandLine.loadControl 2025-06-04T18:51:50.586Z,1749063110.586 [GFScanner](DEBUG): Skipping component CommandLine - no load control 2025-06-04T18:51:50.586Z,1749063110.586 [Supervisor](DEBUG): Could not find element logger.loadControl 2025-06-04T18:51:50.586Z,1749063110.586 [GFScanner](DEBUG): Skipping component logger - no load control 2025-06-04T18:51:50.587Z,1749063110.587 [Supervisor](DEBUG): Could not find element LogSplitter.loadControl 2025-06-04T18:51:50.587Z,1749063110.587 [GFScanner](DEBUG): Skipping component LogSplitter - no load control 2025-06-04T18:51:50.588Z,1749063110.588 [Supervisor](DEBUG): Could not find element Config/Dock.loadControl 2025-06-04T18:51:50.588Z,1749063110.588 [GFScanner](DEBUG): Skipping component Config/Dock - no load control 2025-06-04T18:51:50.588Z,1749063110.588 [Supervisor](DEBUG): Could not find element Config/Derivation.loadControl 2025-06-04T18:51:50.588Z,1749063110.588 [GFScanner](DEBUG): Skipping component Config/Derivation - no load control 2025-06-04T18:51:50.589Z,1749063110.589 [Supervisor](DEBUG): Could not find element Config/secure.loadControl 2025-06-04T18:51:50.589Z,1749063110.589 [GFScanner](DEBUG): Skipping component Config/secure - no load control 2025-06-04T18:51:50.589Z,1749063110.589 [Supervisor](DEBUG): Could not find element Config/logger.loadControl 2025-06-04T18:51:50.590Z,1749063110.590 [GFScanner](DEBUG): Skipping component Config/logger - no load control 2025-06-04T18:51:50.590Z,1749063110.590 [Supervisor](DEBUG): Could not find element Config/vehicle.loadControl 2025-06-04T18:51:50.590Z,1749063110.590 [GFScanner](DEBUG): Skipping component Config/vehicle - no load control 2025-06-04T18:51:50.590Z,1749063110.590 [Supervisor](DEBUG): Could not find element Config/Estimation.loadControl 2025-06-04T18:51:50.591Z,1749063110.591 [GFScanner](DEBUG): Skipping component Config/Estimation - no load control 2025-06-04T18:51:50.591Z,1749063110.591 [Supervisor](DEBUG): Could not find element Config/Navigation.loadControl 2025-06-04T18:51:50.591Z,1749063110.591 [GFScanner](DEBUG): Skipping component Config/Navigation - no load control 2025-06-04T18:51:50.592Z,1749063110.592 [Supervisor](DEBUG): Could not find element Config/BIT.loadControl 2025-06-04T18:51:50.592Z,1749063110.592 [GFScanner](DEBUG): Skipping component Config/BIT - no load control 2025-06-04T18:51:50.592Z,1749063110.592 [Supervisor](DEBUG): Could not find element Config/Simulator.loadControl 2025-06-04T18:51:50.593Z,1749063110.593 [GFScanner](DEBUG): Skipping component Config/Simulator - no load control 2025-06-04T18:51:50.593Z,1749063110.593 [Supervisor](DEBUG): Could not find element Config/Servo.loadControl 2025-06-04T18:51:50.593Z,1749063110.593 [GFScanner](DEBUG): Skipping component Config/Servo - no load control 2025-06-04T18:51:50.594Z,1749063110.594 [Supervisor](DEBUG): Could not find element Config/Science.loadControl 2025-06-04T18:51:50.594Z,1749063110.594 [GFScanner](DEBUG): Skipping component Config/Science - no load control 2025-06-04T18:51:50.594Z,1749063110.594 [Supervisor](DEBUG): Could not find element Config/workSite.loadControl 2025-06-04T18:51:50.594Z,1749063110.594 [GFScanner](DEBUG): Skipping component Config/workSite - no load control 2025-06-04T18:51:50.595Z,1749063110.595 [Supervisor](DEBUG): Could not find element Config/Sensor.loadControl 2025-06-04T18:51:50.595Z,1749063110.595 [GFScanner](DEBUG): Skipping component Config/Sensor - no load control 2025-06-04T18:51:50.595Z,1749063110.595 [Supervisor](DEBUG): Could not find element Config/Control.loadControl 2025-06-04T18:51:50.596Z,1749063110.596 [GFScanner](DEBUG): Skipping component Config/Control - no load control 2025-06-04T18:51:50.596Z,1749063110.596 [Supervisor](DEBUG): Could not find element Config/Guidance.loadControl 2025-06-04T18:51:50.596Z,1749063110.596 [GFScanner](DEBUG): Skipping component Config/Guidance - no load control 2025-06-04T18:51:50.597Z,1749063110.597 [Supervisor](DEBUG): Could not find element Config/Battery.loadControl 2025-06-04T18:51:50.597Z,1749063110.597 [GFScanner](DEBUG): Skipping component Config/Battery - no load control 2025-06-04T18:51:50.598Z,1749063110.598 [GFScanner](INFO): Testing component AHRS_M2 for ground fault isolation 2025-06-04T18:51:50.598Z,1749063110.598 [GFScanner](INFO): Stopping component AHRS_M2 for ground fault isolation test 2025-06-04T18:51:50.938Z,1749063110.938 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:51.370Z,1749063111.370 [Supervisor](INFO): Attempting to isolate load for component: AHRS_M2 2025-06-04T18:51:51.371Z,1749063111.371 [Supervisor](INFO): Isolating primary load control for AHRS_M2 2025-06-04T18:51:51.373Z,1749063111.373 [Supervisor](INFO): Successfully isolated primary load for component: AHRS_M2 2025-06-04T18:51:51.374Z,1749063111.374 [GFScanner](DEBUG): Successfully isolated load for component AHRS_M2 2025-06-04T18:51:52.156Z,1749063112.156 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:53.366Z,1749063113.366 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:54.578Z,1749063114.578 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:55.790Z,1749063115.790 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:57.001Z,1749063117.001 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:58.221Z,1749063118.221 [AHRS_M2](INFO): Powering down 2025-06-04T18:51:59.430Z,1749063119.430 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:00.638Z,1749063120.638 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:01.486Z,1749063121.486 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:52:01.486Z,1749063121.486 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:52:01.849Z,1749063121.849 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:03.063Z,1749063123.063 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:03.917Z,1749063123.917 [SBIT](IMPORTANT): SBIT PASSED 2025-06-04T18:52:03.917Z,1749063123.917 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): DATMMP.loadAtStartup=0 bool; 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=-0.5 degree; 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.950000 m/s; 2025-06-04T18:52:03.918Z,1749063123.918 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=305.318315 cubic_centimeter; 2025-06-04T18:52:03.919Z,1749063123.919 [SBIT](IMPORTANT): VerticalControl.massDefault=11.64778 millimeter; 2025-06-04T18:52:04.274Z,1749063124.274 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:04.326Z,1749063124.326 [MissionManager](IMPORTANT): Started mission Startup 2025-06-04T18:52:04.326Z,1749063124.326 [Startup] Running Loop=1 2025-06-04T18:52:04.326Z,1749063124.326 [Startup](DEBUG): Aggregate::initialize Startup 2025-06-04T18:52:04.327Z,1749063124.327 [Startup:A.GoToSurface] Running Loop=1 2025-06-04T18:52:04.327Z,1749063124.327 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-04T18:52:04.328Z,1749063124.328 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-04T18:52:04.328Z,1749063124.328 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-04T18:52:04.329Z,1749063124.329 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-04T18:52:04.329Z,1749063124.329 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-04T18:52:04.329Z,1749063124.329 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-04T18:52:04.330Z,1749063124.330 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-04T18:52:04.332Z,1749063124.332 [Startup:StartupSatComms] Running Loop=1 2025-06-04T18:52:04.332Z,1749063124.332 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-06-04T18:52:04.332Z,1749063124.332 [Startup:StartupSatComms:A] Running Loop=1 2025-06-04T18:52:04.720Z,1749063124.720 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-06-04T18:52:05.485Z,1749063125.485 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:05.959Z,1749063125.959 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.018744 CHAN A1 (24V): 0.054126 CHAN A2 (12V): 0.000593 CHAN A3 (5V): -0.002430 CHAN B0 (3.3V): -0.002317 CHAN B1 (3.15aV): -0.001528 CHAN B2 (3.15bV): -0.001435 CHAN B3 (GND): -0.001966 OPEN: 0.004252 Full Scale: +/- 1 mA 2025-06-04T18:52:06.698Z,1749063126.698 [AHRS_M2](INFO): Powering down 2025-06-04T18:52:06.894Z,1749063126.894 [GFScanner](IMPORTANT): Component AHRS_M2 is no longer stopped (state: 12), failing component and retrying scan 2025-06-04T18:52:06.894Z,1749063126.894 [AHRS_M2] Hardware Fault, FailCount= 1 2025-06-04T18:52:06.894Z,1749063126.894 [AHRS_M2](ERROR): Hardware Fault 2025-06-04T18:52:07.251Z,1749063127.251 [CBIT](ERROR): Hardware Fault in component: AHRS_M2 2025-06-04T18:52:14.722Z,1749063134.722 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004884 2025-06-04T18:52:17.230Z,1749063137.230 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:52:17.230Z,1749063137.230 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:52:21.689Z,1749063141.689 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.018903 CHAN A1 (24V): 0.054605 CHAN A2 (12V): 0.000318 CHAN A3 (5V): -0.002290 CHAN B0 (3.3V): -0.000595 CHAN B1 (3.15aV): -0.001429 CHAN B2 (3.15bV): -0.001164 CHAN B3 (GND): -0.002222 OPEN: 0.004373 Full Scale: +/- 1 mA 2025-06-04T18:52:22.889Z,1749063142.889 [GFScanner](INFO): Component AHRS_M2 is failed, CBIT will restart after scan 2025-06-04T18:52:22.889Z,1749063142.889 [Supervisor](INFO): Attempting to de-isolate load for component: AHRS_M2 2025-06-04T18:52:22.890Z,1749063142.890 [Supervisor](INFO): De-isolating primary load control for AHRS_M2 2025-06-04T18:52:22.893Z,1749063142.893 [Supervisor](INFO): Successfully de-isolated primary load for component: AHRS_M2 2025-06-04T18:52:22.893Z,1749063142.893 [GFScanner](DEBUG): Successfully de-isolated load for component AHRS_M2 2025-06-04T18:52:22.893Z,1749063142.893 [GFScanner](INFO): Component AHRS_M2 processing complete 2025-06-04T18:52:23.302Z,1749063143.302 [GFScanner](INFO): Testing component BackseatComponent for ground fault isolation 2025-06-04T18:52:23.302Z,1749063143.302 [GFScanner](INFO): Component BackseatComponent is not running, proceeding to isolation 2025-06-04T18:52:23.303Z,1749063143.303 [Supervisor](INFO): Attempting to isolate load for component: BackseatComponent 2025-06-04T18:52:23.304Z,1749063143.304 [Supervisor](INFO): Isolating primary load control for BackseatComponent 2025-06-04T18:52:23.306Z,1749063143.306 [Supervisor](INFO): Successfully isolated primary load for component: BackseatComponent 2025-06-04T18:52:23.307Z,1749063143.307 [GFScanner](DEBUG): Successfully isolated load for component BackseatComponent 2025-06-04T18:52:29.800Z,1749063149.800 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:52:33.385Z,1749063153.385 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:52:33.386Z,1749063153.386 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:52:37.848Z,1749063157.848 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.018479 CHAN A1 (24V): 0.054479 CHAN A2 (12V): -0.000072 CHAN A3 (5V): -0.002510 CHAN B0 (3.3V): -0.001323 CHAN B1 (3.15aV): -0.001229 CHAN B2 (3.15bV): -0.001061 CHAN B3 (GND): -0.002498 OPEN: 0.004732 Full Scale: +/- 1 mA 2025-06-04T18:52:39.049Z,1749063159.049 [Supervisor](INFO): Attempting to de-isolate load for component: BackseatComponent 2025-06-04T18:52:39.049Z,1749063159.049 [Supervisor](INFO): De-isolating primary load control for BackseatComponent 2025-06-04T18:52:39.052Z,1749063159.052 [Supervisor](INFO): Successfully de-isolated primary load for component: BackseatComponent 2025-06-04T18:52:39.053Z,1749063159.053 [GFScanner](DEBUG): Successfully de-isolated load for component BackseatComponent 2025-06-04T18:52:39.053Z,1749063159.053 [GFScanner](INFO): Component BackseatComponent processing complete 2025-06-04T18:52:39.446Z,1749063159.446 [Supervisor](DEBUG): Could not find element LcmUniversalReporter.loadControl 2025-06-04T18:52:39.446Z,1749063159.446 [GFScanner](DEBUG): Skipping component LcmUniversalReporter - no load control 2025-06-04T18:52:39.446Z,1749063159.446 [Supervisor](DEBUG): Could not find element BioacousticsDataBridge.loadControl 2025-06-04T18:52:39.447Z,1749063159.447 [GFScanner](DEBUG): Skipping component BioacousticsDataBridge - no load control 2025-06-04T18:52:39.447Z,1749063159.447 [Supervisor](DEBUG): Could not find element BPC1.loadControl 2025-06-04T18:52:39.466Z,1749063159.466 [GFScanner](DEBUG): Skipping component BPC1 - no load control 2025-06-04T18:52:39.467Z,1749063159.467 [GFScanner](INFO): Testing component DAT for ground fault isolation 2025-06-04T18:52:39.467Z,1749063159.467 [GFScanner](INFO): Stopping component DAT for ground fault isolation test 2025-06-04T18:52:39.624Z,1749063159.624 [DAT](INFO): Powering down 2025-06-04T18:52:39.901Z,1749063159.901 [Supervisor](INFO): Attempting to isolate load for component: DAT 2025-06-04T18:52:39.902Z,1749063159.902 [Supervisor](INFO): Isolating primary load control for DAT 2025-06-04T18:52:39.909Z,1749063159.909 [Supervisor](INFO): Successfully isolated primary load for component: DAT 2025-06-04T18:52:39.909Z,1749063159.909 [GFScanner](DEBUG): Successfully isolated load for component DAT 2025-06-04T18:52:40.380Z,1749063160.380 [DAT](INFO): Powering down 2025-06-04T18:52:41.140Z,1749063161.140 [DAT](INFO): Powering down 2025-06-04T18:52:41.896Z,1749063161.896 [DAT](INFO): Powering down 2025-06-04T18:52:42.903Z,1749063162.903 [DAT](INFO): Powering down 2025-06-04T18:52:43.659Z,1749063163.659 [DAT](INFO): Powering down 2025-06-04T18:52:43.926Z,1749063163.926 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T18:52:44.416Z,1749063164.416 [DAT](INFO): Powering down 2025-06-04T18:52:45.171Z,1749063165.171 [DAT](INFO): Powering down 2025-06-04T18:52:46.179Z,1749063166.179 [DAT](INFO): Powering down 2025-06-04T18:52:46.936Z,1749063166.936 [DAT](INFO): Powering down 2025-06-04T18:52:47.691Z,1749063167.691 [DAT](INFO): Powering down 2025-06-04T18:52:48.448Z,1749063168.448 [DAT](INFO): Powering down 2025-06-04T18:52:49.204Z,1749063169.204 [DAT](INFO): Powering down 2025-06-04T18:52:49.953Z,1749063169.953 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:52:49.953Z,1749063169.953 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:52:49.959Z,1749063169.959 [DAT](INFO): Powering down 2025-06-04T18:52:50.968Z,1749063170.968 [DAT](INFO): Powering down 2025-06-04T18:52:51.724Z,1749063171.724 [DAT](INFO): Powering down 2025-06-04T18:52:52.480Z,1749063172.480 [DAT](INFO): Powering down 2025-06-04T18:52:53.236Z,1749063173.236 [DAT](INFO): Powering down 2025-06-04T18:52:53.992Z,1749063173.992 [DAT](INFO): Powering down 2025-06-04T18:52:54.397Z,1749063174.397 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.019443 CHAN A1 (24V): 0.054452 CHAN A2 (12V): 0.000015 CHAN A3 (5V): -0.001466 CHAN B0 (3.3V): -0.000490 CHAN B1 (3.15aV): -0.001832 CHAN B2 (3.15bV): -0.001521 CHAN B3 (GND): -0.001923 OPEN: 0.003678 Full Scale: +/- 1 mA 2025-06-04T18:52:54.999Z,1749063174.999 [DAT](INFO): Powering down 2025-06-04T18:52:55.213Z,1749063175.213 [GFScanner](IMPORTANT): Component DAT is no longer stopped (state: 12), failing component and retrying scan 2025-06-04T18:52:55.213Z,1749063175.213 [DAT] Hardware Fault, FailCount= 1 2025-06-04T18:52:55.213Z,1749063175.213 [DAT](ERROR): Hardware Fault 2025-06-04T18:52:55.605Z,1749063175.605 [CBIT](ERROR): Hardware Fault in component: DAT 2025-06-04T18:53:03.287Z,1749063183.287 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-06-04T18:53:03.287Z,1749063183.287 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-04T18:53:03.298Z,1749063183.298 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-04T18:53:04.481Z,1749063184.481 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-04T18:52:04.3Z 2025-06-04T18:53:04.481Z,1749063184.481 [Startup:StartupSatComms:A] Stopped 2025-06-04T18:53:04.481Z,1749063184.481 [Startup:StartupSatComms:B] Running Loop=1 2025-06-04T18:53:04.883Z,1749063184.883 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-04T18:53:05.301Z,1749063185.301 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:53:05.301Z,1749063185.301 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:53:09.771Z,1749063189.771 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.019509 CHAN A1 (24V): 0.054199 CHAN A2 (12V): -0.000000 CHAN A3 (5V): -0.001869 CHAN B0 (3.3V): -0.001234 CHAN B1 (3.15aV): -0.001150 CHAN B2 (3.15bV): -0.001461 CHAN B3 (GND): -0.002551 OPEN: 0.003729 Full Scale: +/- 1 mA 2025-06-04T18:53:10.968Z,1749063190.968 [GFScanner](INFO): Component DAT is failed, CBIT will restart after scan 2025-06-04T18:53:10.969Z,1749063190.969 [Supervisor](INFO): Attempting to de-isolate load for component: DAT 2025-06-04T18:53:10.969Z,1749063190.969 [Supervisor](INFO): De-isolating primary load control for DAT 2025-06-04T18:53:10.972Z,1749063190.972 [Supervisor](INFO): Successfully de-isolated primary load for component: DAT 2025-06-04T18:53:10.972Z,1749063190.972 [GFScanner](DEBUG): Successfully de-isolated load for component DAT 2025-06-04T18:53:10.973Z,1749063190.973 [GFScanner](INFO): Component DAT processing complete 2025-06-04T18:53:11.362Z,1749063191.362 [Supervisor](DEBUG): Could not find element DataOverHttps.loadControl 2025-06-04T18:53:11.362Z,1749063191.362 [GFScanner](DEBUG): Skipping component DataOverHttps - no load control 2025-06-04T18:53:11.363Z,1749063191.363 [GFScanner](IMPORTANT): Skipping component Depth_Keller, isolate manually if desired 2025-06-04T18:53:11.364Z,1749063191.364 [Supervisor](DEBUG): Could not find element DropWeight.loadControl 2025-06-04T18:53:11.364Z,1749063191.364 [GFScanner](DEBUG): Skipping component DropWeight - no load control 2025-06-04T18:53:11.365Z,1749063191.365 [GFScanner](INFO): Testing component NAL9602 for ground fault isolation 2025-06-04T18:53:11.365Z,1749063191.365 [GFScanner](INFO): Stopping component NAL9602 for ground fault isolation test 2025-06-04T18:53:11.419Z,1749063191.419 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250604T183255/Courier0007.lzma 2025-06-04T18:53:11.749Z,1749063191.749 [NAL9602](INFO): Powering down 2025-06-04T18:53:12.175Z,1749063192.175 [Supervisor](INFO): Attempting to isolate load for component: NAL9602 2025-06-04T18:53:12.175Z,1749063192.175 [Supervisor](INFO): Isolating primary load control for NAL9602 2025-06-04T18:53:12.178Z,1749063192.178 [Supervisor](INFO): Successfully isolated primary load for component: NAL9602 2025-06-04T18:53:12.178Z,1749063192.178 [GFScanner](DEBUG): Successfully isolated load for component NAL9602 2025-06-04T18:53:12.422Z,1749063192.422 [DataOverHttps](INFO): Moved sent file to Logs/20250604T183255/Courier0007.lzma.bak 2025-06-04T18:53:12.422Z,1749063192.422 [DataOverHttps](INFO): SBD MOMSN=25097420 2025-06-04T18:53:12.960Z,1749063192.960 [NAL9602](INFO): Powering down 2025-06-04T18:53:14.190Z,1749063194.190 [NAL9602](INFO): Powering down 2025-06-04T18:53:14.639Z,1749063194.639 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:53:15.400Z,1749063195.400 [NAL9602](INFO): Powering down 2025-06-04T18:53:16.592Z,1749063196.592 [NAL9602](INFO): Powering down 2025-06-04T18:53:17.804Z,1749063197.804 [NAL9602](INFO): Powering down 2025-06-04T18:53:19.020Z,1749063199.020 [NAL9602](INFO): Powering down 2025-06-04T18:53:20.236Z,1749063200.236 [NAL9602](INFO): Powering down 2025-06-04T18:53:21.444Z,1749063201.444 [NAL9602](INFO): Powering down 2025-06-04T18:53:22.276Z,1749063202.276 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:53:22.276Z,1749063202.276 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:53:22.656Z,1749063202.656 [NAL9602](INFO): Powering down 2025-06-04T18:53:23.864Z,1749063203.864 [NAL9602](INFO): Powering down 2025-06-04T18:53:25.092Z,1749063205.092 [NAL9602](INFO): Powering down 2025-06-04T18:53:26.293Z,1749063206.293 [NAL9602](INFO): Powering down 2025-06-04T18:53:26.740Z,1749063206.740 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.020039 CHAN A1 (24V): 0.054117 CHAN A2 (12V): 0.000540 CHAN A3 (5V): -0.001344 CHAN B0 (3.3V): -0.000637 CHAN B1 (3.15aV): -0.001473 CHAN B2 (3.15bV): -0.001574 CHAN B3 (GND): -0.002279 OPEN: 0.004718 Full Scale: +/- 1 mA 2025-06-04T18:53:27.504Z,1749063207.504 [NAL9602](INFO): Powering down 2025-06-04T18:53:27.521Z,1749063207.521 [GFScanner](IMPORTANT): Component NAL9602 is no longer stopped (state: 12), failing component and retrying scan 2025-06-04T18:53:27.522Z,1749063207.522 [NAL9602] Hardware Fault, FailCount= 1 2025-06-04T18:53:27.522Z,1749063207.522 [NAL9602](ERROR): Hardware Fault 2025-06-04T18:53:27.868Z,1749063207.868 [DataOverHttps](INFO): Sending 300 bytes from file Logs/20250604T184952/Courier0000.lzma 2025-06-04T18:53:27.932Z,1749063207.932 [CBIT](ERROR): Hardware Fault in component: NAL9602 2025-06-04T18:53:28.768Z,1749063208.768 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T18:53:28.869Z,1749063208.869 [DataOverHttps](INFO): Moved sent file to Logs/20250604T184952/Courier0000.lzma.bak 2025-06-04T18:53:28.869Z,1749063208.869 [DataOverHttps](INFO): SBD MOMSN=25097428 2025-06-04T18:53:37.624Z,1749063217.624 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:53:37.624Z,1749063217.624 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:53:42.070Z,1749063222.070 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.020151 CHAN A1 (24V): 0.054117 CHAN A2 (12V): 0.000521 CHAN A3 (5V): -0.001913 CHAN B0 (3.3V): -0.001903 CHAN B1 (3.15aV): -0.001685 CHAN B2 (3.15bV): -0.001711 CHAN B3 (GND): -0.002166 OPEN: 0.004794 Full Scale: +/- 1 mA 2025-06-04T18:53:43.317Z,1749063223.317 [GFScanner](INFO): Component NAL9602 is failed, CBIT will restart after scan 2025-06-04T18:53:43.318Z,1749063223.318 [Supervisor](INFO): Attempting to de-isolate load for component: NAL9602 2025-06-04T18:53:43.318Z,1749063223.318 [Supervisor](INFO): De-isolating primary load control for NAL9602 2025-06-04T18:53:43.321Z,1749063223.321 [Supervisor](INFO): Successfully de-isolated primary load for component: NAL9602 2025-06-04T18:53:43.321Z,1749063223.321 [GFScanner](DEBUG): Successfully de-isolated load for component NAL9602 2025-06-04T18:53:43.321Z,1749063223.321 [GFScanner](INFO): Component NAL9602 processing complete 2025-06-04T18:53:43.739Z,1749063223.739 [Supervisor](DEBUG): Could not find element Onboard.loadControl 2025-06-04T18:53:43.740Z,1749063223.740 [GFScanner](DEBUG): Skipping component Onboard - no load control 2025-06-04T18:53:43.741Z,1749063223.741 [GFScanner](IMPORTANT): Skipping component Power24vConverter, isolate manually if desired 2025-06-04T18:53:43.742Z,1749063223.742 [GFScanner](INFO): Testing component Radio_Surface for ground fault isolation 2025-06-04T18:53:43.742Z,1749063223.742 [GFScanner](INFO): Stopping component Radio_Surface for ground fault isolation test 2025-06-04T18:53:43.763Z,1749063223.763 [Radio_Surface](INFO): Powering down 2025-06-04T18:53:44.200Z,1749063224.200 [DataOverHttps](INFO): Sending 355 bytes from file Logs/20250604T183255/Express0008.lzma 2025-06-04T18:53:44.567Z,1749063224.567 [Supervisor](INFO): Attempting to isolate load for component: Radio_Surface 2025-06-04T18:53:44.568Z,1749063224.568 [Supervisor](INFO): Isolating primary load control for Radio_Surface 2025-06-04T18:53:44.570Z,1749063224.570 [Supervisor](INFO): Successfully isolated primary load for component: Radio_Surface 2025-06-04T18:53:44.570Z,1749063224.570 [GFScanner](DEBUG): Successfully isolated load for component Radio_Surface 2025-06-04T18:53:49.825Z,1749063229.825 [Radio_Surface](INFO): Powering down 2025-06-04T18:53:54.593Z,1749063234.593 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:53:54.593Z,1749063234.593 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:53:55.884Z,1749063235.884 [Radio_Surface](INFO): Powering down 2025-06-04T18:53:59.125Z,1749063239.125 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:53:59.146Z,1749063239.146 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.021333 CHAN A1 (24V): 0.054649 CHAN A2 (12V): -0.000060 CHAN A3 (5V): -0.002210 CHAN B0 (3.3V): -0.000970 CHAN B1 (3.15aV): -0.000643 CHAN B2 (3.15bV): -0.000678 CHAN B3 (GND): -0.001913 OPEN: 0.004549 Full Scale: +/- 1 mA 2025-06-04T18:54:00.269Z,1749063240.269 [Supervisor](INFO): Attempting to de-isolate load for component: Radio_Surface 2025-06-04T18:54:00.270Z,1749063240.270 [Supervisor](INFO): De-isolating primary load control for Radio_Surface 2025-06-04T18:54:00.273Z,1749063240.273 [Supervisor](INFO): Successfully de-isolated primary load for component: Radio_Surface 2025-06-04T18:54:00.273Z,1749063240.273 [GFScanner](DEBUG): Successfully de-isolated load for component Radio_Surface 2025-06-04T18:54:00.273Z,1749063240.273 [GFScanner](INFO): Restarting component Radio_Surface after ground fault isolation test 2025-06-04T18:54:00.328Z,1749063240.328 [Radio_Surface](INFO): Powering up 2025-06-04T18:54:00.653Z,1749063240.653 [GFScanner](INFO): Component Radio_Surface processing complete 2025-06-04T18:54:01.055Z,1749063241.055 [GFScanner](INFO): Testing component Sonardyne_Nano for ground fault isolation 2025-06-04T18:54:01.055Z,1749063241.055 [GFScanner](INFO): Stopping component Sonardyne_Nano for ground fault isolation test 2025-06-04T18:54:01.441Z,1749063241.441 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:01.861Z,1749063241.861 [Supervisor](INFO): Attempting to isolate load for component: Sonardyne_Nano 2025-06-04T18:54:01.861Z,1749063241.861 [Supervisor](INFO): Isolating primary load control for Sonardyne_Nano 2025-06-04T18:54:01.864Z,1749063241.864 [Supervisor](INFO): Successfully isolated primary load for component: Sonardyne_Nano 2025-06-04T18:54:01.864Z,1749063241.864 [GFScanner](DEBUG): Successfully isolated load for component Sonardyne_Nano 2025-06-04T18:54:02.655Z,1749063242.655 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:03.861Z,1749063243.861 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:04.678Z,1749063244.678 [Startup:StartupSatComms:B](INFO): Timed out from 2025-06-04T18:53:04.5Z 2025-06-04T18:54:04.678Z,1749063244.678 [Startup:StartupSatComms:B] Stopped 2025-06-04T18:54:04.678Z,1749063244.678 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-06-04T18:54:04.678Z,1749063244.678 [Startup:StartupSatComms] Stopped 2025-06-04T18:54:04.678Z,1749063244.678 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-06-04T18:54:04.704Z,1749063244.704 [Startup](INFO): Completed Startup 2025-06-04T18:54:04.704Z,1749063244.704 [MissionManager](INFO): Startup is completed. 2025-06-04T18:54:04.704Z,1749063244.704 [MissionManager](INFO): Uninitializing Mission Startup 2025-06-04T18:54:04.704Z,1749063244.704 [Startup] Stopped 2025-06-04T18:54:04.704Z,1749063244.704 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-06-04T18:54:04.704Z,1749063244.704 [Startup:A.GoToSurface] Stopped 2025-06-04T18:54:04.704Z,1749063244.704 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-04T18:54:05.073Z,1749063245.073 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:05.084Z,1749063245.084 [MissionManager](IMPORTANT): Started mission Default 2025-06-04T18:54:05.084Z,1749063245.084 [Default] Running Loop=1 2025-06-04T18:54:05.084Z,1749063245.084 [Default](DEBUG): Aggregate::initialize Default 2025-06-04T18:54:05.084Z,1749063245.084 [Default:B.GoToSurface] Running Loop=1 2025-06-04T18:54:05.084Z,1749063245.084 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-04T18:54:05.085Z,1749063245.085 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-04T18:54:05.085Z,1749063245.085 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-04T18:54:05.085Z,1749063245.085 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-04T18:54:05.085Z,1749063245.085 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-04T18:54:05.086Z,1749063245.086 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-04T18:54:05.086Z,1749063245.086 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-04T18:54:05.086Z,1749063245.086 [Default:A.Wait] Running Loop=1 2025-06-04T18:54:05.086Z,1749063245.086 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-06-04T18:54:06.286Z,1749063246.286 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:07.498Z,1749063247.498 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:08.292Z,1749063248.292 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-06-04T18:54:08.713Z,1749063248.713 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:09.925Z,1749063249.925 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:11.137Z,1749063251.137 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:11.959Z,1749063251.959 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:54:11.959Z,1749063251.959 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:54:12.346Z,1749063252.346 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:13.612Z,1749063253.612 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T18:54:13.615Z,1749063253.615 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:14.789Z,1749063254.789 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:15.985Z,1749063255.985 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:16.407Z,1749063256.407 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.021107 CHAN A1 (24V): 0.054039 CHAN A2 (12V): -0.000013 CHAN A3 (5V): -0.002125 CHAN B0 (3.3V): -0.001029 CHAN B1 (3.15aV): -0.001434 CHAN B2 (3.15bV): -0.001100 CHAN B3 (GND): -0.002328 OPEN: 0.004673 Full Scale: +/- 1 mA 2025-06-04T18:54:17.197Z,1749063257.197 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:54:17.213Z,1749063257.213 [GFScanner](IMPORTANT): Component Sonardyne_Nano is no longer stopped (state: 12), failing component and retrying scan 2025-06-04T18:54:17.214Z,1749063257.214 [Sonardyne_Nano] Hardware Fault, FailCount= 1 2025-06-04T18:54:17.214Z,1749063257.214 [Sonardyne_Nano](ERROR): Hardware Fault 2025-06-04T18:54:17.623Z,1749063257.623 [CBIT](ERROR): Hardware Fault in component: Sonardyne_Nano 2025-06-04T18:54:18.414Z,1749063258.414 [Default:A.Wait](INFO): Done Waiting. 2025-06-04T18:54:18.415Z,1749063258.415 [Default:A.Wait] Stopped 2025-06-04T18:54:18.415Z,1749063258.415 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-06-04T18:54:18.816Z,1749063258.816 [Default:CheckIn] Running Loop=1 2025-06-04T18:54:18.816Z,1749063258.816 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-04T18:54:18.816Z,1749063258.816 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-04T18:54:19.230Z,1749063259.230 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-06-04T18:54:27.320Z,1749063267.320 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:54:27.320Z,1749063267.320 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:54:31.766Z,1749063271.766 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.021286 CHAN A1 (24V): 0.054791 CHAN A2 (12V): 0.000378 CHAN A3 (5V): -0.002046 CHAN B0 (3.3V): -0.001451 CHAN B1 (3.15aV): -0.000881 CHAN B2 (3.15bV): -0.001222 CHAN B3 (GND): -0.001780 OPEN: 0.004759 Full Scale: +/- 1 mA 2025-06-04T18:54:32.972Z,1749063272.972 [GFScanner](INFO): Component Sonardyne_Nano is failed, CBIT will restart after scan 2025-06-04T18:54:32.972Z,1749063272.972 [Supervisor](INFO): Attempting to de-isolate load for component: Sonardyne_Nano 2025-06-04T18:54:32.973Z,1749063272.973 [Supervisor](INFO): De-isolating primary load control for Sonardyne_Nano 2025-06-04T18:54:32.975Z,1749063272.975 [Supervisor](INFO): Successfully de-isolated primary load for component: Sonardyne_Nano 2025-06-04T18:54:32.975Z,1749063272.975 [GFScanner](DEBUG): Successfully de-isolated load for component Sonardyne_Nano 2025-06-04T18:54:32.976Z,1749063272.976 [GFScanner](INFO): Component Sonardyne_Nano processing complete 2025-06-04T18:54:33.383Z,1749063273.383 [Supervisor](DEBUG): Could not find element VerticalControl.loadControl 2025-06-04T18:54:33.383Z,1749063273.383 [GFScanner](DEBUG): Skipping component VerticalControl - no load control 2025-06-04T18:54:33.383Z,1749063273.383 [Supervisor](DEBUG): Could not find element HorizontalControl.loadControl 2025-06-04T18:54:33.384Z,1749063273.384 [GFScanner](DEBUG): Skipping component HorizontalControl - no load control 2025-06-04T18:54:33.384Z,1749063273.384 [Supervisor](DEBUG): Could not find element SpeedControl.loadControl 2025-06-04T18:54:33.384Z,1749063273.384 [GFScanner](DEBUG): Skipping component SpeedControl - no load control 2025-06-04T18:54:33.385Z,1749063273.385 [Supervisor](DEBUG): Could not find element LoopControl.loadControl 2025-06-04T18:54:33.385Z,1749063273.385 [GFScanner](DEBUG): Skipping component LoopControl - no load control 2025-06-04T18:54:33.385Z,1749063273.385 [Supervisor](DEBUG): Could not find element DeadReckonUsingMultipleVelocitySources.loadControl 2025-06-04T18:54:33.385Z,1749063273.385 [GFScanner](DEBUG): Skipping component DeadReckonUsingMultipleVelocitySources - no load control 2025-06-04T18:54:33.386Z,1749063273.386 [Supervisor](DEBUG): Could not find element NavChart.loadControl 2025-06-04T18:54:33.386Z,1749063273.386 [GFScanner](DEBUG): Skipping component NavChart - no load control 2025-06-04T18:54:33.386Z,1749063273.386 [Supervisor](DEBUG): Could not find element UniversalFixResidualReporter.loadControl 2025-06-04T18:54:33.387Z,1749063273.387 [GFScanner](DEBUG): Skipping component UniversalFixResidualReporter - no load control 2025-06-04T18:54:33.387Z,1749063273.387 [Supervisor](DEBUG): Could not find element SBIT.loadControl 2025-06-04T18:54:33.387Z,1749063273.387 [GFScanner](DEBUG): Skipping component SBIT - no load control 2025-06-04T18:54:33.388Z,1749063273.388 [Supervisor](DEBUG): Could not find element IBIT.loadControl 2025-06-04T18:54:33.388Z,1749063273.388 [GFScanner](DEBUG): Skipping component IBIT - no load control 2025-06-04T18:54:33.388Z,1749063273.388 [Supervisor](DEBUG): Could not find element CBIT.loadControl 2025-06-04T18:54:33.388Z,1749063273.388 [GFScanner](DEBUG): Skipping component CBIT - no load control 2025-06-04T18:54:33.389Z,1749063273.389 [Supervisor](DEBUG): Could not find element GFScanner.loadControl 2025-06-04T18:54:33.389Z,1749063273.389 [GFScanner](DEBUG): Skipping component GFScanner - no load control 2025-06-04T18:54:33.390Z,1749063273.390 [GFScanner](INFO): Testing component BuoyancyServo for ground fault isolation 2025-06-04T18:54:33.390Z,1749063273.390 [GFScanner](INFO): Component BuoyancyServo is not running, proceeding to isolation 2025-06-04T18:54:33.391Z,1749063273.391 [Supervisor](INFO): Attempting to isolate load for component: BuoyancyServo 2025-06-04T18:54:33.392Z,1749063273.392 [Supervisor](INFO): Isolating primary load control for BuoyancyServo 2025-06-04T18:54:33.394Z,1749063273.394 [Supervisor](INFO): Successfully isolated primary load for component: BuoyancyServo 2025-06-04T18:54:33.394Z,1749063273.394 [GFScanner](DEBUG): Successfully isolated load for component BuoyancyServo 2025-06-04T18:54:35.787Z,1749063275.787 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-06-04T18:54:35.787Z,1749063275.787 [BuoyancyServo](INFO): Powering down 2025-06-04T18:54:39.428Z,1749063279.428 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-06-04T18:54:43.475Z,1749063283.475 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:54:43.475Z,1749063283.475 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:54:47.927Z,1749063287.927 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.021627 CHAN A1 (24V): 0.054193 CHAN A2 (12V): 0.000351 CHAN A3 (5V): -0.001975 CHAN B0 (3.3V): -0.000536 CHAN B1 (3.15aV): -0.001538 CHAN B2 (3.15bV): -0.001390 CHAN B3 (GND): -0.001828 OPEN: 0.003537 Full Scale: +/- 1 mA 2025-06-04T18:54:49.133Z,1749063289.133 [Supervisor](INFO): Attempting to de-isolate load for component: BuoyancyServo 2025-06-04T18:54:49.133Z,1749063289.133 [Supervisor](INFO): De-isolating primary load control for BuoyancyServo 2025-06-04T18:54:49.136Z,1749063289.136 [Supervisor](INFO): Successfully de-isolated primary load for component: BuoyancyServo 2025-06-04T18:54:49.136Z,1749063289.136 [GFScanner](DEBUG): Successfully de-isolated load for component BuoyancyServo 2025-06-04T18:54:49.136Z,1749063289.136 [GFScanner](INFO): Component BuoyancyServo processing complete 2025-06-04T18:54:49.539Z,1749063289.539 [GFScanner](INFO): Testing component ElevatorServo for ground fault isolation 2025-06-04T18:54:49.540Z,1749063289.540 [GFScanner](INFO): Component ElevatorServo is not running, proceeding to isolation 2025-06-04T18:54:49.540Z,1749063289.540 [Supervisor](INFO): Attempting to isolate load for component: ElevatorServo 2025-06-04T18:54:49.541Z,1749063289.541 [Supervisor](INFO): Isolating primary load control for ElevatorServo 2025-06-04T18:54:49.543Z,1749063289.543 [Supervisor](INFO): Successfully isolated primary load for component: ElevatorServo 2025-06-04T18:54:49.543Z,1749063289.543 [GFScanner](DEBUG): Successfully isolated load for component ElevatorServo 2025-06-04T18:54:50.331Z,1749063290.331 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-04T18:54:50.331Z,1749063290.331 [ElevatorServo](INFO): Powering down 2025-06-04T18:54:59.668Z,1749063299.668 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:54:59.668Z,1749063299.668 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:55:04.086Z,1749063304.086 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.020143 CHAN A1 (24V): 0.054363 CHAN A2 (12V): -0.000450 CHAN A3 (5V): -0.002372 CHAN B0 (3.3V): -0.000558 CHAN B1 (3.15aV): -0.001644 CHAN B2 (3.15bV): -0.000852 CHAN B3 (GND): -0.001901 OPEN: 0.004470 Full Scale: +/- 1 mA 2025-06-04T18:55:05.291Z,1749063305.291 [Supervisor](INFO): Attempting to de-isolate load for component: ElevatorServo 2025-06-04T18:55:05.292Z,1749063305.292 [Supervisor](INFO): De-isolating primary load control for ElevatorServo 2025-06-04T18:55:05.295Z,1749063305.295 [Supervisor](INFO): Successfully de-isolated primary load for component: ElevatorServo 2025-06-04T18:55:05.295Z,1749063305.295 [GFScanner](DEBUG): Successfully de-isolated load for component ElevatorServo 2025-06-04T18:55:05.295Z,1749063305.295 [GFScanner](INFO): Component ElevatorServo processing complete 2025-06-04T18:55:05.700Z,1749063305.700 [GFScanner](INFO): Testing component MassServo for ground fault isolation 2025-06-04T18:55:05.701Z,1749063305.701 [GFScanner](INFO): Component MassServo is not running, proceeding to isolation 2025-06-04T18:55:05.701Z,1749063305.701 [Supervisor](INFO): Attempting to isolate load for component: MassServo 2025-06-04T18:55:05.702Z,1749063305.702 [Supervisor](INFO): Isolating primary load control for MassServo 2025-06-04T18:55:05.704Z,1749063305.704 [Supervisor](INFO): Successfully isolated primary load for component: MassServo 2025-06-04T18:55:05.704Z,1749063305.704 [GFScanner](DEBUG): Successfully isolated load for component MassServo 2025-06-04T18:55:06.495Z,1749063306.495 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-06-04T18:55:06.495Z,1749063306.495 [MassServo](INFO): Powering down 2025-06-04T18:55:10.552Z,1749063310.552 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-06-04T18:55:15.812Z,1749063315.812 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:55:15.812Z,1749063315.812 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:55:20.240Z,1749063320.240 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.020044 CHAN A1 (24V): 0.054549 CHAN A2 (12V): 0.000605 CHAN A3 (5V): -0.002172 CHAN B0 (3.3V): -0.000858 CHAN B1 (3.15aV): -0.001176 CHAN B2 (3.15bV): -0.000991 CHAN B3 (GND): -0.002499 OPEN: 0.004830 Full Scale: +/- 1 mA 2025-06-04T18:55:21.448Z,1749063321.448 [Supervisor](INFO): Attempting to de-isolate load for component: MassServo 2025-06-04T18:55:21.448Z,1749063321.448 [Supervisor](INFO): De-isolating primary load control for MassServo 2025-06-04T18:55:21.451Z,1749063321.451 [Supervisor](INFO): Successfully de-isolated primary load for component: MassServo 2025-06-04T18:55:21.451Z,1749063321.451 [GFScanner](DEBUG): Successfully de-isolated load for component MassServo 2025-06-04T18:55:21.452Z,1749063321.452 [GFScanner](INFO): Component MassServo processing complete 2025-06-04T18:55:21.850Z,1749063321.850 [GFScanner](INFO): Testing component RudderServo for ground fault isolation 2025-06-04T18:55:21.850Z,1749063321.850 [GFScanner](INFO): Component RudderServo is not running, proceeding to isolation 2025-06-04T18:55:21.851Z,1749063321.851 [Supervisor](INFO): Attempting to isolate load for component: RudderServo 2025-06-04T18:55:21.852Z,1749063321.852 [Supervisor](INFO): Isolating primary load control for RudderServo 2025-06-04T18:55:21.854Z,1749063321.854 [Supervisor](INFO): Successfully isolated primary load for component: RudderServo 2025-06-04T18:55:21.854Z,1749063321.854 [GFScanner](DEBUG): Successfully isolated load for component RudderServo 2025-06-04T18:55:22.655Z,1749063322.655 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-06-04T18:55:22.655Z,1749063322.655 [RudderServo](INFO): Powering down 2025-06-04T18:55:28.812Z,1749063328.812 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:55:31.959Z,1749063331.959 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:55:31.959Z,1749063331.959 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:55:36.397Z,1749063336.397 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.020016 CHAN A1 (24V): 0.054226 CHAN A2 (12V): 0.000313 CHAN A3 (5V): -0.001504 CHAN B0 (3.3V): -0.000540 CHAN B1 (3.15aV): -0.000844 CHAN B2 (3.15bV): -0.001214 CHAN B3 (GND): -0.002735 OPEN: 0.004570 Full Scale: +/- 1 mA 2025-06-04T18:55:37.609Z,1749063337.609 [Supervisor](INFO): Attempting to de-isolate load for component: RudderServo 2025-06-04T18:55:37.609Z,1749063337.609 [Supervisor](INFO): De-isolating primary load control for RudderServo 2025-06-04T18:55:37.612Z,1749063337.612 [Supervisor](INFO): Successfully de-isolated primary load for component: RudderServo 2025-06-04T18:55:37.612Z,1749063337.612 [GFScanner](DEBUG): Successfully de-isolated load for component RudderServo 2025-06-04T18:55:37.612Z,1749063337.612 [GFScanner](INFO): Component RudderServo processing complete 2025-06-04T18:55:38.014Z,1749063338.014 [GFScanner](INFO): Testing component ThrusterHE for ground fault isolation 2025-06-04T18:55:38.015Z,1749063338.015 [GFScanner](INFO): Component ThrusterHE is not running, proceeding to isolation 2025-06-04T18:55:38.015Z,1749063338.015 [Supervisor](INFO): Attempting to isolate load for component: ThrusterHE 2025-06-04T18:55:38.016Z,1749063338.016 [Supervisor](INFO): Isolating primary load control for ThrusterHE 2025-06-04T18:55:38.018Z,1749063338.018 [Supervisor](INFO): Successfully isolated primary load for component: ThrusterHE 2025-06-04T18:55:38.019Z,1749063338.019 [GFScanner](DEBUG): Successfully isolated load for component ThrusterHE 2025-06-04T18:55:38.816Z,1749063338.816 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-06-04T18:55:38.816Z,1749063338.816 [ThrusterHE](INFO): Powering down 2025-06-04T18:55:41.676Z,1749063341.676 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-06-04T18:55:48.117Z,1749063348.117 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:55:48.117Z,1749063348.117 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:55:48.680Z,1749063348.680 [DataOverHttps](INFO): Sending 355 bytes from file Logs/20250604T183255/Express0008.lzma 2025-06-04T18:55:49.681Z,1749063349.681 [DataOverHttps](INFO): Moved sent file to Logs/20250604T183255/Express0008.lzma.bak 2025-06-04T18:55:49.681Z,1749063349.681 [DataOverHttps](INFO): SBD MOMSN=25097440 2025-06-04T18:55:52.558Z,1749063352.558 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.019255 CHAN A1 (24V): 0.054513 CHAN A2 (12V): 0.000416 CHAN A3 (5V): -0.001818 CHAN B0 (3.3V): -0.000939 CHAN B1 (3.15aV): -0.001497 CHAN B2 (3.15bV): -0.001603 CHAN B3 (GND): -0.001984 OPEN: 0.004521 Full Scale: +/- 1 mA 2025-06-04T18:55:53.767Z,1749063353.767 [Supervisor](INFO): Attempting to de-isolate load for component: ThrusterHE 2025-06-04T18:55:53.768Z,1749063353.768 [Supervisor](INFO): De-isolating primary load control for ThrusterHE 2025-06-04T18:55:53.770Z,1749063353.770 [Supervisor](INFO): Successfully de-isolated primary load for component: ThrusterHE 2025-06-04T18:55:53.770Z,1749063353.770 [GFScanner](DEBUG): Successfully de-isolated load for component ThrusterHE 2025-06-04T18:55:53.771Z,1749063353.771 [GFScanner](INFO): Component ThrusterHE processing complete 2025-06-04T18:55:54.174Z,1749063354.174 [GFScanner](INFO): Testing component CTD_Seabird for ground fault isolation 2025-06-04T18:55:54.175Z,1749063354.175 [GFScanner](INFO): Component CTD_Seabird is not running, proceeding to isolation 2025-06-04T18:55:54.175Z,1749063354.175 [Supervisor](INFO): Attempting to isolate load for component: CTD_Seabird 2025-06-04T18:55:54.176Z,1749063354.176 [Supervisor](INFO): Isolating primary load control for CTD_Seabird 2025-06-04T18:55:54.178Z,1749063354.178 [Supervisor](INFO): Successfully isolated primary load for component: CTD_Seabird 2025-06-04T18:55:54.179Z,1749063354.179 [GFScanner](DEBUG): Successfully isolated load for component CTD_Seabird 2025-06-04T18:55:55.584Z,1749063355.584 [CTD_Seabird](INFO): Powering down 2025-06-04T18:55:58.653Z,1749063358.653 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:56:04.279Z,1749063364.279 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:56:04.279Z,1749063364.279 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:56:08.722Z,1749063368.722 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.019606 CHAN A1 (24V): 0.054714 CHAN A2 (12V): 0.000404 CHAN A3 (5V): -0.001491 CHAN B0 (3.3V): -0.001352 CHAN B1 (3.15aV): -0.001222 CHAN B2 (3.15bV): -0.001206 CHAN B3 (GND): -0.002463 OPEN: 0.004674 Full Scale: +/- 1 mA 2025-06-04T18:56:09.928Z,1749063369.928 [Supervisor](INFO): Attempting to de-isolate load for component: CTD_Seabird 2025-06-04T18:56:09.928Z,1749063369.928 [Supervisor](INFO): De-isolating primary load control for CTD_Seabird 2025-06-04T18:56:09.931Z,1749063369.931 [Supervisor](INFO): Successfully de-isolated primary load for component: CTD_Seabird 2025-06-04T18:56:09.931Z,1749063369.931 [GFScanner](DEBUG): Successfully de-isolated load for component CTD_Seabird 2025-06-04T18:56:09.931Z,1749063369.931 [GFScanner](INFO): Component CTD_Seabird processing complete 2025-06-04T18:56:10.336Z,1749063370.336 [GFScanner](INFO): Skipping component ESPComponent - simulateHardware 2025-06-04T18:56:10.337Z,1749063370.337 [GFScanner](INFO): Testing component PAR_Licor for ground fault isolation 2025-06-04T18:56:10.337Z,1749063370.337 [GFScanner](INFO): Stopping component PAR_Licor for ground fault isolation test 2025-06-04T18:56:15.601Z,1749063375.601 [Supervisor](INFO): Attempting to isolate load for component: PAR_Licor 2025-06-04T18:56:15.601Z,1749063375.601 [Supervisor](INFO): Isolating primary load control for PAR_Licor 2025-06-04T18:56:15.604Z,1749063375.604 [Supervisor](INFO): Successfully isolated primary load for component: PAR_Licor 2025-06-04T18:56:15.604Z,1749063375.604 [GFScanner](DEBUG): Successfully isolated load for component PAR_Licor 2025-06-04T18:56:25.692Z,1749063385.692 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:56:25.692Z,1749063385.692 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:56:30.142Z,1749063390.142 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.020327 CHAN A1 (24V): 0.055176 CHAN A2 (12V): 0.000543 CHAN A3 (5V): -0.001901 CHAN B0 (3.3V): -0.000401 CHAN B1 (3.15aV): -0.001047 CHAN B2 (3.15bV): -0.001496 CHAN B3 (GND): -0.002064 OPEN: 0.004873 Full Scale: +/- 1 mA 2025-06-04T18:56:31.343Z,1749063391.343 [Supervisor](INFO): Attempting to de-isolate load for component: PAR_Licor 2025-06-04T18:56:31.344Z,1749063391.344 [Supervisor](INFO): De-isolating primary load control for PAR_Licor 2025-06-04T18:56:31.347Z,1749063391.347 [Supervisor](INFO): Successfully de-isolated primary load for component: PAR_Licor 2025-06-04T18:56:31.347Z,1749063391.347 [GFScanner](DEBUG): Successfully de-isolated load for component PAR_Licor 2025-06-04T18:56:31.347Z,1749063391.347 [GFScanner](INFO): Restarting component PAR_Licor after ground fault isolation test 2025-06-04T18:56:36.594Z,1749063396.594 [GFScanner](INFO): Component PAR_Licor processing complete 2025-06-04T18:56:37.001Z,1749063397.001 [GFScanner](INFO): Testing component WetLabsBB2FL for ground fault isolation 2025-06-04T18:56:37.002Z,1749063397.002 [GFScanner](INFO): Component WetLabsBB2FL is not running, proceeding to isolation 2025-06-04T18:56:37.002Z,1749063397.002 [Supervisor](INFO): Attempting to isolate load for component: WetLabsBB2FL 2025-06-04T18:56:37.003Z,1749063397.003 [Supervisor](INFO): Isolating primary load control for WetLabsBB2FL 2025-06-04T18:56:37.009Z,1749063397.009 [Supervisor](INFO): Successfully isolated primary load for component: WetLabsBB2FL 2025-06-04T18:56:37.009Z,1749063397.009 [GFScanner](DEBUG): Successfully isolated load for component WetLabsBB2FL 2025-06-04T18:56:44.309Z,1749063404.309 [BPC1](ERROR): BPC1B: No match for serial number FFFF in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-06-04T18:56:47.119Z,1749063407.119 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-06-04T18:56:47.119Z,1749063407.119 [GFScanner](INFO): Beginning ground fault scan 2025-06-04T18:56:51.548Z,1749063411.548 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.021035 CHAN A1 (24V): 0.055378 CHAN A2 (12V): 0.000184 CHAN A3 (5V): -0.001781 CHAN B0 (3.3V): -0.000708 CHAN B1 (3.15aV): -0.000938 CHAN B2 (3.15bV): -0.001384 CHAN B3 (GND): -0.001678 OPEN: 0.004482 Full Scale: +/- 1 mA 2025-06-04T18:56:52.749Z,1749063412.749 [Supervisor](INFO): Attempting to de-isolate load for component: WetLabsBB2FL 2025-06-04T18:56:52.749Z,1749063412.749 [Supervisor](INFO): De-isolating primary load control for WetLabsBB2FL 2025-06-04T18:56:52.752Z,1749063412.752 [Supervisor](INFO): Successfully de-isolated primary load for component: WetLabsBB2FL 2025-06-04T18:56:52.752Z,1749063412.752 [GFScanner](DEBUG): Successfully de-isolated load for component WetLabsBB2FL 2025-06-04T18:56:52.753Z,1749063412.753 [GFScanner](INFO): Component WetLabsBB2FL processing complete 2025-06-04T18:56:53.163Z,1749063413.163 [Supervisor](DEBUG): Could not find element DepthRateCalculator.loadControl 2025-06-04T18:56:53.163Z,1749063413.163 [GFScanner](DEBUG): Skipping component DepthRateCalculator - no load control 2025-06-04T18:56:53.164Z,1749063413.164 [Supervisor](DEBUG): Could not find element PitchRateCalculator.loadControl 2025-06-04T18:56:53.164Z,1749063413.164 [GFScanner](DEBUG): Skipping component PitchRateCalculator - no load control 2025-06-04T18:56:53.164Z,1749063413.164 [Supervisor](DEBUG): Could not find element SpeedCalculator.loadControl 2025-06-04T18:56:53.164Z,1749063413.164 [GFScanner](DEBUG): Skipping component SpeedCalculator - no load control 2025-06-04T18:56:53.165Z,1749063413.165 [Supervisor](DEBUG): Could not find element YawRateCalculator.loadControl 2025-06-04T18:56:53.165Z,1749063413.165 [GFScanner](DEBUG): Skipping component YawRateCalculator - no load control 2025-06-04T18:56:53.165Z,1749063413.165 [Supervisor](DEBUG): Could not find element ElevatorOffsetCalculator.loadControl 2025-06-04T18:56:53.165Z,1749063413.165 [GFScanner](DEBUG): Skipping component ElevatorOffsetCalculator - no load control 2025-06-04T18:56:53.166Z,1749063413.166 [Supervisor](DEBUG): Could not find element MissionManager.loadControl 2025-06-04T18:56:53.166Z,1749063413.166 [GFScanner](DEBUG): Skipping component MissionManager - no load control 2025-06-04T18:56:53.166Z,1749063413.166 [Supervisor](DEBUG): Could not find element Reporter.loadControl 2025-06-04T18:56:53.167Z,1749063413.167 [GFScanner](DEBUG): Skipping component Reporter - no load control 2025-06-04T18:56:53.167Z,1749063413.167 [Supervisor](DEBUG): Could not find element NavChartDb.loadControl 2025-06-04T18:56:53.167Z,1749063413.167 [GFScanner](DEBUG): Skipping component NavChartDb - no load control 2025-06-04T18:56:53.167Z,1749063413.167 [GFScanner](IMPORTANT): Ground fault isolation complete. Any identified components with ground faults have been left isolated. 2025-06-04T18:56:53.167Z,1749063413.167 [GFScanner](INFO): All components tested for ground fault isolation 2025-06-04T18:56:53.558Z,1749063413.558 [GFScanner](IMPORTANT): Ground fault isolation process complete 2025-06-04T18:56:53.964Z,1749063413.964 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-06-04T18:56:53.964Z,1749063413.964 [AHRS_M2] No Fault, FailCount= 1 2025-06-04T18:56:53.964Z,1749063413.964 [CBIT](INFO): Clearing failed state for component DAT 2025-06-04T18:56:53.964Z,1749063413.964 [DAT] No Fault, FailCount= 1 2025-06-04T18:56:53.965Z,1749063413.965 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-04T18:56:53.965Z,1749063413.965 [NAL9602] No Fault, FailCount= 1 2025-06-04T18:56:53.965Z,1749063413.965 [CBIT](INFO): Clearing failed state for component Sonardyne_Nano 2025-06-04T18:56:53.965Z,1749063413.965 [Sonardyne_Nano] No Fault, FailCount= 1 2025-06-04T18:56:53.965Z,1749063413.965 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-04T18:56:53.965Z,1749063413.965 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-06-04T18:56:54.072Z,1749063414.072 [DAT](INFO): Powering down 2025-06-04T18:56:54.347Z,1749063414.347 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-04T18:56:54.360Z,1749063414.360 [NAL9602](INFO): Powering down 2025-06-04T18:56:54.362Z,1749063414.362 [Sonardyne_Nano](INFO): Powering down 2025-06-04T18:56:55.158Z,1749063415.158 [Sonardyne_Nano](INFO): Initializing. 2025-06-04T18:56:57.095Z,1749063417.095 [DAT](INFO): Powering up 2025-06-04T18:56:57.096Z,1749063417.096 [DAT](DEBUG): Initializing DAT. 2025-06-04T18:56:57.178Z,1749063417.178 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-04T18:56:58.859Z,1749063418.859 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:57:08.960Z,1749063428.960 [DAT](INFO): DAT read: 2025-06-04T18:57:08.961Z,1749063428.961 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-04T18:57:10.472Z,1749063430.472 [DAT](INFO): DAT read: MF Frequency Band 2025-06-04T18:57:10.474Z,1749063430.474 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-04T18:57:10.474Z,1749063430.474 [DAT](INFO): DAT read: Jun 4 2025 18:53:44 2025-06-04T18:57:11.481Z,1749063431.481 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-06-04T18:57:11.482Z,1749063431.482 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-06-04T18:57:11.482Z,1749063431.482 [DAT](INFO): commRate: 800 2025-06-04T18:57:13.547Z,1749063433.547 [DAT](INFO): entering command mode 2025-06-04T18:57:13.748Z,1749063433.748 [DAT](INFO): DAT read: 2025-06-04T18:57:13.749Z,1749063433.749 [DAT](INFO): DAT read: user:1> 2025-06-04T18:57:13.749Z,1749063433.749 [DAT](INFO): setting verbose to 3 2025-06-04T18:57:14.000Z,1749063434.000 [DAT](INFO): DAT read: user:1> 2025-06-04T18:57:14.001Z,1749063434.001 [DAT](INFO): DAT read: Verbose | 3 2025-06-04T18:57:14.001Z,1749063434.001 [DAT](INFO): set verbose to 3 2025-06-04T18:57:14.002Z,1749063434.002 [DAT](INFO): setting DatVerbose to 27440 2025-06-04T18:57:14.252Z,1749063434.252 [DAT](INFO): DAT read: user:2> 2025-06-04T18:57:14.253Z,1749063434.253 [DAT](INFO): DAT read: DatVerbose | 27440 2025-06-04T18:57:14.254Z,1749063434.254 [DAT](INFO): set DatVerbose to 27440 2025-06-04T18:57:14.254Z,1749063434.254 [DAT](INFO): setting transmit power to 8 2025-06-04T18:57:14.504Z,1749063434.504 [DAT](INFO): DAT read: user:3> 2025-06-04T18:57:14.505Z,1749063434.505 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-06-04T18:57:14.505Z,1749063434.505 [DAT](INFO): set transmit power to 8 2025-06-04T18:57:14.506Z,1749063434.506 [DAT](INFO): setting local address to 2 2025-06-04T18:57:14.756Z,1749063434.756 [DAT](INFO): DAT read: user:4> 2025-06-04T18:57:14.757Z,1749063434.757 [DAT](INFO): DAT read: LocalAddr | 2 2025-06-04T18:57:14.757Z,1749063434.757 [DAT](INFO): set local address to 2 2025-06-04T18:57:14.758Z,1749063434.758 [DAT](INFO): Setting time to: 18:57:14 And date to:6/4/2025 2025-06-04T18:57:15.008Z,1749063435.008 [DAT](INFO): DAT read: user:5> 2025-06-04T18:57:15.009Z,1749063435.009 [DAT](INFO): DAT read: Wed Jun 4, 2025 18:57:14 2025-06-04T18:57:15.009Z,1749063435.009 [DAT](INFO): Local DAT time set to Wed Jun 4, 2025 18:57:14 2025-06-04T18:57:24.655Z,1749063444.655 [NAL9602](INFO): Powering up NAL9602 2025-06-04T18:57:35.569Z,1749063455.569 [NAL9602](INFO): NAL9602 initialized 2025-06-04T18:57:38.797Z,1749063458.797 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-06-04T18:57:41.673Z,1749063461.673 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:57:45.676Z,1749063465.676 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2025-06-04T18:58:00.264Z,1749063480.264 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-04T18:58:11.173Z,1749063491.173 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:58:25.717Z,1749063505.717 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-04T18:58:39.802Z,1749063519.802 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4A50. 2025-06-04T18:58:39.802Z,1749063519.802 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6. 2025-06-04T18:58:39.806Z,1749063519.806 [BPC1](INFO): Received data from all battery sticks. 2025-06-04T18:59:19.026Z,1749063559.026 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-04T18:54:18.8Z 2025-06-04T18:59:19.026Z,1749063559.026 [Default:CheckIn:Read_GPS] Stopped 2025-06-04T18:59:19.026Z,1749063559.026 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-04T18:59:19.413Z,1749063559.413 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-04T18:59:20.342Z,1749063560.342 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250604T184952/Courier0004.lzma 2025-06-04T18:59:21.329Z,1749063561.329 [DataOverHttps](INFO): Moved sent file to Logs/20250604T184952/Courier0004.lzma.bak 2025-06-04T18:59:21.329Z,1749063561.329 [DataOverHttps](INFO): SBD MOMSN=25097498 2025-06-04T18:59:36.934Z,1749063576.934 [DataOverHttps](INFO): Sending 1013 bytes from file Logs/20250604T184952/Express0001.lzma 2025-06-04T18:59:37.933Z,1749063577.933 [DataOverHttps](INFO): Moved sent file to Logs/20250604T184952/Express0001.lzma.bak 2025-06-04T18:59:37.933Z,1749063577.933 [DataOverHttps](INFO): SBD MOMSN=25097501 2025-06-04T18:59:53.544Z,1749063593.544 [DataOverHttps](INFO): Sending 415 bytes from file Logs/20250604T184952/Express0005.lzma 2025-06-04T18:59:54.549Z,1749063594.549 [DataOverHttps](INFO): Moved sent file to Logs/20250604T184952/Express0005.lzma.bak 2025-06-04T18:59:54.550Z,1749063594.550 [DataOverHttps](INFO): SBD MOMSN=25097527 2025-06-04T18:59:54.621Z,1749063594.621 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-06-04T18:59:54.622Z,1749063594.622 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-04T18:59:54.632Z,1749063594.632 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-04T18:59:55.022Z,1749063595.022 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-04T18:59:55.022Z,1749063595.022 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-06-04T18:59:55.804Z,1749063595.804 [Default:CheckIn:Read_Iridium] Stopped 2025-06-04T18:59:55.805Z,1749063595.805 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-04T18:59:55.805Z,1749063595.805 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-04T19:00:43.464Z,1749063643.464 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-04T19:00:43.464Z,1749063643.464 [NAL9602] Data Fault, FailCount= 2 2025-06-04T19:00:43.464Z,1749063643.464 [NAL9602](ERROR): Data Fault 2025-06-04T19:00:43.481Z,1749063643.481 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-04T19:00:43.873Z,1749063643.873 [NAL9602](INFO): Powering down 2025-06-04T19:00:44.708Z,1749063644.708 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-04T19:00:44.708Z,1749063644.708 [NAL9602] No Fault, FailCount= 2 2025-06-04T19:01:14.173Z,1749063674.173 [NAL9602](INFO): Powering up NAL9602 2025-06-04T19:01:25.081Z,1749063685.081 [NAL9602](INFO): NAL9602 initialized 2025-06-04T19:02:20.513Z,1749063740.513 [CommandExec](IMPORTANT): got command restart application 2025-06-04T19:02:21.516Z,1749063741.516 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:21.516Z,1749063741.516 [CommandExec](INFO): Uninitializing the command executive. 2025-06-04T19:02:21.516Z,1749063741.516 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-04T19:02:21.516Z,1749063741.516 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:21.683Z,1749063741.683 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-04T19:02:21.684Z,1749063741.684 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-04T19:02:21.684Z,1749063741.684 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:21.684Z,1749063741.684 [NavChartDb](INFO): Join timeout helper Thread ID is 5498 2025-06-04T19:02:21.744Z,1749063741.744 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:21.744Z,1749063741.744 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:21.756Z,1749063741.756 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-06-04T19:02:21.756Z,1749063741.756 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:21.756Z,1749063741.756 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5499 2025-06-04T19:02:21.764Z,1749063741.764 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:21.764Z,1749063741.764 [WetLabsBB2FL](INFO): Powering down 2025-06-04T19:02:21.765Z,1749063741.765 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:21.765Z,1749063741.765 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-06-04T19:02:21.765Z,1749063741.765 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:21.766Z,1749063741.766 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5500 2025-06-04T19:02:22.196Z,1749063742.196 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:22.196Z,1749063742.196 [CTD_Seabird](INFO): Powering down 2025-06-04T19:02:22.207Z,1749063742.207 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:22.211Z,1749063742.211 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-04T19:02:22.211Z,1749063742.211 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:22.212Z,1749063742.212 [Radio_Surface](INFO): Join timeout helper Thread ID is 5501 2025-06-04T19:02:22.540Z,1749063742.540 [Radio_Surface](INFO): Powering down 2025-06-04T19:02:22.540Z,1749063742.540 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:22.541Z,1749063742.541 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:22.555Z,1749063742.555 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-06-04T19:02:22.555Z,1749063742.555 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:22.556Z,1749063742.556 [Onboard](INFO): Join timeout helper Thread ID is 5502 2025-06-04T19:02:23.052Z,1749063743.052 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-06-04T19:02:23.712Z,1749063743.712 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:23.712Z,1749063743.712 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:23.716Z,1749063743.716 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-06-04T19:02:23.716Z,1749063743.716 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:23.717Z,1749063743.717 [DataOverHttps](INFO): Join timeout helper Thread ID is 5503 2025-06-04T19:02:24.056Z,1749063744.056 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:24.056Z,1749063744.056 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.068Z,1749063744.068 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-06-04T19:02:24.069Z,1749063744.069 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.069Z,1749063744.069 [DAT](INFO): Join timeout helper Thread ID is 5504 2025-06-04T19:02:24.259Z,1749063744.259 [DAT](INFO): Powering down 2025-06-04T19:02:24.337Z,1749063744.337 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:24.337Z,1749063744.337 [DAT](INFO): Powering down 2025-06-04T19:02:24.338Z,1749063744.338 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.352Z,1749063744.352 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-06-04T19:02:24.352Z,1749063744.352 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.353Z,1749063744.353 [BackseatComponent](INFO): Join timeout helper Thread ID is 5505 2025-06-04T19:02:24.476Z,1749063744.476 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:24.476Z,1749063744.476 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.480Z,1749063744.480 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-06-04T19:02:24.480Z,1749063744.480 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.481Z,1749063744.481 [logger](INFO): Join timeout helper Thread ID is 5506 2025-06-04T19:02:24.524Z,1749063744.524 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:24.524Z,1749063744.524 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.544Z,1749063744.544 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-06-04T19:02:24.544Z,1749063744.544 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.545Z,1749063744.545 [CommandLine](INFO): Join timeout helper Thread ID is 5507 2025-06-04T19:02:24.568Z,1749063744.568 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:24.568Z,1749063744.568 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.584Z,1749063744.584 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-06-04T19:02:24.584Z,1749063744.584 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.585Z,1749063744.585 [CommandExec](INFO): Join timeout helper Thread ID is 5508 2025-06-04T19:02:24.586Z,1749063744.586 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-06-04T19:02:24.586Z,1749063744.586 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:24.586Z,1749063744.586 [controlThread](INFO): Join timeout helper Thread ID is 5509 2025-06-04T19:02:24.859Z,1749063744.859 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-04T19:02:24.860Z,1749063744.860 [controlThread](DEBUG): Uninitializing ControlThread 2025-06-04T19:02:24.860Z,1749063744.860 [AHRS_M2](INFO): Powering down 2025-06-04T19:02:24.940Z,1749063744.940 [NAL9602](INFO): Powering down 2025-06-04T19:02:24.941Z,1749063744.941 [Sonardyne_Nano](INFO): Powering down 2025-06-04T19:02:25.148Z,1749063745.148 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-06-04T19:02:25.149Z,1749063745.149 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-06-04T19:02:25.149Z,1749063745.149 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-06-04T19:02:25.150Z,1749063745.150 [MissionManager](INFO): Uninitializing Mission Default 2025-06-04T19:02:25.150Z,1749063745.150 [Default] Stopped 2025-06-04T19:02:25.150Z,1749063745.150 [Default](DEBUG): Aggregate::uninitialize Default 2025-06-04T19:02:25.150Z,1749063745.150 [Default:B.GoToSurface] Stopped 2025-06-04T19:02:25.150Z,1749063745.150 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-04T19:02:25.150Z,1749063745.150 [Default:CheckIn] Stopped 2025-06-04T19:02:25.150Z,1749063745.150 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-04T19:02:25.150Z,1749063745.150 [Default:CheckIn:C.Wait] Stopped 2025-06-04T19:02:25.150Z,1749063745.150 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-04T19:02:25.153Z,1749063745.153 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-06-04T19:02:25.153Z,1749063745.153 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-06-04T19:02:25.154Z,1749063745.154 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-06-04T19:02:25.154Z,1749063745.154 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-06-04T19:02:25.154Z,1749063745.154 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-06-04T19:02:25.154Z,1749063745.154 [BuoyancyServo](INFO): Powering down 2025-06-04T19:02:25.168Z,1749063745.168 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-04T19:02:25.168Z,1749063745.168 [ElevatorServo](INFO): Powering down 2025-06-04T19:02:25.168Z,1749063745.168 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-06-04T19:02:25.169Z,1749063745.169 [MassServo](INFO): Powering down 2025-06-04T19:02:25.169Z,1749063745.169 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-06-04T19:02:25.169Z,1749063745.169 [RudderServo](INFO): Powering down 2025-06-04T19:02:25.170Z,1749063745.170 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-06-04T19:02:25.170Z,1749063745.170 [ThrusterHE](INFO): Powering down 2025-06-04T19:02:25.171Z,1749063745.171 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-06-04T19:02:25.172Z,1749063745.172 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-06-04T19:02:25.172Z,1749063745.172 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-06-04T19:02:25.172Z,1749063745.172 [CBIT](DEBUG): Powering off loads. 2025-06-04T19:02:25.183Z,1749063745.183 [CBIT](DEBUG): Disabling WDT. 2025-06-04T19:02:25.196Z,1749063745.196 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-06-04T19:02:25.196Z,1749063745.196 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-06-04T19:02:25.197Z,1749063745.197 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.221Z,1749063745.221 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.225Z,1749063745.225 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.231Z,1749063745.231 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.237Z,1749063745.237 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.278Z,1749063745.278 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.334Z,1749063745.334 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-06-04T19:02:25.334Z,1749063745.334 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-06-04T19:02:25.368Z,1749063745.368 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.375Z,1749063745.375 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.393Z,1749063745.393 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-04T19:02:25.457Z,1749063745.457 [logger ThreadHandler](INFO): Thread cancelled.