2025-04-21T18:20:45.592Z,1745259645.592 [Supervisor](DEBUG): Initializing supervisor. 2025-04-21T18:20:45.596Z,1745259645.596 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-04-21T18:20:45.597Z,1745259645.597 [SyncHandler](INFO): Protected caller Thread ID is 3315 2025-04-21T18:20:45.597Z,1745259645.597 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-04-21T18:20:45.598Z,1745259645.598 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-04-21T18:20:45.598Z,1745259645.598 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3316 2025-04-21T18:20:45.603Z,1745259645.603 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-04-21T18:20:45.623Z,1745259645.623 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-04-21T18:20:45.624Z,1745259645.624 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-04-21T18:20:45.625Z,1745259645.625 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3317 2025-04-21T18:20:45.629Z,1745259645.629 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-04-21T18:20:45.630Z,1745259645.630 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-04-21T18:20:45.630Z,1745259645.630 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3318 2025-04-21T18:20:45.633Z,1745259645.633 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-04-21T18:20:45.634Z,1745259645.634 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-04-21T18:20:45.634Z,1745259645.634 [logger ThreadHandler](INFO): Protected caller Thread ID is 3319 2025-04-21T18:20:45.638Z,1745259645.638 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-04-21T18:20:45.638Z,1745259645.638 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-04-21T18:20:45.640Z,1745259645.640 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-04-21T18:20:45.875Z,1745259645.875 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-04-21T18:20:45.875Z,1745259645.875 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-04-21T18:20:45.998Z,1745259645.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-04-21T18:20:45.999Z,1745259645.999 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-04-21T18:20:46.109Z,1745259646.109 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-04-21T18:20:46.110Z,1745259646.110 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-04-21T18:20:46.637Z,1745259646.637 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-04-21T18:20:46.637Z,1745259646.637 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-04-21T18:20:47.020Z,1745259647.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-04-21T18:20:47.021Z,1745259647.021 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-04-21T18:20:47.402Z,1745259647.402 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-04-21T18:20:47.403Z,1745259647.403 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-04-21T18:20:47.617Z,1745259647.617 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-04-21T18:20:47.617Z,1745259647.617 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-04-21T18:20:47.710Z,1745259647.710 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-04-21T18:20:47.804Z,1745259647.804 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-04-21T18:20:48.256Z,1745259648.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-04-21T18:20:48.257Z,1745259648.257 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-04-21T18:20:48.577Z,1745259648.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-04-21T18:20:48.577Z,1745259648.577 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-04-21T18:20:49.213Z,1745259649.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-04-21T18:20:49.213Z,1745259649.213 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-04-21T18:20:50.073Z,1745259650.073 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-04-21T18:20:50.073Z,1745259650.073 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-04-21T18:20:50.345Z,1745259650.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-04-21T18:20:50.346Z,1745259650.346 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-04-21T18:20:50.504Z,1745259650.504 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-04-21T18:20:50.504Z,1745259650.504 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-04-21T18:20:51.439Z,1745259651.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-04-21T18:20:51.442Z,1745259651.442 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2025-04-21T18:20:51.442Z,1745259651.442 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2025-04-21T18:20:51.542Z,1745259651.542 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2025-04-21T18:20:51.693Z,1745259651.693 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2025-04-21T18:20:51.981Z,1745259651.981 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-04-21T18:20:51.982Z,1745259651.982 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2025-04-21T18:20:52.123Z,1745259652.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2025-04-21T18:20:52.235Z,1745259652.235 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2025-04-21T18:20:52.344Z,1745259652.344 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2025-04-21T18:20:52.467Z,1745259652.467 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2025-04-21T18:20:52.566Z,1745259652.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2025-04-21T18:20:52.666Z,1745259652.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2025-04-21T18:20:52.694Z,1745259652.694 [Config/BIT](ERROR): Could not parse value: GFScanner.gf24Offset 2025-04-21T18:20:52.773Z,1745259652.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2025-04-21T18:20:52.964Z,1745259652.964 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2025-04-21T18:20:52.964Z,1745259652.964 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-04-21T18:20:52.975Z,1745259652.975 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-04-21T18:20:53.028Z,1745259653.028 [DepthRateCalculator] Loaded 2025-04-21T18:20:53.028Z,1745259653.028 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-04-21T18:20:53.034Z,1745259653.034 [PitchRateCalculator] Loaded 2025-04-21T18:20:53.034Z,1745259653.034 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-04-21T18:20:53.045Z,1745259653.045 [SpeedCalculator] Loaded 2025-04-21T18:20:53.045Z,1745259653.045 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-04-21T18:20:53.050Z,1745259653.050 [YawRateCalculator] Loaded 2025-04-21T18:20:53.050Z,1745259653.050 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-04-21T18:20:53.072Z,1745259653.072 [ElevatorOffsetCalculator] Loaded 2025-04-21T18:20:53.073Z,1745259653.073 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-04-21T18:20:53.073Z,1745259653.073 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-04-21T18:20:53.074Z,1745259653.074 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-04-21T18:20:53.103Z,1745259653.103 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-04-21T18:20:53.104Z,1745259653.104 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-04-21T18:20:53.114Z,1745259653.114 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-04-21T18:20:53.115Z,1745259653.115 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-04-21T18:20:53.619Z,1745259653.619 [AHRS_M2] Loaded 2025-04-21T18:20:53.619Z,1745259653.619 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-04-21T18:20:53.659Z,1745259653.659 [BackseatComponent] Loaded 2025-04-21T18:20:53.659Z,1745259653.659 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-04-21T18:20:53.660Z,1745259653.660 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0 2025-04-21T18:20:53.661Z,1745259653.661 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3401 2025-04-21T18:20:53.664Z,1745259653.664 [LcmUniversalReporter] Loaded 2025-04-21T18:20:53.664Z,1745259653.664 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-04-21T18:20:54.778Z,1745259654.778 [BPC1] Loaded 2025-04-21T18:20:54.779Z,1745259654.779 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-04-21T18:20:54.947Z,1745259654.947 [DAT] Loaded 2025-04-21T18:20:54.947Z,1745259654.947 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-04-21T18:20:54.948Z,1745259654.948 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0 2025-04-21T18:20:54.948Z,1745259654.948 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3402 2025-04-21T18:20:55.032Z,1745259655.032 [DataOverHttps] Loaded 2025-04-21T18:20:55.032Z,1745259655.032 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-04-21T18:20:55.033Z,1745259655.033 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0 2025-04-21T18:20:55.034Z,1745259655.034 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3403 2025-04-21T18:20:55.108Z,1745259655.108 [Depth_Keller] Loaded 2025-04-21T18:20:55.145Z,1745259655.145 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-04-21T18:20:55.150Z,1745259655.150 [DropWeight] Loaded 2025-04-21T18:20:55.150Z,1745259655.150 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-04-21T18:20:55.239Z,1745259655.239 [MultiRay](INFO): Found secondary power supply at: /dev/loadC7 2025-04-21T18:20:55.239Z,1745259655.239 [MultiRay] Loaded 2025-04-21T18:20:55.239Z,1745259655.239 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2025-04-21T18:20:55.305Z,1745259655.305 [NAL9602] Loaded 2025-04-21T18:20:55.305Z,1745259655.305 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-04-21T18:20:55.335Z,1745259655.335 [Onboard] Loaded 2025-04-21T18:20:55.336Z,1745259655.336 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-04-21T18:20:55.337Z,1745259655.337 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0 2025-04-21T18:20:55.337Z,1745259655.337 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3404 2025-04-21T18:20:55.343Z,1745259655.343 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2025-04-21T18:20:55.357Z,1745259655.357 [PowerOnly] Loaded 2025-04-21T18:20:55.357Z,1745259655.357 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-04-21T18:20:55.371Z,1745259655.371 [Power24vConverter] Loaded 2025-04-21T18:20:55.371Z,1745259655.371 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-04-21T18:20:55.389Z,1745259655.389 [Radio_Surface] Loaded 2025-04-21T18:20:55.389Z,1745259655.389 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-04-21T18:20:55.390Z,1745259655.390 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0 2025-04-21T18:20:55.391Z,1745259655.391 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3405 2025-04-21T18:20:55.392Z,1745259655.392 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-04-21T18:20:55.393Z,1745259655.393 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-04-21T18:20:55.505Z,1745259655.505 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-04-21T18:20:55.505Z,1745259655.505 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-04-21T18:20:55.520Z,1745259655.520 [NavChart] Loaded 2025-04-21T18:20:55.520Z,1745259655.520 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-04-21T18:20:55.526Z,1745259655.526 [UniversalFixResidualReporter] Loaded 2025-04-21T18:20:55.526Z,1745259655.526 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-04-21T18:20:55.526Z,1745259655.526 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-04-21T18:20:55.527Z,1745259655.527 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-04-21T18:20:55.692Z,1745259655.692 [SBIT](DEBUG): Construct Startup Built In Test. 2025-04-21T18:20:55.706Z,1745259655.706 [SBIT] Loaded 2025-04-21T18:20:55.707Z,1745259655.707 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-04-21T18:20:55.710Z,1745259655.710 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-04-21T18:20:55.723Z,1745259655.723 [IBIT] Loaded 2025-04-21T18:20:55.723Z,1745259655.723 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-04-21T18:20:55.728Z,1745259655.728 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-04-21T18:20:55.810Z,1745259655.810 [CBIT] Loaded 2025-04-21T18:20:55.811Z,1745259655.811 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-04-21T18:20:55.842Z,1745259655.842 [GFScanner] Loaded 2025-04-21T18:20:55.843Z,1745259655.843 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-04-21T18:20:55.843Z,1745259655.843 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-04-21T18:20:55.844Z,1745259655.844 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-04-21T18:20:56.013Z,1745259656.013 [CTD_Seabird] Loaded 2025-04-21T18:20:56.013Z,1745259656.013 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-04-21T18:20:56.014Z,1745259656.014 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0 2025-04-21T18:20:56.015Z,1745259656.015 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3406 2025-04-21T18:20:56.038Z,1745259656.038 [PAR_Licor] Loaded 2025-04-21T18:20:56.039Z,1745259656.039 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-04-21T18:20:56.085Z,1745259656.085 [WetLabsBB2FL] Loaded 2025-04-21T18:20:56.085Z,1745259656.085 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-04-21T18:20:56.086Z,1745259656.086 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0 2025-04-21T18:20:56.087Z,1745259656.087 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3407 2025-04-21T18:20:56.088Z,1745259656.088 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-04-21T18:20:56.088Z,1745259656.088 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-04-21T18:20:56.229Z,1745259656.229 [BuoyancyServo] Loaded 2025-04-21T18:20:56.230Z,1745259656.230 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-04-21T18:20:56.254Z,1745259656.254 [ElevatorServo] Loaded 2025-04-21T18:20:56.254Z,1745259656.254 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-04-21T18:20:56.278Z,1745259656.278 [MassServo] Loaded 2025-04-21T18:20:56.279Z,1745259656.279 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-04-21T18:20:56.301Z,1745259656.301 [RudderServo] Loaded 2025-04-21T18:20:56.302Z,1745259656.302 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-04-21T18:20:56.320Z,1745259656.320 [ThrusterHE] Loaded 2025-04-21T18:20:56.321Z,1745259656.321 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-04-21T18:20:56.321Z,1745259656.321 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-04-21T18:20:56.322Z,1745259656.322 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-04-21T18:20:56.376Z,1745259656.376 [VerticalControl](DEBUG): Construct VerticalControl. 2025-04-21T18:20:56.430Z,1745259656.430 [VerticalControl] Loaded 2025-04-21T18:20:56.430Z,1745259656.430 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-04-21T18:20:56.433Z,1745259656.433 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-04-21T18:20:56.478Z,1745259656.478 [HorizontalControl] Loaded 2025-04-21T18:20:56.478Z,1745259656.478 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-04-21T18:20:56.481Z,1745259656.481 [SpeedControl](DEBUG): Construct SpeedControl. 2025-04-21T18:20:56.482Z,1745259656.482 [SpeedControl] Loaded 2025-04-21T18:20:56.483Z,1745259656.483 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-04-21T18:20:56.486Z,1745259656.486 [LoopControl](DEBUG): Construct LoopControl. 2025-04-21T18:20:56.486Z,1745259656.486 [LoopControl] Loaded 2025-04-21T18:20:56.486Z,1745259656.486 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-04-21T18:20:56.487Z,1745259656.487 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-04-21T18:20:56.487Z,1745259656.487 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-04-21T18:20:56.619Z,1745259656.619 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-04-21T18:20:56.620Z,1745259656.620 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-04-21T18:20:56.801Z,1745259656.801 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-04-21T18:20:56.802Z,1745259656.802 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-04-21T18:20:57.152Z,1745259657.152 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-04-21T18:20:57.153Z,1745259657.153 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-04-21T18:20:57.211Z,1745259657.211 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-04-21T18:20:57.218Z,1745259657.218 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-04-21T18:20:57.221Z,1745259657.221 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-04-21T18:20:57.233Z,1745259657.233 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-04-21T18:20:57.234Z,1745259657.234 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2025-04-21T18:20:57.234Z,1745259657.234 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3408 2025-04-21T18:20:57.239Z,1745259657.239 [Supervisor](INFO): Main Thread ID is 3163 2025-04-21T18:20:57.239Z,1745259657.239 [Supervisor](DEBUG): Running supervisor. 2025-04-21T18:20:57.239Z,1745259657.239 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3409 2025-04-21T18:20:57.240Z,1745259657.240 [CommandExec](INFO): Initializing the command executive. 2025-04-21T18:20:57.242Z,1745259657.242 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3410 2025-04-21T18:20:57.245Z,1745259657.245 [controlThread ThreadHandler](INFO): Handler Thread ID is 3411 2025-04-21T18:20:57.245Z,1745259657.245 [controlThread](DEBUG): Initializing ControlThread 2025-04-21T18:20:57.246Z,1745259657.246 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-04-21T18:20:57.246Z,1745259657.246 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-04-21T18:20:57.247Z,1745259657.247 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-04-21T18:20:57.247Z,1745259657.247 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-04-21T18:20:57.247Z,1745259657.247 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-04-21T18:20:57.252Z,1745259657.252 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-04-21T18:20:57.252Z,1745259657.252 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-04-21T18:20:57.252Z,1745259657.252 [SBIT](INFO): Initialize SBIT Component. 2025-04-21T18:20:57.253Z,1745259657.253 [SBIT](IMPORTANT): git: 2025-04-15_A-2-g8f1fac8d7 2025-04-21T18:20:57.253Z,1745259657.253 [SBIT](INFO): git hash: 8f1fac8d7a27af140302f3f16bb97b99616211e7 2025-04-21T18:20:57.253Z,1745259657.253 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-04-21T18:20:57.255Z,1745259657.255 [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 Mar 17 08:23:48 PDT 2021 2025-04-21T18:20:57.256Z,1745259657.256 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2025-04-21T18:20:57.256Z,1745259657.256 [IBIT](INFO): Initialize IBIT Component. 2025-04-21T18:20:57.257Z,1745259657.257 [CBIT](DEBUG): Initialize CBIT Component. 2025-04-21T18:20:57.258Z,1745259657.258 [logger ThreadHandler](INFO): Handler Thread ID is 3412 2025-04-21T18:20:57.268Z,1745259657.268 [CBIT](DEBUG): Initialized mux pins. 2025-04-21T18:20:57.269Z,1745259657.269 [CBIT](DEBUG): Initializing the watchdog timer. 2025-04-21T18:20:57.277Z,1745259657.277 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3413 2025-04-21T18:20:57.289Z,1745259657.289 [DAT ThreadHandler](INFO): Handler Thread ID is 3414 2025-04-21T18:20:57.290Z,1745259657.290 [DAT](INFO): Powering up 2025-04-21T18:20:57.290Z,1745259657.290 [DAT](DEBUG): Initializing DAT. 2025-04-21T18:20:57.293Z,1745259657.293 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-04-21T18:20:57.293Z,1745259657.293 [CBIT](DEBUG): Initializing heartbeat. 2025-04-21T18:20:57.295Z,1745259657.295 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3416 2025-04-21T18:20:57.297Z,1745259657.297 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-04-21T18:20:57.310Z,1745259657.310 [Onboard ThreadHandler](INFO): Handler Thread ID is 3417 2025-04-21T18:20:57.338Z,1745259657.338 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3418 2025-04-21T18:20:57.347Z,1745259657.347 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3419 2025-04-21T18:20:57.347Z,1745259657.347 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-21T18:20:57.362Z,1745259657.362 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3421 2025-04-21T18:20:57.365Z,1745259657.365 [CBIT](DEBUG): Deactivating emergency mode. 2025-04-21T18:20:57.366Z,1745259657.366 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:20:57.367Z,1745259657.367 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3423 2025-04-21T18:20:57.369Z,1745259657.369 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-04-21T18:20:57.369Z,1745259657.369 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-04-21T18:20:57.370Z,1745259657.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-04-21T18:20:57.370Z,1745259657.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-04-21T18:20:57.370Z,1745259657.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-04-21T18:20:57.370Z,1745259657.370 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-04-21T18:20:57.370Z,1745259657.370 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-04-21T18:20:57.371Z,1745259657.371 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-04-21T18:20:57.405Z,1745259657.405 [CBIT](DEBUG): Backplane powered. 2025-04-21T18:20:57.405Z,1745259657.405 [GFScanner](DEBUG): Initializing GFScanner 2025-04-21T18:20:57.405Z,1745259657.405 [GFScanner](DEBUG): Deactivating GF circuits. 2025-04-21T18:20:57.414Z,1745259657.414 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-04-21T18:20:57.416Z,1745259657.416 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-04-21T18:20:57.417Z,1745259657.417 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-04-21T18:20:57.417Z,1745259657.417 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-04-21T18:20:57.418Z,1745259657.418 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-04-21T18:20:57.419Z,1745259657.419 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-04-21T18:20:57.419Z,1745259657.419 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-04-21T18:20:57.420Z,1745259657.420 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-04-21T18:20:57.487Z,1745259657.487 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-04-21T18:20:57.491Z,1745259657.491 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-21T18:20:57.515Z,1745259657.515 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2025-04-21T18:20:57.516Z,1745259657.516 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-04-21T18:20:57.528Z,1745259657.528 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-04-21T18:20:57.530Z,1745259657.530 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-04-21T18:20:57.741Z,1745259657.741 [Radio_Surface](INFO): Powering up 2025-04-21T18:20:57.752Z,1745259657.752 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-04-21T18:20:57.760Z,1745259657.760 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-04-21T18:20:57.761Z,1745259657.761 [Default:A.Wait](DEBUG): Construct Wait. 2025-04-21T18:20:57.763Z,1745259657.763 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-21T18:20:57.801Z,1745259657.801 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-04-21T18:20:57.804Z,1745259657.804 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-04-21T18:20:57.822Z,1745259657.822 [Default:E.Execute](DEBUG): Construct Execute. 2025-04-21T18:20:57.825Z,1745259657.825 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2025-04-21T18:20:57.841Z,1745259657.841 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,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-04-21T18:20:57.848Z,1745259657.848 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:20:57.905Z,1745259657.905 [Depth_Keller](INFO): Initializing. 2025-04-21T18:20:57.906Z,1745259657.906 [MultiRay](INFO): Powering up MultiRay Lights 2025-04-21T18:20:57.906Z,1745259657.906 [MultiRay](INFO): Powering up secondary power supply. 2025-04-21T18:20:57.950Z,1745259657.950 [Power24vConverter](INFO): Powering up. 2025-04-21T18:20:57.957Z,1745259657.957 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-21T18:20:57.981Z,1745259657.981 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-04-21T18:20:57.989Z,1745259657.989 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-04-21T18:20:57.990Z,1745259657.990 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-04-21T18:20:58.007Z,1745259658.007 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-04-21T18:20:58.008Z,1745259658.008 [MassServo](DEBUG): Initializing EZServoServo. 2025-04-21T18:20:58.017Z,1745259658.017 [MassServo](DEBUG): Initializing MassServo. 2025-04-21T18:20:58.018Z,1745259658.018 [RudderServo](DEBUG): Initializing EZServoServo. 2025-04-21T18:20:58.021Z,1745259658.021 [RudderServo](DEBUG): Initializing RudderServo. 2025-04-21T18:20:58.022Z,1745259658.022 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-04-21T18:20:58.025Z,1745259658.025 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-04-21T18:20:58.290Z,1745259658.290 [Depth_Keller](ERROR): Pressure or depth reading out of range: 816.065491 decibar, 0.000000 m 2025-04-21T18:20:58.290Z,1745259658.290 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-04-21T18:20:58.290Z,1745259658.290 [DropWeight] Hardware Fault, FailCount= 1 2025-04-21T18:20:58.290Z,1745259658.290 [DropWeight](ERROR): Hardware Fault 2025-04-21T18:20:58.330Z,1745259658.330 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-21T18:20:58.347Z,1745259658.347 [CommandExec](FAULT): Scheduling is paused 2025-04-21T18:20:58.347Z,1745259658.347 [CBIT](INFO): Critical error at 20250421T182058 2025-04-21T18:20:58.347Z,1745259658.347 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-04-21T18:20:58.354Z,1745259658.354 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-04-21T18:20:58.354Z,1745259658.354 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-04-21T18:20:58.686Z,1745259658.686 [CBIT](INFO): Critical error at 20250421T182058 2025-04-21T18:20:59.062Z,1745259659.062 [MultiRay](INFO): Powering down 2025-04-21T18:20:59.181Z,1745259659.181 [MultiRay](INFO): Powering down LCB2 2025-04-21T18:21:01.449Z,1745259661.449 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:01.937Z,1745259661.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:02.341Z,1745259662.341 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:02.653Z,1745259662.653 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-04-21T18:21:02.653Z,1745259662.653 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:21:02.654Z,1745259662.654 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:21:02.989Z,1745259662.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:03.153Z,1745259663.153 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:21:03.457Z,1745259663.457 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:03.877Z,1745259663.877 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:04.113Z,1745259664.113 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:21:04.113Z,1745259664.113 [WetLabsBB2FL] No Fault, FailCount= 1 2025-04-21T18:21:04.381Z,1745259664.381 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:21:04.445Z,1745259664.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:04.957Z,1745259664.957 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:05.493Z,1745259665.493 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:05.885Z,1745259665.885 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:06.290Z,1745259666.290 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:06.733Z,1745259666.733 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:07.125Z,1745259667.125 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:07.541Z,1745259667.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:07.945Z,1745259667.945 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:08.349Z,1745259668.349 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:08.753Z,1745259668.753 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:08.897Z,1745259668.897 [DAT](INFO): DAT read: 2025-04-21T18:21:08.899Z,1745259668.899 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-21T18:21:09.145Z,1745259669.145 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:09.557Z,1745259669.557 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:09.673Z,1745259669.673 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-04-21T18:21:09.673Z,1745259669.673 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:21:09.965Z,1745259669.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:10.021Z,1745259670.021 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:21:10.173Z,1745259670.173 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:21:10.373Z,1745259670.373 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:10.410Z,1745259670.410 [DAT](INFO): DAT read: MF Frequency Band 2025-04-21T18:21:10.411Z,1745259670.411 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-04-21T18:21:10.412Z,1745259670.412 [DAT](INFO): DAT read: Apr 21 2025 18:21:05 2025-04-21T18:21:10.417Z,1745259670.417 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:10.417Z,1745259670.417 [CTD_Seabird] Communications Fault, FailCount= 1 2025-04-21T18:21:10.417Z,1745259670.417 [CTD_Seabird](ERROR): Communications Fault 2025-04-21T18:21:10.459Z,1745259670.459 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-21T18:21:10.809Z,1745259670.809 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:10.809Z,1745259670.809 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:10.809Z,1745259670.809 [AHRS_M2] Communications Fault, FailCount= 1 2025-04-21T18:21:10.809Z,1745259670.809 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:21:10.822Z,1745259670.822 [CTD_Seabird](INFO): Powering down 2025-04-21T18:21:10.870Z,1745259670.870 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:21:10.887Z,1745259670.887 [AHRS_M2](INFO): Powering down 2025-04-21T18:21:11.017Z,1745259671.017 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:21:11.017Z,1745259671.017 [WetLabsBB2FL] No Fault, FailCount= 2 2025-04-21T18:21:11.386Z,1745259671.386 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:21:11.418Z,1745259671.418 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-21T18:21:11.419Z,1745259671.419 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-04-21T18:21:11.419Z,1745259671.419 [DAT](INFO): commRate: 800 2025-04-21T18:21:11.748Z,1745259671.748 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:21:11.748Z,1745259671.748 [AHRS_M2] No Fault, FailCount= 1 2025-04-21T18:21:12.099Z,1745259672.099 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:21:12.154Z,1745259672.154 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-21T18:21:12.154Z,1745259672.154 [CTD_Seabird] No Fault, FailCount= 1 2025-04-21T18:21:12.169Z,1745259672.169 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-21T18:21:13.489Z,1745259673.489 [DAT](INFO): entering command mode 2025-04-21T18:21:13.689Z,1745259673.689 [DAT](INFO): DAT read: 2025-04-21T18:21:13.690Z,1745259673.690 [DAT](INFO): DAT read: user:1> 2025-04-21T18:21:13.690Z,1745259673.690 [DAT](INFO): setting verbose to 3 2025-04-21T18:21:13.941Z,1745259673.941 [DAT](INFO): DAT read: user:1> 2025-04-21T18:21:13.942Z,1745259673.942 [DAT](INFO): DAT read: Verbose | 3 2025-04-21T18:21:13.943Z,1745259673.943 [DAT](INFO): set verbose to 3 2025-04-21T18:21:13.943Z,1745259673.943 [DAT](INFO): setting DatVerbose to 27440 2025-04-21T18:21:14.193Z,1745259674.193 [DAT](INFO): DAT read: user:2> 2025-04-21T18:21:14.194Z,1745259674.194 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-21T18:21:14.195Z,1745259674.195 [DAT](INFO): set DatVerbose to 27440 2025-04-21T18:21:14.195Z,1745259674.195 [DAT](INFO): setting transmit power to 8 2025-04-21T18:21:14.446Z,1745259674.446 [DAT](INFO): DAT read: user:3> 2025-04-21T18:21:14.446Z,1745259674.446 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-21T18:21:14.447Z,1745259674.447 [DAT](INFO): set transmit power to 8 2025-04-21T18:21:14.447Z,1745259674.447 [DAT](INFO): setting local address to 9 2025-04-21T18:21:14.697Z,1745259674.697 [DAT](INFO): DAT read: user:4> 2025-04-21T18:21:14.698Z,1745259674.698 [DAT](INFO): DAT read: LocalAddr | 9 2025-04-21T18:21:14.699Z,1745259674.699 [DAT](INFO): set local address to 9 2025-04-21T18:21:14.700Z,1745259674.700 [DAT](INFO): Setting time to: 18:21:14 And date to:4/21/2025 2025-04-21T18:21:14.950Z,1745259674.950 [DAT](INFO): DAT read: user:5> 2025-04-21T18:21:14.951Z,1745259674.951 [DAT](INFO): DAT read: Mon Apr 21, 2025 18:21:14 2025-04-21T18:21:14.951Z,1745259674.951 [DAT](INFO): Local DAT time set to Mon Apr 21, 2025 18:21:14 2025-04-21T18:21:15.645Z,1745259675.645 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:16.061Z,1745259676.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:16.465Z,1745259676.465 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:16.677Z,1745259676.677 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-04-21T18:21:16.677Z,1745259676.677 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:21:16.861Z,1745259676.861 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:16.931Z,1745259676.931 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:21:17.177Z,1745259677.177 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:21:17.269Z,1745259677.269 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:17.685Z,1745259677.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:18.077Z,1745259678.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:18.145Z,1745259678.145 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:21:18.145Z,1745259678.145 [WetLabsBB2FL] No Fault, FailCount= 3 2025-04-21T18:21:18.390Z,1745259678.390 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:21:18.493Z,1745259678.493 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:18.893Z,1745259678.893 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:19.297Z,1745259679.297 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:19.705Z,1745259679.705 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:20.097Z,1745259680.097 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:20.509Z,1745259680.509 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:20.917Z,1745259680.917 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:21.325Z,1745259681.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:21.721Z,1745259681.721 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:22.125Z,1745259682.125 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:22.529Z,1745259682.529 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:22.921Z,1745259682.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:23.333Z,1745259683.333 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:23.681Z,1745259683.681 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-04-21T18:21:23.681Z,1745259683.681 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:21:23.737Z,1745259683.737 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:23.793Z,1745259683.793 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:21:24.149Z,1745259684.149 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:24.186Z,1745259684.186 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:21:24.565Z,1745259684.565 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:24.969Z,1745259684.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:24.969Z,1745259684.969 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:24.969Z,1745259684.969 [AHRS_M2] Communications Fault, FailCount= 2 2025-04-21T18:21:24.969Z,1745259684.969 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:21:25.030Z,1745259685.030 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:21:25.030Z,1745259685.030 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:21:25.031Z,1745259685.031 [WetLabsBB2FL] No Fault, FailCount= 4 2025-04-21T18:21:25.043Z,1745259685.043 [AHRS_M2](INFO): Powering down 2025-04-21T18:21:25.221Z,1745259685.221 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:25.221Z,1745259685.221 [CTD_Seabird] Communications Fault, FailCount= 2 2025-04-21T18:21:25.221Z,1745259685.221 [CTD_Seabird](ERROR): Communications Fault 2025-04-21T18:21:25.426Z,1745259685.426 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:21:25.446Z,1745259685.446 [NAL9602](INFO): Powering up NAL9602 2025-04-21T18:21:25.522Z,1745259685.522 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-21T18:21:25.625Z,1745259685.625 [CTD_Seabird](INFO): Powering down 2025-04-21T18:21:25.905Z,1745259685.905 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:21:25.905Z,1745259685.905 [AHRS_M2] No Fault, FailCount= 2 2025-04-21T18:21:26.251Z,1745259686.251 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:21:26.705Z,1745259686.705 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-21T18:21:26.705Z,1745259686.705 [CTD_Seabird] No Fault, FailCount= 2 2025-04-21T18:21:26.965Z,1745259686.965 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-21T18:21:29.809Z,1745259689.809 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:30.205Z,1745259690.205 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:30.613Z,1745259690.613 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:30.721Z,1745259690.721 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-04-21T18:21:30.721Z,1745259690.721 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:21:31.021Z,1745259691.021 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:31.044Z,1745259691.044 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:21:31.071Z,1745259691.071 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:21:31.221Z,1745259691.221 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:21:31.429Z,1745259691.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:31.829Z,1745259691.829 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:32.225Z,1745259692.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:32.629Z,1745259692.629 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:33.041Z,1745259693.041 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:33.445Z,1745259693.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:33.849Z,1745259693.849 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:34.253Z,1745259694.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:34.661Z,1745259694.661 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:35.061Z,1745259695.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:35.465Z,1745259695.465 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:35.869Z,1745259695.869 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:36.285Z,1745259696.285 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:36.294Z,1745259696.294 [NAL9602](INFO): NAL9602 initialized 2025-04-21T18:21:36.689Z,1745259696.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:37.089Z,1745259697.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:37.485Z,1745259697.485 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:37.897Z,1745259697.897 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:38.301Z,1745259698.301 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:38.717Z,1745259698.717 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:39.117Z,1745259699.117 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:39.117Z,1745259699.117 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:39.117Z,1745259699.117 [AHRS_M2] Communications Fault, FailCount= 3 2025-04-21T18:21:39.117Z,1745259699.117 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:21:39.159Z,1745259699.159 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:21:39.205Z,1745259699.205 [AHRS_M2](INFO): Powering down 2025-04-21T18:21:40.017Z,1745259700.017 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:40.017Z,1745259700.017 [CTD_Seabird] Communications Fault, FailCount= 3 2025-04-21T18:21:40.017Z,1745259700.017 [CTD_Seabird](ERROR): Communications Fault 2025-04-21T18:21:40.030Z,1745259700.030 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:21:40.030Z,1745259700.030 [AHRS_M2] No Fault, FailCount= 3 2025-04-21T18:21:40.031Z,1745259700.031 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-21T18:21:40.031Z,1745259700.031 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-04-21T18:21:40.407Z,1745259700.407 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:21:40.421Z,1745259700.421 [CTD_Seabird](INFO): Powering down 2025-04-21T18:21:43.965Z,1745259703.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:44.373Z,1745259704.373 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:44.777Z,1745259704.777 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:45.181Z,1745259705.181 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:45.593Z,1745259705.593 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:45.985Z,1745259705.985 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:46.381Z,1745259706.381 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:46.793Z,1745259706.793 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:47.201Z,1745259707.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:47.597Z,1745259707.597 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:48.005Z,1745259708.005 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:48.409Z,1745259708.409 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:48.817Z,1745259708.817 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:49.217Z,1745259709.217 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:49.621Z,1745259709.621 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:50.025Z,1745259710.025 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:50.441Z,1745259710.441 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:50.853Z,1745259710.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:51.245Z,1745259711.245 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:51.641Z,1745259711.641 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:52.053Z,1745259712.053 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:52.449Z,1745259712.449 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:52.861Z,1745259712.861 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:53.265Z,1745259713.265 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:53.265Z,1745259713.265 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:21:53.265Z,1745259713.265 [AHRS_M2] Communications Fault, FailCount= 4 2025-04-21T18:21:53.265Z,1745259713.265 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:21:53.318Z,1745259713.318 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:21:53.351Z,1745259713.351 [AHRS_M2](INFO): Powering down 2025-04-21T18:21:54.194Z,1745259714.194 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:21:54.194Z,1745259714.194 [AHRS_M2] No Fault, FailCount= 4 2025-04-21T18:21:54.555Z,1745259714.555 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:21:56.999Z,1745259716.999 [SBIT](IMPORTANT): Beginning Startup BIT 2025-04-21T18:21:57.004Z,1745259717.004 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-04-21T18:21:58.105Z,1745259718.105 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:58.601Z,1745259718.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:58.885Z,1745259718.885 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:21:59.525Z,1745259719.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:00.201Z,1745259720.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:00.773Z,1745259720.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:01.409Z,1745259721.409 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:01.921Z,1745259721.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:02.521Z,1745259722.521 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:03.133Z,1745259723.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:03.198Z,1745259723.198 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.008339 CHAN A1 (24V): -0.050657 CHAN A2 (12V): -0.005088 CHAN A3 (5V): -0.002954 CHAN B0 (3.3V): -0.001146 CHAN B1 (3.15aV): -0.001441 CHAN B2 (3.15bV): -0.001596 CHAN B3 (GND): -0.000350 OPEN: -0.004009 Full Scale: +/- 1 mA 2025-04-21T18:22:03.349Z,1745259723.349 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:03.937Z,1745259723.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:04.345Z,1745259724.345 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:04.757Z,1745259724.757 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:05.177Z,1745259725.177 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:05.593Z,1745259725.593 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:06.009Z,1745259726.009 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:06.425Z,1745259726.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:06.837Z,1745259726.837 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:07.245Z,1745259727.245 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:07.653Z,1745259727.653 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:22:07.653Z,1745259727.653 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:22:07.653Z,1745259727.653 [AHRS_M2] Communications Fault, FailCount= 5 2025-04-21T18:22:07.653Z,1745259727.653 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:22:07.714Z,1745259727.714 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:22:07.714Z,1745259727.714 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2025-04-21T18:22:07.739Z,1745259727.739 [AHRS_M2](INFO): Powering down 2025-04-21T18:22:07.858Z,1745259727.858 [CBIT](INFO): Critical error at 20250421T182207 2025-04-21T18:22:51.052Z,1745259771.052 [SBIT](IMPORTANT): SBIT PASSED 2025-04-21T18:22:51.053Z,1745259771.053 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-04-21T18:22:51.054Z,1745259771.053 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): MultiRay.brightnessWhite=100 none; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool; 2025-04-21T18:22:51.054Z,1745259771.054 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=297.568711 cubic_centimeter; 2025-04-21T18:22:51.055Z,1745259771.055 [SBIT](IMPORTANT): VerticalControl.massDefault=9.783151 millimeter; 2025-04-21T18:22:51.055Z,1745259771.055 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2025-04-21T18:22:51.545Z,1745259771.545 [MissionManager](IMPORTANT): Started mission Startup 2025-04-21T18:22:51.545Z,1745259771.545 [Startup] Running Loop=1 2025-04-21T18:22:51.546Z,1745259771.546 [Startup](DEBUG): Aggregate::initialize Startup 2025-04-21T18:22:51.546Z,1745259771.546 [Startup:A.GoToSurface] Running Loop=1 2025-04-21T18:22:51.546Z,1745259771.546 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-21T18:22:51.546Z,1745259771.546 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-21T18:22:51.547Z,1745259771.547 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-21T18:22:51.547Z,1745259771.547 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-21T18:22:51.547Z,1745259771.547 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-21T18:22:51.548Z,1745259771.548 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-21T18:22:51.548Z,1745259771.548 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-21T18:22:51.551Z,1745259771.551 [Startup:StartupSatComms] Running Loop=1 2025-04-21T18:22:51.551Z,1745259771.551 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-04-21T18:22:51.551Z,1745259771.551 [Startup:StartupSatComms:A] Running Loop=1 2025-04-21T18:22:51.889Z,1745259771.889 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-04-21T18:22:57.529Z,1745259777.529 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-04-21T18:22:57.529Z,1745259777.529 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-04-21T18:22:57.529Z,1745259777.529 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-21T18:22:57.541Z,1745259777.541 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-21T18:22:57.934Z,1745259777.934 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-21T18:22:57.935Z,1745259777.935 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-04-21T18:23:25.120Z,1745259805.120 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005288 2025-04-21T18:23:51.642Z,1745259831.642 [Startup:StartupSatComms:A](INFO): Timed out from 2025-04-21T18:22:51.6Z 2025-04-21T18:23:51.642Z,1745259831.642 [Startup:StartupSatComms:A] Stopped 2025-04-21T18:23:51.642Z,1745259831.642 [Startup:StartupSatComms:B] Running Loop=1 2025-04-21T18:23:52.046Z,1745259832.046 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-21T18:23:57.851Z,1745259837.851 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250414T214426/Courier0007.lzma 2025-04-21T18:23:58.843Z,1745259838.843 [DataOverHttps](INFO): Moved sent file to Logs/20250414T214426/Courier0007.lzma.bak 2025-04-21T18:23:58.844Z,1745259838.844 [DataOverHttps](INFO): SBD MOMSN=24699586 2025-04-21T18:24:00.942Z,1745259840.942 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:24:00.942Z,1745259840.942 [WetLabsBB2FL] No Fault, FailCount= 5 2025-04-21T18:24:01.114Z,1745259841.114 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:24:06.404Z,1745259846.404 [WetLabsBB2FL] Communications Fault, FailCount= 1 2025-04-21T18:24:06.405Z,1745259846.405 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:24:06.600Z,1745259846.600 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:24:06.905Z,1745259846.905 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:24:07.822Z,1745259847.822 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:24:07.822Z,1745259847.822 [WetLabsBB2FL] No Fault, FailCount= 1 2025-04-21T18:24:08.119Z,1745259848.119 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:24:10.283Z,1745259850.283 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-21T18:24:10.283Z,1745259850.283 [CTD_Seabird] No Fault, FailCount= 3 2025-04-21T18:24:10.470Z,1745259850.470 [CommandExec](IMPORTANT): got command gfisolate 2025-04-21T18:24:10.482Z,1745259850.482 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-21T18:24:10.909Z,1745259850.909 [GFScanner](INFO): Ground fault isolation requested 2025-04-21T18:24:10.909Z,1745259850.909 [GFScanner](IMPORTANT): Starting ground fault isolation process 2025-04-21T18:24:10.910Z,1745259850.910 [GFScanner](INFO): Using most recent scan as baseline - proceeding with component isolation 2025-04-21T18:24:11.134Z,1745259851.134 [Supervisor](DEBUG): Could not find element controlThread.loadControl 2025-04-21T18:24:11.134Z,1745259851.134 [GFScanner](DEBUG): Skipping component controlThread - no load control 2025-04-21T18:24:11.134Z,1745259851.134 [Supervisor](DEBUG): Could not find element CycleStarter.loadControl 2025-04-21T18:24:11.135Z,1745259851.135 [GFScanner](DEBUG): Skipping component CycleStarter - no load control 2025-04-21T18:24:11.135Z,1745259851.135 [Supervisor](DEBUG): Could not find element CommandExec.loadControl 2025-04-21T18:24:11.135Z,1745259851.135 [GFScanner](DEBUG): Skipping component CommandExec - no load control 2025-04-21T18:24:11.136Z,1745259851.136 [Supervisor](DEBUG): Could not find element CommandLine.loadControl 2025-04-21T18:24:11.136Z,1745259851.136 [GFScanner](DEBUG): Skipping component CommandLine - no load control 2025-04-21T18:24:11.136Z,1745259851.136 [Supervisor](DEBUG): Could not find element logger.loadControl 2025-04-21T18:24:11.145Z,1745259851.145 [GFScanner](DEBUG): Skipping component logger - no load control 2025-04-21T18:24:11.145Z,1745259851.145 [Supervisor](DEBUG): Could not find element LogSplitter.loadControl 2025-04-21T18:24:11.145Z,1745259851.145 [GFScanner](DEBUG): Skipping component LogSplitter - no load control 2025-04-21T18:24:11.146Z,1745259851.146 [Supervisor](DEBUG): Could not find element Config/Derivation.loadControl 2025-04-21T18:24:11.146Z,1745259851.146 [GFScanner](DEBUG): Skipping component Config/Derivation - no load control 2025-04-21T18:24:11.146Z,1745259851.146 [Supervisor](DEBUG): Could not find element Config/Estimation.loadControl 2025-04-21T18:24:11.146Z,1745259851.146 [GFScanner](DEBUG): Skipping component Config/Estimation - no load control 2025-04-21T18:24:11.147Z,1745259851.147 [Supervisor](DEBUG): Could not find element Config/secure.loadControl 2025-04-21T18:24:11.147Z,1745259851.147 [GFScanner](DEBUG): Skipping component Config/secure - no load control 2025-04-21T18:24:11.147Z,1745259851.147 [Supervisor](DEBUG): Could not find element Config/vehicle.loadControl 2025-04-21T18:24:11.148Z,1745259851.148 [GFScanner](DEBUG): Skipping component Config/vehicle - no load control 2025-04-21T18:24:11.148Z,1745259851.148 [Supervisor](DEBUG): Could not find element Config/Science.loadControl 2025-04-21T18:24:11.148Z,1745259851.148 [GFScanner](DEBUG): Skipping component Config/Science - no load control 2025-04-21T18:24:11.157Z,1745259851.157 [Supervisor](DEBUG): Could not find element Config/Control.loadControl 2025-04-21T18:24:11.157Z,1745259851.157 [GFScanner](DEBUG): Skipping component Config/Control - no load control 2025-04-21T18:24:11.157Z,1745259851.157 [Supervisor](DEBUG): Could not find element Config/logger.loadControl 2025-04-21T18:24:11.158Z,1745259851.158 [GFScanner](DEBUG): Skipping component Config/logger - no load control 2025-04-21T18:24:11.158Z,1745259851.158 [Supervisor](DEBUG): Could not find element Config/Servo.loadControl 2025-04-21T18:24:11.158Z,1745259851.158 [GFScanner](DEBUG): Skipping component Config/Servo - no load control 2025-04-21T18:24:11.159Z,1745259851.159 [Supervisor](DEBUG): Could not find element Config/Navigation.loadControl 2025-04-21T18:24:11.159Z,1745259851.159 [GFScanner](DEBUG): Skipping component Config/Navigation - no load control 2025-04-21T18:24:11.159Z,1745259851.159 [Supervisor](DEBUG): Could not find element Config/Simulator.loadControl 2025-04-21T18:24:11.159Z,1745259851.159 [GFScanner](DEBUG): Skipping component Config/Simulator - no load control 2025-04-21T18:24:11.160Z,1745259851.160 [Supervisor](DEBUG): Could not find element Config/BIT.loadControl 2025-04-21T18:24:11.160Z,1745259851.160 [GFScanner](DEBUG): Skipping component Config/BIT - no load control 2025-04-21T18:24:11.160Z,1745259851.160 [Supervisor](DEBUG): Could not find element Config/Dock.loadControl 2025-04-21T18:24:11.169Z,1745259851.169 [GFScanner](DEBUG): Skipping component Config/Dock - no load control 2025-04-21T18:24:11.169Z,1745259851.169 [Supervisor](DEBUG): Could not find element Config/workSite.loadControl 2025-04-21T18:24:11.169Z,1745259851.169 [GFScanner](DEBUG): Skipping component Config/workSite - no load control 2025-04-21T18:24:11.170Z,1745259851.170 [Supervisor](DEBUG): Could not find element Config/Sensor.loadControl 2025-04-21T18:24:11.170Z,1745259851.170 [GFScanner](DEBUG): Skipping component Config/Sensor - no load control 2025-04-21T18:24:11.170Z,1745259851.170 [Supervisor](DEBUG): Could not find element Config/Battery.loadControl 2025-04-21T18:24:11.170Z,1745259851.170 [GFScanner](DEBUG): Skipping component Config/Battery - no load control 2025-04-21T18:24:11.171Z,1745259851.171 [Supervisor](DEBUG): Could not find element DepthRateCalculator.loadControl 2025-04-21T18:24:11.171Z,1745259851.171 [GFScanner](DEBUG): Skipping component DepthRateCalculator - no load control 2025-04-21T18:24:11.171Z,1745259851.171 [Supervisor](DEBUG): Could not find element PitchRateCalculator.loadControl 2025-04-21T18:24:11.172Z,1745259851.172 [GFScanner](DEBUG): Skipping component PitchRateCalculator - no load control 2025-04-21T18:24:11.172Z,1745259851.172 [Supervisor](DEBUG): Could not find element SpeedCalculator.loadControl 2025-04-21T18:24:11.172Z,1745259851.172 [GFScanner](DEBUG): Skipping component SpeedCalculator - no load control 2025-04-21T18:24:11.181Z,1745259851.181 [Supervisor](DEBUG): Could not find element YawRateCalculator.loadControl 2025-04-21T18:24:11.181Z,1745259851.181 [GFScanner](DEBUG): Skipping component YawRateCalculator - no load control 2025-04-21T18:24:11.181Z,1745259851.181 [Supervisor](DEBUG): Could not find element ElevatorOffsetCalculator.loadControl 2025-04-21T18:24:11.182Z,1745259851.182 [GFScanner](DEBUG): Skipping component ElevatorOffsetCalculator - no load control 2025-04-21T18:24:11.182Z,1745259851.182 [GFScanner](INFO): Testing component AHRS_M2 for ground fault isolation 2025-04-21T18:24:11.182Z,1745259851.182 [GFScanner](INFO): Component AHRS_M2 is not running, proceeding to isolation 2025-04-21T18:24:11.183Z,1745259851.183 [Supervisor](INFO): Attempting to isolate load for component: AHRS_M2 2025-04-21T18:24:11.184Z,1745259851.184 [Supervisor](INFO): Isolating primary load control for AHRS_M2 2025-04-21T18:24:11.191Z,1745259851.191 [Supervisor](INFO): Successfully isolated primary load for component: AHRS_M2 2025-04-21T18:24:11.191Z,1745259851.191 [GFScanner](DEBUG): Successfully isolated load for component AHRS_M2 2025-04-21T18:24:13.413Z,1745259853.413 [WetLabsBB2FL] Communications Fault, FailCount= 2 2025-04-21T18:24:13.413Z,1745259853.413 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:24:13.503Z,1745259853.503 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:24:13.909Z,1745259853.909 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:24:14.957Z,1745259854.957 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20250421T181752/Courier0000.lzma 2025-04-21T18:24:15.959Z,1745259855.959 [DataOverHttps](INFO): Moved sent file to Logs/20250421T181752/Courier0000.lzma.bak 2025-04-21T18:24:15.959Z,1745259855.959 [DataOverHttps](INFO): SBD MOMSN=24699606 2025-04-21T18:24:21.588Z,1745259861.588 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:24:21.593Z,1745259861.593 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:24:23.533Z,1745259863.533 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-21T18:24:23.533Z,1745259863.533 [CTD_Seabird] Communications Fault, FailCount= 1 2025-04-21T18:24:23.533Z,1745259863.533 [CTD_Seabird](ERROR): Communications Fault 2025-04-21T18:24:23.718Z,1745259863.718 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-21T18:24:23.937Z,1745259863.937 [CTD_Seabird](INFO): Powering down 2025-04-21T18:24:26.022Z,1745259866.022 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.010471 CHAN A1 (24V): -0.050184 CHAN A2 (12V): -0.005346 CHAN A3 (5V): -0.003323 CHAN B0 (3.3V): -0.001375 CHAN B1 (3.15aV): -0.001297 CHAN B2 (3.15bV): -0.001597 CHAN B3 (GND): -0.000734 OPEN: 0.005073 Full Scale: +/- 1 mA 2025-04-21T18:24:27.276Z,1745259867.276 [Supervisor](INFO): Attempting to de-isolate load for component: AHRS_M2 2025-04-21T18:24:27.277Z,1745259867.277 [Supervisor](INFO): De-isolating primary load control for AHRS_M2 2025-04-21T18:24:27.280Z,1745259867.280 [Supervisor](INFO): Successfully de-isolated primary load for component: AHRS_M2 2025-04-21T18:24:27.280Z,1745259867.280 [GFScanner](DEBUG): Successfully de-isolated load for component AHRS_M2 2025-04-21T18:24:27.280Z,1745259867.280 [GFScanner](INFO): Component AHRS_M2 processing complete 2025-04-21T18:24:27.619Z,1745259867.619 [GFScanner](INFO): Testing component BackseatComponent for ground fault isolation 2025-04-21T18:24:27.620Z,1745259867.620 [GFScanner](INFO): Component BackseatComponent is not running, proceeding to isolation 2025-04-21T18:24:27.620Z,1745259867.620 [Supervisor](INFO): Attempting to isolate load for component: BackseatComponent 2025-04-21T18:24:27.642Z,1745259867.642 [Supervisor](INFO): Isolating primary load control for BackseatComponent 2025-04-21T18:24:27.689Z,1745259867.689 [Supervisor](INFO): Successfully isolated primary load for component: BackseatComponent 2025-04-21T18:24:27.689Z,1745259867.689 [GFScanner](DEBUG): Successfully isolated load for component BackseatComponent 2025-04-21T18:24:31.525Z,1745259871.525 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20250421T182045/Courier0000.lzma 2025-04-21T18:24:32.526Z,1745259872.526 [DataOverHttps](INFO): Moved sent file to Logs/20250421T182045/Courier0000.lzma.bak 2025-04-21T18:24:32.527Z,1745259872.527 [DataOverHttps](INFO): SBD MOMSN=24699613 2025-04-21T18:24:37.762Z,1745259877.762 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:24:37.762Z,1745259877.762 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:24:42.189Z,1745259882.189 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.010570 CHAN A1 (24V): -0.050193 CHAN A2 (12V): -0.005867 CHAN A3 (5V): -0.002675 CHAN B0 (3.3V): -0.001322 CHAN B1 (3.15aV): -0.001188 CHAN B2 (3.15bV): -0.000964 CHAN B3 (GND): -0.000216 OPEN: 0.004765 Full Scale: +/- 1 mA 2025-04-21T18:24:43.364Z,1745259883.364 [Supervisor](INFO): Attempting to de-isolate load for component: BackseatComponent 2025-04-21T18:24:43.365Z,1745259883.365 [Supervisor](INFO): De-isolating primary load control for BackseatComponent 2025-04-21T18:24:43.367Z,1745259883.367 [Supervisor](INFO): Successfully de-isolated primary load for component: BackseatComponent 2025-04-21T18:24:43.368Z,1745259883.368 [GFScanner](DEBUG): Successfully de-isolated load for component BackseatComponent 2025-04-21T18:24:43.368Z,1745259883.368 [GFScanner](INFO): Component BackseatComponent processing complete 2025-04-21T18:24:43.770Z,1745259883.770 [Supervisor](DEBUG): Could not find element LcmUniversalReporter.loadControl 2025-04-21T18:24:43.770Z,1745259883.770 [GFScanner](DEBUG): Skipping component LcmUniversalReporter - no load control 2025-04-21T18:24:43.770Z,1745259883.770 [Supervisor](DEBUG): Could not find element BPC1.loadControl 2025-04-21T18:24:43.770Z,1745259883.770 [GFScanner](DEBUG): Skipping component BPC1 - no load control 2025-04-21T18:24:43.771Z,1745259883.771 [GFScanner](INFO): Testing component DAT for ground fault isolation 2025-04-21T18:24:43.771Z,1745259883.771 [GFScanner](INFO): Stopping component DAT for ground fault isolation test 2025-04-21T18:24:44.001Z,1745259884.001 [DAT](INFO): Powering down 2025-04-21T18:24:47.025Z,1745259887.025 [DAT](INFO): Powering up 2025-04-21T18:24:47.025Z,1745259887.025 [DAT](DEBUG): Initializing DAT. 2025-04-21T18:24:48.266Z,1745259888.266 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20250414T214426/Express0008.lzma 2025-04-21T18:24:49.266Z,1745259889.266 [DataOverHttps](INFO): Moved sent file to Logs/20250414T214426/Express0008.lzma.bak 2025-04-21T18:24:49.267Z,1745259889.267 [DataOverHttps](INFO): SBD MOMSN=24699620 2025-04-21T18:24:51.862Z,1745259891.862 [Startup:StartupSatComms:B](INFO): Timed out from 2025-04-21T18:23:51.6Z 2025-04-21T18:24:51.862Z,1745259891.862 [Startup:StartupSatComms:B] Stopped 2025-04-21T18:24:51.862Z,1745259891.862 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-04-21T18:24:51.863Z,1745259891.863 [Startup:StartupSatComms] Stopped 2025-04-21T18:24:51.863Z,1745259891.863 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-04-21T18:24:51.864Z,1745259891.864 [Startup](INFO): Completed Startup 2025-04-21T18:24:51.864Z,1745259891.864 [MissionManager](INFO): Startup is completed. 2025-04-21T18:24:51.864Z,1745259891.864 [MissionManager](INFO): Uninitializing Mission Startup 2025-04-21T18:24:51.864Z,1745259891.864 [Startup] Stopped 2025-04-21T18:24:51.864Z,1745259891.864 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-04-21T18:24:51.864Z,1745259891.864 [Startup:A.GoToSurface] Stopped 2025-04-21T18:24:51.864Z,1745259891.864 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-21T18:24:52.261Z,1745259892.261 [MissionManager](IMPORTANT): Started mission Default 2025-04-21T18:24:52.261Z,1745259892.261 [Default] Running Loop=1 2025-04-21T18:24:52.261Z,1745259892.261 [Default](DEBUG): Aggregate::initialize Default 2025-04-21T18:24:52.261Z,1745259892.261 [Default:B.GoToSurface] Running Loop=1 2025-04-21T18:24:52.261Z,1745259892.261 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-21T18:24:52.262Z,1745259892.262 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-21T18:24:52.262Z,1745259892.262 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-21T18:24:52.262Z,1745259892.262 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-21T18:24:52.263Z,1745259892.263 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-21T18:24:52.263Z,1745259892.263 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-21T18:24:52.263Z,1745259892.263 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-21T18:24:52.263Z,1745259892.263 [Default:A.Wait] Running Loop=1 2025-04-21T18:24:52.264Z,1745259892.264 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-04-21T18:24:58.313Z,1745259898.313 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-04-21T18:24:58.313Z,1745259898.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-04-21T18:24:58.313Z,1745259898.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-21T18:24:58.393Z,1745259898.393 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-21T18:24:58.641Z,1745259898.641 [DAT](INFO): DAT read: 2025-04-21T18:24:58.642Z,1745259898.642 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-21T18:25:00.158Z,1745259900.158 [DAT](INFO): DAT read: MF Frequency Band 2025-04-21T18:25:00.159Z,1745259900.159 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-04-21T18:25:00.159Z,1745259900.159 [DAT](INFO): DAT read: Apr 21 2025 18:24:55 2025-04-21T18:25:01.166Z,1745259901.166 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-21T18:25:01.167Z,1745259901.167 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-04-21T18:25:01.167Z,1745259901.167 [DAT](INFO): commRate: 800 2025-04-21T18:25:03.233Z,1745259903.233 [DAT](INFO): entering command mode 2025-04-21T18:25:03.433Z,1745259903.433 [DAT](INFO): DAT read: 2025-04-21T18:25:03.434Z,1745259903.434 [DAT](INFO): DAT read: user:1> 2025-04-21T18:25:03.434Z,1745259903.434 [DAT](INFO): setting verbose to 3 2025-04-21T18:25:03.685Z,1745259903.685 [DAT](INFO): DAT read: user:1> 2025-04-21T18:25:03.686Z,1745259903.686 [DAT](INFO): DAT read: Verbose | 3 2025-04-21T18:25:03.687Z,1745259903.687 [DAT](INFO): set verbose to 3 2025-04-21T18:25:03.687Z,1745259903.687 [DAT](INFO): setting DatVerbose to 27440 2025-04-21T18:25:03.937Z,1745259903.937 [DAT](INFO): DAT read: user:2> 2025-04-21T18:25:03.938Z,1745259903.938 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-21T18:25:03.939Z,1745259903.939 [DAT](INFO): set DatVerbose to 27440 2025-04-21T18:25:03.939Z,1745259903.939 [DAT](INFO): setting transmit power to 8 2025-04-21T18:25:04.189Z,1745259904.189 [DAT](INFO): DAT read: user:3> 2025-04-21T18:25:04.190Z,1745259904.190 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-21T18:25:04.191Z,1745259904.191 [DAT](INFO): set transmit power to 8 2025-04-21T18:25:04.191Z,1745259904.191 [DAT](INFO): setting local address to 9 2025-04-21T18:25:04.441Z,1745259904.441 [DAT](INFO): DAT read: user:4> 2025-04-21T18:25:04.442Z,1745259904.442 [DAT](INFO): DAT read: LocalAddr | 9 2025-04-21T18:25:04.443Z,1745259904.443 [DAT](INFO): set local address to 9 2025-04-21T18:25:04.444Z,1745259904.444 [DAT](INFO): Setting time to: 18:25:4 And date to:4/21/2025 2025-04-21T18:25:04.693Z,1745259904.693 [DAT](INFO): DAT read: user:5> 2025-04-21T18:25:04.694Z,1745259904.694 [DAT](INFO): DAT read: Mon Apr 21, 2025 18:25:04 2025-04-21T18:25:04.695Z,1745259904.695 [DAT](INFO): Local DAT time set to Mon Apr 21, 2025 18:25:04 2025-04-21T18:25:05.296Z,1745259905.296 [DataOverHttps](INFO): Sending 1595 bytes from file Logs/20250421T181752/Express0001.lzma 2025-04-21T18:25:05.574Z,1745259905.574 [Default:A.Wait](INFO): Done Waiting. 2025-04-21T18:25:05.574Z,1745259905.574 [Default:A.Wait] Stopped 2025-04-21T18:25:05.575Z,1745259905.575 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-21T18:25:05.978Z,1745259905.978 [Default:CheckIn] Running Loop=1 2025-04-21T18:25:05.978Z,1745259905.978 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-04-21T18:25:05.978Z,1745259905.978 [Default:CheckIn:Read_GPS] Running Loop=1 2025-04-21T18:25:06.295Z,1745259906.295 [DataOverHttps](INFO): Moved sent file to Logs/20250421T181752/Express0001.lzma.bak 2025-04-21T18:25:06.295Z,1745259906.295 [DataOverHttps](INFO): SBD MOMSN=24699626 2025-04-21T18:25:06.381Z,1745259906.381 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-21T18:25:43.991Z,1745259943.991 [GFScanner](IMPORTANT): Component DAT failed to stop in time, failing the component 2025-04-21T18:25:43.991Z,1745259943.991 [DAT] Hardware Fault, FailCount= 1 2025-04-21T18:25:43.991Z,1745259943.991 [DAT](ERROR): Hardware Fault 2025-04-21T18:25:43.992Z,1745259943.992 [Supervisor](INFO): Attempting to isolate load for component: DAT 2025-04-21T18:25:43.993Z,1745259943.993 [Supervisor](INFO): Isolating primary load control for DAT 2025-04-21T18:25:43.995Z,1745259943.995 [Supervisor](INFO): Successfully isolated primary load for component: DAT 2025-04-21T18:25:43.996Z,1745259943.996 [GFScanner](DEBUG): Successfully isolated load for component DAT 2025-04-21T18:25:44.029Z,1745259944.029 [DAT](INFO): Powering down 2025-04-21T18:25:44.382Z,1745259944.382 [CBIT](ERROR): Hardware Fault in component: DAT 2025-04-21T18:25:54.063Z,1745259954.063 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:25:54.063Z,1745259954.063 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:25:58.530Z,1745259958.530 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.010655 CHAN A1 (24V): -0.050554 CHAN A2 (12V): -0.005244 CHAN A3 (5V): -0.002634 CHAN B0 (3.3V): -0.001605 CHAN B1 (3.15aV): -0.001329 CHAN B2 (3.15bV): -0.001564 CHAN B3 (GND): -0.000528 OPEN: 0.003876 Full Scale: +/- 1 mA 2025-04-21T18:25:59.759Z,1745259959.759 [GFScanner](INFO): Component DAT is failed, CBIT will restart after scan 2025-04-21T18:25:59.760Z,1745259959.760 [Supervisor](INFO): Attempting to de-isolate load for component: DAT 2025-04-21T18:25:59.760Z,1745259959.760 [Supervisor](INFO): De-isolating primary load control for DAT 2025-04-21T18:25:59.779Z,1745259959.779 [Supervisor](INFO): Successfully de-isolated primary load for component: DAT 2025-04-21T18:25:59.779Z,1745259959.779 [GFScanner](DEBUG): Successfully de-isolated load for component DAT 2025-04-21T18:25:59.779Z,1745259959.779 [GFScanner](INFO): Component DAT processing complete 2025-04-21T18:26:00.156Z,1745259960.156 [Supervisor](DEBUG): Could not find element DataOverHttps.loadControl 2025-04-21T18:26:00.156Z,1745259960.156 [GFScanner](DEBUG): Skipping component DataOverHttps - no load control 2025-04-21T18:26:00.157Z,1745259960.157 [GFScanner](IMPORTANT): Skipping component Depth_Keller, isolate manually if desired 2025-04-21T18:26:00.158Z,1745259960.158 [Supervisor](DEBUG): Could not find element DropWeight.loadControl 2025-04-21T18:26:00.158Z,1745259960.158 [GFScanner](DEBUG): Skipping component DropWeight - no load control 2025-04-21T18:26:00.158Z,1745259960.158 [GFScanner](INFO): Testing component MultiRay for ground fault isolation 2025-04-21T18:26:00.159Z,1745259960.159 [GFScanner](INFO): Component MultiRay is not running, proceeding to isolation 2025-04-21T18:26:00.159Z,1745259960.159 [Supervisor](INFO): Attempting to isolate load for component: MultiRay 2025-04-21T18:26:00.160Z,1745259960.160 [Supervisor](INFO): Isolating primary load control for MultiRay 2025-04-21T18:26:00.162Z,1745259960.162 [Supervisor](INFO): Successfully isolated primary load for component: MultiRay 2025-04-21T18:26:00.163Z,1745259960.163 [GFScanner](DEBUG): Successfully isolated load for component MultiRay 2025-04-21T18:26:00.918Z,1745259960.918 [MultiRay](INFO): Powering down LCB2 2025-04-21T18:26:00.918Z,1745259960.918 [MultiRay](INFO): Powering down. 2025-04-21T18:26:10.257Z,1745259970.257 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:26:10.257Z,1745259970.257 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:26:14.701Z,1745259974.701 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.011541 CHAN A1 (24V): -0.050278 CHAN A2 (12V): -0.005314 CHAN A3 (5V): -0.002852 CHAN B0 (3.3V): -0.001225 CHAN B1 (3.15aV): -0.001203 CHAN B2 (3.15bV): -0.001264 CHAN B3 (GND): -0.001001 OPEN: 0.004773 Full Scale: +/- 1 mA 2025-04-21T18:26:15.899Z,1745259975.899 [Supervisor](INFO): Attempting to de-isolate load for component: MultiRay 2025-04-21T18:26:15.899Z,1745259975.899 [Supervisor](INFO): De-isolating primary load control for MultiRay 2025-04-21T18:26:15.903Z,1745259975.903 [Supervisor](INFO): Successfully de-isolated primary load for component: MultiRay 2025-04-21T18:26:15.903Z,1745259975.903 [GFScanner](DEBUG): Successfully de-isolated load for component MultiRay 2025-04-21T18:26:15.903Z,1745259975.903 [GFScanner](INFO): Component MultiRay processing complete 2025-04-21T18:26:16.316Z,1745259976.316 [GFScanner](INFO): Testing component NAL9602 for ground fault isolation 2025-04-21T18:26:16.317Z,1745259976.317 [GFScanner](INFO): Stopping component NAL9602 for ground fault isolation test 2025-04-21T18:26:16.674Z,1745259976.674 [NAL9602](INFO): Powering down 2025-04-21T18:26:17.097Z,1745259977.097 [Supervisor](INFO): Attempting to isolate load for component: NAL9602 2025-04-21T18:26:17.098Z,1745259977.098 [Supervisor](INFO): Isolating primary load control for NAL9602 2025-04-21T18:26:17.100Z,1745259977.100 [Supervisor](INFO): Successfully isolated primary load for component: NAL9602 2025-04-21T18:26:17.101Z,1745259977.101 [GFScanner](DEBUG): Successfully isolated load for component NAL9602 2025-04-21T18:26:17.882Z,1745259977.882 [NAL9602](INFO): Powering down 2025-04-21T18:26:19.141Z,1745259979.141 [NAL9602](INFO): Powering down 2025-04-21T18:26:20.322Z,1745259980.322 [NAL9602](INFO): Powering down 2025-04-21T18:26:21.522Z,1745259981.522 [NAL9602](INFO): Powering down 2025-04-21T18:26:22.730Z,1745259982.730 [NAL9602](INFO): Powering down 2025-04-21T18:26:23.944Z,1745259983.944 [NAL9602](INFO): Powering down 2025-04-21T18:26:25.154Z,1745259985.154 [NAL9602](INFO): Powering down 2025-04-21T18:26:26.370Z,1745259986.370 [NAL9602](INFO): Powering down 2025-04-21T18:26:27.190Z,1745259987.190 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:26:27.190Z,1745259987.190 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:26:27.583Z,1745259987.583 [NAL9602](INFO): Powering down 2025-04-21T18:26:28.790Z,1745259988.790 [NAL9602](INFO): Powering down 2025-04-21T18:26:30.002Z,1745259990.002 [NAL9602](INFO): Powering down 2025-04-21T18:26:31.263Z,1745259991.263 [NAL9602](INFO): Powering down 2025-04-21T18:26:31.662Z,1745259991.662 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.012568 CHAN A1 (24V): -0.049395 CHAN A2 (12V): -0.005784 CHAN A3 (5V): -0.003325 CHAN B0 (3.3V): -0.001225 CHAN B1 (3.15aV): -0.001296 CHAN B2 (3.15bV): -0.001497 CHAN B3 (GND): -0.000915 OPEN: 0.004927 Full Scale: +/- 1 mA 2025-04-21T18:26:32.442Z,1745259992.442 [NAL9602](INFO): Powering down 2025-04-21T18:26:32.858Z,1745259992.858 [Supervisor](INFO): Attempting to de-isolate load for component: NAL9602 2025-04-21T18:26:32.859Z,1745259992.859 [Supervisor](INFO): De-isolating primary load control for NAL9602 2025-04-21T18:26:32.862Z,1745259992.862 [Supervisor](INFO): Successfully de-isolated primary load for component: NAL9602 2025-04-21T18:26:32.862Z,1745259992.862 [GFScanner](DEBUG): Successfully de-isolated load for component NAL9602 2025-04-21T18:26:32.862Z,1745259992.862 [GFScanner](INFO): Restarting component NAL9602 after ground fault isolation test 2025-04-21T18:26:33.252Z,1745259993.252 [GFScanner](INFO): Component NAL9602 processing complete 2025-04-21T18:26:33.656Z,1745259993.656 [Supervisor](DEBUG): Could not find element Onboard.loadControl 2025-04-21T18:26:33.656Z,1745259993.656 [GFScanner](DEBUG): Skipping component Onboard - no load control 2025-04-21T18:26:33.657Z,1745259993.657 [GFScanner](INFO): Testing component PowerOnly for ground fault isolation 2025-04-21T18:26:33.657Z,1745259993.657 [GFScanner](INFO): Component PowerOnly is not running, proceeding to isolation 2025-04-21T18:26:33.657Z,1745259993.657 [Supervisor](INFO): Attempting to isolate load for component: PowerOnly 2025-04-21T18:26:33.658Z,1745259993.658 [Supervisor](INFO): Isolating primary load control for PowerOnly 2025-04-21T18:26:33.668Z,1745259993.668 [Supervisor](INFO): Successfully isolated primary load for component: PowerOnly 2025-04-21T18:26:33.668Z,1745259993.668 [GFScanner](DEBUG): Successfully isolated load for component PowerOnly 2025-04-21T18:26:43.762Z,1745260003.762 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:26:43.762Z,1745260003.762 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:26:48.306Z,1745260008.306 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.011979 CHAN A1 (24V): -0.050014 CHAN A2 (12V): -0.005444 CHAN A3 (5V): -0.002646 CHAN B0 (3.3V): -0.000861 CHAN B1 (3.15aV): -0.001647 CHAN B2 (3.15bV): -0.001269 CHAN B3 (GND): -0.000282 OPEN: 0.004827 Full Scale: +/- 1 mA 2025-04-21T18:26:49.443Z,1745260009.443 [Supervisor](INFO): Attempting to de-isolate load for component: PowerOnly 2025-04-21T18:26:49.444Z,1745260009.444 [Supervisor](INFO): De-isolating primary load control for PowerOnly 2025-04-21T18:26:49.451Z,1745260009.451 [Supervisor](INFO): Successfully de-isolated primary load for component: PowerOnly 2025-04-21T18:26:49.451Z,1745260009.451 [GFScanner](DEBUG): Successfully de-isolated load for component PowerOnly 2025-04-21T18:26:49.451Z,1745260009.451 [GFScanner](INFO): Component PowerOnly processing complete 2025-04-21T18:26:49.841Z,1745260009.841 [GFScanner](IMPORTANT): Skipping component Power24vConverter, isolate manually if desired 2025-04-21T18:26:49.842Z,1745260009.842 [GFScanner](INFO): Testing component Radio_Surface for ground fault isolation 2025-04-21T18:26:49.842Z,1745260009.842 [GFScanner](INFO): Stopping component Radio_Surface for ground fault isolation test 2025-04-21T18:26:50.069Z,1745260010.069 [Radio_Surface](INFO): Powering down 2025-04-21T18:26:50.654Z,1745260010.654 [Supervisor](INFO): Attempting to isolate load for component: Radio_Surface 2025-04-21T18:26:50.655Z,1745260010.655 [Supervisor](INFO): Isolating primary load control for Radio_Surface 2025-04-21T18:26:50.662Z,1745260010.662 [Supervisor](INFO): Successfully isolated primary load for component: Radio_Surface 2025-04-21T18:26:50.662Z,1745260010.662 [GFScanner](DEBUG): Successfully isolated load for component Radio_Surface 2025-04-21T18:26:56.129Z,1745260016.129 [Radio_Surface](INFO): Powering down 2025-04-21T18:27:00.750Z,1745260020.750 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:27:00.750Z,1745260020.750 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:27:02.189Z,1745260022.189 [Radio_Surface](INFO): Powering down 2025-04-21T18:27:02.731Z,1745260022.731 [NAL9602](INFO): Powering up NAL9602 2025-04-21T18:27:05.189Z,1745260025.189 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.013820 CHAN A1 (24V): -0.050495 CHAN A2 (12V): -0.005379 CHAN A3 (5V): -0.003629 CHAN B0 (3.3V): -0.001341 CHAN B1 (3.15aV): -0.001965 CHAN B2 (3.15bV): -0.001453 CHAN B3 (GND): -0.000843 OPEN: 0.004841 Full Scale: +/- 1 mA 2025-04-21T18:27:06.388Z,1745260026.388 [Supervisor](INFO): Attempting to de-isolate load for component: Radio_Surface 2025-04-21T18:27:06.389Z,1745260026.389 [Supervisor](INFO): De-isolating primary load control for Radio_Surface 2025-04-21T18:27:06.391Z,1745260026.391 [Supervisor](INFO): Successfully de-isolated primary load for component: Radio_Surface 2025-04-21T18:27:06.392Z,1745260026.392 [GFScanner](DEBUG): Successfully de-isolated load for component Radio_Surface 2025-04-21T18:27:06.392Z,1745260026.392 [GFScanner](INFO): Restarting component Radio_Surface after ground fault isolation test 2025-04-21T18:27:06.633Z,1745260026.633 [Radio_Surface](INFO): Powering up 2025-04-21T18:27:06.783Z,1745260026.783 [GFScanner](INFO): Component Radio_Surface processing complete 2025-04-21T18:27:07.186Z,1745260027.186 [Supervisor](DEBUG): Could not find element DeadReckonUsingMultipleVelocitySources.loadControl 2025-04-21T18:27:07.186Z,1745260027.186 [GFScanner](DEBUG): Skipping component DeadReckonUsingMultipleVelocitySources - no load control 2025-04-21T18:27:07.187Z,1745260027.187 [Supervisor](DEBUG): Could not find element NavChart.loadControl 2025-04-21T18:27:07.187Z,1745260027.187 [GFScanner](DEBUG): Skipping component NavChart - no load control 2025-04-21T18:27:07.187Z,1745260027.187 [Supervisor](DEBUG): Could not find element UniversalFixResidualReporter.loadControl 2025-04-21T18:27:07.187Z,1745260027.187 [GFScanner](DEBUG): Skipping component UniversalFixResidualReporter - no load control 2025-04-21T18:27:07.188Z,1745260027.188 [Supervisor](DEBUG): Could not find element SBIT.loadControl 2025-04-21T18:27:07.188Z,1745260027.188 [GFScanner](DEBUG): Skipping component SBIT - no load control 2025-04-21T18:27:07.189Z,1745260027.189 [Supervisor](DEBUG): Could not find element IBIT.loadControl 2025-04-21T18:27:07.189Z,1745260027.189 [GFScanner](DEBUG): Skipping component IBIT - no load control 2025-04-21T18:27:07.189Z,1745260027.189 [Supervisor](DEBUG): Could not find element CBIT.loadControl 2025-04-21T18:27:07.189Z,1745260027.189 [GFScanner](DEBUG): Skipping component CBIT - no load control 2025-04-21T18:27:07.190Z,1745260027.190 [Supervisor](DEBUG): Could not find element GFScanner.loadControl 2025-04-21T18:27:07.190Z,1745260027.190 [GFScanner](DEBUG): Skipping component GFScanner - no load control 2025-04-21T18:27:07.191Z,1745260027.191 [GFScanner](INFO): Testing component CTD_Seabird for ground fault isolation 2025-04-21T18:27:07.191Z,1745260027.191 [GFScanner](INFO): Component CTD_Seabird is not running, proceeding to isolation 2025-04-21T18:27:07.191Z,1745260027.191 [Supervisor](INFO): Attempting to isolate load for component: CTD_Seabird 2025-04-21T18:27:07.192Z,1745260027.192 [Supervisor](INFO): Isolating primary load control for CTD_Seabird 2025-04-21T18:27:07.195Z,1745260027.195 [Supervisor](INFO): Successfully isolated primary load for component: CTD_Seabird 2025-04-21T18:27:07.196Z,1745260027.196 [GFScanner](DEBUG): Successfully isolated load for component CTD_Seabird 2025-04-21T18:27:13.634Z,1745260033.634 [NAL9602](INFO): NAL9602 initialized 2025-04-21T18:27:16.462Z,1745260036.462 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-21T18:27:17.308Z,1745260037.308 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:27:17.308Z,1745260037.308 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:27:18.237Z,1745260038.237 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.823193 2025-04-21T18:27:21.733Z,1745260041.733 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.012038 CHAN A1 (24V): -0.050323 CHAN A2 (12V): -0.005805 CHAN A3 (5V): -0.002722 CHAN B0 (3.3V): -0.001352 CHAN B1 (3.15aV): -0.000825 CHAN B2 (3.15bV): -0.001665 CHAN B3 (GND): -0.000769 OPEN: 0.004973 Full Scale: +/- 1 mA 2025-04-21T18:27:22.973Z,1745260042.973 [Supervisor](INFO): Attempting to de-isolate load for component: CTD_Seabird 2025-04-21T18:27:22.974Z,1745260042.974 [Supervisor](INFO): De-isolating primary load control for CTD_Seabird 2025-04-21T18:27:22.977Z,1745260042.977 [Supervisor](INFO): Successfully de-isolated primary load for component: CTD_Seabird 2025-04-21T18:27:22.977Z,1745260042.977 [GFScanner](DEBUG): Successfully de-isolated load for component CTD_Seabird 2025-04-21T18:27:22.977Z,1745260042.977 [GFScanner](INFO): Component CTD_Seabird processing complete 2025-04-21T18:27:23.367Z,1745260043.367 [GFScanner](INFO): Testing component PAR_Licor for ground fault isolation 2025-04-21T18:27:23.368Z,1745260043.368 [GFScanner](INFO): Stopping component PAR_Licor for ground fault isolation test 2025-04-21T18:27:28.616Z,1745260048.616 [Supervisor](INFO): Attempting to isolate load for component: PAR_Licor 2025-04-21T18:27:28.616Z,1745260048.616 [Supervisor](INFO): Isolating primary load control for PAR_Licor 2025-04-21T18:27:28.619Z,1745260048.619 [Supervisor](INFO): Successfully isolated primary load for component: PAR_Licor 2025-04-21T18:27:28.619Z,1745260048.619 [GFScanner](DEBUG): Successfully isolated load for component PAR_Licor 2025-04-21T18:27:38.713Z,1745260058.713 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:27:38.713Z,1745260058.713 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:27:43.166Z,1745260063.166 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.011619 CHAN A1 (24V): -0.050126 CHAN A2 (12V): -0.005700 CHAN A3 (5V): -0.003525 CHAN B0 (3.3V): -0.001540 CHAN B1 (3.15aV): -0.001979 CHAN B2 (3.15bV): -0.001862 CHAN B3 (GND): -0.000940 OPEN: 0.004988 Full Scale: +/- 1 mA 2025-04-21T18:27:44.362Z,1745260064.362 [Supervisor](INFO): Attempting to de-isolate load for component: PAR_Licor 2025-04-21T18:27:44.363Z,1745260064.363 [Supervisor](INFO): De-isolating primary load control for PAR_Licor 2025-04-21T18:27:44.366Z,1745260064.366 [Supervisor](INFO): Successfully de-isolated primary load for component: PAR_Licor 2025-04-21T18:27:44.366Z,1745260064.366 [GFScanner](DEBUG): Successfully de-isolated load for component PAR_Licor 2025-04-21T18:27:44.366Z,1745260064.366 [GFScanner](INFO): Restarting component PAR_Licor after ground fault isolation test 2025-04-21T18:27:49.633Z,1745260069.633 [GFScanner](INFO): Component PAR_Licor processing complete 2025-04-21T18:27:50.032Z,1745260070.032 [GFScanner](INFO): Testing component WetLabsBB2FL for ground fault isolation 2025-04-21T18:27:50.032Z,1745260070.032 [GFScanner](INFO): Component WetLabsBB2FL is not running, proceeding to isolation 2025-04-21T18:27:50.033Z,1745260070.033 [Supervisor](INFO): Attempting to isolate load for component: WetLabsBB2FL 2025-04-21T18:27:50.033Z,1745260070.033 [Supervisor](INFO): Isolating primary load control for WetLabsBB2FL 2025-04-21T18:27:50.036Z,1745260070.036 [Supervisor](INFO): Successfully isolated primary load for component: WetLabsBB2FL 2025-04-21T18:27:50.036Z,1745260070.036 [GFScanner](DEBUG): Successfully isolated load for component WetLabsBB2FL 2025-04-21T18:27:51.369Z,1745260071.369 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-21T18:27:57.270Z,1745260077.270 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2025-04-21T18:27:57.273Z,1745260077.273 [BPC1](INFO): Received data from all battery sticks. 2025-04-21T18:28:00.111Z,1745260080.111 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:28:00.111Z,1745260080.111 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:28:04.586Z,1745260084.586 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.013124 CHAN A1 (24V): -0.049307 CHAN A2 (12V): -0.005337 CHAN A3 (5V): -0.003352 CHAN B0 (3.3V): -0.001248 CHAN B1 (3.15aV): -0.001391 CHAN B2 (3.15bV): -0.001626 CHAN B3 (GND): -0.000613 OPEN: 0.004788 Full Scale: +/- 1 mA 2025-04-21T18:28:05.781Z,1745260085.781 [Supervisor](INFO): Attempting to de-isolate load for component: WetLabsBB2FL 2025-04-21T18:28:05.782Z,1745260085.782 [Supervisor](INFO): De-isolating primary load control for WetLabsBB2FL 2025-04-21T18:28:05.784Z,1745260085.784 [Supervisor](INFO): Successfully de-isolated primary load for component: WetLabsBB2FL 2025-04-21T18:28:05.785Z,1745260085.785 [GFScanner](DEBUG): Successfully de-isolated load for component WetLabsBB2FL 2025-04-21T18:28:05.785Z,1745260085.785 [GFScanner](INFO): Component WetLabsBB2FL processing complete 2025-04-21T18:28:06.168Z,1745260086.168 [GFScanner](INFO): Testing component BuoyancyServo for ground fault isolation 2025-04-21T18:28:06.168Z,1745260086.168 [GFScanner](INFO): Component BuoyancyServo is not running, proceeding to isolation 2025-04-21T18:28:06.168Z,1745260086.168 [Supervisor](INFO): Attempting to isolate load for component: BuoyancyServo 2025-04-21T18:28:06.169Z,1745260086.169 [Supervisor](INFO): Isolating primary load control for BuoyancyServo 2025-04-21T18:28:06.172Z,1745260086.172 [Supervisor](INFO): Successfully isolated primary load for component: BuoyancyServo 2025-04-21T18:28:06.172Z,1745260086.172 [GFScanner](DEBUG): Successfully isolated load for component BuoyancyServo 2025-04-21T18:28:08.591Z,1745260088.591 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-04-21T18:28:08.591Z,1745260088.591 [BuoyancyServo](INFO): Powering down 2025-04-21T18:28:16.284Z,1745260096.284 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:28:16.284Z,1745260096.284 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:28:20.717Z,1745260100.717 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.012172 CHAN A1 (24V): -0.050535 CHAN A2 (12V): -0.005101 CHAN A3 (5V): -0.003043 CHAN B0 (3.3V): -0.001619 CHAN B1 (3.15aV): -0.001106 CHAN B2 (3.15bV): -0.001588 CHAN B3 (GND): -0.000748 OPEN: 0.004282 Full Scale: +/- 1 mA 2025-04-21T18:28:21.949Z,1745260101.949 [Supervisor](INFO): Attempting to de-isolate load for component: BuoyancyServo 2025-04-21T18:28:21.949Z,1745260101.949 [Supervisor](INFO): De-isolating primary load control for BuoyancyServo 2025-04-21T18:28:21.952Z,1745260101.952 [Supervisor](INFO): Successfully de-isolated primary load for component: BuoyancyServo 2025-04-21T18:28:21.952Z,1745260101.952 [GFScanner](DEBUG): Successfully de-isolated load for component BuoyancyServo 2025-04-21T18:28:21.953Z,1745260101.953 [GFScanner](INFO): Component BuoyancyServo processing complete 2025-04-21T18:28:22.354Z,1745260102.354 [GFScanner](INFO): Testing component ElevatorServo for ground fault isolation 2025-04-21T18:28:22.355Z,1745260102.355 [GFScanner](INFO): Component ElevatorServo is not running, proceeding to isolation 2025-04-21T18:28:22.355Z,1745260102.355 [Supervisor](INFO): Attempting to isolate load for component: ElevatorServo 2025-04-21T18:28:22.356Z,1745260102.356 [Supervisor](INFO): Isolating primary load control for ElevatorServo 2025-04-21T18:28:22.358Z,1745260102.358 [Supervisor](INFO): Successfully isolated primary load for component: ElevatorServo 2025-04-21T18:28:22.359Z,1745260102.359 [GFScanner](DEBUG): Successfully isolated load for component ElevatorServo 2025-04-21T18:28:23.135Z,1745260103.135 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-04-21T18:28:23.135Z,1745260103.135 [ElevatorServo](INFO): Powering down 2025-04-21T18:28:26.510Z,1745260106.510 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-21T18:28:32.430Z,1745260112.430 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:28:32.431Z,1745260112.431 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:28:36.898Z,1745260116.898 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.012485 CHAN A1 (24V): -0.050396 CHAN A2 (12V): -0.005214 CHAN A3 (5V): -0.002581 CHAN B0 (3.3V): -0.001373 CHAN B1 (3.15aV): -0.000896 CHAN B2 (3.15bV): -0.002232 CHAN B3 (GND): -0.000957 OPEN: 0.004824 Full Scale: +/- 1 mA 2025-04-21T18:28:38.095Z,1745260118.095 [Supervisor](INFO): Attempting to de-isolate load for component: ElevatorServo 2025-04-21T18:28:38.095Z,1745260118.095 [Supervisor](INFO): De-isolating primary load control for ElevatorServo 2025-04-21T18:28:38.098Z,1745260118.098 [Supervisor](INFO): Successfully de-isolated primary load for component: ElevatorServo 2025-04-21T18:28:38.098Z,1745260118.098 [GFScanner](DEBUG): Successfully de-isolated load for component ElevatorServo 2025-04-21T18:28:38.098Z,1745260118.098 [GFScanner](INFO): Component ElevatorServo processing complete 2025-04-21T18:28:38.492Z,1745260118.492 [GFScanner](INFO): Testing component MassServo for ground fault isolation 2025-04-21T18:28:38.492Z,1745260118.492 [GFScanner](INFO): Component MassServo is not running, proceeding to isolation 2025-04-21T18:28:38.492Z,1745260118.492 [Supervisor](INFO): Attempting to isolate load for component: MassServo 2025-04-21T18:28:38.509Z,1745260118.509 [Supervisor](INFO): Isolating primary load control for MassServo 2025-04-21T18:28:38.512Z,1745260118.512 [Supervisor](INFO): Successfully isolated primary load for component: MassServo 2025-04-21T18:28:38.512Z,1745260118.512 [GFScanner](DEBUG): Successfully isolated load for component MassServo 2025-04-21T18:28:39.296Z,1745260119.296 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-04-21T18:28:39.296Z,1745260119.296 [MassServo](INFO): Powering down 2025-04-21T18:28:48.590Z,1745260128.590 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:28:48.590Z,1745260128.590 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:28:53.114Z,1745260133.114 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.013005 CHAN A1 (24V): -0.049348 CHAN A2 (12V): -0.005884 CHAN A3 (5V): -0.002873 CHAN B0 (3.3V): -0.002034 CHAN B1 (3.15aV): -0.000919 CHAN B2 (3.15bV): -0.001525 CHAN B3 (GND): -0.000842 OPEN: 0.004764 Full Scale: +/- 1 mA 2025-04-21T18:28:54.254Z,1745260134.254 [Supervisor](INFO): Attempting to de-isolate load for component: MassServo 2025-04-21T18:28:54.255Z,1745260134.255 [Supervisor](INFO): De-isolating primary load control for MassServo 2025-04-21T18:28:54.258Z,1745260134.258 [Supervisor](INFO): Successfully de-isolated primary load for component: MassServo 2025-04-21T18:28:54.258Z,1745260134.258 [GFScanner](DEBUG): Successfully de-isolated load for component MassServo 2025-04-21T18:28:54.258Z,1745260134.258 [GFScanner](INFO): Component MassServo processing complete 2025-04-21T18:28:54.671Z,1745260134.671 [GFScanner](INFO): Testing component RudderServo for ground fault isolation 2025-04-21T18:28:54.672Z,1745260134.672 [GFScanner](INFO): Component RudderServo is not running, proceeding to isolation 2025-04-21T18:28:54.672Z,1745260134.672 [Supervisor](INFO): Attempting to isolate load for component: RudderServo 2025-04-21T18:28:54.673Z,1745260134.673 [Supervisor](INFO): Isolating primary load control for RudderServo 2025-04-21T18:28:54.675Z,1745260134.675 [Supervisor](INFO): Successfully isolated primary load for component: RudderServo 2025-04-21T18:28:54.676Z,1745260134.676 [GFScanner](DEBUG): Successfully isolated load for component RudderServo 2025-04-21T18:28:55.470Z,1745260135.470 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-04-21T18:28:55.471Z,1745260135.471 [RudderServo](INFO): Powering down 2025-04-21T18:29:01.657Z,1745260141.657 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-21T18:29:04.763Z,1745260144.763 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:29:04.763Z,1745260144.763 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:29:09.216Z,1745260149.216 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.012677 CHAN A1 (24V): -0.049557 CHAN A2 (12V): -0.005234 CHAN A3 (5V): -0.003411 CHAN B0 (3.3V): -0.000849 CHAN B1 (3.15aV): -0.001574 CHAN B2 (3.15bV): -0.001235 CHAN B3 (GND): -0.000459 OPEN: 0.004827 Full Scale: +/- 1 mA 2025-04-21T18:29:10.421Z,1745260150.421 [Supervisor](INFO): Attempting to de-isolate load for component: RudderServo 2025-04-21T18:29:10.422Z,1745260150.422 [Supervisor](INFO): De-isolating primary load control for RudderServo 2025-04-21T18:29:10.425Z,1745260150.425 [Supervisor](INFO): Successfully de-isolated primary load for component: RudderServo 2025-04-21T18:29:10.425Z,1745260150.425 [GFScanner](DEBUG): Successfully de-isolated load for component RudderServo 2025-04-21T18:29:10.425Z,1745260150.425 [GFScanner](INFO): Component RudderServo processing complete 2025-04-21T18:29:10.811Z,1745260150.811 [GFScanner](INFO): Testing component ThrusterHE for ground fault isolation 2025-04-21T18:29:10.812Z,1745260150.812 [GFScanner](INFO): Component ThrusterHE is not running, proceeding to isolation 2025-04-21T18:29:10.812Z,1745260150.812 [Supervisor](INFO): Attempting to isolate load for component: ThrusterHE 2025-04-21T18:29:10.829Z,1745260150.829 [Supervisor](INFO): Isolating primary load control for ThrusterHE 2025-04-21T18:29:10.832Z,1745260150.832 [Supervisor](INFO): Successfully isolated primary load for component: ThrusterHE 2025-04-21T18:29:10.832Z,1745260150.832 [GFScanner](DEBUG): Successfully isolated load for component ThrusterHE 2025-04-21T18:29:11.628Z,1745260151.628 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-04-21T18:29:11.628Z,1745260151.628 [ThrusterHE](INFO): Powering down 2025-04-21T18:29:20.910Z,1745260160.910 [GFScanner](INFO): Requesting scan for ground fault isolation 2025-04-21T18:29:20.910Z,1745260160.910 [GFScanner](INFO): Beginning ground fault scan 2025-04-21T18:29:25.374Z,1745260165.374 [GFScanner](INFO): Ground fault detected mA: CHAN A0 (Batt): 0.012279 CHAN A1 (24V): -0.049134 CHAN A2 (12V): -0.005105 CHAN A3 (5V): -0.003360 CHAN B0 (3.3V): -0.001219 CHAN B1 (3.15aV): -0.001846 CHAN B2 (3.15bV): -0.001220 CHAN B3 (GND): -0.000375 OPEN: 0.004520 Full Scale: +/- 1 mA 2025-04-21T18:29:26.587Z,1745260166.587 [Supervisor](INFO): Attempting to de-isolate load for component: ThrusterHE 2025-04-21T18:29:26.587Z,1745260166.587 [Supervisor](INFO): De-isolating primary load control for ThrusterHE 2025-04-21T18:29:26.590Z,1745260166.590 [Supervisor](INFO): Successfully de-isolated primary load for component: ThrusterHE 2025-04-21T18:29:26.590Z,1745260166.590 [GFScanner](DEBUG): Successfully de-isolated load for component ThrusterHE 2025-04-21T18:29:26.591Z,1745260166.591 [GFScanner](INFO): Component ThrusterHE processing complete 2025-04-21T18:29:26.971Z,1745260166.971 [Supervisor](DEBUG): Could not find element VerticalControl.loadControl 2025-04-21T18:29:26.971Z,1745260166.971 [GFScanner](DEBUG): Skipping component VerticalControl - no load control 2025-04-21T18:29:26.972Z,1745260166.972 [Supervisor](DEBUG): Could not find element HorizontalControl.loadControl 2025-04-21T18:29:26.972Z,1745260166.972 [GFScanner](DEBUG): Skipping component HorizontalControl - no load control 2025-04-21T18:29:26.973Z,1745260166.973 [Supervisor](DEBUG): Could not find element SpeedControl.loadControl 2025-04-21T18:29:26.973Z,1745260166.973 [GFScanner](DEBUG): Skipping component SpeedControl - no load control 2025-04-21T18:29:26.973Z,1745260166.973 [Supervisor](DEBUG): Could not find element LoopControl.loadControl 2025-04-21T18:29:26.973Z,1745260166.973 [GFScanner](DEBUG): Skipping component LoopControl - no load control 2025-04-21T18:29:26.974Z,1745260166.974 [Supervisor](DEBUG): Could not find element MissionManager.loadControl 2025-04-21T18:29:26.974Z,1745260166.974 [GFScanner](DEBUG): Skipping component MissionManager - no load control 2025-04-21T18:29:26.974Z,1745260166.974 [Supervisor](DEBUG): Could not find element Reporter.loadControl 2025-04-21T18:29:26.975Z,1745260166.975 [GFScanner](DEBUG): Skipping component Reporter - no load control 2025-04-21T18:29:26.975Z,1745260166.975 [Supervisor](DEBUG): Could not find element NavChartDb.loadControl 2025-04-21T18:29:26.975Z,1745260166.975 [GFScanner](DEBUG): Skipping component NavChartDb - no load control 2025-04-21T18:29:26.975Z,1745260166.975 [GFScanner](IMPORTANT): Ground fault isolation complete. Any identified components with ground faults have been left isolated. 2025-04-21T18:29:26.975Z,1745260166.975 [GFScanner](INFO): All components tested for ground fault isolation 2025-04-21T18:29:27.379Z,1745260167.379 [GFScanner](IMPORTANT): Ground fault isolation process complete 2025-04-21T18:29:27.786Z,1745260167.786 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:29:27.786Z,1745260167.786 [AHRS_M2] No Fault, FailCount= 5 2025-04-21T18:29:27.786Z,1745260167.786 [CBIT](INFO): Clearing failed state for component DAT 2025-04-21T18:29:27.786Z,1745260167.786 [DAT] No Fault, FailCount= 1 2025-04-21T18:29:27.787Z,1745260167.787 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-21T18:29:27.787Z,1745260167.787 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-04-21T18:29:27.787Z,1745260167.787 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-21T18:29:27.787Z,1745260167.787 [CTD_Seabird] No Fault, FailCount= 1 2025-04-21T18:29:27.788Z,1745260167.788 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:29:27.788Z,1745260167.788 [WetLabsBB2FL] No Fault, FailCount= 2 2025-04-21T18:29:27.883Z,1745260167.883 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:29:27.917Z,1745260167.917 [DAT](INFO): Powering down 2025-04-21T18:29:27.933Z,1745260167.933 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-21T18:29:28.159Z,1745260168.159 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:29:30.941Z,1745260170.941 [DAT](INFO): Powering up 2025-04-21T18:29:30.941Z,1745260170.941 [DAT](DEBUG): Initializing DAT. 2025-04-21T18:29:31.709Z,1745260171.709 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:32.121Z,1745260172.121 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:32.541Z,1745260172.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:32.929Z,1745260172.929 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:33.181Z,1745260173.181 [WetLabsBB2FL] Communications Fault, FailCount= 3 2025-04-21T18:29:33.181Z,1745260173.181 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:29:33.325Z,1745260173.325 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:33.364Z,1745260173.364 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:29:33.681Z,1745260173.681 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:29:33.729Z,1745260173.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:34.141Z,1745260174.141 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:34.545Z,1745260174.545 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:34.571Z,1745260174.571 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:29:34.571Z,1745260174.571 [WetLabsBB2FL] No Fault, FailCount= 3 2025-04-21T18:29:34.894Z,1745260174.894 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:29:34.945Z,1745260174.945 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:35.353Z,1745260175.353 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:35.761Z,1745260175.761 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:36.153Z,1745260176.153 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:36.557Z,1745260176.557 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:36.809Z,1745260176.809 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-21T18:29:36.965Z,1745260176.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:37.377Z,1745260177.377 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:37.781Z,1745260177.781 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:38.193Z,1745260178.193 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:38.581Z,1745260178.581 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:38.989Z,1745260178.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:39.397Z,1745260179.397 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:39.797Z,1745260179.797 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:40.185Z,1745260180.185 [WetLabsBB2FL] Communications Fault, FailCount= 4 2025-04-21T18:29:40.185Z,1745260180.185 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:29:40.201Z,1745260180.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:40.245Z,1745260180.245 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:29:40.617Z,1745260180.617 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:40.685Z,1745260180.685 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:29:40.985Z,1745260180.985 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-21T18:29:40.985Z,1745260180.985 [CTD_Seabird] Communications Fault, FailCount= 2 2025-04-21T18:29:40.985Z,1745260180.985 [CTD_Seabird](ERROR): Communications Fault 2025-04-21T18:29:41.029Z,1745260181.029 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:41.029Z,1745260181.029 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:29:41.029Z,1745260181.029 [AHRS_M2] Communications Fault, FailCount= 1 2025-04-21T18:29:41.029Z,1745260181.029 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:29:41.097Z,1745260181.097 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:29:41.098Z,1745260181.098 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-21T18:29:41.106Z,1745260181.106 [AHRS_M2](INFO): Powering down 2025-04-21T18:29:41.389Z,1745260181.389 [CTD_Seabird](INFO): Powering down 2025-04-21T18:29:41.529Z,1745260181.529 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2025-04-21T18:29:41.529Z,1745260181.529 [WetLabsBB2FL] No Fault, FailCount= 4 2025-04-21T18:29:41.910Z,1745260181.910 [WetLabsBB2FL](INFO): Powering up 2025-04-21T18:29:41.950Z,1745260181.950 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:29:41.950Z,1745260181.950 [AHRS_M2] No Fault, FailCount= 1 2025-04-21T18:29:42.315Z,1745260182.315 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:29:42.358Z,1745260182.358 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2025-04-21T18:29:42.358Z,1745260182.358 [CTD_Seabird] No Fault, FailCount= 2 2025-04-21T18:29:42.737Z,1745260182.737 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-21T18:29:42.801Z,1745260182.801 [DAT](INFO): DAT read: 2025-04-21T18:29:42.802Z,1745260182.802 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-21T18:29:44.067Z,1745260184.067 [DAT](INFO): DAT read: MF Frequency Band 2025-04-21T18:29:44.318Z,1745260184.318 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-04-21T18:29:44.319Z,1745260184.319 [DAT](INFO): DAT read: Apr 21 2025 18:29:39 2025-04-21T18:29:45.326Z,1745260185.326 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-21T18:29:45.327Z,1745260185.327 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-04-21T18:29:45.328Z,1745260185.328 [DAT](INFO): commRate: 800 2025-04-21T18:29:45.873Z,1745260185.873 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:46.273Z,1745260186.273 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:46.682Z,1745260186.682 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:47.089Z,1745260187.089 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:47.209Z,1745260187.209 [WetLabsBB2FL] Communications Fault, FailCount= 5 2025-04-21T18:29:47.209Z,1745260187.209 [WetLabsBB2FL](ERROR): Communications Fault 2025-04-21T18:29:47.393Z,1745260187.393 [DAT](INFO): entering command mode 2025-04-21T18:29:47.501Z,1745260187.501 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:47.536Z,1745260187.536 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:29:47.537Z,1745260187.537 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2025-04-21T18:29:47.593Z,1745260187.593 [DAT](INFO): DAT read: 2025-04-21T18:29:47.594Z,1745260187.594 [DAT](INFO): DAT read: user:1> 2025-04-21T18:29:47.594Z,1745260187.594 [DAT](INFO): setting verbose to 3 2025-04-21T18:29:47.713Z,1745260187.713 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:29:47.845Z,1745260187.845 [DAT](INFO): DAT read: user:1> 2025-04-21T18:29:47.846Z,1745260187.846 [DAT](INFO): DAT read: Verbose | 3 2025-04-21T18:29:47.847Z,1745260187.847 [DAT](INFO): set verbose to 3 2025-04-21T18:29:47.847Z,1745260187.847 [DAT](INFO): setting DatVerbose to 27440 2025-04-21T18:29:47.905Z,1745260187.905 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:48.097Z,1745260188.097 [DAT](INFO): DAT read: user:2> 2025-04-21T18:29:48.098Z,1745260188.098 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-21T18:29:48.099Z,1745260188.099 [DAT](INFO): set DatVerbose to 27440 2025-04-21T18:29:48.099Z,1745260188.099 [DAT](INFO): setting transmit power to 8 2025-04-21T18:29:48.309Z,1745260188.309 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:48.349Z,1745260188.349 [DAT](INFO): DAT read: user:3> 2025-04-21T18:29:48.350Z,1745260188.350 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-21T18:29:48.351Z,1745260188.351 [DAT](INFO): set transmit power to 8 2025-04-21T18:29:48.351Z,1745260188.351 [DAT](INFO): setting local address to 9 2025-04-21T18:29:48.601Z,1745260188.601 [DAT](INFO): DAT read: user:4> 2025-04-21T18:29:48.602Z,1745260188.602 [DAT](INFO): DAT read: LocalAddr | 9 2025-04-21T18:29:48.603Z,1745260188.603 [DAT](INFO): set local address to 9 2025-04-21T18:29:48.604Z,1745260188.604 [DAT](INFO): Setting time to: 18:29:48 And date to:4/21/2025 2025-04-21T18:29:48.709Z,1745260188.709 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:48.853Z,1745260188.853 [DAT](INFO): DAT read: user:5> 2025-04-21T18:29:48.854Z,1745260188.854 [DAT](INFO): DAT read: Mon Apr 21, 2025 18:29:48 2025-04-21T18:29:48.855Z,1745260188.855 [DAT](INFO): Local DAT time set to Mon Apr 21, 2025 18:29:48 2025-04-21T18:29:49.109Z,1745260189.109 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:49.266Z,1745260189.266 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003159 2025-04-21T18:29:49.509Z,1745260189.509 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:49.913Z,1745260189.913 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:50.317Z,1745260190.317 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:50.729Z,1745260190.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:51.133Z,1745260191.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:51.537Z,1745260191.537 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:51.937Z,1745260191.937 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:52.345Z,1745260192.345 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:52.750Z,1745260192.750 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:53.177Z,1745260193.177 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:53.561Z,1745260193.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:53.969Z,1745260193.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:54.373Z,1745260194.373 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:54.785Z,1745260194.785 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:55.201Z,1745260195.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:29:55.201Z,1745260195.201 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:29:55.201Z,1745260195.201 [AHRS_M2] Communications Fault, FailCount= 2 2025-04-21T18:29:55.201Z,1745260195.201 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:29:55.276Z,1745260195.276 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:29:55.307Z,1745260195.307 [AHRS_M2](INFO): Powering down 2025-04-21T18:29:55.789Z,1745260195.789 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2025-04-21T18:29:55.789Z,1745260195.789 [CTD_Seabird] Communications Fault, FailCount= 3 2025-04-21T18:29:55.789Z,1745260195.789 [CTD_Seabird](ERROR): Communications Fault 2025-04-21T18:29:56.140Z,1745260196.140 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:29:56.140Z,1745260196.140 [AHRS_M2] No Fault, FailCount= 2 2025-04-21T18:29:56.141Z,1745260196.141 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2025-04-21T18:29:56.141Z,1745260196.141 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 2025-04-21T18:29:56.193Z,1745260196.193 [CTD_Seabird](INFO): Powering down 2025-04-21T18:29:56.519Z,1745260196.519 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:30:00.077Z,1745260200.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:00.469Z,1745260200.469 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:00.881Z,1745260200.881 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:01.289Z,1745260201.289 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:01.677Z,1745260201.677 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:02.085Z,1745260202.085 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:02.497Z,1745260202.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:02.905Z,1745260202.905 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:03.305Z,1745260203.305 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:03.721Z,1745260203.721 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:04.113Z,1745260204.113 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:04.525Z,1745260204.525 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:04.933Z,1745260204.933 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:05.333Z,1745260205.333 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:05.729Z,1745260205.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:06.141Z,1745260206.141 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:06.172Z,1745260206.172 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-21T18:25:05.0Z 2025-04-21T18:30:06.172Z,1745260206.172 [Default:CheckIn:Read_GPS] Stopped 2025-04-21T18:30:06.172Z,1745260206.172 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-04-21T18:30:06.561Z,1745260206.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:06.595Z,1745260206.595 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-21T18:30:07.133Z,1745260207.133 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:07.545Z,1745260207.545 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:07.945Z,1745260207.945 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:08.353Z,1745260208.353 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:08.757Z,1745260208.757 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:09.165Z,1745260209.165 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:09.569Z,1745260209.569 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:09.569Z,1745260209.569 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:30:09.569Z,1745260209.569 [AHRS_M2] Communications Fault, FailCount= 3 2025-04-21T18:30:09.569Z,1745260209.569 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:30:09.669Z,1745260209.669 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:30:09.677Z,1745260209.677 [AHRS_M2](INFO): Powering down 2025-04-21T18:30:10.523Z,1745260210.523 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:30:10.523Z,1745260210.523 [AHRS_M2] No Fault, FailCount= 3 2025-04-21T18:30:10.887Z,1745260210.887 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:30:13.633Z,1745260213.633 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250421T182045/Courier0004.lzma 2025-04-21T18:30:14.445Z,1745260214.445 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:14.634Z,1745260214.634 [DataOverHttps](INFO): Moved sent file to Logs/20250421T182045/Courier0004.lzma.bak 2025-04-21T18:30:14.634Z,1745260214.634 [DataOverHttps](INFO): SBD MOMSN=24699834 2025-04-21T18:30:14.850Z,1745260214.850 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:15.253Z,1745260215.253 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:15.665Z,1745260215.665 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:16.077Z,1745260216.077 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:16.497Z,1745260216.497 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:16.885Z,1745260216.885 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:17.289Z,1745260217.289 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:17.693Z,1745260217.693 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:18.145Z,1745260218.145 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:18.573Z,1745260218.573 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:18.977Z,1745260218.977 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:19.381Z,1745260219.381 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:19.773Z,1745260219.773 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:20.185Z,1745260220.185 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:20.589Z,1745260220.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:21.005Z,1745260221.005 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:21.409Z,1745260221.409 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:21.817Z,1745260221.817 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:22.225Z,1745260222.225 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:22.629Z,1745260222.629 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:23.033Z,1745260223.033 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:23.437Z,1745260223.437 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:23.845Z,1745260223.845 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:23.845Z,1745260223.845 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:30:23.845Z,1745260223.845 [AHRS_M2] Communications Fault, FailCount= 4 2025-04-21T18:30:23.845Z,1745260223.845 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:30:23.914Z,1745260223.914 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:30:23.936Z,1745260223.936 [AHRS_M2](INFO): Powering down 2025-04-21T18:30:24.769Z,1745260224.769 [CBIT](INFO): Clearing failed state for component AHRS_M2 2025-04-21T18:30:24.769Z,1745260224.769 [AHRS_M2] No Fault, FailCount= 4 2025-04-21T18:30:25.147Z,1745260225.147 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-21T18:30:28.705Z,1745260228.705 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:29.117Z,1745260229.117 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:29.529Z,1745260229.529 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:29.933Z,1745260229.933 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:30.211Z,1745260230.211 [DataOverHttps](INFO): Sending 1157 bytes from file Logs/20250421T182045/Express0001.lzma 2025-04-21T18:30:30.333Z,1745260230.333 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:30.729Z,1745260230.729 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:31.141Z,1745260231.141 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:31.210Z,1745260231.210 [DataOverHttps](INFO): Moved sent file to Logs/20250421T182045/Express0001.lzma.bak 2025-04-21T18:30:31.211Z,1745260231.211 [DataOverHttps](INFO): SBD MOMSN=24699836 2025-04-21T18:30:31.541Z,1745260231.541 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:31.949Z,1745260231.949 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:32.349Z,1745260232.349 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:32.757Z,1745260232.757 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:33.169Z,1745260233.169 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:33.561Z,1745260233.561 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:33.969Z,1745260233.969 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:34.365Z,1745260234.365 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:34.781Z,1745260234.781 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:35.201Z,1745260235.201 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:35.633Z,1745260235.633 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:36.033Z,1745260236.033 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:36.429Z,1745260236.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:36.833Z,1745260236.833 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:37.249Z,1745260237.249 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:37.665Z,1745260237.665 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:38.061Z,1745260238.061 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2025-04-21T18:30:38.061Z,1745260238.061 [AHRS_M2](FAULT): Failed to initialize within timeout. 2025-04-21T18:30:38.061Z,1745260238.061 [AHRS_M2] Communications Fault, FailCount= 5 2025-04-21T18:30:38.061Z,1745260238.061 [AHRS_M2](ERROR): Communications Fault 2025-04-21T18:30:38.159Z,1745260238.159 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2025-04-21T18:30:38.160Z,1745260238.160 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2025-04-21T18:30:38.169Z,1745260238.169 [AHRS_M2](INFO): Powering down 2025-04-21T18:30:38.288Z,1745260238.288 [CBIT](INFO): Critical error at 20250421T183038 2025-04-21T18:30:46.982Z,1745260246.982 [DataOverHttps](INFO): Sending 577 bytes from file Logs/20250421T182045/Express0005.lzma 2025-04-21T18:30:47.983Z,1745260247.983 [DataOverHttps](INFO): Moved sent file to Logs/20250421T182045/Express0005.lzma.bak 2025-04-21T18:30:47.983Z,1745260247.983 [DataOverHttps](INFO): SBD MOMSN=24699871 2025-04-21T18:30:49.510Z,1745260249.510 [Default:CheckIn:Read_Iridium] Stopped 2025-04-21T18:30:49.510Z,1745260249.510 [Default:CheckIn:C.Wait] Running Loop=1 2025-04-21T18:30:49.510Z,1745260249.510 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-04-21T18:31:28.344Z,1745260288.344 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2025-04-21T18:31:28.344Z,1745260288.344 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-04-21T18:31:28.344Z,1745260288.344 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-21T18:31:28.404Z,1745260288.404 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-21T18:31:28.774Z,1745260288.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-21T18:31:28.774Z,1745260288.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-04-21T18:31:32.029Z,1745260292.029 [CommandExec](IMPORTANT): got command quit 2025-04-21T18:31:33.033Z,1745260293.033 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:33.033Z,1745260293.033 [CommandExec](INFO): Uninitializing the command executive. 2025-04-21T18:31:33.033Z,1745260293.033 [CommandExec](INFO): Uninitializing the command scheduler. 2025-04-21T18:31:33.033Z,1745260293.033 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.085Z,1745260293.085 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-04-21T18:31:33.085Z,1745260293.085 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-04-21T18:31:33.085Z,1745260293.085 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.086Z,1745260293.086 [NavChartDb](INFO): Join timeout helper Thread ID is 3483 2025-04-21T18:31:33.257Z,1745260293.257 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:33.257Z,1745260293.257 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.270Z,1745260293.270 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-04-21T18:31:33.270Z,1745260293.270 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.271Z,1745260293.271 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3484 2025-04-21T18:31:33.661Z,1745260293.661 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:33.661Z,1745260293.661 [WetLabsBB2FL](INFO): Powering down 2025-04-21T18:31:33.662Z,1745260293.662 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.669Z,1745260293.669 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-04-21T18:31:33.669Z,1745260293.669 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.669Z,1745260293.669 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3485 2025-04-21T18:31:33.739Z,1745260293.739 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:33.739Z,1745260293.739 [CTD_Seabird](INFO): Powering down 2025-04-21T18:31:33.753Z,1745260293.753 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.757Z,1745260293.757 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-04-21T18:31:33.757Z,1745260293.757 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:33.757Z,1745260293.757 [Radio_Surface](INFO): Join timeout helper Thread ID is 3486 2025-04-21T18:31:34.141Z,1745260294.141 [Radio_Surface](INFO): Powering down 2025-04-21T18:31:34.142Z,1745260294.142 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:34.142Z,1745260294.142 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:34.149Z,1745260294.149 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-04-21T18:31:34.149Z,1745260294.149 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:34.149Z,1745260294.149 [Onboard](INFO): Join timeout helper Thread ID is 3487 2025-04-21T18:31:35.053Z,1745260295.053 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-04-21T18:31:37.622Z,1745260297.622 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-04-21T18:31:37.622Z,1745260297.622 [NAL9602] Data Fault, FailCount= 1 2025-04-21T18:31:37.622Z,1745260297.622 [NAL9602](ERROR): Data Fault 2025-04-21T18:31:37.640Z,1745260297.640 [CBIT](ERROR): Data Fault in component: NAL9602 2025-04-21T18:31:37.837Z,1745260297.837 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:37.837Z,1745260297.837 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:37.845Z,1745260297.845 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-04-21T18:31:37.846Z,1745260297.846 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:37.846Z,1745260297.846 [DataOverHttps](INFO): Join timeout helper Thread ID is 3488 2025-04-21T18:31:38.022Z,1745260298.022 [NAL9602](INFO): Powering down 2025-04-21T18:31:38.065Z,1745260298.065 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:38.065Z,1745260298.065 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.073Z,1745260298.073 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-04-21T18:31:38.073Z,1745260298.073 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.073Z,1745260298.073 [DAT](INFO): Join timeout helper Thread ID is 3489 2025-04-21T18:31:38.293Z,1745260298.293 [DAT](INFO): Powering down 2025-04-21T18:31:38.365Z,1745260298.365 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:38.365Z,1745260298.365 [DAT](INFO): Powering down 2025-04-21T18:31:38.366Z,1745260298.366 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.378Z,1745260298.378 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-04-21T18:31:38.378Z,1745260298.378 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.378Z,1745260298.378 [BackseatComponent](INFO): Join timeout helper Thread ID is 3490 2025-04-21T18:31:38.397Z,1745260298.397 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:38.397Z,1745260298.397 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.413Z,1745260298.413 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-04-21T18:31:38.414Z,1745260298.414 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.414Z,1745260298.414 [logger](INFO): Join timeout helper Thread ID is 3491 2025-04-21T18:31:38.429Z,1745260298.429 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:38.430Z,1745260298.430 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.438Z,1745260298.438 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-04-21T18:31:38.438Z,1745260298.438 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.438Z,1745260298.438 [CommandLine](INFO): Join timeout helper Thread ID is 3492 2025-04-21T18:31:38.537Z,1745260298.537 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:38.537Z,1745260298.537 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.549Z,1745260298.549 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-04-21T18:31:38.549Z,1745260298.549 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.550Z,1745260298.550 [CommandExec](INFO): Join timeout helper Thread ID is 3493 2025-04-21T18:31:38.551Z,1745260298.551 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-04-21T18:31:38.551Z,1745260298.551 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.551Z,1745260298.551 [controlThread](INFO): Join timeout helper Thread ID is 3494 2025-04-21T18:31:38.821Z,1745260298.821 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-21T18:31:38.821Z,1745260298.821 [controlThread](DEBUG): Uninitializing ControlThread 2025-04-21T18:31:38.821Z,1745260298.821 [AHRS_M2](INFO): Powering down 2025-04-21T18:31:38.825Z,1745260298.825 [MultiRay](INFO): Powering down LCB2 2025-04-21T18:31:38.826Z,1745260298.826 [MultiRay](INFO): Powering down. 2025-04-21T18:31:38.827Z,1745260298.827 [NAL9602](INFO): Powering down 2025-04-21T18:31:38.829Z,1745260298.829 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-04-21T18:31:38.830Z,1745260298.830 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-04-21T18:31:38.830Z,1745260298.830 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-04-21T18:31:38.831Z,1745260298.831 [MissionManager](INFO): Uninitializing Mission Default 2025-04-21T18:31:38.831Z,1745260298.831 [Default] Stopped 2025-04-21T18:31:38.831Z,1745260298.831 [Default](DEBUG): Aggregate::uninitialize Default 2025-04-21T18:31:38.831Z,1745260298.831 [Default:B.GoToSurface] Stopped 2025-04-21T18:31:38.831Z,1745260298.831 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-21T18:31:38.831Z,1745260298.831 [Default:CheckIn] Stopped 2025-04-21T18:31:38.831Z,1745260298.831 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-04-21T18:31:38.831Z,1745260298.831 [Default:CheckIn:C.Wait] Stopped 2025-04-21T18:31:38.832Z,1745260298.832 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-04-21T18:31:38.835Z,1745260298.835 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-04-21T18:31:38.835Z,1745260298.835 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-04-21T18:31:38.835Z,1745260298.835 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-04-21T18:31:38.836Z,1745260298.836 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-04-21T18:31:38.836Z,1745260298.836 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-04-21T18:31:38.836Z,1745260298.836 [BuoyancyServo](INFO): Powering down 2025-04-21T18:31:38.849Z,1745260298.849 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-04-21T18:31:38.849Z,1745260298.849 [ElevatorServo](INFO): Powering down 2025-04-21T18:31:38.850Z,1745260298.850 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-04-21T18:31:38.850Z,1745260298.850 [MassServo](INFO): Powering down 2025-04-21T18:31:38.851Z,1745260298.851 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-04-21T18:31:38.851Z,1745260298.851 [RudderServo](INFO): Powering down 2025-04-21T18:31:38.852Z,1745260298.852 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-04-21T18:31:38.852Z,1745260298.852 [ThrusterHE](INFO): Powering down 2025-04-21T18:31:38.853Z,1745260298.853 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-04-21T18:31:38.853Z,1745260298.853 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-04-21T18:31:38.853Z,1745260298.853 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-04-21T18:31:38.853Z,1745260298.853 [CBIT](DEBUG): Powering off loads. 2025-04-21T18:31:38.864Z,1745260298.864 [CBIT](DEBUG): Disabling WDT. 2025-04-21T18:31:38.877Z,1745260298.877 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-04-21T18:31:38.877Z,1745260298.877 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-04-21T18:31:38.878Z,1745260298.878 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.903Z,1745260298.903 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.908Z,1745260298.908 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.916Z,1745260298.916 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.925Z,1745260298.925 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:38.969Z,1745260298.969 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:39.006Z,1745260299.006 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-04-21T18:31:39.006Z,1745260299.006 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-04-21T18:31:39.022Z,1745260299.022 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:39.027Z,1745260299.027 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:39.088Z,1745260299.088 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-21T18:31:39.138Z,1745260299.138 [logger ThreadHandler](INFO): Thread cancelled.