2024-10-29T23:40:01.331Z,1730245201.331 [Supervisor](DEBUG): Initializing supervisor. 2024-10-29T23:40:01.336Z,1730245201.336 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-10-29T23:40:01.336Z,1730245201.336 [SyncHandler](INFO): Protected caller Thread ID is 840 2024-10-29T23:40:01.337Z,1730245201.337 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-10-29T23:40:01.338Z,1730245201.338 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-10-29T23:40:01.338Z,1730245201.338 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 841 2024-10-29T23:40:01.349Z,1730245201.349 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-10-29T23:40:01.371Z,1730245201.371 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-10-29T23:40:01.372Z,1730245201.372 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-10-29T23:40:01.373Z,1730245201.373 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 842 2024-10-29T23:40:01.383Z,1730245201.383 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-10-29T23:40:01.386Z,1730245201.386 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-10-29T23:40:01.387Z,1730245201.387 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 843 2024-10-29T23:40:01.392Z,1730245201.392 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-10-29T23:40:01.395Z,1730245201.395 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-10-29T23:40:01.396Z,1730245201.396 [logger ThreadHandler](INFO): Protected caller Thread ID is 844 2024-10-29T23:40:01.405Z,1730245201.405 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-10-29T23:40:01.406Z,1730245201.406 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-10-29T23:40:01.412Z,1730245201.412 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-10-29T23:40:01.585Z,1730245201.585 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-10-29T23:40:01.586Z,1730245201.586 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-10-29T23:40:02.620Z,1730245202.620 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-10-29T23:40:02.622Z,1730245202.622 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-10-29T23:40:02.919Z,1730245202.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-10-29T23:40:02.921Z,1730245202.921 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-10-29T23:40:03.028Z,1730245203.028 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-10-29T23:40:03.197Z,1730245203.197 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-10-29T23:40:03.199Z,1730245203.199 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-10-29T23:40:03.305Z,1730245203.305 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-10-29T23:40:03.438Z,1730245203.438 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-10-29T23:40:03.440Z,1730245203.440 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-10-29T23:40:03.946Z,1730245203.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-10-29T23:40:03.947Z,1730245203.947 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-10-29T23:40:04.741Z,1730245204.741 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-10-29T23:40:04.743Z,1730245204.743 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-10-29T23:40:05.097Z,1730245205.097 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-10-29T23:40:05.099Z,1730245205.099 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-10-29T23:40:05.350Z,1730245205.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-10-29T23:40:05.350Z,1730245205.350 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-10-29T23:40:06.015Z,1730245206.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-10-29T23:40:06.015Z,1730245206.015 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-10-29T23:40:06.365Z,1730245206.365 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-10-29T23:40:06.367Z,1730245206.367 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-10-29T23:40:06.666Z,1730245206.666 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-10-29T23:40:06.667Z,1730245206.667 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-10-29T23:40:07.133Z,1730245207.133 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-10-29T23:40:07.135Z,1730245207.135 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-10-29T23:40:07.586Z,1730245207.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-10-29T23:40:07.588Z,1730245207.588 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-10-29T23:40:07.590Z,1730245207.590 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-10-29T23:40:07.718Z,1730245207.718 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-10-29T23:40:07.958Z,1730245207.958 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-10-29T23:40:08.091Z,1730245208.091 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-10-29T23:40:08.220Z,1730245208.220 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-10-29T23:40:08.362Z,1730245208.362 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-10-29T23:40:08.480Z,1730245208.480 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-10-29T23:40:08.614Z,1730245208.614 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-10-29T23:40:08.766Z,1730245208.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-10-29T23:40:09.098Z,1730245209.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-10-29T23:40:09.099Z,1730245209.099 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-10-29T23:40:09.722Z,1730245209.722 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-10-29T23:40:09.853Z,1730245209.853 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-10-29T23:40:10.042Z,1730245210.042 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-10-29T23:40:10.179Z,1730245210.179 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-10-29T23:40:10.200Z,1730245210.200 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-10-29T23:40:10.391Z,1730245210.391 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-10-29T23:40:10.393Z,1730245210.393 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-10-29T23:40:10.474Z,1730245210.474 [VerticalControl](DEBUG): Construct VerticalControl. 2024-10-29T23:40:10.556Z,1730245210.556 [VerticalControl] Loaded 2024-10-29T23:40:10.557Z,1730245210.557 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-10-29T23:40:10.559Z,1730245210.559 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-10-29T23:40:10.616Z,1730245210.616 [HorizontalControl] Loaded 2024-10-29T23:40:10.617Z,1730245210.617 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-10-29T23:40:10.619Z,1730245210.619 [SpeedControl](DEBUG): Construct SpeedControl. 2024-10-29T23:40:10.622Z,1730245210.622 [SpeedControl] Loaded 2024-10-29T23:40:10.622Z,1730245210.622 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-10-29T23:40:10.625Z,1730245210.625 [LoopControl](DEBUG): Construct LoopControl. 2024-10-29T23:40:10.625Z,1730245210.625 [LoopControl] Loaded 2024-10-29T23:40:10.626Z,1730245210.626 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-10-29T23:40:10.626Z,1730245210.626 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-10-29T23:40:10.627Z,1730245210.627 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-10-29T23:40:10.703Z,1730245210.703 [DepthRateCalculator] Loaded 2024-10-29T23:40:10.704Z,1730245210.704 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-10-29T23:40:10.709Z,1730245210.709 [PitchRateCalculator] Loaded 2024-10-29T23:40:10.709Z,1730245210.709 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-10-29T23:40:10.722Z,1730245210.722 [SpeedCalculator] Loaded 2024-10-29T23:40:10.722Z,1730245210.722 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-10-29T23:40:10.726Z,1730245210.726 [YawRateCalculator] Loaded 2024-10-29T23:40:10.726Z,1730245210.726 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-10-29T23:40:10.745Z,1730245210.745 [ElevatorOffsetCalculator] Loaded 2024-10-29T23:40:10.745Z,1730245210.745 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-10-29T23:40:10.746Z,1730245210.746 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-10-29T23:40:10.748Z,1730245210.748 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-10-29T23:40:10.800Z,1730245210.800 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-10-29T23:40:10.801Z,1730245210.801 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-10-29T23:40:10.889Z,1730245210.889 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-10-29T23:40:10.890Z,1730245210.890 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-10-29T23:40:11.376Z,1730245211.376 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-10-29T23:40:11.377Z,1730245211.377 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-10-29T23:40:11.630Z,1730245211.630 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-10-29T23:40:11.630Z,1730245211.630 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-10-29T23:40:12.813Z,1730245212.813 [AHRS_M2] Loaded 2024-10-29T23:40:12.814Z,1730245212.814 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-10-29T23:40:13.111Z,1730245213.111 [BackseatComponent] Loaded 2024-10-29T23:40:13.111Z,1730245213.111 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-10-29T23:40:13.112Z,1730245213.112 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409CA4E0 2024-10-29T23:40:13.113Z,1730245213.113 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 932 2024-10-29T23:40:13.115Z,1730245213.115 [LcmUniversalReporter] Loaded 2024-10-29T23:40:13.116Z,1730245213.116 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-10-29T23:40:13.139Z,1730245213.139 [BPC1](INFO): BPC1A: got serial number for stick 1: 02AF 2024-10-29T23:40:13.140Z,1730245213.140 [BPC1](INFO): BPC1A: got serial number for stick 2: 02A5 2024-10-29T23:40:13.141Z,1730245213.141 [BPC1](INFO): BPC1A: got serial number for stick 3: 01F5 2024-10-29T23:40:13.142Z,1730245213.142 [BPC1](INFO): BPC1A: got serial number for stick 4: 02CF 2024-10-29T23:40:13.143Z,1730245213.143 [BPC1](INFO): BPC1A: got serial number for stick 5: 01D5 2024-10-29T23:40:13.144Z,1730245213.144 [BPC1](INFO): BPC1A: got serial number for stick 6: 02BA 2024-10-29T23:40:13.144Z,1730245213.144 [BPC1](INFO): BPC1A: got serial number for stick 7: 02BB 2024-10-29T23:40:13.145Z,1730245213.145 [BPC1](INFO): BPC1A: got serial number for stick 8: 022C 2024-10-29T23:40:13.145Z,1730245213.145 [BPC1](INFO): BPC1A: marked stick 8 as reserve. 2024-10-29T23:40:13.146Z,1730245213.146 [BPC1](INFO): BPC1A: got serial number for stick 9: 01D1 2024-10-29T23:40:13.147Z,1730245213.147 [BPC1](INFO): BPC1A: got serial number for stick 10: 02AA 2024-10-29T23:40:13.148Z,1730245213.148 [BPC1](INFO): BPC1A: got serial number for stick 11: 02C0 2024-10-29T23:40:13.149Z,1730245213.149 [BPC1](INFO): BPC1A: got serial number for stick 12: 0218 2024-10-29T23:40:13.149Z,1730245213.149 [BPC1](INFO): BPC1A: got serial number for stick 13: 01C7 2024-10-29T23:40:13.150Z,1730245213.150 [BPC1](INFO): BPC1A: got serial number for stick 14: 0204 2024-10-29T23:40:13.151Z,1730245213.151 [BPC1](INFO): BPC1A: got serial number for stick 15: 02CE 2024-10-29T23:40:13.152Z,1730245213.152 [BPC1](INFO): BPC1A: got serial number for stick 16: 0200 2024-10-29T23:40:13.152Z,1730245213.152 [BPC1](INFO): BPC1A: marked stick 16 as reserve. 2024-10-29T23:40:13.153Z,1730245213.153 [BPC1](INFO): BPC1A: got serial number for stick 17: 01D3 2024-10-29T23:40:13.154Z,1730245213.154 [BPC1](INFO): BPC1A: got serial number for stick 18: 0275 2024-10-29T23:40:13.155Z,1730245213.155 [BPC1](INFO): BPC1A: got serial number for stick 19: 02C4 2024-10-29T23:40:13.155Z,1730245213.155 [BPC1](INFO): BPC1A: got serial number for stick 20: 02C7 2024-10-29T23:40:13.156Z,1730245213.156 [BPC1](INFO): BPC1A: got serial number for stick 21: 022E 2024-10-29T23:40:13.157Z,1730245213.157 [BPC1](INFO): BPC1A: got serial number for stick 22: 02C1 2024-10-29T23:40:13.158Z,1730245213.158 [BPC1](INFO): BPC1A: got serial number for stick 23: 0227 2024-10-29T23:40:13.158Z,1730245213.158 [BPC1](INFO): BPC1A: got serial number for stick 24: 0281 2024-10-29T23:40:13.159Z,1730245213.159 [BPC1](INFO): BPC1A: marked stick 24 as reserve. 2024-10-29T23:40:13.159Z,1730245213.159 [BPC1](INFO): BPC1A: got serial number for stick 25: 028D 2024-10-29T23:40:13.160Z,1730245213.160 [BPC1](INFO): BPC1A: got serial number for stick 26: 02C2 2024-10-29T23:40:13.161Z,1730245213.161 [BPC1](INFO): BPC1A: got serial number for stick 27: 01DD 2024-10-29T23:40:13.162Z,1730245213.162 [BPC1](INFO): BPC1A: got serial number for stick 28: 02CC 2024-10-29T23:40:13.162Z,1730245213.162 [BPC1](INFO): BPC1A: got serial number for stick 29: 01CD 2024-10-29T23:40:13.163Z,1730245213.163 [BPC1](INFO): BPC1A: got serial number for stick 30: 029E 2024-10-29T23:40:13.164Z,1730245213.164 [BPC1](INFO): BPC1A: got serial number for stick 31: 022B 2024-10-29T23:40:13.166Z,1730245213.166 [BPC1](INFO): BPC1B: got serial number for stick 32: 021A 2024-10-29T23:40:13.166Z,1730245213.166 [BPC1](INFO): BPC1B: got serial number for stick 33: 01A2 2024-10-29T23:40:13.167Z,1730245213.167 [BPC1](INFO): BPC1B: got serial number for stick 34: 0285 2024-10-29T23:40:13.168Z,1730245213.168 [BPC1](INFO): BPC1B: got serial number for stick 35: 0239 2024-10-29T23:40:13.169Z,1730245213.169 [BPC1](INFO): BPC1B: got serial number for stick 36: 01FC 2024-10-29T23:40:13.170Z,1730245213.170 [BPC1](INFO): BPC1B: got serial number for stick 37: 023B 2024-10-29T23:40:13.170Z,1730245213.170 [BPC1](INFO): BPC1B: got serial number for stick 38: 01D2 2024-10-29T23:40:13.171Z,1730245213.171 [BPC1](INFO): BPC1B: got serial number for stick 39: 0207 2024-10-29T23:40:13.171Z,1730245213.171 [BPC1](INFO): BPC1B: marked stick 39 as reserve. 2024-10-29T23:40:13.186Z,1730245213.186 [BPC1](INFO): BPC1B: got serial number for stick 40: 0263 2024-10-29T23:40:13.187Z,1730245213.187 [BPC1](INFO): BPC1B: got serial number for stick 41: 01ED 2024-10-29T23:40:13.188Z,1730245213.188 [BPC1](INFO): BPC1B: got serial number for stick 42: 01E4 2024-10-29T23:40:13.189Z,1730245213.189 [BPC1](INFO): BPC1B: got serial number for stick 43: 027A 2024-10-29T23:40:13.190Z,1730245213.190 [BPC1](INFO): BPC1B: got serial number for stick 44: 025E 2024-10-29T23:40:13.191Z,1730245213.191 [BPC1](INFO): BPC1B: got serial number for stick 45: 02BF 2024-10-29T23:40:13.191Z,1730245213.191 [BPC1](INFO): BPC1B: got serial number for stick 46: 01C3 2024-10-29T23:40:13.192Z,1730245213.192 [BPC1](INFO): BPC1B: got serial number for stick 47: 0248 2024-10-29T23:40:13.192Z,1730245213.192 [BPC1](INFO): BPC1B: marked stick 47 as reserve. 2024-10-29T23:40:13.193Z,1730245213.193 [BPC1](INFO): BPC1B: got serial number for stick 48: 0249 2024-10-29T23:40:13.194Z,1730245213.194 [BPC1](INFO): BPC1B: got serial number for stick 49: 01E2 2024-10-29T23:40:13.195Z,1730245213.195 [BPC1](INFO): BPC1B: got serial number for stick 50: 0254 2024-10-29T23:40:13.196Z,1730245213.196 [BPC1](INFO): BPC1B: got serial number for stick 51: 01AE 2024-10-29T23:40:13.197Z,1730245213.197 [BPC1](INFO): BPC1B: got serial number for stick 52: 0209 2024-10-29T23:40:13.197Z,1730245213.197 [BPC1](INFO): BPC1B: got serial number for stick 53: 0258 2024-10-29T23:40:13.198Z,1730245213.198 [BPC1](INFO): BPC1B: got serial number for stick 54: 01C4 2024-10-29T23:40:13.199Z,1730245213.199 [BPC1](INFO): BPC1B: got serial number for stick 55: 0250 2024-10-29T23:40:13.199Z,1730245213.199 [BPC1](INFO): BPC1B: marked stick 55 as reserve. 2024-10-29T23:40:13.200Z,1730245213.200 [BPC1](INFO): BPC1B: got serial number for stick 56: 01C8 2024-10-29T23:40:13.201Z,1730245213.201 [BPC1](INFO): BPC1B: got serial number for stick 57: 0270 2024-10-29T23:40:13.201Z,1730245213.201 [BPC1](INFO): BPC1B: got serial number for stick 58: 01EC 2024-10-29T23:40:13.202Z,1730245213.202 [BPC1](INFO): BPC1B: got serial number for stick 59: 022D 2024-10-29T23:40:13.203Z,1730245213.203 [BPC1](INFO): BPC1B: got serial number for stick 60: 01FD 2024-10-29T23:40:13.204Z,1730245213.204 [BPC1](INFO): BPC1B: got serial number for stick 61: 02A9 2024-10-29T23:40:13.204Z,1730245213.204 [BPC1](INFO): BPC1B: got serial number for stick 62: 01E8 2024-10-29T23:40:13.975Z,1730245213.975 [BPC1] Loaded 2024-10-29T23:40:13.975Z,1730245213.975 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-10-29T23:40:14.116Z,1730245214.116 [DataOverHttps] Loaded 2024-10-29T23:40:14.117Z,1730245214.117 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-10-29T23:40:14.118Z,1730245214.118 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409FA4E0 2024-10-29T23:40:14.118Z,1730245214.118 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 933 2024-10-29T23:40:14.141Z,1730245214.141 [Depth_Keller] Loaded 2024-10-29T23:40:14.141Z,1730245214.141 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-10-29T23:40:14.206Z,1730245214.206 [NAL9602] Loaded 2024-10-29T23:40:14.206Z,1730245214.206 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-10-29T23:40:14.236Z,1730245214.236 [Onboard] Loaded 2024-10-29T23:40:14.237Z,1730245214.237 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-10-29T23:40:14.238Z,1730245214.238 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A2A4E0 2024-10-29T23:40:14.238Z,1730245214.238 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 934 2024-10-29T23:40:14.252Z,1730245214.252 [Power24vConverter] Loaded 2024-10-29T23:40:14.253Z,1730245214.253 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-10-29T23:40:14.269Z,1730245214.269 [Radio_Surface] Loaded 2024-10-29T23:40:14.269Z,1730245214.269 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-10-29T23:40:14.270Z,1730245214.270 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A5A4E0 2024-10-29T23:40:14.270Z,1730245214.270 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 935 2024-10-29T23:40:14.318Z,1730245214.318 [RDI_Pathfinder] Loaded 2024-10-29T23:40:14.318Z,1730245214.318 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-10-29T23:40:14.333Z,1730245214.333 [Sonardyne_Nano] Loaded 2024-10-29T23:40:14.333Z,1730245214.333 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-10-29T23:40:14.429Z,1730245214.429 [DAT] Loaded 2024-10-29T23:40:14.429Z,1730245214.429 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-10-29T23:40:14.430Z,1730245214.430 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A8A4E0 2024-10-29T23:40:14.430Z,1730245214.430 [DAT ThreadHandler](INFO): Protected caller Thread ID is 936 2024-10-29T23:40:14.431Z,1730245214.431 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-10-29T23:40:14.432Z,1730245214.432 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-10-29T23:40:14.625Z,1730245214.625 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-10-29T23:40:14.625Z,1730245214.625 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-10-29T23:40:14.647Z,1730245214.647 [NavChart] Loaded 2024-10-29T23:40:14.653Z,1730245214.653 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-10-29T23:40:14.659Z,1730245214.659 [UniversalFixResidualReporter] Loaded 2024-10-29T23:40:14.659Z,1730245214.659 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-10-29T23:40:14.659Z,1730245214.659 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-10-29T23:40:14.700Z,1730245214.700 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-10-29T23:40:14.883Z,1730245214.883 [SBIT](DEBUG): Construct Startup Built In Test. 2024-10-29T23:40:14.892Z,1730245214.892 [SBIT] Loaded 2024-10-29T23:40:14.893Z,1730245214.893 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-10-29T23:40:14.896Z,1730245214.896 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-10-29T23:40:14.909Z,1730245214.909 [IBIT] Loaded 2024-10-29T23:40:14.909Z,1730245214.909 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-10-29T23:40:14.916Z,1730245214.916 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-10-29T23:40:15.024Z,1730245215.024 [CBIT] Loaded 2024-10-29T23:40:15.025Z,1730245215.025 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-10-29T23:40:15.025Z,1730245215.025 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-10-29T23:40:15.026Z,1730245215.026 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-10-29T23:40:15.193Z,1730245215.193 [BuoyancyServo] Loaded 2024-10-29T23:40:15.193Z,1730245215.193 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-10-29T23:40:15.217Z,1730245215.217 [ElevatorServo] Loaded 2024-10-29T23:40:15.217Z,1730245215.217 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-10-29T23:40:15.247Z,1730245215.247 [DockingStepper] Loaded 2024-10-29T23:40:15.248Z,1730245215.248 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-10-29T23:40:15.270Z,1730245215.270 [MassServo] Loaded 2024-10-29T23:40:15.270Z,1730245215.270 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-10-29T23:40:15.290Z,1730245215.290 [RudderServo] Loaded 2024-10-29T23:40:15.291Z,1730245215.291 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-10-29T23:40:15.310Z,1730245215.310 [ThrusterServo] Loaded 2024-10-29T23:40:15.310Z,1730245215.310 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-10-29T23:40:15.311Z,1730245215.311 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-10-29T23:40:15.311Z,1730245215.311 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-10-29T23:40:15.327Z,1730245215.327 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-10-29T23:40:15.328Z,1730245215.328 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-10-29T23:40:15.558Z,1730245215.558 [CTD_Seabird] Loaded 2024-10-29T23:40:15.558Z,1730245215.558 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-10-29T23:40:15.560Z,1730245215.560 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BDE4E0 2024-10-29T23:40:15.560Z,1730245215.560 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 937 2024-10-29T23:40:15.583Z,1730245215.583 [PAR_Licor] Loaded 2024-10-29T23:40:15.583Z,1730245215.583 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-10-29T23:40:15.629Z,1730245215.629 [WetLabsBB2FL] Loaded 2024-10-29T23:40:15.629Z,1730245215.629 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-10-29T23:40:15.630Z,1730245215.630 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C0E4E0 2024-10-29T23:40:15.631Z,1730245215.631 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 938 2024-10-29T23:40:15.652Z,1730245215.652 [WetLabsUBAT] Loaded 2024-10-29T23:40:15.653Z,1730245215.653 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-10-29T23:40:15.654Z,1730245215.654 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C3E4E0 2024-10-29T23:40:15.654Z,1730245215.654 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 939 2024-10-29T23:40:15.654Z,1730245215.654 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-10-29T23:40:15.661Z,1730245215.661 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-10-29T23:40:15.664Z,1730245215.664 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-10-29T23:40:15.675Z,1730245215.675 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-10-29T23:40:15.676Z,1730245215.676 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6E4E0 2024-10-29T23:40:15.677Z,1730245215.677 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 940 2024-10-29T23:40:15.681Z,1730245215.681 [Supervisor](INFO): Main Thread ID is 831 2024-10-29T23:40:15.681Z,1730245215.681 [Supervisor](DEBUG): Running supervisor. 2024-10-29T23:40:15.682Z,1730245215.682 [CommandExec ThreadHandler](INFO): Handler Thread ID is 941 2024-10-29T23:40:15.683Z,1730245215.683 [CommandExec](INFO): Initializing the command executive. 2024-10-29T23:40:15.684Z,1730245215.684 [CommandLine ThreadHandler](INFO): Handler Thread ID is 942 2024-10-29T23:40:15.686Z,1730245215.686 [controlThread ThreadHandler](INFO): Handler Thread ID is 943 2024-10-29T23:40:15.686Z,1730245215.686 [controlThread](DEBUG): Initializing ControlThread 2024-10-29T23:40:15.687Z,1730245215.687 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-10-29T23:40:15.689Z,1730245215.689 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-10-29T23:40:15.690Z,1730245215.690 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-10-29T23:40:15.690Z,1730245215.690 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-10-29T23:40:15.691Z,1730245215.691 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-10-29T23:40:15.691Z,1730245215.691 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-10-29T23:40:15.691Z,1730245215.691 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-10-29T23:40:15.692Z,1730245215.692 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-10-29T23:40:15.692Z,1730245215.692 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-10-29T23:40:15.697Z,1730245215.697 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-10-29T23:40:15.698Z,1730245215.698 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-10-29T23:40:15.698Z,1730245215.698 [SBIT](INFO): Initialize SBIT Component. 2024-10-29T23:40:15.698Z,1730245215.698 [SBIT](IMPORTANT): git: 2024-10-08_A-1-gd8541c08e 2024-10-29T23:40:15.698Z,1730245215.698 [SBIT](INFO): git hash: d8541c08e5b9954ca0b5a715681f71c182fc7331 2024-10-29T23:40:15.699Z,1730245215.699 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-10-29T23:40:15.700Z,1730245215.700 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-10-29T23:40:15.701Z,1730245215.701 [SBIT](INFO): Beginning SBIT in 114.000000 seconds. 2024-10-29T23:40:15.702Z,1730245215.702 [IBIT](INFO): Initialize IBIT Component. 2024-10-29T23:40:15.702Z,1730245215.702 [CBIT](DEBUG): Initialize CBIT Component. 2024-10-29T23:40:15.703Z,1730245215.703 [logger ThreadHandler](INFO): Handler Thread ID is 944 2024-10-29T23:40:15.716Z,1730245215.716 [CBIT](DEBUG): Initialized mux pins. 2024-10-29T23:40:15.716Z,1730245215.716 [CBIT](DEBUG): Initializing the watchdog timer. 2024-10-29T23:40:15.724Z,1730245215.724 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 945 2024-10-29T23:40:15.736Z,1730245215.736 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 946 2024-10-29T23:40:15.738Z,1730245215.738 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-10-29T23:40:15.740Z,1730245215.740 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-10-29T23:40:15.740Z,1730245215.740 [CBIT](DEBUG): Initializing heartbeat. 2024-10-29T23:40:15.748Z,1730245215.748 [Onboard ThreadHandler](INFO): Handler Thread ID is 947 2024-10-29T23:40:15.778Z,1730245215.778 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 948 2024-10-29T23:40:15.785Z,1730245215.785 [DAT ThreadHandler](INFO): Handler Thread ID is 949 2024-10-29T23:40:15.785Z,1730245215.785 [DAT](INFO): Powering up 2024-10-29T23:40:15.786Z,1730245215.786 [DAT](DEBUG): Initializing DAT. 2024-10-29T23:40:15.789Z,1730245215.789 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 951 2024-10-29T23:40:15.790Z,1730245215.790 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-10-29T23:40:15.793Z,1730245215.793 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 953 2024-10-29T23:40:15.796Z,1730245215.796 [WetLabsBB2FL](INFO): Powering up 2024-10-29T23:40:15.797Z,1730245215.797 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 955 2024-10-29T23:40:15.801Z,1730245215.801 [WetLabsUBAT](INFO): Powering up 2024-10-29T23:40:15.802Z,1730245215.802 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 957 2024-10-29T23:40:15.811Z,1730245215.811 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-10-29T23:40:15.811Z,1730245215.811 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-10-29T23:40:15.812Z,1730245215.812 [CBIT](DEBUG): Deactivating GF circuits. 2024-10-29T23:40:15.812Z,1730245215.812 [CBIT](DEBUG): Deactivating emergency mode. 2024-10-29T23:40:15.812Z,1730245215.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-10-29T23:40:15.812Z,1730245215.812 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-10-29T23:40:15.813Z,1730245215.813 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-10-29T23:40:15.813Z,1730245215.813 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-10-29T23:40:15.813Z,1730245215.813 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-10-29T23:40:15.813Z,1730245215.813 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-10-29T23:40:15.852Z,1730245215.852 [CBIT](DEBUG): Backplane powered. 2024-10-29T23:40:15.856Z,1730245215.856 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-10-29T23:40:15.857Z,1730245215.857 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-10-29T23:40:15.857Z,1730245215.857 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-10-29T23:40:15.876Z,1730245215.876 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-10-29T23:40:15.891Z,1730245215.891 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-10-29T23:40:15.892Z,1730245215.892 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-10-29T23:40:15.892Z,1730245215.892 [MissionManager](ERROR): Could not load startup mission. 2024-10-29T23:40:15.893Z,1730245215.893 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-10-29T23:40:15.893Z,1730245215.893 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-10-29T23:40:15.901Z,1730245215.901 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-10-29T23:40:16.180Z,1730245216.180 [Radio_Surface](INFO): Powering up 2024-10-29T23:40:16.428Z,1730245216.428 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into: 0 6 10 1 3 30 Timed out while trying to detach from dock at current depth of . Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-10-29T23:40:16.435Z,1730245216.435 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-10-29T23:40:16.443Z,1730245216.443 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2024-10-29T23:40:16.458Z,1730245216.458 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2024-10-29T23:40:16.462Z,1730245216.462 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2024-10-29T23:40:16.481Z,1730245216.481 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-10-29T23:40:16.494Z,1730245216.494 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2024-10-29T23:40:16.495Z,1730245216.495 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-10-29T23:40:16.630Z,1730245216.630 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-10-29T23:40:16.631Z,1730245216.631 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-29T23:40:16.683Z,1730245216.683 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-10-29T23:40:16.724Z,1730245216.724 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-10-29T23:40:16.727Z,1730245216.727 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-10-29T23:40:16.749Z,1730245216.749 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-10-29T23:40:16.770Z,1730245216.770 [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 DefaultWithUndock { arguments { ElapsedSinceDefaultStarted = 0 minute DetachTimeout = 6 hour """ Maximum time duration for the vehicle to detach form the dock. """ TransponderCode = Dock:Dock.transponderCode """ Dock transponder address. """ TrackingUpdatePeriod = 10 second """ Time duration between acoustic range queries while the mission is detaching from the dock. """ NumberOfPings = 1 count """ Number of pings requested each time. """ DriftTimeout = 3 minute """ How long to allow vehicle to drift away from dock before retrying reverse """ } 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 = 30 second } aggregate LeaveDock { run in sequence timeout duration=DetachTimeout { syslog important "Timed out while trying to detach from dock at current depth of " + Universal:depth~meter + "." } # Acoustic tracking directives behavior Estimation:TrackAcousticContact { run while ( Universal:depth > Control:VerticalControl.surfaceThreshold ) set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } # Leave the dock behavior Dock:Undock { run in sequence set driftTimeout = DriftTimeout } } aggregate SurfaceDefault { run in sequence # This mission assumes open water so from here on it's the same old default that's always used 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=P2H { 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-10-29T23:40:16.774Z,1730245216.774 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-10-29T23:40:16.801Z,1730245216.801 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-10-29T23:40:16.953Z,1730245216.953 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-10-29T23:40:16.954Z,1730245216.954 [Power24vConverter](INFO): Powering up. 2024-10-29T23:40:16.955Z,1730245216.955 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-10-29T23:40:16.965Z,1730245216.965 [Sonardyne_Nano](INFO): Initializing. 2024-10-29T23:40:16.993Z,1730245216.993 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-10-29T23:40:17.018Z,1730245217.018 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-10-29T23:40:17.024Z,1730245217.024 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-10-29T23:40:17.025Z,1730245217.025 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-10-29T23:40:17.033Z,1730245217.033 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-10-29T23:40:17.033Z,1730245217.033 [DockingStepper](INFO): Start 2024-10-29T23:40:17.034Z,1730245217.034 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-10-29T23:40:17.040Z,1730245217.040 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-10-29T23:40:17.041Z,1730245217.041 [MassServo](DEBUG): Initializing EZServoServo. 2024-10-29T23:40:17.048Z,1730245217.048 [MassServo](DEBUG): Initializing MassServo. 2024-10-29T23:40:17.049Z,1730245217.049 [RudderServo](DEBUG): Initializing EZServoServo. 2024-10-29T23:40:17.056Z,1730245217.056 [RudderServo](DEBUG): Initializing RudderServo. 2024-10-29T23:40:17.057Z,1730245217.057 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-10-29T23:40:17.064Z,1730245217.064 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-10-29T23:40:17.308Z,1730245217.308 [DockingStepper](INFO): Starting 2024-10-29T23:40:17.608Z,1730245217.608 [DockingStepper](INFO): Starting 2024-10-29T23:40:18.128Z,1730245218.128 [DockingStepper](INFO): Starting 2024-10-29T23:40:18.177Z,1730245218.177 [DockingStepper](INFO): Init string: /1z16351aE13561N3m50 2024-10-29T23:40:18.408Z,1730245218.408 [WetLabsBB2FL](INFO): Powering down 2024-10-29T23:40:18.428Z,1730245218.428 [DockingStepper](INFO): Starting 2024-10-29T23:40:18.840Z,1730245218.840 [DockingStepper](INFO): Starting 2024-10-29T23:40:19.206Z,1730245219.206 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-10-29T23:40:19.271Z,1730245219.271 [DockingStepper](INFO): Starting 2024-10-29T23:40:19.676Z,1730245219.676 [DockingStepper](INFO): Starting 2024-10-29T23:40:19.700Z,1730245219.700 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-10-29T23:40:20.139Z,1730245220.139 [DockingStepper](INFO): Starting 2024-10-29T23:40:20.456Z,1730245220.456 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-10-29T23:40:20.897Z,1730245220.897 [DockingStepper](INFO): Pause 2024-10-29T23:40:21.434Z,1730245221.434 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2024-10-29T23:40:21.435Z,1730245221.435 [Radio_Surface](INFO): No local IP found 2024-10-29T23:40:25.100Z,1730245225.100 [WetLabsUBAT](INFO): Powering down 2024-10-29T23:40:29.900Z,1730245229.900 [DAT](INFO): DAT read: 2024-10-29T23:40:29.902Z,1730245229.902 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-10-29T23:40:31.665Z,1730245231.665 [DAT](INFO): DAT read: MF Frequency Band 2024-10-29T23:40:31.666Z,1730245231.666 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-10-29T23:40:31.667Z,1730245231.667 [DAT](INFO): DAT read: Oct 29 2024 23:38:56 2024-10-29T23:40:32.675Z,1730245232.675 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-10-29T23:40:32.925Z,1730245232.925 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2024-10-29T23:40:32.926Z,1730245232.926 [DAT](INFO): commRate: 600 2024-10-29T23:40:34.992Z,1730245234.992 [DAT](INFO): entering command mode 2024-10-29T23:40:35.192Z,1730245235.192 [DAT](INFO): DAT read: 2024-10-29T23:40:35.193Z,1730245235.193 [DAT](INFO): DAT read: user:1> 2024-10-29T23:40:35.193Z,1730245235.193 [DAT](INFO): setting verbose to 3 2024-10-29T23:40:35.445Z,1730245235.445 [DAT](INFO): DAT read: user:1> 2024-10-29T23:40:35.446Z,1730245235.446 [DAT](INFO): DAT read: Verbose | 3 2024-10-29T23:40:35.446Z,1730245235.446 [DAT](INFO): set verbose to 3 2024-10-29T23:40:35.446Z,1730245235.446 [DAT](INFO): setting DatVerbose to 27440 2024-10-29T23:40:35.697Z,1730245235.697 [DAT](INFO): DAT read: user:2> 2024-10-29T23:40:35.697Z,1730245235.697 [DAT](INFO): DAT read: DatVerbose | 27440 2024-10-29T23:40:35.698Z,1730245235.698 [DAT](INFO): set DatVerbose to 27440 2024-10-29T23:40:35.698Z,1730245235.698 [DAT](INFO): setting transmit power to 8 2024-10-29T23:40:35.949Z,1730245235.949 [DAT](INFO): DAT read: user:3> 2024-10-29T23:40:35.950Z,1730245235.950 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-10-29T23:40:35.950Z,1730245235.950 [DAT](INFO): set transmit power to 8 2024-10-29T23:40:35.950Z,1730245235.950 [DAT](INFO): setting local address to 10 2024-10-29T23:40:36.200Z,1730245236.200 [DAT](INFO): DAT read: user:4> 2024-10-29T23:40:36.201Z,1730245236.201 [DAT](INFO): DAT read: LocalAddr | 10 2024-10-29T23:40:36.202Z,1730245236.202 [DAT](INFO): set local address to 10 2024-10-29T23:40:36.203Z,1730245236.203 [DAT](INFO): Setting time to: 23:40:36 And date to:10/29/2024 2024-10-29T23:40:36.452Z,1730245236.453 [DAT](INFO): DAT read: user:5> 2024-10-29T23:40:36.453Z,1730245236.453 [DAT](INFO): DAT read: Tue Oct 29, 2024 23:40:36 2024-10-29T23:40:36.454Z,1730245236.454 [DAT](INFO): Local DAT time set to Tue Oct 29, 2024 23:40:36 2024-10-29T23:40:44.257Z,1730245244.257 [NAL9602](INFO): Powering up NAL9602 2024-10-29T23:40:55.165Z,1730245255.165 [NAL9602](INFO): NAL9602 initialized 2024-10-29T23:41:17.796Z,1730245277.796 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:41:17.808Z,1730245277.808 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:41:18.997Z,1730245278.997 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:41:19.401Z,1730245279.401 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:41:23.440Z,1730245283.440 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:41:23.457Z,1730245283.457 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:41:23.457Z,1730245283.457 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:41:23.457Z,1730245283.457 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:41:23.495Z,1730245283.495 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:41:23.495Z,1730245283.495 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:41:23.853Z,1730245283.853 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:41:23.860Z,1730245283.860 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:41:24.664Z,1730245284.664 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:41:24.676Z,1730245284.676 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:41:31.925Z,1730245291.925 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:41:32.329Z,1730245292.329 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:41:36.773Z,1730245296.773 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:41:36.841Z,1730245296.841 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:41:36.841Z,1730245296.841 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:41:37.183Z,1730245297.183 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:41:37.183Z,1730245297.183 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:41:37.273Z,1730245297.273 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:41:37.273Z,1730245297.273 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:41:37.599Z,1730245297.599 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:41:37.996Z,1730245297.996 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:41:38.400Z,1730245298.400 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:41:45.660Z,1730245305.660 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:41:45.660Z,1730245305.660 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:41:50.508Z,1730245310.508 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:41:50.625Z,1730245310.625 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:41:50.625Z,1730245310.625 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:41:50.626Z,1730245310.626 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:41:50.699Z,1730245310.699 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:41:50.699Z,1730245310.699 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:41:50.919Z,1730245310.919 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:41:50.926Z,1730245310.926 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:41:51.732Z,1730245311.732 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:41:51.744Z,1730245311.744 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:41:58.993Z,1730245318.993 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:41:59.398Z,1730245319.398 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:42:03.841Z,1730245323.841 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:42:03.908Z,1730245323.908 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:03.909Z,1730245323.909 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:42:04.245Z,1730245324.245 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:42:04.314Z,1730245324.314 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:04.314Z,1730245324.314 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:42:04.321Z,1730245324.321 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:42:04.659Z,1730245324.659 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:42:05.076Z,1730245325.076 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:42:05.468Z,1730245325.468 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:42:10.342Z,1730245330.342 [SBIT](IMPORTANT): Beginning Startup BIT 2024-10-29T23:42:10.346Z,1730245330.346 [CBIT](IMPORTANT): Beginning ground fault scan 2024-10-29T23:42:12.740Z,1730245332.740 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:42:12.741Z,1730245332.741 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:42:17.184Z,1730245337.184 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:42:17.254Z,1730245337.254 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:17.255Z,1730245337.255 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:42:17.255Z,1730245337.255 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:42:17.329Z,1730245337.329 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:17.329Z,1730245337.329 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:42:17.616Z,1730245337.616 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:42:17.643Z,1730245337.643 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:42:18.408Z,1730245338.408 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:42:18.420Z,1730245338.420 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:42:21.837Z,1730245341.837 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.430459 CHAN A1 (24V): 0.618002 CHAN A2 (12V): 0.134750 CHAN A3 (5V): 0.019996 CHAN B0 (3.3V): 0.010048 CHAN B1 (3.15aV): 0.010608 CHAN B2 (3.15bV): 0.012687 CHAN B3 (GND): -0.015417 OPEN: -0.001238 Full Scale: +/- 1 mA 2024-10-29T23:42:25.276Z,1730245345.276 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:42:25.670Z,1730245345.670 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:42:30.113Z,1730245350.113 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:42:30.181Z,1730245350.181 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:30.182Z,1730245350.182 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:42:30.528Z,1730245350.528 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:42:30.528Z,1730245350.528 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:42:30.669Z,1730245350.669 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:30.669Z,1730245350.669 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:42:31.039Z,1730245351.039 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:42:31.432Z,1730245351.432 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:42:31.836Z,1730245351.836 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:42:39.100Z,1730245359.100 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:42:39.101Z,1730245359.101 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:42:43.541Z,1730245363.541 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:42:43.607Z,1730245363.607 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:43.608Z,1730245363.608 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:42:43.952Z,1730245363.952 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:42:43.953Z,1730245363.953 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:42:44.043Z,1730245364.043 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:44.043Z,1730245364.043 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:42:44.367Z,1730245364.367 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:42:44.764Z,1730245364.764 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:42:45.168Z,1730245365.168 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:42:52.446Z,1730245372.446 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:42:52.446Z,1730245372.446 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:42:53.954Z,1730245373.954 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004741 2024-10-29T23:42:54.952Z,1730245374.952 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:42:56.888Z,1730245376.888 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:42:56.979Z,1730245376.979 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:56.979Z,1730245376.979 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:42:56.984Z,1730245376.984 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:42:57.118Z,1730245377.118 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:42:57.118Z,1730245377.118 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:42:57.325Z,1730245377.325 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:42:57.348Z,1730245377.348 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:42:58.112Z,1730245378.112 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:42:58.124Z,1730245378.124 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:43:03.500Z,1730245383.500 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:04.192Z,1730245384.192 [SBIT](IMPORTANT): SBIT PASSED 2024-10-29T23:43:04.193Z,1730245384.193 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): DockingStepper.slideValue=10800 count; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 5.000000 meter; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): LineCapture.interceptTimeout=5 second; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): LineCapture.kiHeadingFinalApproach=0.02 reciprocal_second; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): LineCapture.kiHeadingTerminalGuidance=0.02 reciprocal_second; 2024-10-29T23:43:04.194Z,1730245384.194 [SBIT](IMPORTANT): LineCapture.navigationGain=3 none; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): Undock.reverseThrustTimeout=20 second; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=317.403036 cubic_centimeter; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): VerticalControl.kdPitchMass=1.25 second; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=1.25 reciprocal_second; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): VerticalControl.kpPitchMass=1.25 none; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): VerticalControl.massDeadband=0.05 centimeter; 2024-10-29T23:43:04.195Z,1730245384.195 [SBIT](IMPORTANT): VerticalControl.massDefault=23.583194 millimeter; 2024-10-29T23:43:04.196Z,1730245384.196 [SBIT](IMPORTANT): VerticalControl.massOnlyForceInt=0 bool; 2024-10-29T23:43:04.655Z,1730245384.655 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2024-10-29T23:43:04.655Z,1730245384.655 [DefaultWithUndock] Running Loop=1 2024-10-29T23:43:04.655Z,1730245384.655 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2024-10-29T23:43:04.660Z,1730245384.660 [DefaultWithUndock:A.Wait] Running Loop=1 2024-10-29T23:43:04.660Z,1730245384.660 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2024-10-29T23:43:05.374Z,1730245385.374 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:43:05.374Z,1730245385.374 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:43:10.221Z,1730245390.221 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:43:10.295Z,1730245390.295 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:10.295Z,1730245390.295 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:43:10.296Z,1730245390.296 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:43:10.375Z,1730245390.375 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:10.375Z,1730245390.375 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:43:10.639Z,1730245390.639 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:43:10.654Z,1730245390.654 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:43:11.444Z,1730245391.444 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:43:11.456Z,1730245391.456 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:43:11.912Z,1730245391.912 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:15.931Z,1730245395.931 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-10-29T23:43:15.931Z,1730245395.931 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-10-29T23:43:15.966Z,1730245395.966 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-10-29T23:43:16.334Z,1730245396.334 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-10-29T23:43:16.334Z,1730245396.334 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-10-29T23:43:18.706Z,1730245398.706 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:43:19.108Z,1730245399.108 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:43:20.316Z,1730245400.316 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:23.553Z,1730245403.553 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:43:23.663Z,1730245403.663 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:23.668Z,1730245403.668 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:43:23.961Z,1730245403.961 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:43:24.069Z,1730245404.069 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:24.069Z,1730245404.069 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:43:24.086Z,1730245404.086 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:43:24.367Z,1730245404.367 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:43:24.788Z,1730245404.788 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:43:25.180Z,1730245405.180 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:43:30.689Z,1730245410.689 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:33.445Z,1730245413.445 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:43:33.842Z,1730245413.842 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:43:34.678Z,1730245414.678 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:A.Wait] Stopped 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:LeaveDock] Running Loop=1 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2024-10-29T23:43:34.679Z,1730245414.679 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2024-10-29T23:43:34.680Z,1730245414.680 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-29T23:43:35.084Z,1730245415.084 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2024-10-29T23:43:35.084Z,1730245415.084 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-10-29T23:43:35.089Z,1730245415.089 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth -0.332181 m. 2024-10-29T23:43:35.090Z,1730245415.090 [DefaultWithUndock:LeaveDock:A.] Stopped 2024-10-29T23:43:35.090Z,1730245415.090 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact. 2024-10-29T23:43:35.099Z,1730245415.099 [DockingStepper](INFO): Resume 2024-10-29T23:43:35.490Z,1730245415.490 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2024-10-29T23:43:35.506Z,1730245415.506 [DockingStepper](INFO): Resuming 2024-10-29T23:43:35.908Z,1730245415.908 [DockingStepper](INFO): Start 2024-10-29T23:43:35.908Z,1730245415.908 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-10-29T23:43:36.022Z,1730245416.022 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-10-29T23:43:36.327Z,1730245416.327 [DockingStepper](INFO): Starting 2024-10-29T23:43:36.838Z,1730245416.838 [DockingStepper](INFO): Starting 2024-10-29T23:43:37.126Z,1730245417.126 [DockingStepper](INFO): Starting 2024-10-29T23:43:37.177Z,1730245417.177 [DockingStepper](INFO): Init string: /1z16352aE13561N3m50 2024-10-29T23:43:37.561Z,1730245417.561 [DockingStepper](INFO): Starting 2024-10-29T23:43:37.988Z,1730245417.988 [DockingStepper](INFO): Starting 2024-10-29T23:43:38.286Z,1730245418.286 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:43:38.355Z,1730245418.355 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:38.356Z,1730245418.356 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:43:38.450Z,1730245418.450 [DockingStepper](INFO): Starting 2024-10-29T23:43:38.689Z,1730245418.689 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:43:38.758Z,1730245418.758 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:38.758Z,1730245418.758 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:43:38.766Z,1730245418.766 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:43:38.846Z,1730245418.846 [DockingStepper](INFO): Starting 2024-10-29T23:43:38.869Z,1730245418.869 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-10-29T23:43:39.101Z,1730245419.101 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:43:39.149Z,1730245419.149 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:39.178Z,1730245419.178 [DockingStepper](INFO): Starting 2024-10-29T23:43:39.521Z,1730245419.521 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:43:39.913Z,1730245419.913 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:43:46.771Z,1730245426.771 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:43:47.174Z,1730245427.174 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:43:47.861Z,1730245427.861 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:51.618Z,1730245431.618 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:43:51.733Z,1730245431.733 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:51.733Z,1730245431.733 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:43:52.025Z,1730245432.025 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:43:52.134Z,1730245432.134 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:43:52.134Z,1730245432.134 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:43:52.150Z,1730245432.150 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:43:52.433Z,1730245432.433 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:43:52.853Z,1730245432.853 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:43:53.245Z,1730245433.245 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:43:55.680Z,1730245435.680 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby. 2024-10-29T23:43:56.103Z,1730245436.103 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby. 2024-10-29T23:43:56.479Z,1730245436.479 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2024-10-29T23:43:56.479Z,1730245436.479 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:LeaveDock] Stopped 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1 2024-10-29T23:43:56.480Z,1730245436.480 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-10-29T23:43:56.481Z,1730245436.481 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-10-29T23:43:56.481Z,1730245436.481 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-10-29T23:43:56.482Z,1730245436.482 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-10-29T23:43:56.482Z,1730245436.482 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-10-29T23:43:56.482Z,1730245436.482 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-10-29T23:43:56.483Z,1730245436.483 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-10-29T23:43:56.833Z,1730245436.833 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:43:56.888Z,1730245436.888 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2024-10-29T23:43:56.888Z,1730245436.888 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2024-10-29T23:43:56.888Z,1730245436.888 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2024-10-29T23:43:57.034Z,1730245437.034 [DockingStepper](INFO): Pause 2024-10-29T23:43:57.291Z,1730245437.291 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-10-29T23:44:00.103Z,1730245440.103 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:44:00.506Z,1730245440.506 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:44:04.950Z,1730245444.950 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:44:05.019Z,1730245445.019 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:44:05.021Z,1730245445.021 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:44:05.022Z,1730245445.022 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:44:05.098Z,1730245445.098 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:44:05.098Z,1730245445.098 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:44:05.362Z,1730245445.362 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:44:05.369Z,1730245445.369 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:44:05.454Z,1730245445.454 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:44:06.173Z,1730245446.173 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:44:06.187Z,1730245446.187 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:44:13.030Z,1730245453.030 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:44:13.838Z,1730245453.838 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:44:13.914Z,1730245453.914 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:44:17.878Z,1730245457.878 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:44:18.039Z,1730245458.039 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:44:18.039Z,1730245458.039 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:44:18.288Z,1730245458.288 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:44:18.288Z,1730245458.288 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:44:18.439Z,1730245458.439 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:44:18.439Z,1730245458.439 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:44:18.704Z,1730245458.704 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:44:19.105Z,1730245459.105 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:44:19.505Z,1730245459.505 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:44:22.721Z,1730245462.721 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:44:26.362Z,1730245466.362 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:44:27.170Z,1730245467.170 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:44:31.210Z,1730245471.210 [BPC1](INFO): BPC1A: validating data format. 2024-10-29T23:44:31.213Z,1730245471.213 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:44:31.287Z,1730245471.287 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:44:31.287Z,1730245471.287 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2024-10-29T23:44:31.620Z,1730245471.620 [BPC1](INFO): BPC1A: data parsed. 2024-10-29T23:44:32.029Z,1730245472.029 [BPC1](INFO): BPC1B: validating data format. 2024-10-29T23:44:32.101Z,1730245472.101 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2024-10-29T23:44:32.102Z,1730245472.102 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2024-10-29T23:44:32.437Z,1730245472.437 [BPC1](INFO): BPC1A: initialized. 2024-10-29T23:44:32.444Z,1730245472.444 [BPC1](INFO): BPC1B: data parsed. 2024-10-29T23:44:33.277Z,1730245473.277 [BPC1](INFO): BPC1B: initialized. 2024-10-29T23:44:37.319Z,1730245477.319 [CommandExec](IMPORTANT): got command quit 2024-10-29T23:44:38.321Z,1730245478.321 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-10-29T23:44:38.321Z,1730245478.321 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:38.321Z,1730245478.321 [CommandExec](INFO): Uninitializing the command executive. 2024-10-29T23:44:38.322Z,1730245478.322 [CommandExec](INFO): Uninitializing the command scheduler. 2024-10-29T23:44:38.322Z,1730245478.322 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.397Z,1730245478.397 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-10-29T23:44:38.397Z,1730245478.397 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-10-29T23:44:38.397Z,1730245478.397 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.398Z,1730245478.398 [NavChartDb](INFO): Join timeout helper Thread ID is 989 2024-10-29T23:44:38.585Z,1730245478.585 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:38.585Z,1730245478.585 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.597Z,1730245478.597 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-10-29T23:44:38.597Z,1730245478.597 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.598Z,1730245478.598 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 990 2024-10-29T23:44:38.613Z,1730245478.613 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:38.614Z,1730245478.614 [WetLabsUBAT](INFO): Powering down 2024-10-29T23:44:38.614Z,1730245478.614 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.626Z,1730245478.626 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-10-29T23:44:38.626Z,1730245478.626 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.626Z,1730245478.626 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 991 2024-10-29T23:44:38.897Z,1730245478.897 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:38.897Z,1730245478.897 [WetLabsBB2FL](INFO): Powering down 2024-10-29T23:44:38.898Z,1730245478.898 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.917Z,1730245478.917 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-10-29T23:44:38.917Z,1730245478.917 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:38.918Z,1730245478.918 [CTD_Seabird](INFO): Join timeout helper Thread ID is 992 2024-10-29T23:44:39.301Z,1730245479.301 [CTD_Seabird](INFO): Powering down 2024-10-29T23:44:39.313Z,1730245479.313 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:39.313Z,1730245479.313 [CTD_Seabird](INFO): Powering down 2024-10-29T23:44:39.325Z,1730245479.325 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:39.333Z,1730245479.333 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-10-29T23:44:39.333Z,1730245479.333 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:39.334Z,1730245479.334 [DAT](INFO): Join timeout helper Thread ID is 993 2024-10-29T23:44:39.337Z,1730245479.337 [DAT](INFO): Powering down 2024-10-29T23:44:39.406Z,1730245479.406 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:39.406Z,1730245479.406 [DAT](INFO): Powering down 2024-10-29T23:44:39.407Z,1730245479.407 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:39.414Z,1730245479.414 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-10-29T23:44:39.414Z,1730245479.414 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:39.414Z,1730245479.414 [Radio_Surface](INFO): Join timeout helper Thread ID is 994 2024-10-29T23:44:39.415Z,1730245479.415 [Radio_Surface](INFO): Powering down 2024-10-29T23:44:39.416Z,1730245479.416 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:39.416Z,1730245479.416 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:39.417Z,1730245479.417 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-10-29T23:44:39.417Z,1730245479.417 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:39.418Z,1730245479.418 [Onboard](INFO): Join timeout helper Thread ID is 995 2024-10-29T23:44:39.697Z,1730245479.697 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-10-29T23:44:39.697Z,1730245479.697 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-10-29T23:44:40.121Z,1730245480.121 [BPC1](INFO): BPC1A: sending IBPS break. 2024-10-29T23:44:40.931Z,1730245480.931 [BPC1](INFO): BPC1B: sending IBPS break. 2024-10-29T23:44:42.369Z,1730245482.369 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:42.369Z,1730245482.369 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.387Z,1730245482.387 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-10-29T23:44:42.387Z,1730245482.387 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.388Z,1730245482.388 [DataOverHttps](INFO): Join timeout helper Thread ID is 996 2024-10-29T23:44:42.709Z,1730245482.709 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:42.710Z,1730245482.710 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.714Z,1730245482.714 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-10-29T23:44:42.714Z,1730245482.714 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.714Z,1730245482.714 [BackseatComponent](INFO): Join timeout helper Thread ID is 997 2024-10-29T23:44:42.850Z,1730245482.850 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:42.850Z,1730245482.850 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.854Z,1730245482.854 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-10-29T23:44:42.854Z,1730245482.854 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.854Z,1730245482.854 [logger](INFO): Join timeout helper Thread ID is 998 2024-10-29T23:44:42.901Z,1730245482.901 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:42.902Z,1730245482.902 [logger ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.914Z,1730245482.914 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-10-29T23:44:42.914Z,1730245482.914 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.914Z,1730245482.914 [CommandLine](INFO): Join timeout helper Thread ID is 999 2024-10-29T23:44:42.933Z,1730245482.933 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:42.934Z,1730245482.934 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.958Z,1730245482.958 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-10-29T23:44:42.958Z,1730245482.958 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.958Z,1730245482.958 [CommandExec](INFO): Join timeout helper Thread ID is 1000 2024-10-29T23:44:42.966Z,1730245482.966 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-10-29T23:44:42.966Z,1730245482.966 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:42.966Z,1730245482.966 [controlThread](INFO): Join timeout helper Thread ID is 1001 2024-10-29T23:44:42.986Z,1730245482.986 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-10-29T23:44:42.986Z,1730245482.986 [controlThread](DEBUG): Uninitializing ControlThread 2024-10-29T23:44:42.986Z,1730245482.986 [AHRS_M2](INFO): Powering down 2024-10-29T23:44:43.058Z,1730245483.058 [NAL9602](INFO): Powering down 2024-10-29T23:44:43.129Z,1730245483.129 [RDI_Pathfinder](INFO): Powering down 2024-10-29T23:44:43.130Z,1730245483.130 [Sonardyne_Nano](INFO): Powering down 2024-10-29T23:44:43.250Z,1730245483.250 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-10-29T23:44:43.251Z,1730245483.251 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-10-29T23:44:43.251Z,1730245483.251 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-10-29T23:44:43.252Z,1730245483.252 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock] Stopped 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault] Stopped 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Stopped 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2024-10-29T23:44:43.252Z,1730245483.252 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2024-10-29T23:44:43.260Z,1730245483.260 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-10-29T23:44:43.260Z,1730245483.260 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-10-29T23:44:43.260Z,1730245483.260 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-10-29T23:44:43.261Z,1730245483.261 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-10-29T23:44:43.261Z,1730245483.261 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-10-29T23:44:43.261Z,1730245483.261 [BuoyancyServo](INFO): Powering down 2024-10-29T23:44:43.273Z,1730245483.273 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-10-29T23:44:43.273Z,1730245483.273 [ElevatorServo](INFO): Powering down 2024-10-29T23:44:43.274Z,1730245483.274 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-10-29T23:44:43.274Z,1730245483.274 [DockingStepper](INFO): Powering down 2024-10-29T23:44:43.275Z,1730245483.275 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-10-29T23:44:43.275Z,1730245483.275 [MassServo](INFO): Powering down 2024-10-29T23:44:43.276Z,1730245483.276 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-10-29T23:44:43.276Z,1730245483.276 [RudderServo](INFO): Powering down 2024-10-29T23:44:43.277Z,1730245483.277 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-10-29T23:44:43.277Z,1730245483.277 [ThrusterServo](INFO): Powering down 2024-10-29T23:44:43.278Z,1730245483.278 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-10-29T23:44:43.278Z,1730245483.278 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-10-29T23:44:43.278Z,1730245483.278 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-10-29T23:44:43.278Z,1730245483.278 [CBIT](DEBUG): Powering off loads. 2024-10-29T23:44:43.289Z,1730245483.289 [CBIT](DEBUG): Disabling WDT. 2024-10-29T23:44:43.301Z,1730245483.301 [CBIT](DEBUG): Opening all GF detection circuits. 2024-10-29T23:44:43.302Z,1730245483.302 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.356Z,1730245483.356 [DAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.364Z,1730245483.364 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.366Z,1730245483.366 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.371Z,1730245483.371 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.417Z,1730245483.417 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.478Z,1730245483.478 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.480Z,1730245483.480 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.484Z,1730245483.484 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.492Z,1730245483.492 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-10-29T23:44:43.562Z,1730245483.562 [logger ThreadHandler](INFO): Thread cancelled.