2024-05-08T17:22:56.260Z,1715188976.260 [Supervisor](DEBUG): Initializing supervisor. 2024-05-08T17:22:56.264Z,1715188976.264 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-08T17:22:56.265Z,1715188976.265 [SyncHandler](INFO): Protected caller Thread ID is 829 2024-05-08T17:22:56.265Z,1715188976.265 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-08T17:22:56.266Z,1715188976.266 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-08T17:22:56.267Z,1715188976.267 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 830 2024-05-08T17:22:56.270Z,1715188976.270 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-08T17:22:56.288Z,1715188976.288 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-08T17:22:56.289Z,1715188976.289 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-08T17:22:56.290Z,1715188976.290 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 831 2024-05-08T17:22:56.294Z,1715188976.294 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-08T17:22:56.295Z,1715188976.295 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-08T17:22:56.295Z,1715188976.295 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 832 2024-05-08T17:22:56.297Z,1715188976.297 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-08T17:22:56.298Z,1715188976.298 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-08T17:22:56.299Z,1715188976.299 [logger ThreadHandler](INFO): Protected caller Thread ID is 833 2024-05-08T17:22:56.302Z,1715188976.302 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-08T17:22:56.303Z,1715188976.303 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-08T17:22:56.308Z,1715188976.308 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-08T17:22:56.415Z,1715188976.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-08T17:22:56.417Z,1715188976.417 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-08T17:22:56.666Z,1715188976.666 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-08T17:22:56.668Z,1715188976.668 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-08T17:22:56.958Z,1715188976.958 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-08T17:22:56.959Z,1715188976.959 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-08T17:22:57.078Z,1715188977.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-08T17:22:57.080Z,1715188977.080 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-08T17:22:57.895Z,1715188977.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-08T17:22:57.896Z,1715188977.896 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-08T17:22:58.427Z,1715188978.427 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-08T17:22:58.429Z,1715188978.429 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-08T17:22:58.995Z,1715188978.995 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-08T17:22:58.996Z,1715188978.996 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-08T17:22:59.436Z,1715188979.436 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-08T17:22:59.594Z,1715188979.594 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-08T17:23:00.154Z,1715188980.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-08T17:23:00.155Z,1715188980.155 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-08T17:23:00.553Z,1715188980.553 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-08T17:23:00.553Z,1715188980.553 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-08T17:23:00.796Z,1715188980.796 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-08T17:23:00.796Z,1715188980.796 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-08T17:23:00.951Z,1715188980.951 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-08T17:23:00.951Z,1715188980.951 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-08T17:23:01.046Z,1715188981.046 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-08T17:23:01.136Z,1715188981.136 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-08T17:23:01.337Z,1715188981.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-08T17:23:01.339Z,1715188981.339 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-08T17:23:01.587Z,1715188981.587 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-08T17:23:01.588Z,1715188981.588 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2024-05-08T17:23:01.592Z,1715188981.592 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2024-05-08T17:23:01.687Z,1715188981.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2024-05-08T17:23:01.960Z,1715188981.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-08T17:23:01.961Z,1715188981.961 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2024-05-08T17:23:02.067Z,1715188982.067 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2024-05-08T17:23:02.243Z,1715188982.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2024-05-08T17:23:02.355Z,1715188982.355 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2024-05-08T17:23:02.477Z,1715188982.477 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2024-05-08T17:23:02.602Z,1715188982.602 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2024-05-08T17:23:02.751Z,1715188982.751 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2024-05-08T17:23:02.939Z,1715188982.939 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2024-05-08T17:23:03.047Z,1715188983.047 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2024-05-08T17:23:03.157Z,1715188983.157 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2024-05-08T17:23:03.257Z,1715188983.257 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-08T17:23:03.273Z,1715188983.273 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-08T17:23:03.492Z,1715188983.492 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-08T17:23:03.493Z,1715188983.493 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-08T17:23:03.683Z,1715188983.683 [BuoyancyServo] Loaded 2024-05-08T17:23:03.683Z,1715188983.683 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-08T17:23:03.704Z,1715188983.704 [ElevatorServo] Loaded 2024-05-08T17:23:03.704Z,1715188983.704 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-08T17:23:03.724Z,1715188983.724 [MassServo] Loaded 2024-05-08T17:23:03.725Z,1715188983.725 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-08T17:23:03.745Z,1715188983.745 [RudderServo] Loaded 2024-05-08T17:23:03.745Z,1715188983.745 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-08T17:23:03.761Z,1715188983.761 [ThrusterHE] Loaded 2024-05-08T17:23:03.761Z,1715188983.761 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-05-08T17:23:03.761Z,1715188983.761 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-08T17:23:03.763Z,1715188983.763 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-08T17:23:03.936Z,1715188983.936 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-08T17:23:03.950Z,1715188983.950 [SBIT] Loaded 2024-05-08T17:23:03.951Z,1715188983.951 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-08T17:23:03.953Z,1715188983.953 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-08T17:23:03.974Z,1715188983.974 [IBIT] Loaded 2024-05-08T17:23:03.974Z,1715188983.974 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-08T17:23:03.980Z,1715188983.980 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-08T17:23:04.196Z,1715188984.196 [CBIT] Loaded 2024-05-08T17:23:04.197Z,1715188984.197 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-08T17:23:04.197Z,1715188984.197 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-08T17:23:04.198Z,1715188984.198 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-08T17:23:04.417Z,1715188984.417 [CTD_Seabird] Loaded 2024-05-08T17:23:04.418Z,1715188984.418 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-08T17:23:04.419Z,1715188984.419 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0 2024-05-08T17:23:04.419Z,1715188984.419 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 919 2024-05-08T17:23:04.451Z,1715188984.451 [ESPComponent] Loaded 2024-05-08T17:23:04.451Z,1715188984.451 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-05-08T17:23:04.471Z,1715188984.471 [PAR_Licor] Loaded 2024-05-08T17:23:04.471Z,1715188984.471 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-08T17:23:04.514Z,1715188984.514 [WetLabsBB2FL] Loaded 2024-05-08T17:23:04.514Z,1715188984.514 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-08T17:23:04.515Z,1715188984.515 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0 2024-05-08T17:23:04.515Z,1715188984.515 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 920 2024-05-08T17:23:04.516Z,1715188984.516 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-08T17:23:04.516Z,1715188984.516 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-08T17:23:04.771Z,1715188984.771 [DepthRateCalculator] Loaded 2024-05-08T17:23:04.771Z,1715188984.771 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-08T17:23:04.777Z,1715188984.777 [PitchRateCalculator] Loaded 2024-05-08T17:23:04.777Z,1715188984.777 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-08T17:23:04.788Z,1715188984.788 [SpeedCalculator] Loaded 2024-05-08T17:23:04.788Z,1715188984.788 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-08T17:23:04.793Z,1715188984.793 [YawRateCalculator] Loaded 2024-05-08T17:23:04.793Z,1715188984.793 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-08T17:23:04.812Z,1715188984.812 [ElevatorOffsetCalculator] Loaded 2024-05-08T17:23:04.813Z,1715188984.813 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-08T17:23:04.813Z,1715188984.813 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-08T17:23:04.814Z,1715188984.814 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-08T17:23:04.994Z,1715188984.994 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-08T17:23:04.994Z,1715188984.994 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-08T17:23:05.038Z,1715188985.038 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-08T17:23:05.039Z,1715188985.039 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-08T17:23:05.177Z,1715188985.177 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-08T17:23:05.177Z,1715188985.177 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-08T17:23:05.191Z,1715188985.191 [NavChart] Loaded 2024-05-08T17:23:05.192Z,1715188985.192 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-08T17:23:05.197Z,1715188985.197 [UniversalFixResidualReporter] Loaded 2024-05-08T17:23:05.198Z,1715188985.198 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-08T17:23:05.198Z,1715188985.198 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-08T17:23:05.199Z,1715188985.199 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-08T17:23:06.030Z,1715188986.030 [AHRS_M2] Loaded 2024-05-08T17:23:06.030Z,1715188986.030 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-08T17:23:06.279Z,1715188986.279 [BackseatComponent] Loaded 2024-05-08T17:23:06.279Z,1715188986.279 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-05-08T17:23:06.281Z,1715188986.281 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0 2024-05-08T17:23:06.281Z,1715188986.281 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921 2024-05-08T17:23:06.284Z,1715188986.284 [LcmUniversalReporter] Loaded 2024-05-08T17:23:06.284Z,1715188986.284 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-05-08T17:23:07.008Z,1715188987.008 [BPC1] Loaded 2024-05-08T17:23:07.009Z,1715188987.009 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-08T17:23:07.149Z,1715188987.149 [DataOverHttps] Loaded 2024-05-08T17:23:07.150Z,1715188987.150 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-08T17:23:07.151Z,1715188987.151 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0 2024-05-08T17:23:07.151Z,1715188987.151 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922 2024-05-08T17:23:07.171Z,1715188987.171 [Depth_Keller] Loaded 2024-05-08T17:23:07.172Z,1715188987.172 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-08T17:23:07.177Z,1715188987.177 [DropWeight] Loaded 2024-05-08T17:23:07.177Z,1715188987.177 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-05-08T17:23:07.216Z,1715188987.216 [DVL_micro] Loaded 2024-05-08T17:23:07.216Z,1715188987.216 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2024-05-08T17:23:07.276Z,1715188987.276 [NAL9602] Loaded 2024-05-08T17:23:07.276Z,1715188987.276 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-08T17:23:07.303Z,1715188987.303 [Onboard] Loaded 2024-05-08T17:23:07.303Z,1715188987.303 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-08T17:23:07.304Z,1715188987.304 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AB34E0 2024-05-08T17:23:07.304Z,1715188987.304 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923 2024-05-08T17:23:07.317Z,1715188987.317 [Power24vConverter] Loaded 2024-05-08T17:23:07.317Z,1715188987.317 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-08T17:23:07.330Z,1715188987.330 [Radio_Surface] Loaded 2024-05-08T17:23:07.330Z,1715188987.330 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-08T17:23:07.331Z,1715188987.331 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AE34E0 2024-05-08T17:23:07.332Z,1715188987.332 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924 2024-05-08T17:23:07.425Z,1715188987.425 [DAT] Loaded 2024-05-08T17:23:07.426Z,1715188987.426 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-05-08T17:23:07.427Z,1715188987.427 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B134E0 2024-05-08T17:23:07.427Z,1715188987.427 [DAT ThreadHandler](INFO): Protected caller Thread ID is 925 2024-05-08T17:23:07.428Z,1715188987.428 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-08T17:23:07.428Z,1715188987.428 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-08T17:23:07.511Z,1715188987.511 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-08T17:23:07.513Z,1715188987.513 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-08T17:23:07.585Z,1715188987.585 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-08T17:23:07.636Z,1715188987.636 [VerticalControl] Loaded 2024-05-08T17:23:07.636Z,1715188987.636 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-08T17:23:07.639Z,1715188987.639 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-08T17:23:07.683Z,1715188987.683 [HorizontalControl] Loaded 2024-05-08T17:23:07.684Z,1715188987.684 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-08T17:23:07.686Z,1715188987.686 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-08T17:23:07.688Z,1715188987.688 [SpeedControl] Loaded 2024-05-08T17:23:07.688Z,1715188987.688 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-08T17:23:07.691Z,1715188987.691 [LoopControl](DEBUG): Construct LoopControl. 2024-05-08T17:23:07.691Z,1715188987.691 [LoopControl] Loaded 2024-05-08T17:23:07.692Z,1715188987.692 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-08T17:23:07.692Z,1715188987.692 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-08T17:23:07.693Z,1715188987.693 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-08T17:23:07.708Z,1715188987.708 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-08T17:23:07.709Z,1715188987.709 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-08T17:23:08.113Z,1715188988.113 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-08T17:23:08.120Z,1715188988.120 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-08T17:23:08.123Z,1715188988.123 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-08T17:23:08.134Z,1715188988.134 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-08T17:23:08.135Z,1715188988.135 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-05-08T17:23:08.135Z,1715188988.135 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 926 2024-05-08T17:23:08.139Z,1715188988.139 [Supervisor](INFO): Main Thread ID is 822 2024-05-08T17:23:08.140Z,1715188988.140 [Supervisor](DEBUG): Running supervisor. 2024-05-08T17:23:08.140Z,1715188988.140 [CommandExec ThreadHandler](INFO): Handler Thread ID is 927 2024-05-08T17:23:08.141Z,1715188988.141 [CommandExec](INFO): Initializing the command executive. 2024-05-08T17:23:08.142Z,1715188988.142 [CommandLine ThreadHandler](INFO): Handler Thread ID is 928 2024-05-08T17:23:08.144Z,1715188988.144 [controlThread ThreadHandler](INFO): Handler Thread ID is 929 2024-05-08T17:23:08.145Z,1715188988.145 [controlThread](DEBUG): Initializing ControlThread 2024-05-08T17:23:08.147Z,1715188988.147 [SBIT](INFO): Initialize SBIT Component. 2024-05-08T17:23:08.147Z,1715188988.147 [SBIT](IMPORTANT): git: 2024-05-06 2024-05-08T17:23:08.147Z,1715188988.147 [SBIT](INFO): git hash: 5fc11fab0683feef1094efea7282b340ac202615 2024-05-08T17:23:08.148Z,1715188988.148 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-08T17:23:08.149Z,1715188988.149 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-05-08T17:23:08.150Z,1715188988.150 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2024-05-08T17:23:08.151Z,1715188988.151 [IBIT](INFO): Initialize IBIT Component. 2024-05-08T17:23:08.151Z,1715188988.151 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-08T17:23:08.152Z,1715188988.152 [logger ThreadHandler](INFO): Handler Thread ID is 930 2024-05-08T17:23:08.165Z,1715188988.165 [CBIT](DEBUG): Initialized mux pins. 2024-05-08T17:23:08.166Z,1715188988.166 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-08T17:23:08.178Z,1715188988.178 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 931 2024-05-08T17:23:08.179Z,1715188988.179 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-08T17:23:08.183Z,1715188988.183 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 933 2024-05-08T17:23:08.186Z,1715188988.186 [WetLabsBB2FL](INFO): Powering up 2024-05-08T17:23:08.187Z,1715188988.187 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 935 2024-05-08T17:23:08.190Z,1715188988.190 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-08T17:23:08.190Z,1715188988.190 [CBIT](DEBUG): Initializing heartbeat. 2024-05-08T17:23:08.204Z,1715188988.204 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 936 2024-05-08T17:23:08.205Z,1715188988.205 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-08T17:23:08.218Z,1715188988.218 [Onboard ThreadHandler](INFO): Handler Thread ID is 937 2024-05-08T17:23:08.235Z,1715188988.235 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 938 2024-05-08T17:23:08.258Z,1715188988.258 [DAT ThreadHandler](INFO): Handler Thread ID is 939 2024-05-08T17:23:08.259Z,1715188988.259 [DAT](INFO): Powering up 2024-05-08T17:23:08.259Z,1715188988.259 [DAT](DEBUG): Initializing DAT. 2024-05-08T17:23:08.262Z,1715188988.262 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-08T17:23:08.262Z,1715188988.262 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-08T17:23:08.263Z,1715188988.263 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 941 2024-05-08T17:23:08.270Z,1715188988.270 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-05-08T17:23:08.270Z,1715188988.270 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-05-08T17:23:08.271Z,1715188988.271 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-05-08T17:23:08.271Z,1715188988.271 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-05-08T17:23:08.271Z,1715188988.271 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-05-08T17:23:08.271Z,1715188988.271 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-05-08T17:23:08.271Z,1715188988.271 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-05-08T17:23:08.271Z,1715188988.271 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-05-08T17:23:08.301Z,1715188988.301 [CBIT](DEBUG): Backplane powered. 2024-05-08T17:23:08.306Z,1715188988.306 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-08T17:23:08.306Z,1715188988.306 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-08T17:23:08.307Z,1715188988.307 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-08T17:23:08.307Z,1715188988.307 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-08T17:23:08.307Z,1715188988.307 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-08T17:23:08.308Z,1715188988.308 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-08T17:23:08.309Z,1715188988.309 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-08T17:23:08.320Z,1715188988.320 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-08T17:23:08.321Z,1715188988.321 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-08T17:23:08.330Z,1715188988.330 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-08T17:23:08.331Z,1715188988.331 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-08T17:23:08.331Z,1715188988.331 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-08T17:23:08.332Z,1715188988.332 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-05-08T17:23:08.332Z,1715188988.332 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-05-08T17:23:08.338Z,1715188988.338 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-05-08T17:23:08.407Z,1715188988.407 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-05-08T17:23:08.434Z,1715188988.434 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-08T17:23:08.478Z,1715188988.478 [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 } } } 2024-05-08T17:23:08.483Z,1715188988.483 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-05-08T17:23:08.483Z,1715188988.483 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-05-08T17:23:08.491Z,1715188988.491 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-05-08T17:23:08.642Z,1715188988.642 [Radio_Surface](INFO): Powering up 2024-05-08T17:23:08.767Z,1715188988.767 [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 2024-05-08T17:23:08.793Z,1715188988.793 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-08T17:23:08.799Z,1715188988.799 [Default:A.Wait](DEBUG): Construct Wait. 2024-05-08T17:23:08.801Z,1715188988.801 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-08T17:23:08.845Z,1715188988.845 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-08T17:23:08.855Z,1715188988.855 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-08T17:23:08.861Z,1715188988.861 [Default:E.Execute](DEBUG): Construct Execute. 2024-05-08T17:23:08.880Z,1715188988.880 [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" } } 2024-05-08T17:23:08.885Z,1715188988.885 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-08T17:23:08.911Z,1715188988.911 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-08T17:23:09.050Z,1715188989.050 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m 2024-05-08T17:23:09.055Z,1715188989.055 [Power24vConverter](INFO): Powering up. 2024-05-08T17:23:09.066Z,1715188989.066 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-05-08T17:23:09.146Z,1715188989.146 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-08T17:23:09.154Z,1715188989.154 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-08T17:23:09.155Z,1715188989.155 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-08T17:23:09.162Z,1715188989.162 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-08T17:23:09.163Z,1715188989.163 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-08T17:23:09.170Z,1715188989.170 [MassServo](DEBUG): Initializing MassServo. 2024-05-08T17:23:09.171Z,1715188989.171 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-08T17:23:09.178Z,1715188989.178 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-08T17:23:09.179Z,1715188989.179 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-05-08T17:23:09.190Z,1715188989.190 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-05-08T17:23:09.341Z,1715188989.341 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-05-08T17:23:09.341Z,1715188989.341 [DropWeight] Hardware Fault, FailCount= 1 2024-05-08T17:23:09.341Z,1715188989.341 [DropWeight](ERROR): Hardware Fault 2024-05-08T17:23:09.364Z,1715188989.364 [CommandExec](FAULT): Scheduling is paused 2024-05-08T17:23:09.364Z,1715188989.364 [CBIT](INFO): Critical error at 20240508T172309 2024-05-08T17:23:09.365Z,1715188989.365 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-05-08T17:23:09.375Z,1715188989.375 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-05-08T17:23:09.376Z,1715188989.376 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-05-08T17:23:09.718Z,1715188989.718 [CBIT](INFO): Critical error at 20240508T172309 2024-05-08T17:23:12.454Z,1715188992.454 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:12.890Z,1715188992.890 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:13.378Z,1715188993.378 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:13.501Z,1715188993.501 [WetLabsBB2FL] Communications Fault, FailCount= 1 2024-05-08T17:23:13.502Z,1715188993.502 [WetLabsBB2FL](ERROR): Communications Fault 2024-05-08T17:23:13.826Z,1715188993.826 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:13.995Z,1715188993.995 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-05-08T17:23:14.018Z,1715188994.018 [WetLabsBB2FL](INFO): Powering down 2024-05-08T17:23:14.334Z,1715188994.334 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:14.818Z,1715188994.818 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:14.940Z,1715188994.940 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-05-08T17:23:15.005Z,1715188995.005 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-05-08T17:23:15.006Z,1715188995.006 [WetLabsBB2FL] No Fault, FailCount= 1 2024-05-08T17:23:15.232Z,1715188995.232 [WetLabsBB2FL](INFO): Powering up 2024-05-08T17:23:15.346Z,1715188995.346 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:16.006Z,1715188996.006 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:16.442Z,1715188996.442 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:16.858Z,1715188996.858 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:17.354Z,1715188997.354 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:17.774Z,1715188997.774 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:18.214Z,1715188998.214 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:18.355Z,1715188998.355 [CBIT](CRITICAL): Environmental Failure. Press:14.705774 PSI. Humidity:37%. Temp:26 C. ABORTING MISSION 2024-05-08T17:23:18.694Z,1715188998.694 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:18.772Z,1715188998.772 [CBIT](INFO): Critical error at 20240508T172318 2024-05-08T17:23:19.122Z,1715188999.122 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:19.542Z,1715188999.542 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:19.962Z,1715188999.962 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:20.354Z,1715189000.354 [DAT](INFO): DAT read: 2024-05-08T17:23:20.355Z,1715189000.355 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-05-08T17:23:20.382Z,1715189000.382 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:20.530Z,1715189000.530 [WetLabsBB2FL] Communications Fault, FailCount= 2 2024-05-08T17:23:20.530Z,1715189000.530 [WetLabsBB2FL](ERROR): Communications Fault 2024-05-08T17:23:20.578Z,1715189000.578 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-05-08T17:23:20.926Z,1715189000.926 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:21.030Z,1715189001.030 [WetLabsBB2FL](INFO): Powering down 2024-05-08T17:23:21.230Z,1715189001.230 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-05-08T17:23:21.230Z,1715189001.230 [CTD_Seabird] Communications Fault, FailCount= 1 2024-05-08T17:23:21.230Z,1715189001.230 [CTD_Seabird](ERROR): Communications Fault 2024-05-08T17:23:21.354Z,1715189001.354 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:21.422Z,1715189001.422 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-05-08T17:23:21.635Z,1715189001.635 [CTD_Seabird](INFO): Powering down 2024-05-08T17:23:21.754Z,1715189001.754 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:21.754Z,1715189001.754 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-05-08T17:23:21.754Z,1715189001.754 [AHRS_M2] Communications Fault, FailCount= 1 2024-05-08T17:23:21.754Z,1715189001.754 [AHRS_M2](ERROR): Communications Fault 2024-05-08T17:23:21.818Z,1715189001.818 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-05-08T17:23:21.854Z,1715189001.854 [AHRS_M2](INFO): Powering down 2024-05-08T17:23:21.866Z,1715189001.866 [DAT](INFO): DAT read: MF Frequency Band 2024-05-08T17:23:21.868Z,1715189001.868 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-05-08T17:23:21.868Z,1715189001.868 [DAT](INFO): DAT read: May 8 2024 17:23:15 2024-05-08T17:23:21.998Z,1715189001.998 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-05-08T17:23:21.998Z,1715189001.998 [WetLabsBB2FL] No Fault, FailCount= 2 2024-05-08T17:23:22.243Z,1715189002.243 [WetLabsBB2FL](INFO): Powering up 2024-05-08T17:23:22.698Z,1715189002.698 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-05-08T17:23:22.698Z,1715189002.698 [CTD_Seabird] No Fault, FailCount= 1 2024-05-08T17:23:22.698Z,1715189002.698 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-05-08T17:23:22.698Z,1715189002.698 [AHRS_M2] No Fault, FailCount= 1 2024-05-08T17:23:22.978Z,1715189002.978 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-08T17:23:23.054Z,1715189003.054 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-08T17:23:23.128Z,1715189003.128 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-05-08T17:23:23.129Z,1715189003.129 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2024-05-08T17:23:23.129Z,1715189003.129 [DAT](INFO): commRate: 1200 2024-05-08T17:23:25.194Z,1715189005.194 [DAT](INFO): entering command mode 2024-05-08T17:23:25.394Z,1715189005.394 [DAT](INFO): DAT read: 2024-05-08T17:23:25.395Z,1715189005.395 [DAT](INFO): DAT read: user:1> 2024-05-08T17:23:25.395Z,1715189005.395 [DAT](INFO): setting verbose to 3 2024-05-08T17:23:25.646Z,1715189005.646 [DAT](INFO): DAT read: user:1> 2024-05-08T17:23:25.647Z,1715189005.647 [DAT](INFO): DAT read: Verbose | 3 2024-05-08T17:23:25.648Z,1715189005.648 [DAT](INFO): set verbose to 3 2024-05-08T17:23:25.648Z,1715189005.648 [DAT](INFO): setting DatVerbose to 27440 2024-05-08T17:23:25.898Z,1715189005.898 [DAT](INFO): DAT read: user:2> 2024-05-08T17:23:25.899Z,1715189005.899 [DAT](INFO): DAT read: DatVerbose | 27440 2024-05-08T17:23:25.900Z,1715189005.900 [DAT](INFO): set DatVerbose to 27440 2024-05-08T17:23:25.900Z,1715189005.900 [DAT](INFO): setting transmit power to 8 2024-05-08T17:23:26.150Z,1715189006.150 [DAT](INFO): DAT read: user:3> 2024-05-08T17:23:26.151Z,1715189006.151 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-05-08T17:23:26.151Z,1715189006.151 [DAT](INFO): set transmit power to 8 2024-05-08T17:23:26.152Z,1715189006.152 [DAT](INFO): setting local address to 5 2024-05-08T17:23:26.402Z,1715189006.402 [DAT](INFO): DAT read: user:4> 2024-05-08T17:23:26.403Z,1715189006.403 [DAT](INFO): DAT read: LocalAddr | 5 2024-05-08T17:23:26.404Z,1715189006.404 [DAT](INFO): set local address to 5 2024-05-08T17:23:26.405Z,1715189006.405 [DAT](INFO): Setting time to: 17:23:26 And date to:5/8/2024 2024-05-08T17:23:26.598Z,1715189006.598 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:26.603Z,1715189006.603 [DVL_micro](FAULT): Failed to initialize within timeout. 2024-05-08T17:23:26.603Z,1715189006.603 [DVL_micro] Communications Fault, FailCount= 1 2024-05-08T17:23:26.603Z,1715189006.603 [DVL_micro](ERROR): Communications Fault 2024-05-08T17:23:26.654Z,1715189006.654 [DAT](INFO): DAT read: user:5> 2024-05-08T17:23:26.656Z,1715189006.656 [DAT](INFO): DAT read: Wed May 8, 2024 17:23:26 2024-05-08T17:23:26.656Z,1715189006.656 [DAT](INFO): Local DAT time set to Wed May 8, 2024 17:23:26 2024-05-08T17:23:26.678Z,1715189006.678 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-05-08T17:23:27.022Z,1715189007.022 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:27.122Z,1715189007.122 [DVL_micro](INFO): Powering down 2024-05-08T17:23:27.538Z,1715189007.538 [WetLabsBB2FL] Communications Fault, FailCount= 3 2024-05-08T17:23:27.538Z,1715189007.538 [WetLabsBB2FL](ERROR): Communications Fault 2024-05-08T17:23:27.606Z,1715189007.606 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:27.694Z,1715189007.694 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-05-08T17:23:28.038Z,1715189008.038 [WetLabsBB2FL](INFO): Powering down 2024-05-08T17:23:28.050Z,1715189008.050 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:28.116Z,1715189008.116 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-05-08T17:23:28.116Z,1715189008.116 [DVL_micro] No Fault, FailCount= 1 2024-05-08T17:23:28.470Z,1715189008.470 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:28.898Z,1715189008.898 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:28.967Z,1715189008.967 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-05-08T17:23:28.967Z,1715189008.967 [WetLabsBB2FL] No Fault, FailCount= 3 2024-05-08T17:23:29.251Z,1715189009.251 [WetLabsBB2FL](INFO): Powering up 2024-05-08T17:23:29.314Z,1715189009.314 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:29.726Z,1715189009.726 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:30.142Z,1715189010.142 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:30.550Z,1715189010.550 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:30.734Z,1715189010.734 [CommandExec](IMPORTANT): got command quit 2024-05-08T17:23:30.978Z,1715189010.978 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:31.394Z,1715189011.394 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:31.738Z,1715189011.738 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:31.738Z,1715189011.738 [CommandExec](INFO): Uninitializing the command executive. 2024-05-08T17:23:31.738Z,1715189011.738 [CommandExec](INFO): Uninitializing the command scheduler. 2024-05-08T17:23:31.738Z,1715189011.738 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:31.770Z,1715189011.770 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-05-08T17:23:31.770Z,1715189011.770 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-05-08T17:23:31.770Z,1715189011.770 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:31.771Z,1715189011.771 [NavChartDb](INFO): Join timeout helper Thread ID is 956 2024-05-08T17:23:31.818Z,1715189011.818 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:32.230Z,1715189012.230 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:32.642Z,1715189012.642 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:32.999Z,1715189012.999 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:32.000Z,1715189013.000 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:33.002Z,1715189013.002 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-05-08T17:23:33.002Z,1715189013.002 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:33.002Z,1715189013.002 [DAT](INFO): Join timeout helper Thread ID is 958 2024-05-08T17:23:33.073Z,1715189013.073 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:33.226Z,1715189013.226 [DAT](INFO): Powering down 2024-05-08T17:23:33.298Z,1715189013.298 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:33.298Z,1715189013.298 [DAT](INFO): Powering down 2024-05-08T17:23:33.299Z,1715189013.299 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:33.310Z,1715189013.310 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-05-08T17:23:33.310Z,1715189013.310 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:33.310Z,1715189013.310 [Radio_Surface](INFO): Join timeout helper Thread ID is 959 2024-05-08T17:23:33.490Z,1715189013.490 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:33.702Z,1715189013.702 [Radio_Surface](INFO): Powering down 2024-05-08T17:23:33.703Z,1715189013.703 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:33.703Z,1715189013.703 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:33.703Z,1715189013.703 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-05-08T17:23:33.703Z,1715189013.703 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:33.704Z,1715189013.704 [Onboard](INFO): Join timeout helper Thread ID is 960 2024-05-08T17:23:33.894Z,1715189013.894 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:34.306Z,1715189014.306 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:34.545Z,1715189014.545 [WetLabsBB2FL] Communications Fault, FailCount= 4 2024-05-08T17:23:34.546Z,1715189014.546 [WetLabsBB2FL](ERROR): Communications Fault 2024-05-08T17:23:34.713Z,1715189014.713 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:34.758Z,1715189014.758 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2024-05-08T17:23:35.046Z,1715189015.046 [WetLabsBB2FL](INFO): Powering down 2024-05-08T17:23:35.122Z,1715189015.122 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:35.553Z,1715189015.553 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:35.965Z,1715189015.965 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2024-05-08T17:23:35.966Z,1715189015.966 [AHRS_M2](FAULT): Failed to initialize within timeout. 2024-05-08T17:23:35.966Z,1715189015.966 [AHRS_M2] Communications Fault, FailCount= 2 2024-05-08T17:23:35.966Z,1715189015.966 [AHRS_M2](ERROR): Communications Fault 2024-05-08T17:23:36.019Z,1715189016.019 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2024-05-08T17:23:36.019Z,1715189016.019 [WetLabsBB2FL] No Fault, FailCount= 4 2024-05-08T17:23:36.019Z,1715189016.019 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2024-05-08T17:23:36.030Z,1715189016.030 [CTD_Seabird](FAULT): Failed to initialize within timeout. 2024-05-08T17:23:36.030Z,1715189016.030 [CTD_Seabird] Communications Fault, FailCount= 2 2024-05-08T17:23:36.030Z,1715189016.030 [CTD_Seabird](ERROR): Communications Fault 2024-05-08T17:23:36.055Z,1715189016.055 [AHRS_M2](INFO): Powering down 2024-05-08T17:23:36.194Z,1715189016.194 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 2024-05-08T17:23:36.259Z,1715189016.259 [WetLabsBB2FL](INFO): Powering up 2024-05-08T17:23:36.434Z,1715189016.434 [CTD_Seabird](INFO): Powering down 2024-05-08T17:23:36.884Z,1715189016.884 [CBIT](INFO): Clearing failed state for component AHRS_M2 2024-05-08T17:23:36.884Z,1715189016.884 [AHRS_M2] No Fault, FailCount= 2 2024-05-08T17:23:37.243Z,1715189017.243 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-08T17:23:37.649Z,1715189017.649 [NAL9602](INFO): Powering up NAL9602 2024-05-08T17:23:37.702Z,1715189017.702 [CBIT](INFO): Clearing failed state for component CTD_Seabird 2024-05-08T17:23:37.702Z,1715189017.702 [CTD_Seabird] No Fault, FailCount= 2 2024-05-08T17:23:37.778Z,1715189017.778 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-08T17:23:38.242Z,1715189018.242 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.242Z,1715189018.242 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.246Z,1715189018.246 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-05-08T17:23:38.246Z,1715189018.246 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.246Z,1715189018.246 [DataOverHttps](INFO): Join timeout helper Thread ID is 964 2024-05-08T17:23:38.322Z,1715189018.322 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.322Z,1715189018.322 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.342Z,1715189018.342 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-05-08T17:23:38.343Z,1715189018.343 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.343Z,1715189018.343 [BackseatComponent](INFO): Join timeout helper Thread ID is 965 2024-05-08T17:23:38.454Z,1715189018.454 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.454Z,1715189018.454 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.463Z,1715189018.463 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-05-08T17:23:38.463Z,1715189018.463 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.463Z,1715189018.463 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 966 2024-05-08T17:23:38.534Z,1715189018.534 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.630Z,1715189018.630 [WetLabsBB2FL](INFO): Powering down 2024-05-08T17:23:38.631Z,1715189018.631 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.638Z,1715189018.638 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-05-08T17:23:38.638Z,1715189018.638 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.639Z,1715189018.639 [CTD_Seabird](INFO): Join timeout helper Thread ID is 967 2024-05-08T17:23:38.782Z,1715189018.782 [CTD_Seabird](INFO): Powering down 2024-05-08T17:23:38.920Z,1715189018.920 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.920Z,1715189018.920 [CTD_Seabird](INFO): Powering down 2024-05-08T17:23:38.934Z,1715189018.934 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.938Z,1715189018.938 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-05-08T17:23:38.938Z,1715189018.938 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.939Z,1715189018.939 [logger](INFO): Join timeout helper Thread ID is 968 2024-05-08T17:23:38.962Z,1715189018.962 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.962Z,1715189018.962 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.978Z,1715189018.978 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-05-08T17:23:38.978Z,1715189018.978 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.979Z,1715189018.979 [CommandLine](INFO): Join timeout helper Thread ID is 969 2024-05-08T17:23:38.994Z,1715189018.994 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:38.994Z,1715189018.994 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.998Z,1715189018.998 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-05-08T17:23:38.998Z,1715189018.998 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:38.999Z,1715189018.999 [CommandExec](INFO): Join timeout helper Thread ID is 970 2024-05-08T17:23:38.000Z,1715189019.000 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-05-08T17:23:38.000Z,1715189019.000 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.000Z,1715189019.000 [controlThread](INFO): Join timeout helper Thread ID is 971 2024-05-08T17:23:39.250Z,1715189019.250 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-08T17:23:39.250Z,1715189019.250 [controlThread](DEBUG): Uninitializing ControlThread 2024-05-08T17:23:39.252Z,1715189019.252 [AHRS_M2](INFO): Powering down 2024-05-08T17:23:39.418Z,1715189019.418 [DVL_micro](INFO): Powering down 2024-05-08T17:23:39.419Z,1715189019.419 [NAL9602](INFO): Powering down 2024-05-08T17:23:39.420Z,1715189019.420 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-05-08T17:23:39.421Z,1715189019.421 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-05-08T17:23:39.422Z,1715189019.422 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-05-08T17:23:39.422Z,1715189019.422 [MissionManager](INFO): Uninitializing Mission Default 2024-05-08T17:23:39.425Z,1715189019.425 [MissionManager](INFO): Uninitializing Mission Startup 2024-05-08T17:23:39.426Z,1715189019.426 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-05-08T17:23:39.427Z,1715189019.427 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-05-08T17:23:39.427Z,1715189019.427 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-05-08T17:23:39.427Z,1715189019.427 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-05-08T17:23:39.427Z,1715189019.427 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-05-08T17:23:39.428Z,1715189019.428 [BuoyancyServo](INFO): Powering down 2024-05-08T17:23:39.442Z,1715189019.442 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-08T17:23:39.442Z,1715189019.442 [ElevatorServo](INFO): Powering down 2024-05-08T17:23:39.443Z,1715189019.443 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-05-08T17:23:39.443Z,1715189019.443 [MassServo](INFO): Powering down 2024-05-08T17:23:39.444Z,1715189019.444 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-05-08T17:23:39.444Z,1715189019.444 [RudderServo](INFO): Powering down 2024-05-08T17:23:39.445Z,1715189019.445 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-05-08T17:23:39.445Z,1715189019.445 [ThrusterHE](INFO): Powering down 2024-05-08T17:23:39.446Z,1715189019.446 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-05-08T17:23:39.446Z,1715189019.446 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-05-08T17:23:39.446Z,1715189019.446 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-05-08T17:23:39.446Z,1715189019.446 [CBIT](DEBUG): Powering off loads. 2024-05-08T17:23:39.457Z,1715189019.457 [CBIT](DEBUG): Disabling WDT. 2024-05-08T17:23:39.469Z,1715189019.469 [CBIT](DEBUG): Opening all GF detection circuits. 2024-05-08T17:23:39.470Z,1715189019.470 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.746Z,1715189019.746 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.753Z,1715189019.753 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.782Z,1715189019.782 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.786Z,1715189019.786 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.788Z,1715189019.788 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.795Z,1715189019.795 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.839Z,1715189019.839 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.889Z,1715189019.889 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-08T17:23:39.956Z,1715189019.956 [logger ThreadHandler](INFO): Thread cancelled.