2026-01-30T17:58:41.550Z,1769795921.550 [Supervisor](DEBUG): Initializing supervisor.
2026-01-30T17:58:41.564Z,1769795921.564 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2026-01-30T17:58:41.564Z,1769795921.564 [SyncHandler](INFO): Protected caller Thread ID is 836
2026-01-30T17:58:41.565Z,1769795921.565 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2026-01-30T17:58:41.576Z,1769795921.576 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2026-01-30T17:58:41.576Z,1769795921.576 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 837
2026-01-30T17:58:41.580Z,1769795921.580 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2026-01-30T17:58:41.624Z,1769795921.624 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2026-01-30T17:58:41.636Z,1769795921.636 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2026-01-30T17:58:41.636Z,1769795921.636 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 838
2026-01-30T17:58:41.640Z,1769795921.640 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2026-01-30T17:58:41.652Z,1769795921.652 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2026-01-30T17:58:41.652Z,1769795921.652 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839
2026-01-30T17:58:41.654Z,1769795921.654 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2026-01-30T17:58:41.664Z,1769795921.664 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2026-01-30T17:58:41.664Z,1769795921.664 [logger ThreadHandler](INFO): Protected caller Thread ID is 840
2026-01-30T17:58:41.668Z,1769795921.668 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2026-01-30T17:58:41.668Z,1769795921.668 [Supervisor](INFO): Looking for Config files in directory: Config/
2026-01-30T17:58:41.681Z,1769795921.681 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2026-01-30T17:58:42.180Z,1769795922.180 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2026-01-30T17:58:42.180Z,1769795922.180 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2026-01-30T17:58:42.278Z,1769795922.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2026-01-30T17:58:42.280Z,1769795922.280 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2026-01-30T17:58:42.395Z,1769795922.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2026-01-30T17:58:42.395Z,1769795922.395 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2026-01-30T17:58:42.533Z,1769795922.533 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2026-01-30T17:58:42.534Z,1769795922.534 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2026-01-30T17:58:42.972Z,1769795922.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2026-01-30T17:58:42.972Z,1769795922.972 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2026-01-30T17:58:43.076Z,1769795923.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2026-01-30T17:58:43.077Z,1769795923.077 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2026-01-30T17:58:43.467Z,1769795923.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2026-01-30T17:58:43.469Z,1769795923.469 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2026-01-30T17:58:43.693Z,1769795923.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2026-01-30T17:58:43.694Z,1769795923.694 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2026-01-30T17:58:43.782Z,1769795923.782 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2026-01-30T17:58:44.023Z,1769795924.023 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2026-01-30T17:58:44.025Z,1769795924.025 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2026-01-30T17:58:44.276Z,1769795924.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2026-01-30T17:58:44.278Z,1769795924.278 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2026-01-30T17:58:44.825Z,1769795924.825 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2026-01-30T17:58:44.827Z,1769795924.827 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2026-01-30T17:58:45.010Z,1769795925.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2026-01-30T17:58:45.011Z,1769795925.011 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2026-01-30T17:58:45.306Z,1769795925.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2026-01-30T17:58:45.307Z,1769795925.307 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2026-01-30T17:58:46.123Z,1769795926.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2026-01-30T17:58:46.125Z,1769795926.125 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2026-01-30T17:58:46.670Z,1769795926.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2026-01-30T17:58:46.672Z,1769795926.672 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2026-01-30T17:58:46.675Z,1769795926.675 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2026-01-30T17:58:46.778Z,1769795926.778 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2026-01-30T17:58:46.912Z,1769795926.912 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2026-01-30T17:58:47.005Z,1769795927.005 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2026-01-30T17:58:47.118Z,1769795927.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2026-01-30T17:58:47.218Z,1769795927.218 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2026-01-30T17:58:47.482Z,1769795927.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2026-01-30T17:58:47.483Z,1769795927.483 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2026-01-30T17:58:47.598Z,1769795927.598 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2026-01-30T17:58:47.702Z,1769795927.702 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2026-01-30T17:58:47.846Z,1769795927.846 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2026-01-30T17:58:47.941Z,1769795927.941 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2026-01-30T17:58:47.941Z,1769795927.941 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2026-01-30T17:58:47.955Z,1769795927.955 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2026-01-30T17:58:48.118Z,1769795928.118 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2026-01-30T17:58:48.119Z,1769795928.119 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2026-01-30T17:58:48.190Z,1769795928.190 [VerticalControl](DEBUG): Construct VerticalControl.
2026-01-30T17:58:48.249Z,1769795928.249 [VerticalControl] Loaded
2026-01-30T17:58:48.250Z,1769795928.250 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2026-01-30T17:58:48.252Z,1769795928.252 [HorizontalControl](DEBUG): Construct HorizontalControl.
2026-01-30T17:58:48.299Z,1769795928.299 [HorizontalControl] Loaded
2026-01-30T17:58:48.300Z,1769795928.300 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2026-01-30T17:58:48.302Z,1769795928.302 [SpeedControl](DEBUG): Construct SpeedControl.
2026-01-30T17:58:48.305Z,1769795928.305 [SpeedControl] Loaded
2026-01-30T17:58:48.305Z,1769795928.305 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2026-01-30T17:58:48.308Z,1769795928.308 [LoopControl](DEBUG): Construct LoopControl.
2026-01-30T17:58:48.308Z,1769795928.308 [LoopControl] Loaded
2026-01-30T17:58:48.309Z,1769795928.309 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2026-01-30T17:58:48.309Z,1769795928.309 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2026-01-30T17:58:48.311Z,1769795928.311 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2026-01-30T17:58:48.396Z,1769795928.396 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2026-01-30T17:58:48.397Z,1769795928.397 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2026-01-30T17:58:49.226Z,1769795929.226 [AHRS_M2] Loaded
2026-01-30T17:58:49.226Z,1769795929.226 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2026-01-30T17:58:49.480Z,1769795929.480 [BackseatComponent] Loaded
2026-01-30T17:58:49.480Z,1769795929.480 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2026-01-30T17:58:49.481Z,1769795929.481 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0
2026-01-30T17:58:49.482Z,1769795929.482 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 920
2026-01-30T17:58:49.485Z,1769795929.485 [LcmPublisher](INFO): Full slate access is ENABLED. All requested slate values (including non-universals) will be published on LCM.
2026-01-30T17:58:49.485Z,1769795929.485 [LcmPublisher] Loaded
2026-01-30T17:58:49.485Z,1769795929.485 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread.
2026-01-30T17:58:50.292Z,1769795930.292 [BPC1] Loaded
2026-01-30T17:58:50.292Z,1769795930.292 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2026-01-30T17:58:50.388Z,1769795930.388 [DAT] Loaded
2026-01-30T17:58:50.388Z,1769795930.388 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2026-01-30T17:58:50.389Z,1769795930.389 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0
2026-01-30T17:58:50.390Z,1769795930.390 [DAT ThreadHandler](INFO): Protected caller Thread ID is 921
2026-01-30T17:58:50.530Z,1769795930.530 [DataOverHttps] Loaded
2026-01-30T17:58:50.530Z,1769795930.530 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2026-01-30T17:58:50.531Z,1769795930.531 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4091D4E0
2026-01-30T17:58:50.532Z,1769795930.532 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922
2026-01-30T17:58:50.554Z,1769795930.554 [Depth_Keller] Loaded
2026-01-30T17:58:50.554Z,1769795930.554 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2026-01-30T17:58:50.559Z,1769795930.559 [DropWeight] Loaded
2026-01-30T17:58:50.559Z,1769795930.559 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2026-01-30T17:58:50.623Z,1769795930.623 [NAL9602] Loaded
2026-01-30T17:58:50.623Z,1769795930.623 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2026-01-30T17:58:50.652Z,1769795930.652 [Onboard] Loaded
2026-01-30T17:58:50.653Z,1769795930.653 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2026-01-30T17:58:50.654Z,1769795930.654 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4094D4E0
2026-01-30T17:58:50.654Z,1769795930.654 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923
2026-01-30T17:58:50.668Z,1769795930.668 [Power24vConverter] Loaded
2026-01-30T17:58:50.668Z,1769795930.668 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2026-01-30T17:58:50.698Z,1769795930.698 [Radio_Surface] Loaded
2026-01-30T17:58:50.699Z,1769795930.699 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2026-01-30T17:58:50.699Z,1769795930.699 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4097D4E0
2026-01-30T17:58:50.700Z,1769795930.700 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924
2026-01-30T17:58:50.715Z,1769795930.715 [Sonardyne_Nano] Loaded
2026-01-30T17:58:50.715Z,1769795930.715 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2026-01-30T17:58:50.716Z,1769795930.716 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2026-01-30T17:58:50.716Z,1769795930.716 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2026-01-30T17:58:50.737Z,1769795930.737 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2026-01-30T17:58:50.738Z,1769795930.738 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2026-01-30T17:58:50.817Z,1769795930.817 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2026-01-30T17:58:50.817Z,1769795930.817 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2026-01-30T17:58:51.010Z,1769795931.010 [SBIT](DEBUG): Construct Startup Built In Test.
2026-01-30T17:58:51.019Z,1769795931.019 [SBIT] Loaded
2026-01-30T17:58:51.019Z,1769795931.019 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2026-01-30T17:58:51.022Z,1769795931.022 [IBIT](DEBUG): Construct Initiated Built In Test.
2026-01-30T17:58:51.034Z,1769795931.034 [IBIT] Loaded
2026-01-30T17:58:51.034Z,1769795931.034 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2026-01-30T17:58:51.039Z,1769795931.039 [CBIT](DEBUG): Construct Continuous Built In Test.
2026-01-30T17:58:51.118Z,1769795931.118 [CBIT] Loaded
2026-01-30T17:58:51.119Z,1769795931.119 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2026-01-30T17:58:51.151Z,1769795931.151 [GFScanner] Loaded
2026-01-30T17:58:51.151Z,1769795931.151 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2026-01-30T17:58:51.152Z,1769795931.152 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2026-01-30T17:58:51.152Z,1769795931.152 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2026-01-30T17:58:51.549Z,1769795931.549 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2026-01-30T17:58:51.551Z,1769795931.551 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2026-01-30T17:58:51.620Z,1769795931.620 [DepthRateCalculator] Loaded
2026-01-30T17:58:51.620Z,1769795931.620 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2026-01-30T17:58:51.625Z,1769795931.625 [PitchRateCalculator] Loaded
2026-01-30T17:58:51.625Z,1769795931.625 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2026-01-30T17:58:51.635Z,1769795931.635 [SpeedCalculator] Loaded
2026-01-30T17:58:51.636Z,1769795931.636 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2026-01-30T17:58:51.640Z,1769795931.640 [YawRateCalculator] Loaded
2026-01-30T17:58:51.640Z,1769795931.640 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2026-01-30T17:58:51.659Z,1769795931.659 [ElevatorOffsetCalculator] Loaded
2026-01-30T17:58:51.659Z,1769795931.659 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2026-01-30T17:58:51.660Z,1769795931.660 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2026-01-30T17:58:51.660Z,1769795931.660 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2026-01-30T17:58:51.872Z,1769795931.872 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2026-01-30T17:58:51.872Z,1769795931.872 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2026-01-30T17:58:52.008Z,1769795932.008 [DeadReckonUsingMultipleVelocitySources] Loaded
2026-01-30T17:58:52.009Z,1769795932.009 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2026-01-30T17:58:52.022Z,1769795932.022 [NavChart] Loaded
2026-01-30T17:58:52.023Z,1769795932.023 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2026-01-30T17:58:52.028Z,1769795932.028 [UniversalFixResidualReporter] Loaded
2026-01-30T17:58:52.028Z,1769795932.028 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2026-01-30T17:58:52.029Z,1769795932.029 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2026-01-30T17:58:52.030Z,1769795932.030 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2026-01-30T17:58:52.193Z,1769795932.193 [BuoyancyServo] Loaded
2026-01-30T17:58:52.193Z,1769795932.193 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2026-01-30T17:58:52.216Z,1769795932.216 [ElevatorServo] Loaded
2026-01-30T17:58:52.216Z,1769795932.216 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2026-01-30T17:58:52.237Z,1769795932.237 [MassServo] Loaded
2026-01-30T17:58:52.238Z,1769795932.238 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2026-01-30T17:58:52.258Z,1769795932.258 [RudderServo] Loaded
2026-01-30T17:58:52.258Z,1769795932.258 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2026-01-30T17:58:52.275Z,1769795932.275 [ThrusterHE] Loaded
2026-01-30T17:58:52.275Z,1769795932.275 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2026-01-30T17:58:52.276Z,1769795932.276 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2026-01-30T17:58:52.276Z,1769795932.276 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2026-01-30T17:58:52.495Z,1769795932.495 [CTD_Seabird] Loaded
2026-01-30T17:58:52.495Z,1769795932.495 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2026-01-30T17:58:52.496Z,1769795932.496 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0D4E0
2026-01-30T17:58:52.496Z,1769795932.496 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 925
2026-01-30T17:58:52.532Z,1769795932.532 [ESPComponent] Loaded
2026-01-30T17:58:52.533Z,1769795932.533 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2026-01-30T17:58:52.554Z,1769795932.554 [PAR_Licor] Loaded
2026-01-30T17:58:52.554Z,1769795932.554 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2026-01-30T17:58:52.599Z,1769795932.599 [WetLabsBB2FL] Loaded
2026-01-30T17:58:52.599Z,1769795932.599 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2026-01-30T17:58:52.600Z,1769795932.600 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3D4E0
2026-01-30T17:58:52.600Z,1769795932.600 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 926
2026-01-30T17:58:52.601Z,1769795932.601 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2026-01-30T17:58:52.607Z,1769795932.607 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2026-01-30T17:58:52.611Z,1769795932.611 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2026-01-30T17:58:52.622Z,1769795932.622 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2026-01-30T17:58:52.623Z,1769795932.623 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
2026-01-30T17:58:52.623Z,1769795932.623 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 927
2026-01-30T17:58:52.627Z,1769795932.627 [Supervisor](INFO): Main Thread ID is 827
2026-01-30T17:58:52.627Z,1769795932.627 [Supervisor](DEBUG): Running supervisor.
2026-01-30T17:58:52.628Z,1769795932.628 [CommandExec ThreadHandler](INFO): Handler Thread ID is 928
2026-01-30T17:58:52.629Z,1769795932.629 [CommandExec](INFO): Initializing the command executive.
2026-01-30T17:58:52.630Z,1769795932.630 [CommandLine ThreadHandler](INFO): Handler Thread ID is 929
2026-01-30T17:58:52.632Z,1769795932.632 [controlThread ThreadHandler](INFO): Handler Thread ID is 930
2026-01-30T17:58:52.633Z,1769795932.633 [controlThread](DEBUG): Initializing ControlThread
2026-01-30T17:58:52.634Z,1769795932.634 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2026-01-30T17:58:52.635Z,1769795932.635 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2026-01-30T17:58:52.636Z,1769795932.636 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2026-01-30T17:58:52.637Z,1769795932.637 [LoopControl](DEBUG): Initialize LoopControlComponent.
2026-01-30T17:58:52.640Z,1769795932.640 [SBIT](INFO): Initialize SBIT Component.
2026-01-30T17:58:52.640Z,1769795932.640 [SBIT](IMPORTANT): git: 2025-12-11
2026-01-30T17:58:52.640Z,1769795932.640 [SBIT](INFO): git hash: c6c837cd550bef1cdcd0ab398e63035052ae6845
2026-01-30T17:58:52.641Z,1769795932.641 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2026-01-30T17:58:52.642Z,1769795932.642 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023
2026-01-30T17:58:52.643Z,1769795932.643 [SBIT](INFO): Beginning SBIT in 115.000000 seconds.
2026-01-30T17:58:52.643Z,1769795932.643 [IBIT](INFO): Initialize IBIT Component.
2026-01-30T17:58:52.644Z,1769795932.644 [CBIT](DEBUG): Initialize CBIT Component.
2026-01-30T17:58:52.645Z,1769795932.645 [logger ThreadHandler](INFO): Handler Thread ID is 931
2026-01-30T17:58:52.656Z,1769795932.656 [CBIT](DEBUG): Initialized mux pins.
2026-01-30T17:58:52.656Z,1769795932.656 [CBIT](DEBUG): Initializing the watchdog timer.
2026-01-30T17:58:52.664Z,1769795932.664 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 932
2026-01-30T17:58:52.680Z,1769795932.680 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2026-01-30T17:58:52.680Z,1769795932.680 [CBIT](DEBUG): Initializing heartbeat.
2026-01-30T17:58:52.681Z,1769795932.681 [DAT ThreadHandler](INFO): Handler Thread ID is 933
2026-01-30T17:58:52.682Z,1769795932.682 [DAT](INFO): Powering up
2026-01-30T17:58:52.682Z,1769795932.682 [DAT](DEBUG): Initializing DAT.
2026-01-30T17:58:52.685Z,1769795932.685 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935
2026-01-30T17:58:52.687Z,1769795932.687 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2026-01-30T17:58:52.708Z,1769795932.708 [Onboard ThreadHandler](INFO): Handler Thread ID is 936
2026-01-30T17:58:52.725Z,1769795932.725 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937
2026-01-30T17:58:52.748Z,1769795932.748 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938
2026-01-30T17:58:52.749Z,1769795932.749 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2026-01-30T17:58:52.752Z,1769795932.752 [CBIT](DEBUG): Deactivating emergency mode.
2026-01-30T17:58:52.753Z,1769795932.753 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940
2026-01-30T17:58:52.756Z,1769795932.756 [WetLabsBB2FL](INFO): Powering up
2026-01-30T17:58:52.757Z,1769795932.757 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942
2026-01-30T17:58:52.764Z,1769795932.764 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2026-01-30T17:58:52.765Z,1769795932.765 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2026-01-30T17:58:52.765Z,1769795932.765 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2026-01-30T17:58:52.765Z,1769795932.765 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2026-01-30T17:58:52.765Z,1769795932.765 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2026-01-30T17:58:52.765Z,1769795932.765 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2026-01-30T17:58:52.766Z,1769795932.766 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2026-01-30T17:58:52.766Z,1769795932.766 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2026-01-30T17:58:52.792Z,1769795932.792 [CBIT](DEBUG): Backplane powered.
2026-01-30T17:58:52.792Z,1769795932.792 [GFScanner](DEBUG): Initializing GFScanner
2026-01-30T17:58:52.792Z,1769795932.792 [GFScanner](DEBUG): Deactivating GF circuits.
2026-01-30T17:58:52.797Z,1769795932.797 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2026-01-30T17:58:52.797Z,1769795932.797 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2026-01-30T17:58:52.797Z,1769795932.797 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2026-01-30T17:58:52.798Z,1769795932.798 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2026-01-30T17:58:52.798Z,1769795932.798 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2026-01-30T17:58:52.799Z,1769795932.799 [NavChart](DEBUG): Initialize NavChart Navigation.
2026-01-30T17:58:52.799Z,1769795932.799 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2026-01-30T17:58:52.808Z,1769795932.808 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2026-01-30T17:58:52.809Z,1769795932.809 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2026-01-30T17:58:52.809Z,1769795932.809 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2026-01-30T17:58:52.813Z,1769795932.813 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2026-01-30T17:58:52.886Z,1769795932.886 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2026-01-30T17:58:52.890Z,1769795932.890 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2026-01-30T17:58:52.957Z,1769795932.957 [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
    }
  }
}


2026-01-30T17:58:52.958Z,1769795932.958 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2026-01-30T17:58:52.958Z,1769795932.958 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2026-01-30T17:58:52.976Z,1769795932.976 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2026-01-30T17:58:53.132Z,1769795933.132 [Radio_Surface](INFO): Powering up
2026-01-30T17:58:53.252Z,1769795933.252 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2026-01-30T17:58:53.266Z,1769795933.266 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2026-01-30T17:58:53.267Z,1769795933.267 [Default:A.Wait](DEBUG): Construct Wait.
2026-01-30T17:58:53.278Z,1769795933.278 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2026-01-30T17:58:53.342Z,1769795933.342 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2026-01-30T17:58:53.344Z,1769795933.344 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2026-01-30T17:58:53.366Z,1769795933.366 [Default:E.Execute](DEBUG): Construct Execute.
2026-01-30T17:58:53.369Z,1769795933.369 [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"
  }
}


2026-01-30T17:58:53.376Z,1769795933.376 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmPublisher,Reporter,LogSplitter,
2026-01-30T17:58:53.396Z,1769795933.396 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-01-30T17:58:53.552Z,1769795933.552 [Depth_Keller](INFO): Initializing.
2026-01-30T17:58:53.554Z,1769795933.554 [Power24vConverter](INFO): Powering up.
2026-01-30T17:58:53.554Z,1769795933.554 [Sonardyne_Nano](INFO): Initializing.
2026-01-30T17:58:53.577Z,1769795933.577 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-01-30T17:58:53.599Z,1769795933.599 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2026-01-30T17:58:53.604Z,1769795933.604 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2026-01-30T17:58:53.605Z,1769795933.605 [ElevatorServo](DEBUG): Initializing EZServoServo.
2026-01-30T17:58:53.612Z,1769795933.612 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2026-01-30T17:58:53.613Z,1769795933.613 [MassServo](DEBUG): Initializing EZServoServo.
2026-01-30T17:58:53.620Z,1769795933.620 [MassServo](DEBUG): Initializing MassServo.
2026-01-30T17:58:53.621Z,1769795933.621 [RudderServo](DEBUG): Initializing EZServoServo.
2026-01-30T17:58:53.628Z,1769795933.628 [RudderServo](DEBUG): Initializing RudderServo.
2026-01-30T17:58:53.629Z,1769795933.629 [ThrusterHE](DEBUG): Initializing EZServoServo.
2026-01-30T17:58:53.636Z,1769795933.636 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2026-01-30T17:58:53.826Z,1769795933.826 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2026-01-30T17:58:53.826Z,1769795933.826 [DropWeight] Hardware Fault, FailCount= 1
2026-01-30T17:58:53.826Z,1769795933.826 [DropWeight](ERROR): Hardware Fault
2026-01-30T17:58:53.869Z,1769795933.869 [CommandExec](FAULT): Scheduling is paused
2026-01-30T17:58:53.870Z,1769795933.870 [CBIT](INFO): Critical error at 20260130T175853
2026-01-30T17:58:53.870Z,1769795933.870 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2026-01-30T17:58:53.889Z,1769795933.889 [CBIT](ERROR): Hardware Fault in component: DropWeight
2026-01-30T17:58:53.889Z,1769795933.889 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2026-01-30T17:58:54.229Z,1769795934.229 [CBIT](INFO): Critical error at 20260130T175853
2026-01-30T17:58:56.940Z,1769795936.940 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:58:57.336Z,1769795937.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:58:58.008Z,1769795938.008 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:58:58.048Z,1769795938.048 [WetLabsBB2FL] Communications Fault, FailCount= 1
2026-01-30T17:58:58.048Z,1769795938.048 [WetLabsBB2FL](ERROR): Communications Fault
2026-01-30T17:58:58.245Z,1769795938.245 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2026-01-30T17:58:58.548Z,1769795938.548 [WetLabsBB2FL](INFO): Powering down
2026-01-30T17:58:58.576Z,1769795938.576 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:58:59.080Z,1769795939.080 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:58:59.524Z,1769795939.524 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:58:59.796Z,1769795939.796 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2026-01-30T17:58:59.796Z,1769795939.796 [WetLabsBB2FL] No Fault, FailCount= 1
2026-01-30T17:59:00.128Z,1769795940.128 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:00.165Z,1769795940.165 [WetLabsBB2FL](INFO): Powering up
2026-01-30T17:59:00.660Z,1769795940.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:01.088Z,1769795941.088 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:01.496Z,1769795941.496 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:01.928Z,1769795941.928 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:02.332Z,1769795942.332 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:02.736Z,1769795942.736 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:02.817Z,1769795942.817 [CBIT](CRITICAL): Environmental Failure. Press:14.902369 PSI. Humidity:28%. Temp:23 C. ABORTING MISSION
2026-01-30T17:59:03.152Z,1769795943.152 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:03.230Z,1769795943.230 [CBIT](INFO): Critical error at 20260130T175902
2026-01-30T17:59:03.564Z,1769795943.564 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:03.972Z,1769795943.972 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:04.416Z,1769795944.416 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:04.820Z,1769795944.820 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:05.224Z,1769795945.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:05.456Z,1769795945.456 [WetLabsBB2FL] Communications Fault, FailCount= 2
2026-01-30T17:59:05.456Z,1769795945.456 [WetLabsBB2FL](ERROR): Communications Fault
2026-01-30T17:59:05.532Z,1769795945.532 [DAT](INFO): DAT read: 

2026-01-30T17:59:05.534Z,1769795945.534 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2026-01-30T17:59:05.660Z,1769795945.660 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:05.768Z,1769795945.768 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2026-01-30T17:59:05.801Z,1769795945.801 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:05.802Z,1769795945.802 [CTD_Seabird] Communications Fault, FailCount= 1
2026-01-30T17:59:05.802Z,1769795945.802 [CTD_Seabird](ERROR): Communications Fault
2026-01-30T17:59:05.956Z,1769795945.956 [WetLabsBB2FL](INFO): Powering down
2026-01-30T17:59:06.092Z,1769795946.092 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:06.164Z,1769795946.164 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2026-01-30T17:59:06.213Z,1769795946.213 [CTD_Seabird](INFO): Powering down
2026-01-30T17:59:06.504Z,1769795946.504 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:06.504Z,1769795946.504 [AHRS_M2](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:06.504Z,1769795946.504 [AHRS_M2] Communications Fault, FailCount= 1
2026-01-30T17:59:06.504Z,1769795946.504 [AHRS_M2](ERROR): Communications Fault
2026-01-30T17:59:06.600Z,1769795946.600 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2026-01-30T17:59:06.607Z,1769795946.607 [AHRS_M2](INFO): Powering down
2026-01-30T17:59:07.093Z,1769795947.093 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2026-01-30T17:59:07.093Z,1769795947.093 [WetLabsBB2FL] No Fault, FailCount= 2
2026-01-30T17:59:07.169Z,1769795947.169 [WetLabsBB2FL](INFO): Powering up
2026-01-30T17:59:07.297Z,1769795947.297 [DAT](INFO): DAT read: MF Frequency Band

2026-01-30T17:59:07.298Z,1769795947.298 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2026-01-30T17:59:07.298Z,1769795947.298 [DAT](INFO): DAT read: Jan 30 2026 17:59:01 

2026-01-30T17:59:07.476Z,1769795947.476 [CBIT](INFO): Clearing failed state for component AHRS_M2
2026-01-30T17:59:07.476Z,1769795947.476 [AHRS_M2] No Fault, FailCount= 1
2026-01-30T17:59:07.476Z,1769795947.476 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2026-01-30T17:59:07.476Z,1769795947.476 [CTD_Seabird] No Fault, FailCount= 1
2026-01-30T17:59:07.552Z,1769795947.552 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2026-01-30T17:59:07.818Z,1769795947.818 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-01-30T17:59:08.557Z,1769795948.557 [DAT](INFO): DAT read: Features enabled [Bearing]

2026-01-30T17:59:08.558Z,1769795948.558 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2026-01-30T17:59:08.558Z,1769795948.558 [DAT](INFO): commRate: 800
2026-01-30T17:59:10.624Z,1769795950.624 [DAT](INFO): entering command mode
2026-01-30T17:59:10.825Z,1769795950.825 [DAT](INFO): DAT read: 

2026-01-30T17:59:10.825Z,1769795950.825 [DAT](INFO): DAT read: user:1>

2026-01-30T17:59:10.826Z,1769795950.826 [DAT](INFO): setting verbose to 3
2026-01-30T17:59:11.091Z,1769795951.091 [DAT](INFO): DAT read: user:1>

2026-01-30T17:59:11.092Z,1769795951.092 [DAT](INFO): DAT read: Verbose         | 3           

2026-01-30T17:59:11.092Z,1769795951.092 [DAT](INFO): set verbose to 3
2026-01-30T17:59:11.092Z,1769795951.092 [DAT](INFO): setting DatVerbose to 27440
2026-01-30T17:59:11.345Z,1769795951.345 [DAT](INFO): DAT read: user:2>

2026-01-30T17:59:11.345Z,1769795951.345 [DAT](INFO): DAT read: DatVerbose      | 27440       

2026-01-30T17:59:11.346Z,1769795951.346 [DAT](INFO): set DatVerbose to 27440
2026-01-30T17:59:11.346Z,1769795951.346 [DAT](INFO): setting transmit power to 8
2026-01-30T17:59:11.368Z,1769795951.368 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:11.596Z,1769795951.596 [DAT](INFO): DAT read: user:3>

2026-01-30T17:59:11.597Z,1769795951.597 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2026-01-30T17:59:11.598Z,1769795951.598 [DAT](INFO): set transmit power to 8
2026-01-30T17:59:11.598Z,1769795951.598 [DAT](INFO): setting local address to 1
2026-01-30T17:59:11.816Z,1769795951.816 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:11.849Z,1769795951.849 [DAT](INFO): DAT read: user:4>

2026-01-30T17:59:11.850Z,1769795951.850 [DAT](INFO): DAT read: LocalAddr       | 1           

2026-01-30T17:59:11.850Z,1769795951.850 [DAT](INFO): set local address to 1
2026-01-30T17:59:11.851Z,1769795951.851 [DAT](INFO): Setting time to: 17:59:11 And date to:1/30/2026
2026-01-30T17:59:12.101Z,1769795952.101 [DAT](INFO): DAT read: user:5>

2026-01-30T17:59:12.101Z,1769795952.101 [DAT](INFO): DAT read: Fri Jan 30, 2026  17:59:11  

2026-01-30T17:59:12.102Z,1769795952.102 [DAT](INFO): Local DAT time set to Fri Jan 30, 2026  17:59:11  

2026-01-30T17:59:12.252Z,1769795952.252 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:12.460Z,1769795952.460 [WetLabsBB2FL] Communications Fault, FailCount= 3
2026-01-30T17:59:12.460Z,1769795952.460 [WetLabsBB2FL](ERROR): Communications Fault
2026-01-30T17:59:12.664Z,1769795952.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:12.800Z,1769795952.800 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2026-01-30T17:59:12.960Z,1769795952.960 [WetLabsBB2FL](INFO): Powering down
2026-01-30T17:59:13.125Z,1769795953.125 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:13.536Z,1769795953.536 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:13.944Z,1769795953.944 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:14.018Z,1769795954.018 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2026-01-30T17:59:14.018Z,1769795954.018 [WetLabsBB2FL] No Fault, FailCount= 3
2026-01-30T17:59:14.173Z,1769795954.173 [WetLabsBB2FL](INFO): Powering up
2026-01-30T17:59:14.352Z,1769795954.352 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:14.756Z,1769795954.756 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:15.168Z,1769795955.168 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:15.564Z,1769795955.564 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:15.976Z,1769795955.976 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:16.388Z,1769795956.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:16.800Z,1769795956.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:17.204Z,1769795957.204 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:17.624Z,1769795957.624 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:18.032Z,1769795958.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:18.444Z,1769795958.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:18.840Z,1769795958.840 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:19.248Z,1769795959.248 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:19.464Z,1769795959.464 [WetLabsBB2FL] Communications Fault, FailCount= 4
2026-01-30T17:59:19.464Z,1769795959.464 [WetLabsBB2FL](ERROR): Communications Fault
2026-01-30T17:59:19.652Z,1769795959.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:19.729Z,1769795959.729 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2026-01-30T17:59:19.964Z,1769795959.964 [WetLabsBB2FL](INFO): Powering down
2026-01-30T17:59:20.072Z,1769795960.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:20.480Z,1769795960.480 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:20.605Z,1769795960.605 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:20.606Z,1769795960.606 [CTD_Seabird] Communications Fault, FailCount= 2
2026-01-30T17:59:20.606Z,1769795960.606 [CTD_Seabird](ERROR): Communications Fault
2026-01-30T17:59:20.888Z,1769795960.888 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:20.888Z,1769795960.888 [AHRS_M2](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:20.888Z,1769795960.888 [AHRS_M2] Communications Fault, FailCount= 2
2026-01-30T17:59:20.888Z,1769795960.888 [AHRS_M2](ERROR): Communications Fault
2026-01-30T17:59:20.893Z,1769795960.893 [NAL9602](INFO): Powering up NAL9602
2026-01-30T17:59:20.969Z,1769795960.969 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2026-01-30T17:59:20.969Z,1769795960.969 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2026-01-30T17:59:20.969Z,1769795960.969 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2026-01-30T17:59:20.970Z,1769795960.970 [WetLabsBB2FL] No Fault, FailCount= 4
2026-01-30T17:59:20.997Z,1769795960.997 [AHRS_M2](INFO): Powering down
2026-01-30T17:59:21.008Z,1769795961.008 [CTD_Seabird](INFO): Powering down
2026-01-30T17:59:21.177Z,1769795961.177 [WetLabsBB2FL](INFO): Powering up
2026-01-30T17:59:21.836Z,1769795961.836 [CBIT](INFO): Clearing failed state for component AHRS_M2
2026-01-30T17:59:21.836Z,1769795961.836 [AHRS_M2] No Fault, FailCount= 2
2026-01-30T17:59:22.188Z,1769795962.188 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-01-30T17:59:22.268Z,1769795962.268 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2026-01-30T17:59:22.268Z,1769795962.268 [CTD_Seabird] No Fault, FailCount= 2
2026-01-30T17:59:22.352Z,1769795962.352 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2026-01-30T17:59:25.736Z,1769795965.736 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:26.148Z,1769795966.148 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:26.468Z,1769795966.468 [WetLabsBB2FL] Communications Fault, FailCount= 5
2026-01-30T17:59:26.468Z,1769795966.468 [WetLabsBB2FL](ERROR): Communications Fault
2026-01-30T17:59:26.544Z,1769795966.544 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:26.604Z,1769795966.604 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2026-01-30T17:59:26.604Z,1769795966.604 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2026-01-30T17:59:26.952Z,1769795966.952 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:26.969Z,1769795966.969 [WetLabsBB2FL](INFO): Powering down
2026-01-30T17:59:27.364Z,1769795967.364 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:27.892Z,1769795967.892 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:28.300Z,1769795968.300 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:28.700Z,1769795968.700 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:29.096Z,1769795969.096 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:29.500Z,1769795969.500 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:29.924Z,1769795969.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:30.328Z,1769795970.328 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:30.732Z,1769795970.732 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:31.120Z,1769795971.120 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:31.536Z,1769795971.536 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:31.956Z,1769795971.956 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:31.965Z,1769795971.965 [NAL9602](INFO): NAL9602 initialized
2026-01-30T17:59:32.372Z,1769795972.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:32.761Z,1769795972.761 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:33.192Z,1769795973.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:33.604Z,1769795973.604 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:34.016Z,1769795974.016 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:34.424Z,1769795974.424 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:34.836Z,1769795974.836 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:35.252Z,1769795975.252 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:35.252Z,1769795975.252 [AHRS_M2](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:35.252Z,1769795975.252 [AHRS_M2] Communications Fault, FailCount= 3
2026-01-30T17:59:35.252Z,1769795975.252 [AHRS_M2](ERROR): Communications Fault
2026-01-30T17:59:35.345Z,1769795975.345 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2026-01-30T17:59:35.353Z,1769795975.353 [AHRS_M2](INFO): Powering down
2026-01-30T17:59:35.408Z,1769795975.408 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:35.408Z,1769795975.408 [CTD_Seabird] Communications Fault, FailCount= 3
2026-01-30T17:59:35.408Z,1769795975.408 [CTD_Seabird](ERROR): Communications Fault
2026-01-30T17:59:35.496Z,1769795975.496 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2026-01-30T17:59:35.497Z,1769795975.497 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2026-01-30T17:59:35.812Z,1769795975.812 [CTD_Seabird](INFO): Powering down
2026-01-30T17:59:36.216Z,1769795976.216 [CBIT](INFO): Clearing failed state for component AHRS_M2
2026-01-30T17:59:36.216Z,1769795976.216 [AHRS_M2] No Fault, FailCount= 3
2026-01-30T17:59:36.566Z,1769795976.566 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-01-30T17:59:39.057Z,1769795979.057 [CommandExec](IMPORTANT): got command strobe off
2026-01-30T17:59:39.057Z,1769795979.057 [CommandExec](IMPORTANT): Deactivating strobe
2026-01-30T17:59:40.124Z,1769795980.124 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:40.540Z,1769795980.540 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:40.948Z,1769795980.948 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:41.360Z,1769795981.360 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:41.768Z,1769795981.768 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:42.164Z,1769795982.164 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:42.556Z,1769795982.556 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:42.976Z,1769795982.976 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:43.380Z,1769795983.380 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:43.772Z,1769795983.772 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:44.180Z,1769795984.180 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:44.596Z,1769795984.596 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:45.012Z,1769795985.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:45.432Z,1769795985.432 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:45.848Z,1769795985.848 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:46.256Z,1769795986.256 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:46.668Z,1769795986.668 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:47.064Z,1769795987.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:47.464Z,1769795987.464 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:47.868Z,1769795987.868 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:48.280Z,1769795988.280 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:48.664Z,1769795988.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:49.072Z,1769795989.072 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:49.476Z,1769795989.476 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:49.476Z,1769795989.476 [AHRS_M2](FAULT): Failed to initialize within timeout.
2026-01-30T17:59:49.476Z,1769795989.476 [AHRS_M2] Communications Fault, FailCount= 4
2026-01-30T17:59:49.476Z,1769795989.476 [AHRS_M2](ERROR): Communications Fault
2026-01-30T17:59:49.577Z,1769795989.577 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2026-01-30T17:59:49.585Z,1769795989.585 [AHRS_M2](INFO): Powering down
2026-01-30T17:59:50.468Z,1769795990.468 [CBIT](INFO): Clearing failed state for component AHRS_M2
2026-01-30T17:59:50.468Z,1769795990.468 [AHRS_M2] No Fault, FailCount= 4
2026-01-30T17:59:50.797Z,1769795990.797 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-01-30T17:59:54.356Z,1769795994.356 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:54.804Z,1769795994.804 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:55.244Z,1769795995.244 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:55.672Z,1769795995.672 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:56.096Z,1769795996.096 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:56.492Z,1769795996.492 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:56.884Z,1769795996.884 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:57.296Z,1769795997.296 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:57.700Z,1769795997.700 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:58.120Z,1769795998.120 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:58.512Z,1769795998.512 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:58.920Z,1769795998.920 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:59.416Z,1769795999.416 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T17:59:59.808Z,1769795999.808 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:00.224Z,1769796000.224 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:00.636Z,1769796000.636 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:01.048Z,1769796001.048 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:01.468Z,1769796001.468 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:01.860Z,1769796001.860 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:02.264Z,1769796002.264 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:02.668Z,1769796002.668 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:03.076Z,1769796003.076 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:03.468Z,1769796003.468 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:03.880Z,1769796003.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2026-01-30T18:00:03.880Z,1769796003.880 [AHRS_M2](FAULT): Failed to initialize within timeout.
2026-01-30T18:00:03.880Z,1769796003.880 [AHRS_M2] Communications Fault, FailCount= 5
2026-01-30T18:00:03.880Z,1769796003.880 [AHRS_M2](ERROR): Communications Fault
2026-01-30T18:00:03.931Z,1769796003.931 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2026-01-30T18:00:03.932Z,1769796003.932 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2026-01-30T18:00:03.961Z,1769796003.961 [AHRS_M2](INFO): Powering down
2026-01-30T18:00:04.058Z,1769796004.058 [CBIT](INFO): Critical error at 20260130T180003
2026-01-30T18:00:48.066Z,1769796048.066 [SBIT](IMPORTANT): Beginning Startup BIT
2026-01-30T18:00:48.071Z,1769796048.071 [GFScanner](IMPORTANT): Beginning ground fault scan
2026-01-30T18:00:52.553Z,1769796052.553 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.011803
CHAN A1 (24V): 0.000459
CHAN A2 (12V): 0.000278
CHAN A3 (5V): -0.002284
CHAN B0 (3.3V): 0.000597
CHAN B1 (3.15aV): -0.000285
CHAN B2 (3.15bV): -0.000055
CHAN B3 (GND): 0.000171
OPEN: 0.006672
Full Scale: +/- 1 mA
2026-01-30T18:00:52.895Z,1769796052.895 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2026-01-30T18:00:52.895Z,1769796052.895 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2026-01-30T18:00:52.895Z,1769796052.895 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-01-30T18:00:53.097Z,1769796053.097 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-01-30T18:00:53.449Z,1769796053.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-01-30T18:00:53.449Z,1769796053.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2026-01-30T18:01:42.270Z,1769796102.270 [SBIT](IMPORTANT): SBIT PASSED
2026-01-30T18:01:42.270Z,1769796102.270 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=19 count;

2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): BackseatComponent.fullSlateAccess=1 bool;

2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): DAT.surfaceThreshold=-0.5 meter;

2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): Express linearApproximation PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter;

2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;

2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 2.000000 count_per_second;

2026-01-30T18:01:42.271Z,1769796102.271 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 100.000000 count_per_second;

2026-01-30T18:01:42.272Z,1769796102.272 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=187.304467 cubic_centimeter;

2026-01-30T18:01:42.273Z,1769796102.273 [SBIT](IMPORTANT): VerticalControl.massDefault=23.909546 millimeter;

2026-01-30T18:01:42.273Z,1769796102.273 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool;

2026-01-30T18:01:42.657Z,1769796102.657 [MissionManager](IMPORTANT): Started mission Startup
2026-01-30T18:01:42.657Z,1769796102.657 [Startup] Running Loop=1
2026-01-30T18:01:42.657Z,1769796102.657 [Startup](DEBUG): Aggregate::initialize Startup
2026-01-30T18:01:42.658Z,1769796102.658 [Startup:A.GoToSurface] Running Loop=1
2026-01-30T18:01:42.658Z,1769796102.658 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-01-30T18:01:42.658Z,1769796102.658 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-01-30T18:01:42.659Z,1769796102.659 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-01-30T18:01:42.659Z,1769796102.659 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-01-30T18:01:42.659Z,1769796102.659 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-01-30T18:01:42.660Z,1769796102.660 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-01-30T18:01:42.660Z,1769796102.660 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-01-30T18:01:42.661Z,1769796102.661 [Startup:StartupSatComms] Running Loop=1
2026-01-30T18:01:42.662Z,1769796102.662 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2026-01-30T18:01:42.662Z,1769796102.662 [Startup:StartupSatComms:A] Running Loop=1
2026-01-30T18:01:43.058Z,1769796103.058 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2026-01-30T18:01:54.752Z,1769796114.752 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2026-01-30T18:01:56.838Z,1769796116.838 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2026-01-30T18:01:56.838Z,1769796116.838 [WetLabsBB2FL] No Fault, FailCount= 5
2026-01-30T18:01:56.865Z,1769796116.865 [WetLabsBB2FL](INFO): Powering up
2026-01-30T18:01:57.877Z,1769796117.877 [CommandExec](IMPORTANT): got command restart system
2026-01-30T18:01:59.940Z,1769796119.940 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:01:59.940Z,1769796119.940 [CommandExec](INFO): Uninitializing the command executive.
2026-01-30T18:01:59.940Z,1769796119.940 [CommandExec](INFO): Uninitializing the command scheduler.
2026-01-30T18:01:59.941Z,1769796119.941 [CommandExec ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.020Z,1769796120.020 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2026-01-30T18:02:00.020Z,1769796120.020 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2026-01-30T18:02:00.020Z,1769796120.020 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.021Z,1769796120.021 [NavChartDb](INFO): Join timeout helper Thread ID is 985
2026-01-30T18:02:00.100Z,1769796120.100 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:00.101Z,1769796120.101 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.104Z,1769796120.104 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2026-01-30T18:02:00.104Z,1769796120.104 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.104Z,1769796120.104 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 986
2026-01-30T18:02:00.148Z,1769796120.148 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:00.244Z,1769796120.244 [WetLabsBB2FL](INFO): Powering down
2026-01-30T18:02:00.245Z,1769796120.245 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.264Z,1769796120.264 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2026-01-30T18:02:00.264Z,1769796120.264 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.264Z,1769796120.264 [CTD_Seabird](INFO): Join timeout helper Thread ID is 987
2026-01-30T18:02:00.608Z,1769796120.608 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:00.608Z,1769796120.608 [CTD_Seabird](INFO): Powering down
2026-01-30T18:02:00.620Z,1769796120.620 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.620Z,1769796120.620 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2026-01-30T18:02:00.620Z,1769796120.620 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:00.621Z,1769796120.621 [Radio_Surface](INFO): Join timeout helper Thread ID is 988
2026-01-30T18:02:01.008Z,1769796121.008 [Radio_Surface](INFO): Powering down
2026-01-30T18:02:01.009Z,1769796121.009 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:01.009Z,1769796121.009 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:01.028Z,1769796121.028 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2026-01-30T18:02:01.028Z,1769796121.028 [Onboard ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:01.028Z,1769796121.028 [Onboard](INFO): Join timeout helper Thread ID is 989
2026-01-30T18:02:02.888Z,1769796122.888 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:02.888Z,1769796122.888 [Onboard ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:02.897Z,1769796122.897 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2026-01-30T18:02:02.897Z,1769796122.897 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:02.897Z,1769796122.897 [DataOverHttps](INFO): Join timeout helper Thread ID is 990
2026-01-30T18:02:03.460Z,1769796123.460 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:03.461Z,1769796123.461 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.480Z,1769796123.480 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2026-01-30T18:02:03.481Z,1769796123.481 [DAT ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.481Z,1769796123.481 [DAT](INFO): Join timeout helper Thread ID is 991
2026-01-30T18:02:03.592Z,1769796123.592 [DAT](INFO): Powering down
2026-01-30T18:02:03.665Z,1769796123.665 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:03.665Z,1769796123.665 [DAT](INFO): Powering down
2026-01-30T18:02:03.666Z,1769796123.666 [DAT ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.685Z,1769796123.685 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2026-01-30T18:02:03.685Z,1769796123.685 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.685Z,1769796123.685 [BackseatComponent](INFO): Join timeout helper Thread ID is 992
2026-01-30T18:02:03.824Z,1769796123.824 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:03.824Z,1769796123.824 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.829Z,1769796123.829 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2026-01-30T18:02:03.829Z,1769796123.829 [logger ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.829Z,1769796123.829 [logger](INFO): Join timeout helper Thread ID is 993
2026-01-30T18:02:03.852Z,1769796123.852 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:03.852Z,1769796123.852 [logger ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.869Z,1769796123.869 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2026-01-30T18:02:03.869Z,1769796123.869 [CommandLine ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.869Z,1769796123.869 [CommandLine](INFO): Join timeout helper Thread ID is 994
2026-01-30T18:02:03.956Z,1769796123.956 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:03.956Z,1769796123.956 [CommandLine ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.968Z,1769796123.968 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2026-01-30T18:02:03.969Z,1769796123.969 [CommandExec ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.969Z,1769796123.969 [CommandExec](INFO): Join timeout helper Thread ID is 995
2026-01-30T18:02:03.970Z,1769796123.970 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2026-01-30T18:02:03.970Z,1769796123.970 [controlThread ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:03.971Z,1769796123.971 [controlThread](INFO): Join timeout helper Thread ID is 996
2026-01-30T18:02:04.036Z,1769796124.036 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2026-01-30T18:02:04.036Z,1769796124.036 [controlThread](DEBUG): Uninitializing ControlThread
2026-01-30T18:02:04.037Z,1769796124.037 [AHRS_M2](INFO): Powering down
2026-01-30T18:02:04.040Z,1769796124.040 [NAL9602](INFO): Powering down
2026-01-30T18:02:04.041Z,1769796124.041 [Sonardyne_Nano](INFO): Powering down
2026-01-30T18:02:04.248Z,1769796124.248 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2026-01-30T18:02:04.249Z,1769796124.249 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2026-01-30T18:02:04.250Z,1769796124.250 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2026-01-30T18:02:04.250Z,1769796124.250 [MissionManager](INFO): Uninitializing Mission Default
2026-01-30T18:02:04.253Z,1769796124.253 [MissionManager](INFO): Uninitializing Mission Startup
2026-01-30T18:02:04.253Z,1769796124.253 [Startup] Stopped
2026-01-30T18:02:04.253Z,1769796124.253 [Startup](DEBUG): Aggregate::uninitialize Startup
2026-01-30T18:02:04.253Z,1769796124.253 [Startup:A.GoToSurface] Stopped
2026-01-30T18:02:04.254Z,1769796124.254 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-01-30T18:02:04.254Z,1769796124.254 [Startup:StartupSatComms] Stopped
2026-01-30T18:02:04.254Z,1769796124.254 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2026-01-30T18:02:04.254Z,1769796124.254 [Startup:StartupSatComms:A] Stopped
2026-01-30T18:02:04.256Z,1769796124.256 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2026-01-30T18:02:04.256Z,1769796124.256 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2026-01-30T18:02:04.256Z,1769796124.256 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2026-01-30T18:02:04.256Z,1769796124.256 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2026-01-30T18:02:04.257Z,1769796124.257 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2026-01-30T18:02:04.257Z,1769796124.257 [BuoyancyServo](INFO): Powering down
2026-01-30T18:02:04.272Z,1769796124.272 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2026-01-30T18:02:04.272Z,1769796124.272 [ElevatorServo](INFO): Powering down
2026-01-30T18:02:04.273Z,1769796124.273 [MassServo](DEBUG): Uninitialize Mass Servo.
2026-01-30T18:02:04.273Z,1769796124.273 [MassServo](INFO): Powering down
2026-01-30T18:02:04.274Z,1769796124.274 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2026-01-30T18:02:04.274Z,1769796124.274 [RudderServo](INFO): Powering down
2026-01-30T18:02:04.275Z,1769796124.275 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2026-01-30T18:02:04.275Z,1769796124.275 [ThrusterHE](INFO): Powering down
2026-01-30T18:02:04.276Z,1769796124.276 [SBIT](DEBUG): Uninitialize SBIT Component.
2026-01-30T18:02:04.277Z,1769796124.277 [IBIT](DEBUG): Uninitialize IBIT Component.
2026-01-30T18:02:04.277Z,1769796124.277 [CBIT](DEBUG): Uninitialize CBIT Component.
2026-01-30T18:02:04.277Z,1769796124.277 [CBIT](DEBUG): Powering off loads.
2026-01-30T18:02:04.288Z,1769796124.288 [CBIT](DEBUG): Disabling WDT.
2026-01-30T18:02:04.300Z,1769796124.300 [GFScanner](DEBUG): Uninitialize GFScanner component.
2026-01-30T18:02:04.300Z,1769796124.300 [GFScanner](DEBUG): Opening all GF detection circuits.
2026-01-30T18:02:04.301Z,1769796124.301 [controlThread ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.331Z,1769796124.331 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.334Z,1769796124.334 [Onboard ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.341Z,1769796124.341 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.347Z,1769796124.347 [DAT ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.396Z,1769796124.396 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.429Z,1769796124.429 [GFScanner](DEBUG): Uninitialize GFScanner component.
2026-01-30T18:02:04.429Z,1769796124.429 [GFScanner](DEBUG): Opening all GF detection circuits.
2026-01-30T18:02:04.489Z,1769796124.489 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.495Z,1769796124.495 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.503Z,1769796124.503 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2026-01-30T18:02:04.574Z,1769796124.574 [logger ThreadHandler](INFO): Thread cancelled.