1980-12-11T22:00:47.399Z,345420047.399 [Supervisor](DEBUG): Initializing supervisor.
1980-12-11T22:00:47.403Z,345420047.403 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
1980-12-11T22:00:47.404Z,345420047.404 [SyncHandler](INFO): Protected caller Thread ID is 837
1980-12-11T22:00:47.404Z,345420047.404 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
1980-12-11T22:00:47.405Z,345420047.405 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
1980-12-11T22:00:47.406Z,345420047.406 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838
1980-12-11T22:00:47.410Z,345420047.410 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
1980-12-11T22:00:47.430Z,345420047.430 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
1980-12-11T22:00:47.431Z,345420047.431 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
1980-12-11T22:00:47.431Z,345420047.431 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839
1980-12-11T22:00:47.435Z,345420047.435 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
1980-12-11T22:00:47.437Z,345420047.437 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
1980-12-11T22:00:47.437Z,345420047.437 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840
1980-12-11T22:00:47.439Z,345420047.439 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
1980-12-11T22:00:47.440Z,345420047.440 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
1980-12-11T22:00:47.441Z,345420047.441 [logger ThreadHandler](INFO): Protected caller Thread ID is 841
1980-12-11T22:00:47.444Z,345420047.444 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
1980-12-11T22:00:47.445Z,345420047.445 [Supervisor](INFO): Looking for Config files in directory: Config/
1980-12-11T22:00:47.449Z,345420047.449 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
1980-12-11T22:00:47.850Z,345420047.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
1980-12-11T22:00:47.852Z,345420047.852 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
1980-12-11T22:00:48.125Z,345420048.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
1980-12-11T22:00:48.127Z,345420048.127 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
1980-12-11T22:00:48.640Z,345420048.640 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
1980-12-11T22:00:48.642Z,345420048.642 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
1980-12-11T22:00:48.888Z,345420048.888 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
1980-12-11T22:00:48.889Z,345420048.889 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
1980-12-11T22:00:49.121Z,345420049.121 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
1980-12-11T22:00:49.123Z,345420049.123 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
1980-12-11T22:00:49.947Z,345420049.947 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
1980-12-11T22:00:49.948Z,345420049.948 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
1980-12-11T22:00:50.530Z,345420050.530 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
1980-12-11T22:00:50.543Z,345420050.543 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
1980-12-11T22:00:50.837Z,345420050.837 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
1980-12-11T22:00:50.837Z,345420050.837 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
1980-12-11T22:00:50.927Z,345420050.927 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
1980-12-11T22:00:51.118Z,345420051.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
1980-12-11T22:00:51.118Z,345420051.118 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
1980-12-11T22:00:51.225Z,345420051.225 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
1980-12-11T22:00:51.227Z,345420051.227 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
1980-12-11T22:00:51.457Z,345420051.457 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
1980-12-11T22:00:51.457Z,345420051.457 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
1980-12-11T22:00:51.606Z,345420051.606 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
1980-12-11T22:00:51.608Z,345420051.608 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
1980-12-11T22:00:51.709Z,345420051.709 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
1980-12-11T22:00:51.710Z,345420051.710 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
1980-12-11T22:00:52.156Z,345420052.156 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
1980-12-11T22:00:52.157Z,345420052.157 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
1980-12-11T22:00:52.831Z,345420052.831 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
1980-12-11T22:00:52.833Z,345420052.833 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
1980-12-11T22:00:52.835Z,345420052.835 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
1980-12-11T22:00:52.952Z,345420052.952 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
1980-12-11T22:00:53.234Z,345420053.234 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
1980-12-11T22:00:53.234Z,345420053.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
1980-12-11T22:00:53.346Z,345420053.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
1980-12-11T22:00:53.451Z,345420053.451 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
1980-12-11T22:00:53.570Z,345420053.570 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
1980-12-11T22:00:53.714Z,345420053.714 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
1980-12-11T22:00:53.823Z,345420053.823 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
1980-12-11T22:00:53.940Z,345420053.940 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
1980-12-11T22:00:54.034Z,345420054.034 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
1980-12-11T22:00:54.157Z,345420054.157 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
1980-12-11T22:00:54.252Z,345420054.252 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/root/
1980-12-11T22:00:54.253Z,345420054.253 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
1980-12-11T22:00:54.267Z,345420054.267 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
1980-12-11T22:00:54.284Z,345420054.284 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
1980-12-11T22:00:54.284Z,345420054.284 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
1980-12-11T22:00:54.429Z,345420054.429 [DeadReckonUsingMultipleVelocitySources] Loaded
1980-12-11T22:00:54.429Z,345420054.429 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
1980-12-11T22:00:54.470Z,345420054.470 [DeadReckonWithRespectToSeafloor] Loaded
1980-12-11T22:00:54.470Z,345420054.470 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
1980-12-11T22:00:54.484Z,345420054.484 [NavChart] Loaded
1980-12-11T22:00:54.484Z,345420054.484 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
1980-12-11T22:00:54.490Z,345420054.490 [UniversalFixResidualReporter] Loaded
1980-12-11T22:00:54.490Z,345420054.490 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
1980-12-11T22:00:54.491Z,345420054.491 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
1980-12-11T22:00:54.491Z,345420054.491 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
1980-12-11T22:00:55.528Z,345420055.528 [AHRS_M2] Loaded
1980-12-11T22:00:55.528Z,345420055.528 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
1980-12-11T22:00:55.782Z,345420055.782 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
1980-12-11T22:00:55.783Z,345420055.783 [BackseatComponent] Loaded
1980-12-11T22:00:55.783Z,345420055.783 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
1980-12-11T22:00:55.785Z,345420055.785 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085E4E0
1980-12-11T22:00:55.785Z,345420055.785 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 924
1980-12-11T22:00:55.788Z,345420055.788 [LcmUniversalReporter] Loaded
1980-12-11T22:00:55.788Z,345420055.788 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
1980-12-11T22:00:56.626Z,345420056.626 [BPC1] Loaded
1980-12-11T22:00:56.626Z,345420056.626 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
1980-12-11T22:00:56.725Z,345420056.725 [DAT] Loaded
1980-12-11T22:00:56.725Z,345420056.725 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
1980-12-11T22:00:56.726Z,345420056.726 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088E4E0
1980-12-11T22:00:56.726Z,345420056.726 [DAT ThreadHandler](INFO): Protected caller Thread ID is 925
1980-12-11T22:00:57.056Z,345420057.056 [DataOverHttps] Loaded
1980-12-11T22:00:57.056Z,345420057.056 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
1980-12-11T22:00:57.057Z,345420057.057 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BE4E0
1980-12-11T22:00:57.058Z,345420057.058 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 926
1980-12-11T22:00:57.081Z,345420057.081 [DepthKeller33X] Loaded
1980-12-11T22:00:57.081Z,345420057.081 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
1980-12-11T22:00:57.086Z,345420057.086 [DropWeight] Loaded
1980-12-11T22:00:57.086Z,345420057.086 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
1980-12-11T22:00:57.151Z,345420057.151 [NAL9602] Loaded
1980-12-11T22:00:57.151Z,345420057.151 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
1980-12-11T22:00:57.181Z,345420057.181 [Onboard] Loaded
1980-12-11T22:00:57.181Z,345420057.181 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
1980-12-11T22:00:57.182Z,345420057.182 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408EE4E0
1980-12-11T22:00:57.183Z,345420057.183 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 927
1980-12-11T22:00:57.197Z,345420057.197 [Power24vConverter] Loaded
1980-12-11T22:00:57.197Z,345420057.197 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
1980-12-11T22:00:57.214Z,345420057.214 [Radio_Surface] Loaded
1980-12-11T22:00:57.215Z,345420057.215 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
1980-12-11T22:00:57.216Z,345420057.216 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091E4E0
1980-12-11T22:00:57.216Z,345420057.216 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 928
1980-12-11T22:00:57.263Z,345420057.263 [RDI_Pathfinder] Loaded
1980-12-11T22:00:57.263Z,345420057.263 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
1980-12-11T22:00:57.279Z,345420057.279 [Sonardyne_Nano] Loaded
1980-12-11T22:00:57.279Z,345420057.279 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
1980-12-11T22:00:57.279Z,345420057.279 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
1980-12-11T22:00:57.280Z,345420057.280 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
1980-12-11T22:00:57.491Z,345420057.491 [DepthRateCalculator] Loaded
1980-12-11T22:00:57.491Z,345420057.491 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
1980-12-11T22:00:57.505Z,345420057.505 [PitchRateCalculator] Loaded
1980-12-11T22:00:57.505Z,345420057.505 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
1980-12-11T22:00:57.557Z,345420057.557 [SpeedCalculator] Loaded
1980-12-11T22:00:57.558Z,345420057.558 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
1980-12-11T22:00:57.601Z,345420057.601 [YawRateCalculator] Loaded
1980-12-11T22:00:57.602Z,345420057.602 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
1980-12-11T22:00:57.625Z,345420057.625 [ElevatorOffsetCalculator] Loaded
1980-12-11T22:00:57.625Z,345420057.625 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
1980-12-11T22:00:57.625Z,345420057.625 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
1980-12-11T22:00:57.626Z,345420057.626 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
1980-12-11T22:00:58.360Z,345420058.360 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
1980-12-11T22:00:58.361Z,345420058.361 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
1980-12-11T22:00:58.533Z,345420058.533 [BuoyancyServo] Loaded
1980-12-11T22:00:58.534Z,345420058.534 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
1980-12-11T22:00:58.558Z,345420058.558 [ElevatorServo] Loaded
1980-12-11T22:00:58.558Z,345420058.558 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
1980-12-11T22:00:58.582Z,345420058.582 [MassServo] Loaded
1980-12-11T22:00:58.582Z,345420058.582 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
1980-12-11T22:00:58.605Z,345420058.605 [RudderServo] Loaded
1980-12-11T22:00:58.605Z,345420058.605 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
1980-12-11T22:00:58.624Z,345420058.624 [ThrusterHE] Loaded
1980-12-11T22:00:58.624Z,345420058.624 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
1980-12-11T22:00:58.624Z,345420058.624 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
1980-12-11T22:00:58.625Z,345420058.625 [Module Loader](DEBUG): Loading Module at Modules/Science.so
1980-12-11T22:00:58.852Z,345420058.852 [CTD_Seabird] Loaded
1980-12-11T22:00:58.853Z,345420058.853 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
1980-12-11T22:00:58.854Z,345420058.854 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0
1980-12-11T22:00:58.854Z,345420058.854 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 929
1980-12-11T22:00:58.875Z,345420058.875 [RBRTridente] Loaded
1980-12-11T22:00:58.876Z,345420058.876 [ComponentRegistry](DEBUG): Component "RBRTridente" handled in its own thread.
1980-12-11T22:00:58.877Z,345420058.877 [RBRTridente ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0
1980-12-11T22:00:58.877Z,345420058.877 [RBRTridente ThreadHandler](INFO): Protected caller Thread ID is 930
1980-12-11T22:00:58.878Z,345420058.878 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
1980-12-11T22:00:58.879Z,345420058.879 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
1980-12-11T22:00:59.051Z,345420059.051 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
1980-12-11T22:00:59.052Z,345420059.052 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
1980-12-11T22:00:59.276Z,345420059.276 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
1980-12-11T22:00:59.277Z,345420059.277 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
1980-12-11T22:00:59.693Z,345420059.693 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
1980-12-11T22:00:59.694Z,345420059.694 [Module Loader](DEBUG): Loading Module at Modules/Control.so
1980-12-11T22:00:59.769Z,345420059.769 [VerticalControl](DEBUG): Construct VerticalControl.
1980-12-11T22:00:59.823Z,345420059.823 [VerticalControl] Loaded
1980-12-11T22:00:59.824Z,345420059.824 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
1980-12-11T22:00:59.827Z,345420059.827 [HorizontalControl](DEBUG): Construct HorizontalControl.
1980-12-11T22:00:59.875Z,345420059.875 [HorizontalControl] Loaded
1980-12-11T22:00:59.876Z,345420059.876 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
1980-12-11T22:00:59.878Z,345420059.878 [SpeedControl](DEBUG): Construct SpeedControl.
1980-12-11T22:00:59.880Z,345420059.880 [SpeedControl] Loaded
1980-12-11T22:00:59.880Z,345420059.880 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
1980-12-11T22:00:59.883Z,345420059.883 [LoopControl](DEBUG): Construct LoopControl.
1980-12-11T22:00:59.884Z,345420059.884 [LoopControl] Loaded
1980-12-11T22:00:59.884Z,345420059.884 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
1980-12-11T22:00:59.884Z,345420059.884 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
1980-12-11T22:00:59.885Z,345420059.885 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
1980-12-11T22:01:00.085Z,345420060.085 [SBIT](DEBUG): Construct Startup Built In Test.
1980-12-11T22:01:00.094Z,345420060.094 [SBIT] Loaded
1980-12-11T22:01:00.094Z,345420060.094 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
1980-12-11T22:01:00.097Z,345420060.097 [IBIT](DEBUG): Construct Initiated Built In Test.
1980-12-11T22:01:00.110Z,345420060.110 [IBIT] Loaded
1980-12-11T22:01:00.110Z,345420060.110 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
1980-12-11T22:01:00.116Z,345420060.116 [CBIT](DEBUG): Construct Continuous Built In Test.
1980-12-11T22:01:00.200Z,345420060.200 [CBIT] Loaded
1980-12-11T22:01:00.200Z,345420060.200 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
1980-12-11T22:01:00.233Z,345420060.233 [GFScanner] Loaded
1980-12-11T22:01:00.234Z,345420060.234 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
1980-12-11T22:01:00.234Z,345420060.234 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
1980-12-11T22:01:00.235Z,345420060.235 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
1980-12-11T22:01:00.284Z,345420060.284 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
1980-12-11T22:01:00.290Z,345420060.290 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
1980-12-11T22:01:00.293Z,345420060.293 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
1980-12-11T22:01:00.305Z,345420060.305 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
1980-12-11T22:01:00.306Z,345420060.306 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
1980-12-11T22:01:00.306Z,345420060.306 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 931
1980-12-11T22:01:00.311Z,345420060.311 [Supervisor](INFO): Main Thread ID is 828
1980-12-11T22:01:00.311Z,345420060.311 [Supervisor](DEBUG): Running supervisor.
1980-12-11T22:01:00.311Z,345420060.311 [CommandExec ThreadHandler](INFO): Handler Thread ID is 932
1980-12-11T22:01:00.312Z,345420060.312 [CommandExec](INFO): Initializing the command executive.
1980-12-11T22:01:00.314Z,345420060.314 [CommandLine ThreadHandler](INFO): Handler Thread ID is 933
1980-12-11T22:01:00.316Z,345420060.316 [controlThread ThreadHandler](INFO): Handler Thread ID is 934
1980-12-11T22:01:00.316Z,345420060.316 [controlThread](DEBUG): Initializing ControlThread
1980-12-11T22:01:00.318Z,345420060.318 [NavChart](DEBUG): Initialize NavChart Navigation.
1980-12-11T22:01:00.318Z,345420060.318 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
1980-12-11T22:01:00.321Z,345420060.321 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
1980-12-11T22:01:00.322Z,345420060.322 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
1980-12-11T22:01:00.322Z,345420060.322 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
1980-12-11T22:01:00.322Z,345420060.322 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
1980-12-11T22:01:00.323Z,345420060.323 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
1980-12-11T22:01:00.324Z,345420060.324 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
1980-12-11T22:01:00.326Z,345420060.326 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
1980-12-11T22:01:00.326Z,345420060.326 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
1980-12-11T22:01:00.327Z,345420060.327 [LoopControl](DEBUG): Initialize LoopControlComponent.
1980-12-11T22:01:00.327Z,345420060.327 [SBIT](INFO): Initialize SBIT Component.
1980-12-11T22:01:00.328Z,345420060.328 [SBIT](IMPORTANT): git: 2025-09-11
1980-12-11T22:01:00.328Z,345420060.328 [SBIT](INFO): git hash: 809a1152453d4a7797fa86b43c86e80bc3a54567
1980-12-11T22:01:00.328Z,345420060.328 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
1980-12-11T22:01:00.329Z,345420060.329 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023
1980-12-11T22:01:00.330Z,345420060.330 [SBIT](INFO): Beginning SBIT in 95.000000 seconds.
1980-12-11T22:01:00.331Z,345420060.331 [IBIT](INFO): Initialize IBIT Component.
1980-12-11T22:01:00.332Z,345420060.332 [CBIT](DEBUG): Initialize CBIT Component.
1980-12-11T22:01:00.333Z,345420060.333 [logger ThreadHandler](INFO): Handler Thread ID is 935
1980-12-11T22:01:00.344Z,345420060.344 [CBIT](DEBUG): Initialized mux pins.
1980-12-11T22:01:00.344Z,345420060.344 [CBIT](DEBUG): Initializing the watchdog timer.
1980-12-11T22:01:00.352Z,345420060.352 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 936
1980-12-11T22:01:00.368Z,345420060.368 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
1980-12-11T22:01:00.369Z,345420060.369 [CBIT](DEBUG): Initializing heartbeat.
1980-12-11T22:01:00.369Z,345420060.369 [DAT ThreadHandler](INFO): Handler Thread ID is 937
1980-12-11T22:01:00.370Z,345420060.370 [DAT](INFO): Powering up
1980-12-11T22:01:00.370Z,345420060.370 [DAT](DEBUG): Initializing DAT.
1980-12-11T22:01:00.373Z,345420060.373 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 939
1980-12-11T22:01:00.375Z,345420060.375 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
1980-12-11T22:01:00.393Z,345420060.393 [Onboard ThreadHandler](INFO): Handler Thread ID is 940
1980-12-11T22:01:00.410Z,345420060.410 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 941
1980-12-11T22:01:00.428Z,345420060.428 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 942
1980-12-11T22:01:00.429Z,345420060.429 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
1980-12-11T22:01:00.433Z,345420060.433 [RBRTridente ThreadHandler](INFO): Handler Thread ID is 944
1980-12-11T22:01:00.434Z,345420060.434 [RBRTridente](INFO): Start
1980-12-11T22:01:00.436Z,345420060.436 [RBRTridente](INFO): Powering up
1980-12-11T22:01:00.438Z,345420060.438 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 946
1980-12-11T22:01:00.440Z,345420060.440 [CBIT](DEBUG): Deactivating emergency mode.
1980-12-11T22:01:00.447Z,345420060.447 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
1980-12-11T22:01:00.447Z,345420060.447 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
1980-12-11T22:01:00.447Z,345420060.447 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
1980-12-11T22:01:00.447Z,345420060.447 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
1980-12-11T22:01:00.448Z,345420060.448 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
1980-12-11T22:01:00.448Z,345420060.448 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
1980-12-11T22:01:00.448Z,345420060.448 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
1980-12-11T22:01:00.448Z,345420060.448 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
1980-12-11T22:01:00.480Z,345420060.480 [CBIT](DEBUG): Backplane powered.
1980-12-11T22:01:00.480Z,345420060.480 [GFScanner](DEBUG): Initializing GFScanner
1980-12-11T22:01:00.480Z,345420060.480 [GFScanner](DEBUG): Deactivating GF circuits.
1980-12-11T22:01:00.485Z,345420060.485 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
1980-12-11T22:01:00.486Z,345420060.486 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
1980-12-11T22:01:00.486Z,345420060.486 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
1980-12-11T22:01:00.491Z,345420060.491 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
1980-12-11T22:01:00.565Z,345420060.565 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
1980-12-11T22:01:00.569Z,345420060.569 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
1980-12-11T22:01:00.615Z,345420060.615 [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
}
}
}
1980-12-11T22:01:00.616Z,345420060.616 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
1980-12-11T22:01:00.616Z,345420060.616 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
1980-12-11T22:01:00.628Z,345420060.628 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
1980-12-11T22:01:00.816Z,345420060.816 [Radio_Surface](INFO): Powering up
1980-12-11T22:01:00.836Z,345420060.836 [RBRTridente](INFO): Starting
1980-12-11T22:01:00.971Z,345420060.971 [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
1980-12-11T22:01:00.993Z,345420060.993 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
1980-12-11T22:01:00.994Z,345420060.994 [Default:A.Wait](DEBUG): Construct Wait.
1980-12-11T22:01:00.997Z,345420060.997 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
1980-12-11T22:01:01.044Z,345420061.044 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
1980-12-11T22:01:01.046Z,345420061.046 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
1980-12-11T22:01:01.069Z,345420061.069 [Default:E.Execute](DEBUG): Construct Execute.
1980-12-11T22:01:01.088Z,345420061.088 [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"
}
}
1980-12-11T22:01:01.093Z,345420061.093 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
1980-12-11T22:01:01.116Z,345420061.116 [AHRS_M2](DEBUG): Initializing AHRS_M2.
1980-12-11T22:01:01.180Z,345420061.180 [DepthKeller33X](INFO): Initializing.
1980-12-11T22:01:01.197Z,345420061.197 [Power24vConverter](INFO): Powering up.
1980-12-11T22:01:01.197Z,345420061.197 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
1980-12-11T22:01:01.205Z,345420061.205 [Sonardyne_Nano](INFO): Initializing.
1980-12-11T22:01:01.224Z,345420061.224 [DepthRateCalculator](ERROR): Depth measurement is not active
1980-12-11T22:01:01.240Z,345420061.240 [RBRTridente](INFO): Starting
1980-12-11T22:01:01.253Z,345420061.253 [BuoyancyServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:01.260Z,345420061.260 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
1980-12-11T22:01:01.261Z,345420061.261 [ElevatorServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:01.268Z,345420061.268 [ElevatorServo](DEBUG): Initializing ElevatorServo.
1980-12-11T22:01:01.269Z,345420061.269 [MassServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:01.276Z,345420061.276 [MassServo](DEBUG): Initializing MassServo.
1980-12-11T22:01:01.277Z,345420061.277 [RudderServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:01.284Z,345420061.284 [RudderServo](DEBUG): Initializing RudderServo.
1980-12-11T22:01:01.285Z,345420061.285 [ThrusterHE](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:01.292Z,345420061.292 [ThrusterHE](DEBUG): Initializing ThrusterHE.
1980-12-11T22:01:01.552Z,345420061.552 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
1980-12-11T22:01:01.553Z,345420061.553 [DropWeight] Hardware Fault, FailCount= 1
1980-12-11T22:01:01.553Z,345420061.553 [DropWeight](ERROR): Hardware Fault
1980-12-11T22:01:01.554Z,345420061.554 [DepthRateCalculator](ERROR): Depth measurement is not active
1980-12-11T22:01:01.571Z,345420061.571 [CommandExec](FAULT): Scheduling is paused
1980-12-11T22:01:01.580Z,345420061.580 [CBIT](INFO): Critical error at 19801211T220101
1980-12-11T22:01:01.580Z,345420061.580 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
1980-12-11T22:01:01.583Z,345420061.583 [CBIT](ERROR): Hardware Fault in component: DropWeight
1980-12-11T22:01:01.583Z,345420061.583 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
1980-12-11T22:01:01.644Z,345420061.644 [RBRTridente](INFO): Starting
1980-12-11T22:01:01.909Z,345420061.909 [DepthRateCalculator](ERROR): Depth measurement is not active
1980-12-11T22:01:01.918Z,345420061.918 [CBIT](INFO): Critical error at 19801211T220101
1980-12-11T22:01:02.048Z,345420062.048 [RBRTridente](INFO): Starting
1980-12-11T22:01:02.312Z,345420062.312 [DepthRateCalculator](ERROR): Depth measurement is not active
1980-12-11T22:01:02.453Z,345420062.453 [RBRTridente](INFO): Starting
1980-12-11T22:01:02.737Z,345420062.737 [DepthRateCalculator](ERROR): Depth measurement is not active
1980-12-11T22:01:02.857Z,345420062.857 [RBRTridente](INFO): Starting
1980-12-11T22:01:03.260Z,345420063.260 [RBRTridente](INFO): Starting
1980-12-11T22:01:03.664Z,345420063.664 [RBRTridente](INFO): Starting
1980-12-11T22:01:04.071Z,345420064.071 [RBRTridente](INFO): Starting
1980-12-11T22:01:04.472Z,345420064.472 [RBRTridente](INFO): Starting
1980-12-11T22:01:04.652Z,345420064.652 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:04.876Z,345420064.876 [RBRTridente](INFO): Starting
1980-12-11T22:01:05.060Z,345420065.060 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:05.280Z,345420065.280 [RBRTridente](INFO): Starting
1980-12-11T22:01:05.532Z,345420065.532 [RBRTridente] Communications Fault, FailCount= 1
1980-12-11T22:01:05.532Z,345420065.532 [RBRTridente](ERROR): Communications Fault
1980-12-11T22:01:05.628Z,345420065.628 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:05.730Z,345420065.730 [CBIT](ERROR): Communications Fault in component: RBRTridente
1980-12-11T22:01:05.936Z,345420065.936 [RBRTridente](INFO): Stop
1980-12-11T22:01:06.009Z,345420066.009 [RBRTridente](INFO): Powering down
1980-12-11T22:01:06.064Z,345420066.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:06.412Z,345420066.412 [RBRTridente](INFO): Stopping
1980-12-11T22:01:06.556Z,345420066.556 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:06.996Z,345420066.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:07.073Z,345420067.073 [RudderServo](FAULT): Overload Error
1980-12-11T22:01:07.073Z,345420067.073 [RudderServo] Hardware Fault, FailCount= 1
1980-12-11T22:01:07.073Z,345420067.073 [RudderServo](ERROR): Hardware Fault
1980-12-11T22:01:07.244Z,345420067.244 [CBIT](ERROR): Hardware Fault in component: RudderServo
1980-12-11T22:01:07.244Z,345420067.244 [CBIT](INFO): Clearing failed state for component RBRTridente
1980-12-11T22:01:07.244Z,345420067.244 [RBRTridente] No Fault, FailCount= 1
1980-12-11T22:01:07.572Z,345420067.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:07.617Z,345420067.617 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1980-12-11T22:01:07.617Z,345420067.617 [RudderServo](INFO): Powering down
1980-12-11T22:01:07.624Z,345420067.624 [RBRTridente](INFO): Start
1980-12-11T22:01:07.625Z,345420067.625 [RBRTridente](INFO): Powering up
1980-12-11T22:01:08.029Z,345420068.029 [RBRTridente](INFO): Starting
1980-12-11T22:01:08.076Z,345420068.076 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:08.432Z,345420068.432 [RBRTridente](INFO): Starting
1980-12-11T22:01:08.496Z,345420068.496 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:08.549Z,345420068.549 [RudderServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:08.669Z,345420068.669 [RudderServo](DEBUG): Initializing RudderServo.
1980-12-11T22:01:08.674Z,345420068.674 [CBIT](INFO): Clearing failed state for component RudderServo
1980-12-11T22:01:08.674Z,345420068.674 [RudderServo] No Fault, FailCount= 1
1980-12-11T22:01:08.836Z,345420068.836 [RBRTridente](INFO): Starting
1980-12-11T22:01:09.012Z,345420069.012 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:09.240Z,345420069.240 [RBRTridente](INFO): Starting
1980-12-11T22:01:09.552Z,345420069.552 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:09.644Z,345420069.644 [RBRTridente](INFO): Starting
1980-12-11T22:01:10.032Z,345420070.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:10.053Z,345420070.053 [RBRTridente](INFO): Starting
1980-12-11T22:01:10.456Z,345420070.456 [RBRTridente](INFO): Starting
1980-12-11T22:01:10.460Z,345420070.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:10.860Z,345420070.860 [RBRTridente](INFO): Starting
1980-12-11T22:01:10.888Z,345420070.888 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:11.264Z,345420071.264 [RBRTridente](INFO): Starting
1980-12-11T22:01:11.308Z,345420071.308 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:11.669Z,345420071.669 [RBRTridente](INFO): Starting
1980-12-11T22:01:11.756Z,345420071.756 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:12.072Z,345420072.072 [RBRTridente](INFO): Starting
1980-12-11T22:01:12.185Z,345420072.185 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:12.470Z,345420072.470 [DAT](INFO): DAT read:
1980-12-11T22:01:12.473Z,345420072.473 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
1980-12-11T22:01:12.477Z,345420072.477 [RBRTridente](INFO): Starting
1980-12-11T22:01:12.728Z,345420072.728 [RBRTridente] Communications Fault, FailCount= 2
1980-12-11T22:01:12.728Z,345420072.728 [RBRTridente](ERROR): Communications Fault
1980-12-11T22:01:12.856Z,345420072.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:13.089Z,345420073.089 [CBIT](ERROR): Communications Fault in component: RBRTridente
1980-12-11T22:01:13.133Z,345420073.133 [RBRTridente](INFO): Stop
1980-12-11T22:01:13.204Z,345420073.204 [RBRTridente](INFO): Powering down
1980-12-11T22:01:13.412Z,345420073.412 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:13.480Z,345420073.480 [CTD_Seabird](FAULT): Failed to initialize within timeout.
1980-12-11T22:01:13.481Z,345420073.481 [CTD_Seabird] Communications Fault, FailCount= 1
1980-12-11T22:01:13.481Z,345420073.481 [CTD_Seabird](ERROR): Communications Fault
1980-12-11T22:01:13.608Z,345420073.608 [RBRTridente](INFO): Stopping
1980-12-11T22:01:13.652Z,345420073.652 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
1980-12-11T22:01:13.885Z,345420073.885 [CTD_Seabird](INFO): Powering down
1980-12-11T22:01:13.989Z,345420073.989 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:13.989Z,345420073.989 [AHRS_M2](FAULT): Failed to initialize within timeout.
1980-12-11T22:01:13.990Z,345420073.990 [AHRS_M2] Communications Fault, FailCount= 1
1980-12-11T22:01:13.990Z,345420073.990 [AHRS_M2](ERROR): Communications Fault
1980-12-11T22:01:14.112Z,345420074.112 [RudderServo](FAULT): Overload Error
1980-12-11T22:01:14.113Z,345420074.113 [RudderServo] Hardware Fault, FailCount= 2
1980-12-11T22:01:14.113Z,345420074.113 [RudderServo](ERROR): Hardware Fault
1980-12-11T22:01:14.165Z,345420074.165 [CommandExec](IMPORTANT): got command quit
1980-12-11T22:01:14.224Z,345420074.224 [CBIT](ERROR): Communications Fault in component: AHRS_M2
1980-12-11T22:01:14.224Z,345420074.224 [CBIT](ERROR): Hardware Fault in component: RudderServo
1980-12-11T22:01:14.225Z,345420074.225 [CBIT](INFO): Clearing failed state for component RBRTridente
1980-12-11T22:01:14.225Z,345420074.225 [RBRTridente] No Fault, FailCount= 2
1980-12-11T22:01:14.234Z,345420074.234 [DAT](INFO): DAT read: MF Frequency Band
1980-12-11T22:01:14.235Z,345420074.235 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0
1980-12-11T22:01:14.236Z,345420074.236 [DAT](INFO): DAT read: Oct 7 2025 22:06:44
1980-12-11T22:01:14.238Z,345420074.238 [AHRS_M2](INFO): Powering down
1980-12-11T22:01:14.361Z,345420074.361 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1980-12-11T22:01:14.361Z,345420074.361 [RudderServo](INFO): Powering down
1980-12-11T22:01:14.416Z,345420074.416 [RBRTridente](INFO): Start
1980-12-11T22:01:14.417Z,345420074.417 [RBRTridente](INFO): Powering up
1980-12-11T22:01:14.821Z,345420074.821 [RBRTridente](INFO): Starting
1980-12-11T22:01:15.082Z,345420075.082 [RudderServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:15.168Z,345420075.168 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:15.168Z,345420075.168 [CommandExec](INFO): Uninitializing the command executive.
1980-12-11T22:01:15.168Z,345420075.168 [CommandExec](INFO): Uninitializing the command scheduler.
1980-12-11T22:01:15.169Z,345420075.169 [CommandExec ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:15.201Z,345420075.201 [RudderServo](DEBUG): Initializing RudderServo.
1980-12-11T22:01:15.206Z,345420075.206 [CBIT](INFO): Clearing failed state for component AHRS_M2
1980-12-11T22:01:15.206Z,345420075.206 [AHRS_M2] No Fault, FailCount= 1
1980-12-11T22:01:15.207Z,345420075.207 [CBIT](INFO): Clearing failed state for component RudderServo
1980-12-11T22:01:15.207Z,345420075.207 [RudderServo] No Fault, FailCount= 2
1980-12-11T22:01:15.207Z,345420075.207 [CBIT](INFO): Clearing failed state for component CTD_Seabird
1980-12-11T22:01:15.207Z,345420075.207 [CTD_Seabird] No Fault, FailCount= 1
1980-12-11T22:01:15.224Z,345420075.224 [RBRTridente](INFO): Starting
1980-12-11T22:01:15.229Z,345420075.229 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
1980-12-11T22:01:15.241Z,345420075.241 [DAT](INFO): DAT read: Features enabled [Bearing]
1980-12-11T22:01:15.242Z,345420075.242 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP
1980-12-11T22:01:15.242Z,345420075.242 [DAT](INFO): commRate: 600
1980-12-11T22:01:15.336Z,345420075.336 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
1980-12-11T22:01:15.336Z,345420075.336 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
1980-12-11T22:01:15.336Z,345420075.336 [NavChartDb ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:15.337Z,345420075.337 [NavChartDb](INFO): Join timeout helper Thread ID is 961
1980-12-11T22:01:15.442Z,345420075.442 [AHRS_M2](DEBUG): Initializing AHRS_M2.
1980-12-11T22:01:15.628Z,345420075.628 [RBRTridente](INFO): Starting
1980-12-11T22:01:15.791Z,345420075.791 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:15.793Z,345420075.793 [NavChartDb ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:15.812Z,345420075.812 [ComponentRegistry](INFO): Shutting down RBRTridente ThreadHandler
1980-12-11T22:01:15.812Z,345420075.812 [RBRTridente ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:15.813Z,345420075.813 [RBRTridente](INFO): Join timeout helper Thread ID is 963
1980-12-11T22:01:15.884Z,345420075.884 [RBRTridente ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:15.956Z,345420075.956 [RBRTridente](INFO): Powering down
1980-12-11T22:01:15.957Z,345420075.957 [RBRTridente ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:15.968Z,345420075.968 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
1980-12-11T22:01:15.968Z,345420075.968 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:15.968Z,345420075.968 [CTD_Seabird](INFO): Join timeout helper Thread ID is 965
1980-12-11T22:01:16.232Z,345420076.232 [CTD_Seabird](INFO): Powering down
1980-12-11T22:01:16.360Z,345420076.360 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:16.360Z,345420076.360 [CTD_Seabird](INFO): Powering down
1980-12-11T22:01:16.372Z,345420076.372 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:16.388Z,345420076.388 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
1980-12-11T22:01:16.388Z,345420076.388 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:16.388Z,345420076.388 [Radio_Surface](INFO): Join timeout helper Thread ID is 966
1980-12-11T22:01:16.572Z,345420076.572 [Radio_Surface](INFO): Powering down
1980-12-11T22:01:16.573Z,345420076.573 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:16.573Z,345420076.573 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:16.580Z,345420076.580 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
1980-12-11T22:01:16.580Z,345420076.580 [Onboard ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:16.580Z,345420076.580 [Onboard](INFO): Join timeout helper Thread ID is 967
1980-12-11T22:01:17.312Z,345420077.312 [DAT](INFO): entering command mode
1980-12-11T22:01:17.513Z,345420077.513 [DAT](INFO): DAT read:
1980-12-11T22:01:17.514Z,345420077.514 [DAT](INFO): DAT read: user:1>
1980-12-11T22:01:17.514Z,345420077.514 [DAT](INFO): setting verbose to 3
1980-12-11T22:01:17.765Z,345420077.765 [DAT](INFO): DAT read: user:1>
1980-12-11T22:01:17.766Z,345420077.766 [DAT](INFO): DAT read: Verbose | 3
1980-12-11T22:01:17.766Z,345420077.766 [DAT](INFO): set verbose to 3
1980-12-11T22:01:17.766Z,345420077.766 [DAT](INFO): setting DatVerbose to 27440
1980-12-11T22:01:18.017Z,345420078.017 [DAT](INFO): DAT read: user:2>
1980-12-11T22:01:18.018Z,345420078.018 [DAT](INFO): DAT read: DatVerbose | 27440
1980-12-11T22:01:18.018Z,345420078.018 [DAT](INFO): set DatVerbose to 27440
1980-12-11T22:01:18.019Z,345420078.019 [DAT](INFO): setting transmit power to 8
1980-12-11T22:01:18.269Z,345420078.269 [DAT](INFO): DAT read: user:3>
1980-12-11T22:01:18.270Z,345420078.270 [DAT](INFO): DAT read: TxPower | 8 (Max)
1980-12-11T22:01:18.270Z,345420078.270 [DAT](INFO): set transmit power to 8
1980-12-11T22:01:18.270Z,345420078.270 [DAT](INFO): setting local address to 3
1980-12-11T22:01:18.521Z,345420078.521 [DAT](INFO): DAT read: user:4>
1980-12-11T22:01:18.521Z,345420078.521 [DAT](INFO): DAT read: LocalAddr | 3
1980-12-11T22:01:18.522Z,345420078.522 [DAT](INFO): set local address to 3
1980-12-11T22:01:18.523Z,345420078.523 [DAT](INFO): Setting time to: 22:1:18 And date to:12/11/1980
1980-12-11T22:01:18.773Z,345420078.773 [DAT](INFO): DAT read: user:5>
1980-12-11T22:01:18.774Z,345420078.774 [DAT](INFO): DAT read: Thu Dec 11, 1980 22:01:18
1980-12-11T22:01:18.774Z,345420078.774 [DAT](INFO): Local DAT time set to Thu Dec 11, 1980 22:01:18
1980-12-11T22:01:19.008Z,345420079.008 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:19.452Z,345420079.452 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:19.880Z,345420079.880 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:19.997Z,345420079.997 [RudderServo](FAULT): Overload Error
1980-12-11T22:01:19.997Z,345420079.997 [RudderServo] Hardware Fault, FailCount= 3
1980-12-11T22:01:19.997Z,345420079.997 [RudderServo](ERROR): Hardware Fault
1980-12-11T22:01:20.108Z,345420080.108 [CBIT](ERROR): Hardware Fault in component: RudderServo
1980-12-11T22:01:20.109Z,345420080.109 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
1980-12-11T22:01:20.408Z,345420080.408 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:20.408Z,345420080.408 [Onboard ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.421Z,345420080.421 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
1980-12-11T22:01:20.421Z,345420080.421 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.421Z,345420080.421 [DataOverHttps](INFO): Join timeout helper Thread ID is 968
1980-12-11T22:01:20.444Z,345420080.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:20.452Z,345420080.452 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:20.452Z,345420080.452 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.461Z,345420080.461 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
1980-12-11T22:01:20.461Z,345420080.461 [DAT ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.461Z,345420080.461 [DAT](INFO): Join timeout helper Thread ID is 969
1980-12-11T22:01:20.497Z,345420080.497 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1980-12-11T22:01:20.498Z,345420080.498 [RudderServo](INFO): Powering down
1980-12-11T22:01:20.501Z,345420080.501 [CBIT](INFO): Critical error at 19801211T220120
1980-12-11T22:01:20.536Z,345420080.536 [DAT](INFO): Powering down
1980-12-11T22:01:20.604Z,345420080.604 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:20.605Z,345420080.605 [DAT](INFO): Powering down
1980-12-11T22:01:20.609Z,345420080.609 [DAT ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.613Z,345420080.613 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
1980-12-11T22:01:20.613Z,345420080.613 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.613Z,345420080.613 [BackseatComponent](INFO): Join timeout helper Thread ID is 970
1980-12-11T22:01:20.776Z,345420080.776 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:20.776Z,345420080.776 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.793Z,345420080.793 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
1980-12-11T22:01:20.793Z,345420080.793 [logger ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:20.793Z,345420080.793 [logger](INFO): Join timeout helper Thread ID is 971
1980-12-11T22:01:20.857Z,345420080.857 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:21.122Z,345420081.122 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:21.122Z,345420081.122 [logger ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.141Z,345420081.141 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
1980-12-11T22:01:21.141Z,345420081.141 [CommandLine ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.142Z,345420081.142 [CommandLine](INFO): Join timeout helper Thread ID is 972
1980-12-11T22:01:21.220Z,345420081.220 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:21.221Z,345420081.221 [CommandLine ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.233Z,345420081.233 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
1980-12-11T22:01:21.233Z,345420081.233 [CommandExec ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.233Z,345420081.233 [CommandExec](INFO): Join timeout helper Thread ID is 973
1980-12-11T22:01:21.234Z,345420081.234 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
1980-12-11T22:01:21.234Z,345420081.234 [controlThread ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.235Z,345420081.235 [controlThread](INFO): Join timeout helper Thread ID is 974
1980-12-11T22:01:21.288Z,345420081.288 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
1980-12-11T22:01:21.333Z,345420081.333 [RudderServo](DEBUG): Initializing EZServoServo.
1980-12-11T22:01:21.453Z,345420081.453 [RudderServo](DEBUG): Initializing RudderServo.
1980-12-11T22:01:21.459Z,345420081.459 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
1980-12-11T22:01:21.459Z,345420081.459 [controlThread](DEBUG): Uninitializing ControlThread
1980-12-11T22:01:21.459Z,345420081.459 [AHRS_M2](INFO): Powering down
1980-12-11T22:01:21.533Z,345420081.533 [DepthKeller33X](INFO): Powering down
1980-12-11T22:01:21.629Z,345420081.629 [NAL9602](INFO): Powering down
1980-12-11T22:01:21.700Z,345420081.700 [RDI_Pathfinder](INFO): Powering down
1980-12-11T22:01:21.701Z,345420081.701 [Sonardyne_Nano](INFO): Powering down
1980-12-11T22:01:21.820Z,345420081.820 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
1980-12-11T22:01:21.821Z,345420081.821 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
1980-12-11T22:01:21.822Z,345420081.822 [NavChart](DEBUG): Uninitialize NavChart Navigation.
1980-12-11T22:01:21.822Z,345420081.822 [MissionManager](INFO): Uninitializing Mission Default
1980-12-11T22:01:21.825Z,345420081.825 [MissionManager](INFO): Uninitializing Mission Startup
1980-12-11T22:01:21.827Z,345420081.827 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
1980-12-11T22:01:21.827Z,345420081.827 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
1980-12-11T22:01:21.827Z,345420081.827 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
1980-12-11T22:01:21.827Z,345420081.827 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
1980-12-11T22:01:21.828Z,345420081.828 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
1980-12-11T22:01:21.828Z,345420081.828 [BuoyancyServo](INFO): Powering down
1980-12-11T22:01:21.840Z,345420081.840 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
1980-12-11T22:01:21.840Z,345420081.840 [ElevatorServo](INFO): Powering down
1980-12-11T22:01:21.841Z,345420081.841 [MassServo](DEBUG): Uninitialize Mass Servo.
1980-12-11T22:01:21.841Z,345420081.841 [MassServo](INFO): Powering down
1980-12-11T22:01:21.842Z,345420081.842 [RudderServo](DEBUG): Uninitialize Rudder Servo.
1980-12-11T22:01:21.842Z,345420081.842 [RudderServo](INFO): Powering down
1980-12-11T22:01:21.843Z,345420081.843 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
1980-12-11T22:01:21.843Z,345420081.843 [ThrusterHE](INFO): Powering down
1980-12-11T22:01:21.844Z,345420081.844 [SBIT](DEBUG): Uninitialize SBIT Component.
1980-12-11T22:01:21.844Z,345420081.844 [IBIT](DEBUG): Uninitialize IBIT Component.
1980-12-11T22:01:21.844Z,345420081.844 [CBIT](DEBUG): Uninitialize CBIT Component.
1980-12-11T22:01:21.844Z,345420081.844 [CBIT](DEBUG): Powering off loads.
1980-12-11T22:01:21.856Z,345420081.856 [CBIT](DEBUG): Disabling WDT.
1980-12-11T22:01:21.868Z,345420081.868 [GFScanner](DEBUG): Uninitialize GFScanner component.
1980-12-11T22:01:21.868Z,345420081.868 [GFScanner](DEBUG): Opening all GF detection circuits.
1980-12-11T22:01:21.869Z,345420081.869 [controlThread ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.888Z,345420081.888 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.891Z,345420081.891 [Onboard ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.897Z,345420081.897 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.903Z,345420081.903 [DAT ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:21.944Z,345420081.944 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:22.347Z,345420082.347 [RBRTridente ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:22.348Z,345420082.348 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:22.389Z,345420082.389 [GFScanner](DEBUG): Uninitialize GFScanner component.
1980-12-11T22:01:22.389Z,345420082.389 [GFScanner](DEBUG): Opening all GF detection circuits.
1980-12-11T22:01:22.408Z,345420082.408 [NavChartDb ThreadHandler](INFO): Thread cancelled.
1980-12-11T22:01:22.457Z,345420082.457 [logger ThreadHandler](INFO): Thread cancelled.