2023-02-18T01:02:50.812Z,1676682170.812 [Supervisor](DEBUG): Initializing supervisor. 2023-02-18T01:02:50.817Z,1676682170.817 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-02-18T01:02:50.817Z,1676682170.817 [SyncHandler](INFO): Protected caller Thread ID is 832 2023-02-18T01:02:50.818Z,1676682170.818 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-02-18T01:02:50.819Z,1676682170.819 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-02-18T01:02:50.819Z,1676682170.819 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 833 2023-02-18T01:02:50.823Z,1676682170.823 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-02-18T01:02:50.840Z,1676682170.840 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-02-18T01:02:50.841Z,1676682170.841 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-02-18T01:02:50.842Z,1676682170.842 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 834 2023-02-18T01:02:50.846Z,1676682170.846 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-02-18T01:02:50.847Z,1676682170.847 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-02-18T01:02:50.847Z,1676682170.847 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 835 2023-02-18T01:02:50.849Z,1676682170.849 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-02-18T01:02:50.850Z,1676682170.850 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-02-18T01:02:50.850Z,1676682170.850 [logger ThreadHandler](INFO): Protected caller Thread ID is 836 2023-02-18T01:02:50.854Z,1676682170.854 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-02-18T01:02:50.854Z,1676682170.854 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-02-18T01:02:50.860Z,1676682170.860 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-02-18T01:02:50.956Z,1676682170.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-02-18T01:02:50.958Z,1676682170.958 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-02-18T01:02:51.176Z,1676682171.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-02-18T01:02:51.177Z,1676682171.177 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-02-18T01:02:51.432Z,1676682171.432 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-02-18T01:02:51.434Z,1676682171.434 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-02-18T01:02:51.541Z,1676682171.541 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-02-18T01:02:51.543Z,1676682171.543 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-02-18T01:02:52.227Z,1676682172.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-02-18T01:02:52.228Z,1676682172.228 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-02-18T01:02:52.705Z,1676682172.705 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-02-18T01:02:52.706Z,1676682172.706 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-02-18T01:02:53.190Z,1676682173.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-02-18T01:02:53.190Z,1676682173.190 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-02-18T01:02:53.588Z,1676682173.588 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-02-18T01:02:53.589Z,1676682173.589 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-02-18T01:02:53.917Z,1676682173.917 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-02-18T01:02:53.919Z,1676682173.919 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-02-18T01:02:54.522Z,1676682174.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-02-18T01:02:54.523Z,1676682174.523 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-02-18T01:02:54.949Z,1676682174.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-02-18T01:02:54.950Z,1676682174.950 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-02-18T01:02:55.090Z,1676682175.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-02-18T01:02:55.090Z,1676682175.090 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-02-18T01:02:55.172Z,1676682175.172 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-02-18T01:02:55.253Z,1676682175.253 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-02-18T01:02:55.445Z,1676682175.445 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-02-18T01:02:55.446Z,1676682175.446 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-02-18T01:02:55.670Z,1676682175.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-02-18T01:02:55.672Z,1676682175.672 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2023-02-18T01:02:55.674Z,1676682175.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2023-02-18T01:02:55.757Z,1676682175.757 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2023-02-18T01:02:56.086Z,1676682176.086 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-02-18T01:02:56.087Z,1676682176.087 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2023-02-18T01:02:56.203Z,1676682176.203 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2023-02-18T01:02:56.366Z,1676682176.366 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2023-02-18T01:02:56.545Z,1676682176.545 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2023-02-18T01:02:56.630Z,1676682176.630 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2023-02-18T01:02:56.737Z,1676682176.737 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2023-02-18T01:02:56.843Z,1676682176.843 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2023-02-18T01:02:56.999Z,1676682176.999 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2023-02-18T01:02:57.103Z,1676682177.103 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2023-02-18T01:02:57.202Z,1676682177.202 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2023-02-18T01:02:57.207Z,1676682177.207 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-02-18T01:02:57.423Z,1676682177.423 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-02-18T01:02:57.424Z,1676682177.424 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-02-18T01:02:57.605Z,1676682177.605 [BuoyancyServo] Loaded 2023-02-18T01:02:57.605Z,1676682177.605 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-02-18T01:02:57.626Z,1676682177.626 [ElevatorServo] Loaded 2023-02-18T01:02:57.627Z,1676682177.627 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-02-18T01:02:57.647Z,1676682177.647 [MassServo] Loaded 2023-02-18T01:02:57.647Z,1676682177.647 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-02-18T01:02:57.667Z,1676682177.667 [RudderServo] Loaded 2023-02-18T01:02:57.667Z,1676682177.667 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-02-18T01:02:57.683Z,1676682177.683 [ThrusterHE] Loaded 2023-02-18T01:02:57.683Z,1676682177.683 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-02-18T01:02:57.683Z,1676682177.683 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-02-18T01:02:57.685Z,1676682177.685 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-02-18T01:02:57.854Z,1676682177.854 [SBIT](DEBUG): Construct Startup Built In Test. 2023-02-18T01:02:57.869Z,1676682177.869 [SBIT] Loaded 2023-02-18T01:02:57.869Z,1676682177.869 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-02-18T01:02:57.872Z,1676682177.872 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-02-18T01:02:57.893Z,1676682177.893 [IBIT] Loaded 2023-02-18T01:02:57.893Z,1676682177.893 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-02-18T01:02:57.899Z,1676682177.899 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-02-18T01:02:58.117Z,1676682178.117 [CBIT] Loaded 2023-02-18T01:02:58.117Z,1676682178.117 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-02-18T01:02:58.118Z,1676682178.118 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-02-18T01:02:58.118Z,1676682178.118 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-02-18T01:02:58.330Z,1676682178.330 [CTD_Seabird] Loaded 2023-02-18T01:02:58.331Z,1676682178.331 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-02-18T01:02:58.332Z,1676682178.332 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406644E0 2023-02-18T01:02:58.332Z,1676682178.332 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 919 2023-02-18T01:02:58.364Z,1676682178.364 [ESPComponent] Loaded 2023-02-18T01:02:58.364Z,1676682178.364 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2023-02-18T01:02:58.383Z,1676682178.383 [PAR_Licor] Loaded 2023-02-18T01:02:58.383Z,1676682178.383 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-02-18T01:02:58.414Z,1676682178.414 [WetLabsBB2FL] Loaded 2023-02-18T01:02:58.414Z,1676682178.414 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-02-18T01:02:58.415Z,1676682178.415 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406944E0 2023-02-18T01:02:58.416Z,1676682178.416 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 920 2023-02-18T01:02:58.416Z,1676682178.416 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-02-18T01:02:58.418Z,1676682178.418 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-02-18T01:02:58.488Z,1676682178.488 [DepthRateCalculator] Loaded 2023-02-18T01:02:58.488Z,1676682178.488 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-02-18T01:02:58.493Z,1676682178.493 [PitchRateCalculator] Loaded 2023-02-18T01:02:58.493Z,1676682178.493 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-02-18T01:02:58.504Z,1676682178.504 [SpeedCalculator] Loaded 2023-02-18T01:02:58.504Z,1676682178.504 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-02-18T01:02:58.509Z,1676682178.509 [YawRateCalculator] Loaded 2023-02-18T01:02:58.509Z,1676682178.509 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-02-18T01:02:58.528Z,1676682178.528 [ElevatorOffsetCalculator] Loaded 2023-02-18T01:02:58.528Z,1676682178.528 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-02-18T01:02:58.529Z,1676682178.529 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-02-18T01:02:58.529Z,1676682178.529 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-02-18T01:02:58.651Z,1676682178.651 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-02-18T01:02:58.652Z,1676682178.652 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-02-18T01:02:58.695Z,1676682178.695 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-02-18T01:02:58.696Z,1676682178.696 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-02-18T01:02:58.832Z,1676682178.832 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-02-18T01:02:58.833Z,1676682178.833 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-02-18T01:02:58.847Z,1676682178.847 [NavChart] Loaded 2023-02-18T01:02:58.847Z,1676682178.847 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-02-18T01:02:58.853Z,1676682178.853 [UniversalFixResidualReporter] Loaded 2023-02-18T01:02:58.853Z,1676682178.853 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-02-18T01:02:58.853Z,1676682178.853 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-02-18T01:02:58.855Z,1676682178.855 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-02-18T01:02:59.650Z,1676682179.650 [AHRS_M2] Loaded 2023-02-18T01:02:59.650Z,1676682179.650 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-02-18T01:02:59.898Z,1676682179.898 [BackseatComponent] Loaded 2023-02-18T01:02:59.899Z,1676682179.899 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-02-18T01:02:59.900Z,1676682179.900 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A244E0 2023-02-18T01:02:59.900Z,1676682179.900 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921 2023-02-18T01:02:59.903Z,1676682179.903 [LcmUniversalReporter] Loaded 2023-02-18T01:02:59.903Z,1676682179.903 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-02-18T01:02:59.921Z,1676682179.921 [BPC1](INFO): BPC1A: got serial number for stick 1: 0C1E 2023-02-18T01:02:59.922Z,1676682179.922 [BPC1](INFO): BPC1A: got serial number for stick 2: 0481 2023-02-18T01:02:59.923Z,1676682179.923 [BPC1](INFO): BPC1A: got serial number for stick 3: 047B 2023-02-18T01:02:59.923Z,1676682179.923 [BPC1](INFO): BPC1A: got serial number for stick 4: 0464 2023-02-18T01:02:59.924Z,1676682179.924 [BPC1](INFO): BPC1A: got serial number for stick 5: 045C 2023-02-18T01:02:59.925Z,1676682179.925 [BPC1](INFO): BPC1A: got serial number for stick 6: 046A 2023-02-18T01:02:59.926Z,1676682179.926 [BPC1](INFO): BPC1A: got serial number for stick 7: 045A 2023-02-18T01:02:59.926Z,1676682179.926 [BPC1](INFO): BPC1A: got serial number for stick 8: 0487 2023-02-18T01:02:59.927Z,1676682179.927 [BPC1](INFO): BPC1A: marked stick 8 as reserve. 2023-02-18T01:02:59.928Z,1676682179.928 [BPC1](INFO): BPC1A: got serial number for stick 9: 03FE 2023-02-18T01:02:59.929Z,1676682179.929 [BPC1](INFO): BPC1A: got serial number for stick 10: 0465 2023-02-18T01:02:59.929Z,1676682179.929 [BPC1](INFO): BPC1A: got serial number for stick 11: 046B 2023-02-18T01:02:59.930Z,1676682179.930 [BPC1](INFO): BPC1A: got serial number for stick 12: 0445 2023-02-18T01:02:59.931Z,1676682179.931 [BPC1](INFO): BPC1A: got serial number for stick 13: 040D 2023-02-18T01:02:59.931Z,1676682179.931 [BPC1](INFO): BPC1A: got serial number for stick 14: 04AA 2023-02-18T01:02:59.932Z,1676682179.932 [BPC1](INFO): BPC1A: got serial number for stick 15: 049A 2023-02-18T01:02:59.933Z,1676682179.933 [BPC1](INFO): BPC1A: got serial number for stick 16: 04C6 2023-02-18T01:02:59.933Z,1676682179.933 [BPC1](INFO): BPC1A: marked stick 16 as reserve. 2023-02-18T01:02:59.934Z,1676682179.934 [BPC1](INFO): BPC1A: got serial number for stick 17: 0486 2023-02-18T01:02:59.935Z,1676682179.935 [BPC1](INFO): BPC1A: got serial number for stick 18: 0442 2023-02-18T01:02:59.936Z,1676682179.936 [BPC1](INFO): BPC1A: got serial number for stick 19: 0457 2023-02-18T01:02:59.937Z,1676682179.937 [BPC1](INFO): BPC1A: got serial number for stick 20: 0455 2023-02-18T01:02:59.937Z,1676682179.937 [BPC1](INFO): BPC1A: got serial number for stick 21: 04C0 2023-02-18T01:02:59.938Z,1676682179.938 [BPC1](INFO): BPC1A: got serial number for stick 22: 0459 2023-02-18T01:02:59.939Z,1676682179.939 [BPC1](INFO): BPC1A: got serial number for stick 23: 045F 2023-02-18T01:02:59.939Z,1676682179.939 [BPC1](INFO): BPC1A: got serial number for stick 24: 0449 2023-02-18T01:02:59.940Z,1676682179.940 [BPC1](INFO): BPC1A: marked stick 24 as reserve. 2023-02-18T01:02:59.940Z,1676682179.940 [BPC1](INFO): BPC1A: got serial number for stick 25: 0441 2023-02-18T01:02:59.941Z,1676682179.941 [BPC1](INFO): BPC1A: got serial number for stick 26: 0460 2023-02-18T01:02:59.942Z,1676682179.942 [BPC1](INFO): BPC1A: got serial number for stick 27: 04A8 2023-02-18T01:02:59.943Z,1676682179.943 [BPC1](INFO): BPC1A: got serial number for stick 28: 04BF 2023-02-18T01:02:59.943Z,1676682179.943 [BPC1](INFO): BPC1A: got serial number for stick 29: 045D 2023-02-18T01:02:59.944Z,1676682179.944 [BPC1](INFO): BPC1A: got serial number for stick 30: 04A4 2023-02-18T01:02:59.945Z,1676682179.945 [BPC1](INFO): BPC1A: got serial number for stick 31: 04D9 2023-02-18T01:02:59.946Z,1676682179.946 [BPC1](INFO): BPC1B: got serial number for stick 32: 0BE5 2023-02-18T01:02:59.947Z,1676682179.947 [BPC1](INFO): BPC1B: got serial number for stick 33: 0124 2023-02-18T01:02:59.948Z,1676682179.948 [BPC1](INFO): BPC1B: got serial number for stick 34: 0162 2023-02-18T01:02:59.949Z,1676682179.949 [BPC1](INFO): BPC1B: got serial number for stick 35: 017A 2023-02-18T01:02:59.950Z,1676682179.950 [BPC1](INFO): BPC1B: got serial number for stick 36: 0495 2023-02-18T01:02:59.950Z,1676682179.950 [BPC1](INFO): BPC1B: got serial number for stick 37: 0458 2023-02-18T01:02:59.951Z,1676682179.951 [BPC1](INFO): BPC1B: got serial number for stick 38: 0139 2023-02-18T01:02:59.952Z,1676682179.952 [BPC1](INFO): BPC1B: got serial number for stick 39: 00F0 2023-02-18T01:02:59.952Z,1676682179.952 [BPC1](INFO): BPC1B: marked stick 39 as reserve. 2023-02-18T01:02:59.953Z,1676682179.953 [BPC1](INFO): BPC1B: got serial number for stick 40: 0451 2023-02-18T01:02:59.954Z,1676682179.954 [BPC1](INFO): BPC1B: got serial number for stick 41: 049E 2023-02-18T01:02:59.954Z,1676682179.954 [BPC1](INFO): BPC1B: got serial number for stick 42: 04A2 2023-02-18T01:02:59.955Z,1676682179.955 [BPC1](INFO): BPC1B: got serial number for stick 43: 044F 2023-02-18T01:02:59.956Z,1676682179.956 [BPC1](INFO): BPC1B: got serial number for stick 44: 047F 2023-02-18T01:02:59.957Z,1676682179.957 [BPC1](INFO): BPC1B: got serial number for stick 45: 0496 2023-02-18T01:02:59.957Z,1676682179.957 [BPC1](INFO): BPC1B: got serial number for stick 46: 04CE 2023-02-18T01:02:59.958Z,1676682179.958 [BPC1](INFO): BPC1B: got serial number for stick 47: 04A5 2023-02-18T01:02:59.958Z,1676682179.958 [BPC1](INFO): BPC1B: marked stick 47 as reserve. 2023-02-18T01:02:59.959Z,1676682179.959 [BPC1](INFO): BPC1B: got serial number for stick 48: 04D7 2023-02-18T01:02:59.960Z,1676682179.960 [BPC1](INFO): BPC1B: got serial number for stick 49: 04CA 2023-02-18T01:02:59.961Z,1676682179.961 [BPC1](INFO): BPC1B: got serial number for stick 50: 04A1 2023-02-18T01:02:59.962Z,1676682179.962 [BPC1](INFO): BPC1B: got serial number for stick 51: 049B 2023-02-18T01:02:59.963Z,1676682179.963 [BPC1](INFO): BPC1B: got serial number for stick 52: 04BD 2023-02-18T01:02:59.963Z,1676682179.963 [BPC1](INFO): BPC1B: got serial number for stick 53: 0494 2023-02-18T01:02:59.964Z,1676682179.964 [BPC1](INFO): BPC1B: got serial number for stick 54: 0466 2023-02-18T01:02:59.965Z,1676682179.965 [BPC1](INFO): BPC1B: got serial number for stick 55: 0447 2023-02-18T01:02:59.965Z,1676682179.965 [BPC1](INFO): BPC1B: marked stick 55 as reserve. 2023-02-18T01:02:59.966Z,1676682179.966 [BPC1](INFO): BPC1B: got serial number for stick 56: 0480 2023-02-18T01:02:59.966Z,1676682179.966 [BPC1](INFO): BPC1B: got serial number for stick 57: 04A3 2023-02-18T01:02:59.967Z,1676682179.967 [BPC1](INFO): BPC1B: got serial number for stick 58: 04C5 2023-02-18T01:02:59.968Z,1676682179.968 [BPC1](INFO): BPC1B: got serial number for stick 59: 046D 2023-02-18T01:02:59.969Z,1676682179.969 [BPC1](INFO): BPC1B: got serial number for stick 60: 0409 2023-02-18T01:02:59.969Z,1676682179.969 [BPC1](INFO): BPC1B: got serial number for stick 61: 04D3 2023-02-18T01:02:59.970Z,1676682179.970 [BPC1](INFO): BPC1B: got serial number for stick 62: 0493 2023-02-18T01:03:01.113Z,1676682181.113 [BPC1] Loaded 2023-02-18T01:03:01.113Z,1676682181.113 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-02-18T01:03:01.255Z,1676682181.255 [DataOverHttps] Loaded 2023-02-18T01:03:01.255Z,1676682181.255 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-02-18T01:03:01.256Z,1676682181.256 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A544E0 2023-02-18T01:03:01.256Z,1676682181.256 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922 2023-02-18T01:03:01.277Z,1676682181.277 [Depth_Keller] Loaded 2023-02-18T01:03:01.277Z,1676682181.277 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-02-18T01:03:01.282Z,1676682181.282 [DropWeight] Loaded 2023-02-18T01:03:01.283Z,1676682181.283 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-02-18T01:03:01.320Z,1676682181.320 [DVL_micro] Loaded 2023-02-18T01:03:01.321Z,1676682181.321 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2023-02-18T01:03:01.340Z,1676682181.340 [MultiRay] Loaded 2023-02-18T01:03:01.340Z,1676682181.340 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2023-02-18T01:03:01.399Z,1676682181.399 [NAL9602] Loaded 2023-02-18T01:03:01.399Z,1676682181.399 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-02-18T01:03:01.425Z,1676682181.425 [Onboard] Loaded 2023-02-18T01:03:01.425Z,1676682181.425 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-02-18T01:03:01.426Z,1676682181.426 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A844E0 2023-02-18T01:03:01.427Z,1676682181.427 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923 2023-02-18T01:03:01.440Z,1676682181.440 [Power24vConverter] Loaded 2023-02-18T01:03:01.440Z,1676682181.440 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-02-18T01:03:01.453Z,1676682181.453 [Radio_Surface] Loaded 2023-02-18T01:03:01.454Z,1676682181.454 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-02-18T01:03:01.455Z,1676682181.455 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AB44E0 2023-02-18T01:03:01.455Z,1676682181.455 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924 2023-02-18T01:03:01.456Z,1676682181.456 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-02-18T01:03:01.457Z,1676682181.457 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-02-18T01:03:01.538Z,1676682181.538 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-02-18T01:03:01.538Z,1676682181.538 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-02-18T01:03:01.605Z,1676682181.605 [VerticalControl](DEBUG): Construct VerticalControl. 2023-02-18T01:03:01.657Z,1676682181.657 [VerticalControl] Loaded 2023-02-18T01:03:01.657Z,1676682181.657 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-02-18T01:03:01.660Z,1676682181.660 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-02-18T01:03:01.698Z,1676682181.698 [HorizontalControl] Loaded 2023-02-18T01:03:01.698Z,1676682181.698 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-02-18T01:03:01.700Z,1676682181.700 [SpeedControl](DEBUG): Construct SpeedControl. 2023-02-18T01:03:01.702Z,1676682181.702 [SpeedControl] Loaded 2023-02-18T01:03:01.702Z,1676682181.702 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-02-18T01:03:01.705Z,1676682181.705 [LoopControl](DEBUG): Construct LoopControl. 2023-02-18T01:03:01.706Z,1676682181.706 [LoopControl] Loaded 2023-02-18T01:03:01.706Z,1676682181.706 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-02-18T01:03:01.706Z,1676682181.706 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-02-18T01:03:01.707Z,1676682181.707 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-02-18T01:03:01.723Z,1676682181.723 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-02-18T01:03:01.724Z,1676682181.724 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-02-18T01:03:02.086Z,1676682182.086 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-02-18T01:03:02.092Z,1676682182.092 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-02-18T01:03:02.095Z,1676682182.095 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-02-18T01:03:02.106Z,1676682182.106 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-02-18T01:03:02.107Z,1676682182.107 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BAE4E0 2023-02-18T01:03:02.107Z,1676682182.107 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 925 2023-02-18T01:03:02.111Z,1676682182.111 [Supervisor](INFO): Main Thread ID is 827 2023-02-18T01:03:02.112Z,1676682182.112 [Supervisor](DEBUG): Running supervisor. 2023-02-18T01:03:02.112Z,1676682182.112 [CommandExec ThreadHandler](INFO): Handler Thread ID is 926 2023-02-18T01:03:02.113Z,1676682182.113 [CommandExec](INFO): Initializing the command executive. 2023-02-18T01:03:02.114Z,1676682182.114 [CommandLine ThreadHandler](INFO): Handler Thread ID is 927 2023-02-18T01:03:02.116Z,1676682182.116 [controlThread ThreadHandler](INFO): Handler Thread ID is 928 2023-02-18T01:03:02.117Z,1676682182.117 [controlThread](DEBUG): Initializing ControlThread 2023-02-18T01:03:02.119Z,1676682182.119 [SBIT](INFO): Initialize SBIT Component. 2023-02-18T01:03:02.119Z,1676682182.119 [SBIT](IMPORTANT): git: 2023-02-15A-1-g98c560e2e 2023-02-18T01:03:02.119Z,1676682182.119 [SBIT](INFO): git hash: 98c560e2e862bfc439cbc2881c3a6b20e1bb1b72 2023-02-18T01:03:02.120Z,1676682182.120 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-02-18T01:03:02.121Z,1676682182.121 [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 2023-02-18T01:03:02.122Z,1676682182.122 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2023-02-18T01:03:02.123Z,1676682182.123 [IBIT](INFO): Initialize IBIT Component. 2023-02-18T01:03:02.124Z,1676682182.124 [CBIT](DEBUG): Initialize CBIT Component. 2023-02-18T01:03:02.124Z,1676682182.124 [logger ThreadHandler](INFO): Handler Thread ID is 929 2023-02-18T01:03:02.136Z,1676682182.136 [CBIT](DEBUG): Initialized mux pins. 2023-02-18T01:03:02.136Z,1676682182.136 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2023-02-18T01:03:02.136Z,1676682182.136 [CBIT](DEBUG): Initializing the watchdog timer. 2023-02-18T01:03:02.144Z,1676682182.144 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 930 2023-02-18T01:03:02.145Z,1676682182.145 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-02-18T01:03:02.150Z,1676682182.150 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 932 2023-02-18T01:03:02.152Z,1676682182.152 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:03:02.153Z,1676682182.153 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934 2023-02-18T01:03:02.160Z,1676682182.160 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-02-18T01:03:02.160Z,1676682182.160 [CBIT](DEBUG): Initializing heartbeat. 2023-02-18T01:03:02.162Z,1676682182.162 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935 2023-02-18T01:03:02.163Z,1676682182.163 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-02-18T01:03:02.176Z,1676682182.176 [Onboard ThreadHandler](INFO): Handler Thread ID is 936 2023-02-18T01:03:02.194Z,1676682182.194 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937 2023-02-18T01:03:02.212Z,1676682182.212 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 938 2023-02-18T01:03:02.221Z,1676682182.221 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-02-18T01:03:02.221Z,1676682182.221 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-02-18T01:03:02.222Z,1676682182.222 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-02-18T01:03:02.222Z,1676682182.222 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-02-18T01:03:02.222Z,1676682182.222 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-02-18T01:03:02.222Z,1676682182.222 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-02-18T01:03:02.222Z,1676682182.222 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-02-18T01:03:02.222Z,1676682182.222 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-02-18T01:03:02.223Z,1676682182.223 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000 2023-02-18T01:03:02.223Z,1676682182.223 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000 2023-02-18T01:03:02.232Z,1676682182.232 [CBIT](DEBUG): Deactivating GF circuits. 2023-02-18T01:03:02.232Z,1676682182.232 [CBIT](DEBUG): Deactivating emergency mode. 2023-02-18T01:03:02.268Z,1676682182.268 [CBIT](DEBUG): Backplane powered. 2023-02-18T01:03:02.272Z,1676682182.272 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-02-18T01:03:02.272Z,1676682182.272 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-02-18T01:03:02.273Z,1676682182.273 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-02-18T01:03:02.273Z,1676682182.273 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-02-18T01:03:02.274Z,1676682182.274 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-02-18T01:03:02.275Z,1676682182.275 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-02-18T01:03:02.275Z,1676682182.275 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-02-18T01:03:02.286Z,1676682182.286 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-02-18T01:03:02.296Z,1676682182.296 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-02-18T01:03:02.297Z,1676682182.297 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-02-18T01:03:02.297Z,1676682182.297 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-02-18T01:03:02.298Z,1676682182.298 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-02-18T01:03:02.342Z,1676682182.342 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-02-18T01:03:02.382Z,1676682182.382 [MissionManager](DEBUG): 2023-02-18T01:03:02.383Z,1676682182.383 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-02-18T01:03:02.460Z,1676682182.460 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-02-18T01:03:02.461Z,1676682182.461 [Default:A.Wait](DEBUG): Construct Wait. 2023-02-18T01:03:02.463Z,1676682182.463 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-02-18T01:03:02.520Z,1676682182.520 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-02-18T01:03:02.523Z,1676682182.523 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-02-18T01:03:02.555Z,1676682182.555 [Default:E.Execute](DEBUG): Construct Execute. 2023-02-18T01:03:02.580Z,1676682182.580 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2023-02-18T01:03:02.592Z,1676682182.592 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,MultiRay,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, 2023-02-18T01:03:02.600Z,1676682182.600 [Radio_Surface](INFO): Powering up 2023-02-18T01:03:02.602Z,1676682182.602 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-02-18T01:03:02.740Z,1676682182.740 [Depth_Keller](ERROR): Pressure reading out of range: 1895.444336 decibar 2023-02-18T01:03:02.749Z,1676682182.749 [MultiRay](INFO): Powering up MultiRay Lights 2023-02-18T01:03:02.788Z,1676682182.788 [Power24vConverter](INFO): Powering up. 2023-02-18T01:03:02.796Z,1676682182.796 [DepthRateCalculator](ERROR): Depth measurement is not active 2023-02-18T01:03:02.878Z,1676682182.878 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-02-18T01:03:02.884Z,1676682182.884 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-02-18T01:03:02.885Z,1676682182.885 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-02-18T01:03:02.892Z,1676682182.892 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-02-18T01:03:02.893Z,1676682182.893 [MassServo](DEBUG): Initializing EZServoServo. 2023-02-18T01:03:02.900Z,1676682182.900 [MassServo](DEBUG): Initializing MassServo. 2023-02-18T01:03:02.901Z,1676682182.901 [RudderServo](DEBUG): Initializing EZServoServo. 2023-02-18T01:03:02.908Z,1676682182.908 [RudderServo](DEBUG): Initializing RudderServo. 2023-02-18T01:03:02.909Z,1676682182.909 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-02-18T01:03:02.916Z,1676682182.916 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-02-18T01:03:03.073Z,1676682183.073 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-02-18T01:03:03.074Z,1676682183.074 [DropWeight] Hardware Fault, FailCount= 1 2023-02-18T01:03:03.074Z,1676682183.074 [DropWeight](ERROR): Hardware Fault 2023-02-18T01:03:03.157Z,1676682183.157 [CommandExec](FAULT): Scheduling is paused 2023-02-18T01:03:03.158Z,1676682183.158 [CBIT](INFO): Critical error at 20230218T010303 2023-02-18T01:03:03.158Z,1676682183.158 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-02-18T01:03:03.169Z,1676682183.169 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-02-18T01:03:03.169Z,1676682183.169 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-02-18T01:03:03.740Z,1676682183.740 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2023-02-18T01:03:03.740Z,1676682183.740 [RudderServo](FAULT): Rudder failed to initialize 2023-02-18T01:03:03.740Z,1676682183.740 [RudderServo] Communications Fault, FailCount= 1 2023-02-18T01:03:03.740Z,1676682183.740 [RudderServo](ERROR): Communications Fault 2023-02-18T01:03:03.742Z,1676682183.742 [CBIT](INFO): Critical error at 20230218T010303 2023-02-18T01:03:03.744Z,1676682183.744 [CBIT](ERROR): Communications Fault in component: RudderServo 2023-02-18T01:03:04.205Z,1676682184.205 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-02-18T01:03:04.205Z,1676682184.205 [RudderServo](INFO): Powering down 2023-02-18T01:03:04.652Z,1676682184.652 [RudderServo](DEBUG): Initializing EZServoServo. 2023-02-18T01:03:04.773Z,1676682184.773 [RudderServo](DEBUG): Initializing RudderServo. 2023-02-18T01:03:04.777Z,1676682184.777 [CBIT](INFO): Clearing failed state for component RudderServo 2023-02-18T01:03:04.777Z,1676682184.777 [RudderServo] No Fault, FailCount= 1 2023-02-18T01:03:07.439Z,1676682187.439 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:03:07.440Z,1676682187.440 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:03:07.582Z,1676682187.582 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:03:07.940Z,1676682187.940 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:03:08.405Z,1676682188.405 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-02-18T01:03:09.055Z,1676682189.055 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:03:09.056Z,1676682189.056 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:03:09.154Z,1676682189.154 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:03:12.364Z,1676682192.364 [CBIT](CRITICAL): Environmental Failure. Press:14.752095 PSI. Humidity:32%. Temp:26 C. ABORTING MISSION 2023-02-18T01:03:12.774Z,1676682192.774 [CBIT](INFO): Critical error at 20230218T010312 2023-02-18T01:03:14.444Z,1676682194.444 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:03:14.444Z,1676682194.444 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:03:14.445Z,1676682194.445 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:03:14.944Z,1676682194.944 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:03:16.008Z,1676682196.008 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:03:16.008Z,1676682196.008 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:03:16.157Z,1676682196.157 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:03:19.993Z,1676682199.993 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:03:19.993Z,1676682199.993 [DVL_micro] Communications Fault, FailCount= 1 2023-02-18T01:03:19.993Z,1676682199.993 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:03:20.064Z,1676682200.064 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:03:20.476Z,1676682200.476 [DVL_micro](INFO): Powering down 2023-02-18T01:03:21.281Z,1676682201.281 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:03:21.281Z,1676682201.281 [DVL_micro] No Fault, FailCount= 1 2023-02-18T01:03:21.447Z,1676682201.447 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:03:21.448Z,1676682201.448 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:03:21.672Z,1676682201.672 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:03:21.949Z,1676682201.949 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:03:22.897Z,1676682202.897 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:03:22.897Z,1676682202.897 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:03:23.180Z,1676682203.180 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:03:28.465Z,1676682208.465 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:03:28.465Z,1676682208.465 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:03:28.536Z,1676682208.536 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:03:28.972Z,1676682208.972 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:03:29.844Z,1676682209.844 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:03:29.844Z,1676682209.844 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:03:30.185Z,1676682210.185 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:03:31.706Z,1676682211.706 [NAL9602](INFO): Powering up NAL9602 2023-02-18T01:03:35.484Z,1676682215.484 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:03:35.484Z,1676682215.484 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:03:35.768Z,1676682215.768 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:03:35.768Z,1676682215.768 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:03:35.984Z,1676682215.984 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:03:38.982Z,1676682218.982 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:03:38.982Z,1676682218.982 [DVL_micro] Communications Fault, FailCount= 2 2023-02-18T01:03:38.982Z,1676682218.982 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:03:38.998Z,1676682218.998 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:03:39.456Z,1676682219.456 [DVL_micro](INFO): Powering down 2023-02-18T01:03:40.209Z,1676682220.209 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:03:40.209Z,1676682220.209 [DVL_micro] No Fault, FailCount= 2 2023-02-18T01:03:42.619Z,1676682222.619 [NAL9602](INFO): NAL9602 initialized 2023-02-18T01:03:50.640Z,1676682230.640 [CommandExec](IMPORTANT): got command failComponent 2023-02-18T01:03:50.640Z,1676682230.640 [CommandExec](IMPORTANT): Failed components: 2023-02-18T01:03:50.641Z,1676682230.641 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2023-02-18T01:03:50.641Z,1676682230.641 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2023-02-18T01:03:57.978Z,1676682237.978 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:03:57.978Z,1676682237.978 [DVL_micro] Communications Fault, FailCount= 3 2023-02-18T01:03:57.978Z,1676682237.978 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:03:57.994Z,1676682237.994 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:03:57.994Z,1676682237.994 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2023-02-18T01:03:58.440Z,1676682238.440 [DVL_micro](INFO): Powering down 2023-02-18T01:03:58.463Z,1676682238.463 [CBIT](INFO): Critical error at 20230218T010357 2023-02-18T01:04:01.634Z,1676682241.634 [SBIT](IMPORTANT): Beginning Startup BIT 2023-02-18T01:04:01.639Z,1676682241.639 [CBIT](IMPORTANT): Beginning ground fault scan 2023-02-18T01:04:03.636Z,1676682243.636 [BPC1](INFO): BPC1A: initialized. 2023-02-18T01:04:03.656Z,1676682243.656 [BPC1](INFO): BPC1B: initialized. 2023-02-18T01:04:04.469Z,1676682244.469 [CommandLine](INFO): End of History 2023-02-18T01:04:04.836Z,1676682244.836 [BPC1](INFO): BPC1B: sending IBPS break. 2023-02-18T01:04:05.240Z,1676682245.240 [BPC1](INFO): BPC1A: sending IBPS break. 2023-02-18T01:04:09.688Z,1676682249.688 [BPC1](INFO): BPC1A: validating data format. 2023-02-18T01:04:09.723Z,1676682249.723 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU. 2023-02-18T01:04:09.724Z,1676682249.724 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2023-02-18T01:04:09.724Z,1676682249.724 [BPC1](INFO): BPC1B: validating data format. 2023-02-18T01:04:09.741Z,1676682249.741 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with LONG_IBPS_MENU. 2023-02-18T01:04:09.742Z,1676682249.742 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2023-02-18T01:04:09.904Z,1676682249.904 [CommandExec](IMPORTANT): got command failComponent 2023-02-18T01:04:09.904Z,1676682249.904 [CommandExec](IMPORTANT): Failed components: 2023-02-18T01:04:09.905Z,1676682249.905 [CommandExec](IMPORTANT): WetLabsBB2FL: Communications Fault 2023-02-18T01:04:09.905Z,1676682249.905 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2023-02-18T01:04:09.905Z,1676682249.905 [CommandExec](IMPORTANT): DVL_micro: Communications Fault 2023-02-18T01:04:10.089Z,1676682250.089 [BPC1](INFO): Looking for stick 0451to match 0C1E 2023-02-18T01:04:10.089Z,1676682250.089 [BPC1](INFO): Looking for stick 0451to match 0481 2023-02-18T01:04:10.089Z,1676682250.089 [BPC1](INFO): Looking for stick 0451to match 047B 2023-02-18T01:04:10.090Z,1676682250.090 [BPC1](INFO): Looking for stick 0451to match 0464 2023-02-18T01:04:10.090Z,1676682250.090 [BPC1](INFO): Looking for stick 0451to match 045C 2023-02-18T01:04:10.090Z,1676682250.090 [BPC1](INFO): Looking for stick 0451to match 046A 2023-02-18T01:04:10.091Z,1676682250.091 [BPC1](INFO): Looking for stick 0451to match 045A 2023-02-18T01:04:10.091Z,1676682250.091 [BPC1](INFO): Looking for stick 0451to match 0487 2023-02-18T01:04:10.091Z,1676682250.091 [BPC1](INFO): Looking for stick 0451to match 03FE 2023-02-18T01:04:10.092Z,1676682250.092 [BPC1](INFO): Looking for stick 0451to match 0465 2023-02-18T01:04:10.092Z,1676682250.092 [BPC1](INFO): Looking for stick 0451to match 046B 2023-02-18T01:04:10.093Z,1676682250.093 [BPC1](INFO): Looking for stick 0451to match 0445 2023-02-18T01:04:10.093Z,1676682250.093 [BPC1](INFO): Looking for stick 0451to match 040D 2023-02-18T01:04:10.093Z,1676682250.093 [BPC1](INFO): Looking for stick 0451to match 04AA 2023-02-18T01:04:10.093Z,1676682250.093 [BPC1](INFO): Looking for stick 0451to match 049A 2023-02-18T01:04:10.094Z,1676682250.094 [BPC1](INFO): Looking for stick 0451to match 04C6 2023-02-18T01:04:10.095Z,1676682250.095 [BPC1](INFO): Looking for stick 0451to match 0486 2023-02-18T01:04:10.097Z,1676682250.097 [BPC1](INFO): Looking for stick 0451to match 0442 2023-02-18T01:04:10.099Z,1676682250.099 [BPC1](INFO): Looking for stick 0451to match 0457 2023-02-18T01:04:10.100Z,1676682250.100 [BPC1](INFO): Looking for stick 0451to match 0455 2023-02-18T01:04:10.100Z,1676682250.100 [BPC1](INFO): Looking for stick 0451to match 04C0 2023-02-18T01:04:10.101Z,1676682250.101 [BPC1](INFO): Looking for stick 0451to match 0459 2023-02-18T01:04:10.101Z,1676682250.101 [BPC1](INFO): Looking for stick 0451to match 045F 2023-02-18T01:04:10.101Z,1676682250.101 [BPC1](INFO): Looking for stick 0451to match 0449 2023-02-18T01:04:10.102Z,1676682250.102 [BPC1](INFO): Looking for stick 0451to match 0441 2023-02-18T01:04:10.102Z,1676682250.102 [BPC1](INFO): Looking for stick 0451to match 0460 2023-02-18T01:04:10.102Z,1676682250.102 [BPC1](INFO): Looking for stick 0451to match 04A8 2023-02-18T01:04:10.103Z,1676682250.103 [BPC1](INFO): Looking for stick 0451to match 04BF 2023-02-18T01:04:10.103Z,1676682250.103 [BPC1](INFO): Looking for stick 0451to match 045D 2023-02-18T01:04:10.103Z,1676682250.103 [BPC1](INFO): Looking for stick 0451to match 04A4 2023-02-18T01:04:10.104Z,1676682250.104 [BPC1](INFO): Looking for stick 0451to match 04D9 2023-02-18T01:04:10.105Z,1676682250.105 [BPC1](ERROR): BPC1A: No match for serial number 0451 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-02-18T01:04:10.105Z,1676682250.105 [BPC1](INFO): Looking for stick 03FEto match 0BE5 2023-02-18T01:04:10.106Z,1676682250.106 [BPC1](INFO): Looking for stick 03FEto match 0124 2023-02-18T01:04:10.106Z,1676682250.106 [BPC1](INFO): Looking for stick 03FEto match 0162 2023-02-18T01:04:10.106Z,1676682250.106 [BPC1](INFO): Looking for stick 03FEto match 017A 2023-02-18T01:04:10.107Z,1676682250.107 [BPC1](INFO): Looking for stick 03FEto match 0495 2023-02-18T01:04:10.107Z,1676682250.107 [BPC1](INFO): Looking for stick 03FEto match 0458 2023-02-18T01:04:10.124Z,1676682250.124 [BPC1](INFO): Looking for stick 03FEto match 0139 2023-02-18T01:04:10.124Z,1676682250.124 [BPC1](INFO): Looking for stick 03FEto match 00F0 2023-02-18T01:04:10.124Z,1676682250.124 [BPC1](INFO): Looking for stick 03FEto match 0451 2023-02-18T01:04:10.125Z,1676682250.125 [BPC1](INFO): Looking for stick 03FEto match 049E 2023-02-18T01:04:10.125Z,1676682250.125 [BPC1](INFO): Looking for stick 03FEto match 04A2 2023-02-18T01:04:10.125Z,1676682250.125 [BPC1](INFO): Looking for stick 03FEto match 044F 2023-02-18T01:04:10.126Z,1676682250.126 [BPC1](INFO): Looking for stick 03FEto match 047F 2023-02-18T01:04:10.126Z,1676682250.126 [BPC1](INFO): Looking for stick 03FEto match 0496 2023-02-18T01:04:10.126Z,1676682250.126 [BPC1](INFO): Looking for stick 03FEto match 04CE 2023-02-18T01:04:10.127Z,1676682250.127 [BPC1](INFO): Looking for stick 03FEto match 04A5 2023-02-18T01:04:10.127Z,1676682250.127 [BPC1](INFO): Looking for stick 03FEto match 04D7 2023-02-18T01:04:10.127Z,1676682250.127 [BPC1](INFO): Looking for stick 03FEto match 04CA 2023-02-18T01:04:10.132Z,1676682250.132 [BPC1](INFO): Looking for stick 03FEto match 04A1 2023-02-18T01:04:10.132Z,1676682250.132 [BPC1](INFO): Looking for stick 03FEto match 049B 2023-02-18T01:04:10.133Z,1676682250.133 [BPC1](INFO): Looking for stick 03FEto match 04BD 2023-02-18T01:04:10.133Z,1676682250.133 [BPC1](INFO): Looking for stick 03FEto match 0494 2023-02-18T01:04:10.133Z,1676682250.133 [BPC1](INFO): Looking for stick 03FEto match 0466 2023-02-18T01:04:10.134Z,1676682250.134 [BPC1](INFO): Looking for stick 03FEto match 0447 2023-02-18T01:04:10.134Z,1676682250.134 [BPC1](INFO): Looking for stick 03FEto match 0480 2023-02-18T01:04:10.134Z,1676682250.134 [BPC1](INFO): Looking for stick 03FEto match 04A3 2023-02-18T01:04:10.134Z,1676682250.134 [BPC1](INFO): Looking for stick 03FEto match 04C5 2023-02-18T01:04:10.135Z,1676682250.135 [BPC1](INFO): Looking for stick 03FEto match 046D 2023-02-18T01:04:10.135Z,1676682250.135 [BPC1](INFO): Looking for stick 03FEto match 0409 2023-02-18T01:04:10.136Z,1676682250.136 [BPC1](INFO): Looking for stick 03FEto match 04D3 2023-02-18T01:04:10.137Z,1676682250.137 [BPC1](INFO): Looking for stick 03FEto match 0493 2023-02-18T01:04:10.138Z,1676682250.138 [BPC1](ERROR): BPC1B: No match for serial number 03FE in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-18T01:04:10.138Z,1676682250.138 [BPC1](FAULT): Failed to parse data from all battery packs. 2023-02-18T01:04:10.138Z,1676682250.138 [BPC1] Data Fault, FailCount= 1 2023-02-18T01:04:10.138Z,1676682250.138 [BPC1](ERROR): Data Fault 2023-02-18T01:04:10.280Z,1676682250.280 [CBIT](ERROR): Data Fault in component: BPC1 2023-02-18T01:04:12.636Z,1676682252.636 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.005895 CHAN A1 (24V): 0.000737 CHAN A2 (12V): -0.005444 CHAN A3 (5V): -0.002616 CHAN B0 (3.3V): -0.000908 CHAN B1 (3.15aV): -0.001582 CHAN B2 (3.15bV): -0.001166 CHAN B3 (GND): 0.000256 OPEN: 0.004838 Full Scale: +/- 1 mA 2023-02-18T01:04:15.006Z,1676682255.006 [SBIT](FAULT): Rudder: EXPECTED:15.000000 ACTUAL:14.524950 2023-02-18T01:04:27.317Z,1676682267.317 [CommandExec](IMPORTANT): got command configSet BPC1A.uart 0 2023-02-18T01:04:27.317Z,1676682267.317 [CommandExec](FAULT): Incomplete syntax. Try: help configSet 2023-02-18T01:04:41.674Z,1676682281.674 [SBIT](FAULT): Elevator: EXPECTED:-15.000000 ACTUAL:-14.703101 2023-02-18T01:04:41.674Z,1676682281.674 [SBIT](FAULT): Control surface position failure. 2023-02-18T01:04:55.753Z,1676682295.753 [SBIT](CRITICAL): SBIT FAILED 2023-02-18T01:04:55.753Z,1676682295.753 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2023-02-18T01:04:55.755Z,1676682295.755 [CBIT](INFO): Critical error at 20230218T010455 2023-02-18T01:04:56.152Z,1676682296.152 [MissionManager](IMPORTANT): Started mission Startup 2023-02-18T01:04:56.153Z,1676682296.153 [Startup] Running Loop=1 2023-02-18T01:04:56.153Z,1676682296.153 [Startup](DEBUG): Aggregate::initialize Startup 2023-02-18T01:04:56.153Z,1676682296.153 [Startup:A.GoToSurface] Running Loop=1 2023-02-18T01:04:56.153Z,1676682296.153 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-02-18T01:04:56.154Z,1676682296.154 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-02-18T01:04:56.154Z,1676682296.154 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-02-18T01:04:56.154Z,1676682296.154 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-02-18T01:04:56.155Z,1676682296.155 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-02-18T01:04:56.155Z,1676682296.155 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-02-18T01:04:56.156Z,1676682296.156 [Startup:StartupSatComms] Running Loop=1 2023-02-18T01:04:56.156Z,1676682296.156 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-02-18T01:04:56.157Z,1676682296.157 [Startup:StartupSatComms:A] Running Loop=1 2023-02-18T01:04:56.561Z,1676682296.561 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-02-18T01:05:35.994Z,1676682335.994 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004543 2023-02-18T01:05:56.362Z,1676682356.362 [Startup:StartupSatComms:A](INFO): Timed out from 2023-02-18T01:04:56.2Z 2023-02-18T01:05:56.362Z,1676682356.362 [Startup:StartupSatComms:A] Stopped 2023-02-18T01:05:56.362Z,1676682356.362 [Startup:StartupSatComms:B] Running Loop=1 2023-02-18T01:05:56.774Z,1676682356.774 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-02-18T01:06:02.422Z,1676682362.422 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-02-18T01:06:02.422Z,1676682362.422 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-18T01:06:02.433Z,1676682362.433 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-18T01:06:02.871Z,1676682362.871 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-18T01:06:02.871Z,1676682362.871 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-02-18T01:06:05.682Z,1676682365.682 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:06:05.682Z,1676682365.682 [WetLabsBB2FL] No Fault, FailCount= 5 2023-02-18T01:06:05.873Z,1676682365.873 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:06:11.167Z,1676682371.167 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:06:11.167Z,1676682371.167 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:06:11.336Z,1676682371.336 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:06:11.669Z,1676682371.669 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:06:12.554Z,1676682372.554 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:06:12.554Z,1676682372.554 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:06:12.881Z,1676682372.881 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:06:15.487Z,1676682375.487 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230218T003133/Courier0007.lzma 2023-02-18T01:06:16.490Z,1676682376.490 [DataOverHttps](INFO): Moved sent file to Logs/20230218T003133/Courier0007.lzma.bak 2023-02-18T01:06:16.490Z,1676682376.490 [DataOverHttps](INFO): SBD MOMSN=17483010 2023-02-18T01:06:18.172Z,1676682378.172 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:06:18.172Z,1676682378.172 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:06:18.231Z,1676682378.231 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:06:18.668Z,1676682378.668 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:06:19.825Z,1676682379.825 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:06:19.825Z,1676682379.825 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:06:19.881Z,1676682379.881 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:06:25.172Z,1676682385.172 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:06:25.172Z,1676682385.172 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:06:25.458Z,1676682385.458 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:06:25.672Z,1676682385.672 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:06:26.689Z,1676682386.689 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:06:26.689Z,1676682386.689 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:06:26.885Z,1676682386.885 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:06:32.175Z,1676682392.175 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:06:32.176Z,1676682392.176 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:06:32.325Z,1676682392.325 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:06:32.676Z,1676682392.676 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:06:33.563Z,1676682393.563 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:06:33.563Z,1676682393.563 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:06:33.889Z,1676682393.889 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:06:35.955Z,1676682395.955 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230218T005033/Courier0000.lzma 2023-02-18T01:06:36.925Z,1676682396.925 [DataOverHttps](INFO): Moved sent file to Logs/20230218T005033/Courier0000.lzma.bak 2023-02-18T01:06:36.926Z,1676682396.926 [DataOverHttps](INFO): SBD MOMSN=17483012 2023-02-18T01:06:39.180Z,1676682399.180 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:06:39.180Z,1676682399.180 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:06:39.296Z,1676682399.296 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:06:39.296Z,1676682399.296 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:06:39.680Z,1676682399.680 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:06:56.560Z,1676682416.560 [Startup:StartupSatComms:B](INFO): Timed out from 2023-02-18T01:05:56.4Z 2023-02-18T01:06:56.560Z,1676682416.560 [Startup:StartupSatComms:B] Stopped 2023-02-18T01:06:56.560Z,1676682416.560 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-02-18T01:06:56.560Z,1676682416.560 [Startup:StartupSatComms] Stopped 2023-02-18T01:06:56.560Z,1676682416.560 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-02-18T01:06:56.561Z,1676682416.561 [Startup](INFO): Completed Startup 2023-02-18T01:06:56.561Z,1676682416.561 [MissionManager](INFO): Startup is completed. 2023-02-18T01:06:56.561Z,1676682416.561 [MissionManager](INFO): Uninitializing Mission Startup 2023-02-18T01:06:56.562Z,1676682416.562 [Startup] Stopped 2023-02-18T01:06:56.562Z,1676682416.562 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-02-18T01:06:56.562Z,1676682416.562 [Startup:A.GoToSurface] Stopped 2023-02-18T01:06:56.562Z,1676682416.562 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-02-18T01:06:56.988Z,1676682416.988 [MissionManager](IMPORTANT): Started mission Default 2023-02-18T01:06:56.988Z,1676682416.988 [Default] Running Loop=1 2023-02-18T01:06:56.988Z,1676682416.988 [Default](DEBUG): Aggregate::initialize Default 2023-02-18T01:06:56.988Z,1676682416.988 [Default:B.GoToSurface] Running Loop=1 2023-02-18T01:06:56.988Z,1676682416.988 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-02-18T01:06:56.988Z,1676682416.988 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-02-18T01:06:56.989Z,1676682416.989 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-02-18T01:06:56.989Z,1676682416.989 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-02-18T01:06:56.989Z,1676682416.989 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-02-18T01:06:56.990Z,1676682416.990 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-02-18T01:06:56.990Z,1676682416.990 [Default:A.Wait] Running Loop=1 2023-02-18T01:06:56.990Z,1676682416.990 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-02-18T01:06:58.247Z,1676682418.247 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:06:58.247Z,1676682418.247 [DVL_micro] No Fault, FailCount= 3 2023-02-18T01:07:08.880Z,1676682428.880 [DataOverHttps](INFO): Sending 366 bytes from file Logs/20230218T010250/Courier0000.lzma 2023-02-18T01:07:09.881Z,1676682429.881 [DataOverHttps](INFO): Moved sent file to Logs/20230218T010250/Courier0000.lzma.bak 2023-02-18T01:07:09.882Z,1676682429.882 [DataOverHttps](INFO): SBD MOMSN=17483015 2023-02-18T01:07:10.316Z,1676682430.316 [Default:A.Wait](INFO): Done Waiting. 2023-02-18T01:07:10.316Z,1676682430.316 [Default:A.Wait] Stopped 2023-02-18T01:07:10.316Z,1676682430.316 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-02-18T01:07:10.710Z,1676682430.710 [Default:CheckIn] Running Loop=1 2023-02-18T01:07:10.710Z,1676682430.710 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-18T01:07:10.710Z,1676682430.710 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-18T01:07:11.122Z,1676682431.122 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-02-18T01:07:15.942Z,1676682435.942 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:07:15.942Z,1676682435.942 [DVL_micro] Communications Fault, FailCount= 1 2023-02-18T01:07:15.942Z,1676682435.942 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:07:15.978Z,1676682435.978 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:07:16.428Z,1676682436.428 [DVL_micro](INFO): Powering down 2023-02-18T01:07:17.171Z,1676682437.171 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:07:17.171Z,1676682437.171 [DVL_micro] No Fault, FailCount= 1 2023-02-18T01:07:34.930Z,1676682454.930 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:07:34.930Z,1676682454.930 [DVL_micro] Communications Fault, FailCount= 2 2023-02-18T01:07:34.930Z,1676682454.930 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:07:34.947Z,1676682454.947 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:07:35.408Z,1676682455.408 [DVL_micro](INFO): Powering down 2023-02-18T01:07:36.205Z,1676682456.205 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:07:36.206Z,1676682456.206 [DVL_micro] No Fault, FailCount= 2 2023-02-18T01:07:53.918Z,1676682473.918 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:07:53.918Z,1676682473.918 [DVL_micro] Communications Fault, FailCount= 3 2023-02-18T01:07:53.918Z,1676682473.918 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:07:53.935Z,1676682473.935 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:07:53.935Z,1676682473.935 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2023-02-18T01:07:54.400Z,1676682474.400 [DVL_micro](INFO): Powering down 2023-02-18T01:07:54.420Z,1676682474.420 [CBIT](INFO): Critical error at 20230218T010753 2023-02-18T01:08:45.630Z,1676682525.630 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-02-18T01:09:03.411Z,1676682543.411 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-02-18T01:09:03.411Z,1676682543.411 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-18T01:09:03.442Z,1676682543.442 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-18T01:09:03.852Z,1676682543.852 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-18T01:09:03.852Z,1676682543.852 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-02-18T01:09:09.489Z,1676682549.489 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:09:09.489Z,1676682549.489 [WetLabsBB2FL] No Fault, FailCount= 5 2023-02-18T01:09:09.597Z,1676682549.597 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:09:14.895Z,1676682554.895 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:09:14.895Z,1676682554.895 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:09:15.156Z,1676682555.156 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:09:15.396Z,1676682555.396 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:09:16.363Z,1676682556.363 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:09:16.363Z,1676682556.363 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:09:16.609Z,1676682556.609 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:09:21.899Z,1676682561.899 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:09:21.900Z,1676682561.900 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:09:22.038Z,1676682562.038 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:09:22.400Z,1676682562.400 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:09:23.218Z,1676682563.218 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:09:23.218Z,1676682563.218 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:09:23.613Z,1676682563.613 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:09:28.903Z,1676682568.903 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:09:28.904Z,1676682568.904 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:09:29.293Z,1676682569.293 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:09:29.404Z,1676682569.404 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:09:30.494Z,1676682570.494 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:09:30.494Z,1676682570.494 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:09:30.617Z,1676682570.617 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:09:35.907Z,1676682575.907 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:09:35.908Z,1676682575.908 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:09:36.169Z,1676682576.169 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:09:36.408Z,1676682576.408 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:09:37.390Z,1676682577.390 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:09:37.391Z,1676682577.391 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:09:37.621Z,1676682577.621 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:09:42.912Z,1676682582.912 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:09:42.912Z,1676682582.912 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:09:43.039Z,1676682583.039 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:09:43.044Z,1676682583.044 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:09:43.412Z,1676682583.412 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:10:54.120Z,1676682654.120 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:10:54.120Z,1676682654.120 [DVL_micro] No Fault, FailCount= 3 2023-02-18T01:11:11.878Z,1676682671.878 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:11:11.878Z,1676682671.878 [DVL_micro] Communications Fault, FailCount= 1 2023-02-18T01:11:11.878Z,1676682671.878 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:11:11.923Z,1676682671.923 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:11:12.348Z,1676682672.348 [DVL_micro](INFO): Powering down 2023-02-18T01:11:13.118Z,1676682673.118 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:11:13.119Z,1676682673.119 [DVL_micro] No Fault, FailCount= 1 2023-02-18T01:11:30.878Z,1676682690.878 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:11:30.878Z,1676682690.878 [DVL_micro] Communications Fault, FailCount= 2 2023-02-18T01:11:30.878Z,1676682690.878 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:11:30.915Z,1676682690.915 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:11:31.348Z,1676682691.348 [DVL_micro](INFO): Powering down 2023-02-18T01:11:32.094Z,1676682692.094 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:11:32.094Z,1676682692.094 [DVL_micro] No Fault, FailCount= 2 2023-02-18T01:11:49.854Z,1676682709.854 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:11:49.854Z,1676682709.854 [DVL_micro] Communications Fault, FailCount= 3 2023-02-18T01:11:49.854Z,1676682709.854 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:11:49.901Z,1676682709.901 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:11:49.903Z,1676682709.903 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2023-02-18T01:11:50.336Z,1676682710.336 [DVL_micro](INFO): Powering down 2023-02-18T01:11:50.351Z,1676682710.351 [CBIT](INFO): Critical error at 20230218T011149 2023-02-18T01:12:04.444Z,1676682724.444 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-02-18T01:12:04.444Z,1676682724.444 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-18T01:12:04.492Z,1676682724.492 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-18T01:12:04.900Z,1676682724.900 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-18T01:12:04.900Z,1676682724.900 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-02-18T01:12:10.889Z,1676682730.889 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-18T01:07:10.7Z 2023-02-18T01:12:10.889Z,1676682730.889 [Default:CheckIn:Read_GPS] Stopped 2023-02-18T01:12:10.889Z,1676682730.889 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-18T01:12:11.301Z,1676682731.301 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-02-18T01:12:13.144Z,1676682733.144 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:12:13.144Z,1676682733.144 [WetLabsBB2FL] No Fault, FailCount= 5 2023-02-18T01:12:13.377Z,1676682733.377 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:12:18.668Z,1676682738.668 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:12:18.668Z,1676682738.668 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:12:18.785Z,1676682738.785 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:12:19.172Z,1676682739.172 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:12:20.392Z,1676682740.392 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:12:20.392Z,1676682740.392 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:12:20.789Z,1676682740.789 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:12:25.858Z,1676682745.858 [DataOverHttps](INFO): Sending 97 bytes from file Logs/20230218T010250/Courier0004.lzma 2023-02-18T01:12:26.088Z,1676682746.088 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:12:26.088Z,1676682746.088 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:12:26.471Z,1676682746.471 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:12:26.588Z,1676682746.588 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:12:26.904Z,1676682746.904 [DataOverHttps](INFO): Moved sent file to Logs/20230218T010250/Courier0004.lzma.bak 2023-02-18T01:12:26.904Z,1676682746.904 [DataOverHttps](INFO): SBD MOMSN=17483023 2023-02-18T01:12:27.627Z,1676682747.627 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:12:27.627Z,1676682747.627 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:12:27.801Z,1676682747.801 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:12:33.096Z,1676682753.096 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:12:33.096Z,1676682753.096 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:12:33.366Z,1676682753.366 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:12:33.596Z,1676682753.596 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:12:34.562Z,1676682754.562 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:12:34.562Z,1676682754.562 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:12:34.865Z,1676682754.865 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:12:40.116Z,1676682760.116 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:12:40.116Z,1676682760.116 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:12:40.188Z,1676682760.188 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:12:40.612Z,1676682760.612 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:12:41.762Z,1676682761.762 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:12:41.762Z,1676682761.762 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:12:41.825Z,1676682761.825 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:12:47.116Z,1676682767.116 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:12:47.116Z,1676682767.116 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:12:47.452Z,1676682767.452 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:12:47.452Z,1676682767.452 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:12:47.616Z,1676682767.616 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:13:21.059Z,1676682801.059 [Power24vConverter](INFO): Powering down. 2023-02-18T01:13:21.547Z,1676682801.547 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230218T003133/Express0008.lzma 2023-02-18T01:13:22.550Z,1676682802.550 [DataOverHttps](INFO): Moved sent file to Logs/20230218T003133/Express0008.lzma.bak 2023-02-18T01:13:22.550Z,1676682802.550 [DataOverHttps](INFO): SBD MOMSN=17483027 2023-02-18T01:13:45.713Z,1676682825.713 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-18T01:13:45.713Z,1676682825.713 [NAL9602] Data Fault, FailCount= 1 2023-02-18T01:13:45.713Z,1676682825.713 [NAL9602](ERROR): Data Fault 2023-02-18T01:13:45.735Z,1676682825.735 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-18T01:13:46.117Z,1676682826.117 [NAL9602](INFO): Powering down 2023-02-18T01:13:46.943Z,1676682826.943 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-18T01:13:46.943Z,1676682826.943 [NAL9602] No Fault, FailCount= 1 2023-02-18T01:14:05.925Z,1676682845.925 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230218T005033/Express0001.lzma 2023-02-18T01:14:06.925Z,1676682846.925 [DataOverHttps](INFO): Moved sent file to Logs/20230218T005033/Express0001.lzma.bak 2023-02-18T01:14:06.925Z,1676682846.925 [DataOverHttps](INFO): SBD MOMSN=17483029 2023-02-18T01:14:11.201Z,1676682851.201 [CBIT](INFO): Clearing failed state for component BPC1 2023-02-18T01:14:11.201Z,1676682851.201 [BPC1] No Fault, FailCount= 1 2023-02-18T01:14:16.418Z,1676682856.418 [NAL9602](INFO): Powering up NAL9602 2023-02-18T01:14:27.325Z,1676682867.325 [NAL9602](INFO): NAL9602 initialized 2023-02-18T01:14:33.017Z,1676682873.017 [DataOverHttps](INFO): Sending 1041 bytes from file Logs/20230218T010250/Express0001.lzma 2023-02-18T01:14:34.009Z,1676682874.009 [DataOverHttps](INFO): Moved sent file to Logs/20230218T010250/Express0001.lzma.bak 2023-02-18T01:14:34.010Z,1676682874.010 [DataOverHttps](INFO): SBD MOMSN=17483031 2023-02-18T01:14:49.969Z,1676682889.969 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:14:49.969Z,1676682889.969 [DVL_micro] No Fault, FailCount= 3 2023-02-18T01:14:50.372Z,1676682890.372 [Power24vConverter](INFO): Powering up. 2023-02-18T01:14:58.244Z,1676682898.244 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20230218T010250/Express0005.lzma 2023-02-18T01:14:59.245Z,1676682899.245 [DataOverHttps](INFO): Moved sent file to Logs/20230218T010250/Express0005.lzma.bak 2023-02-18T01:14:59.246Z,1676682899.246 [DataOverHttps](INFO): SBD MOMSN=17483063 2023-02-18T01:15:05.352Z,1676682905.352 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-02-18T01:15:05.352Z,1676682905.352 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-18T01:15:05.371Z,1676682905.371 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-18T01:15:05.773Z,1676682905.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-18T01:15:05.773Z,1676682905.773 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-02-18T01:15:07.775Z,1676682907.775 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:15:07.775Z,1676682907.775 [DVL_micro] Communications Fault, FailCount= 1 2023-02-18T01:15:07.775Z,1676682907.775 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:15:07.851Z,1676682907.851 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:15:08.232Z,1676682908.232 [DVL_micro](INFO): Powering down 2023-02-18T01:15:08.985Z,1676682908.985 [Default:CheckIn:Read_Iridium] Stopped 2023-02-18T01:15:08.985Z,1676682908.985 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-18T01:15:08.985Z,1676682908.985 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-18T01:15:08.999Z,1676682908.999 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:15:09.014Z,1676682909.014 [DVL_micro] No Fault, FailCount= 1 2023-02-18T01:15:12.612Z,1676682912.612 [BPC1](INFO): BPC1A: initialized. 2023-02-18T01:15:12.624Z,1676682912.624 [BPC1](INFO): BPC1B: initialized. 2023-02-18T01:15:14.216Z,1676682914.216 [BPC1](INFO): BPC1A: sending IBPS break. 2023-02-18T01:15:14.216Z,1676682914.216 [BPC1](INFO): BPC1B: sending IBPS break. 2023-02-18T01:15:17.123Z,1676682917.123 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:15:17.123Z,1676682917.123 [WetLabsBB2FL] No Fault, FailCount= 5 2023-02-18T01:15:17.129Z,1676682917.129 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:15:18.261Z,1676682918.261 [BPC1](INFO): BPC1A: validating data format. 2023-02-18T01:15:18.278Z,1676682918.278 [BPC1](INFO): BPC1A: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2023-02-18T01:15:18.278Z,1676682918.278 [BPC1](INFO): BPC1A: got valid message (1824 bytes). 2023-02-18T01:15:18.664Z,1676682918.664 [BPC1](INFO): Looking for stick 018Dto match 0C1E 2023-02-18T01:15:18.665Z,1676682918.665 [BPC1](INFO): Looking for stick 018Dto match 0481 2023-02-18T01:15:18.665Z,1676682918.665 [BPC1](INFO): Looking for stick 018Dto match 047B 2023-02-18T01:15:18.665Z,1676682918.665 [BPC1](INFO): Looking for stick 018Dto match 0464 2023-02-18T01:15:18.666Z,1676682918.666 [BPC1](INFO): Looking for stick 018Dto match 045C 2023-02-18T01:15:18.666Z,1676682918.666 [BPC1](INFO): Looking for stick 018Dto match 046A 2023-02-18T01:15:18.666Z,1676682918.666 [BPC1](INFO): Looking for stick 018Dto match 045A 2023-02-18T01:15:18.667Z,1676682918.667 [BPC1](INFO): Looking for stick 018Dto match 0487 2023-02-18T01:15:18.667Z,1676682918.667 [BPC1](INFO): Looking for stick 018Dto match 03FE 2023-02-18T01:15:18.668Z,1676682918.668 [BPC1](INFO): Looking for stick 018Dto match 0465 2023-02-18T01:15:18.668Z,1676682918.668 [BPC1](INFO): Looking for stick 018Dto match 046B 2023-02-18T01:15:18.668Z,1676682918.668 [BPC1](INFO): Looking for stick 018Dto match 0445 2023-02-18T01:15:18.669Z,1676682918.669 [BPC1](INFO): Looking for stick 018Dto match 040D 2023-02-18T01:15:18.669Z,1676682918.669 [BPC1](INFO): Looking for stick 018Dto match 04AA 2023-02-18T01:15:18.669Z,1676682918.669 [BPC1](INFO): Looking for stick 018Dto match 049A 2023-02-18T01:15:18.670Z,1676682918.670 [BPC1](INFO): Looking for stick 018Dto match 04C6 2023-02-18T01:15:18.670Z,1676682918.670 [BPC1](INFO): Looking for stick 018Dto match 0486 2023-02-18T01:15:18.670Z,1676682918.670 [BPC1](INFO): Looking for stick 018Dto match 0442 2023-02-18T01:15:18.671Z,1676682918.671 [BPC1](INFO): Looking for stick 018Dto match 0457 2023-02-18T01:15:18.671Z,1676682918.671 [BPC1](INFO): Looking for stick 018Dto match 0455 2023-02-18T01:15:18.671Z,1676682918.671 [BPC1](INFO): Looking for stick 018Dto match 04C0 2023-02-18T01:15:18.700Z,1676682918.700 [BPC1](INFO): Looking for stick 018Dto match 0459 2023-02-18T01:15:18.700Z,1676682918.700 [BPC1](INFO): Looking for stick 018Dto match 045F 2023-02-18T01:15:18.701Z,1676682918.701 [BPC1](INFO): Looking for stick 018Dto match 0449 2023-02-18T01:15:18.701Z,1676682918.701 [BPC1](INFO): Looking for stick 018Dto match 0441 2023-02-18T01:15:18.701Z,1676682918.701 [BPC1](INFO): Looking for stick 018Dto match 0460 2023-02-18T01:15:18.702Z,1676682918.702 [BPC1](INFO): Looking for stick 018Dto match 04A8 2023-02-18T01:15:18.702Z,1676682918.702 [BPC1](INFO): Looking for stick 018Dto match 04BF 2023-02-18T01:15:18.702Z,1676682918.702 [BPC1](INFO): Looking for stick 018Dto match 045D 2023-02-18T01:15:18.702Z,1676682918.702 [BPC1](INFO): Looking for stick 018Dto match 04A4 2023-02-18T01:15:18.703Z,1676682918.703 [BPC1](INFO): Looking for stick 018Dto match 04D9 2023-02-18T01:15:18.708Z,1676682918.708 [BPC1](ERROR): BPC1A: No match for serial number 018D in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-02-18T01:15:18.708Z,1676682918.708 [BPC1](INFO): BPC1B: validating data format. 2023-02-18T01:15:18.742Z,1676682918.742 [BPC1](INFO): BPC1B: got 8 stick msg (1824 bytes) with SHORT_IBPS_MENU. 2023-02-18T01:15:18.742Z,1676682918.742 [BPC1](INFO): BPC1B: got valid message (1824 bytes). 2023-02-18T01:15:19.076Z,1676682919.076 [BPC1](INFO): Looking for stick 04CCto match 0BE5 2023-02-18T01:15:19.077Z,1676682919.077 [BPC1](INFO): Looking for stick 04CCto match 0124 2023-02-18T01:15:19.077Z,1676682919.077 [BPC1](INFO): Looking for stick 04CCto match 0162 2023-02-18T01:15:19.077Z,1676682919.077 [BPC1](INFO): Looking for stick 04CCto match 017A 2023-02-18T01:15:19.078Z,1676682919.078 [BPC1](INFO): Looking for stick 04CCto match 0495 2023-02-18T01:15:19.078Z,1676682919.078 [BPC1](INFO): Looking for stick 04CCto match 0458 2023-02-18T01:15:19.078Z,1676682919.078 [BPC1](INFO): Looking for stick 04CCto match 0139 2023-02-18T01:15:19.079Z,1676682919.079 [BPC1](INFO): Looking for stick 04CCto match 00F0 2023-02-18T01:15:19.079Z,1676682919.079 [BPC1](INFO): Looking for stick 04CCto match 0451 2023-02-18T01:15:19.079Z,1676682919.079 [BPC1](INFO): Looking for stick 04CCto match 049E 2023-02-18T01:15:19.080Z,1676682919.080 [BPC1](INFO): Looking for stick 04CCto match 04A2 2023-02-18T01:15:19.080Z,1676682919.080 [BPC1](INFO): Looking for stick 04CCto match 044F 2023-02-18T01:15:19.081Z,1676682919.081 [BPC1](INFO): Looking for stick 04CCto match 047F 2023-02-18T01:15:19.081Z,1676682919.081 [BPC1](INFO): Looking for stick 04CCto match 0496 2023-02-18T01:15:19.081Z,1676682919.081 [BPC1](INFO): Looking for stick 04CCto match 04CE 2023-02-18T01:15:19.081Z,1676682919.081 [BPC1](INFO): Looking for stick 04CCto match 04A5 2023-02-18T01:15:19.082Z,1676682919.082 [BPC1](INFO): Looking for stick 04CCto match 04D7 2023-02-18T01:15:19.082Z,1676682919.082 [BPC1](INFO): Looking for stick 04CCto match 04CA 2023-02-18T01:15:19.082Z,1676682919.082 [BPC1](INFO): Looking for stick 04CCto match 04A1 2023-02-18T01:15:19.083Z,1676682919.083 [BPC1](INFO): Looking for stick 04CCto match 049B 2023-02-18T01:15:19.083Z,1676682919.083 [BPC1](INFO): Looking for stick 04CCto match 04BD 2023-02-18T01:15:19.083Z,1676682919.083 [BPC1](INFO): Looking for stick 04CCto match 0494 2023-02-18T01:15:19.084Z,1676682919.084 [BPC1](INFO): Looking for stick 04CCto match 0466 2023-02-18T01:15:19.084Z,1676682919.084 [BPC1](INFO): Looking for stick 04CCto match 0447 2023-02-18T01:15:19.084Z,1676682919.084 [BPC1](INFO): Looking for stick 04CCto match 0480 2023-02-18T01:15:19.085Z,1676682919.085 [BPC1](INFO): Looking for stick 04CCto match 04A3 2023-02-18T01:15:19.085Z,1676682919.085 [BPC1](INFO): Looking for stick 04CCto match 04C5 2023-02-18T01:15:19.085Z,1676682919.085 [BPC1](INFO): Looking for stick 04CCto match 046D 2023-02-18T01:15:19.086Z,1676682919.086 [BPC1](INFO): Looking for stick 04CCto match 0409 2023-02-18T01:15:19.086Z,1676682919.086 [BPC1](INFO): Looking for stick 04CCto match 04D3 2023-02-18T01:15:19.086Z,1676682919.086 [BPC1](INFO): Looking for stick 04CCto match 0493 2023-02-18T01:15:19.087Z,1676682919.087 [BPC1](ERROR): BPC1B: No match for serial number 04CC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-02-18T01:15:19.092Z,1676682919.092 [BPC1](FAULT): Failed to parse data from all battery packs. 2023-02-18T01:15:19.092Z,1676682919.092 [BPC1] Data Fault, FailCount= 2 2023-02-18T01:15:19.092Z,1676682919.092 [BPC1](ERROR): Data Fault 2023-02-18T01:15:19.167Z,1676682919.167 [CBIT](ERROR): Data Fault in component: BPC1 2023-02-18T01:15:22.423Z,1676682922.423 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:15:22.424Z,1676682922.424 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:15:22.737Z,1676682922.737 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:15:22.924Z,1676682922.924 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:15:23.935Z,1676682923.935 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:15:23.935Z,1676682923.935 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:15:24.137Z,1676682924.137 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:15:26.746Z,1676682926.746 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:15:26.746Z,1676682926.746 [DVL_micro] Communications Fault, FailCount= 2 2023-02-18T01:15:26.746Z,1676682926.746 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:15:26.799Z,1676682926.799 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:15:27.224Z,1676682927.224 [DVL_micro](INFO): Powering down 2023-02-18T01:15:28.009Z,1676682928.009 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:15:28.009Z,1676682928.009 [DVL_micro] No Fault, FailCount= 2 2023-02-18T01:15:29.427Z,1676682929.427 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:15:29.428Z,1676682929.428 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:15:29.623Z,1676682929.623 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:15:29.928Z,1676682929.928 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:15:30.807Z,1676682930.807 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:15:30.807Z,1676682930.807 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:15:31.141Z,1676682931.141 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:15:36.443Z,1676682936.443 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:15:36.444Z,1676682936.444 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:15:36.490Z,1676682936.490 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:15:36.944Z,1676682936.944 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:15:38.074Z,1676682938.074 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:15:38.074Z,1676682938.074 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:15:38.157Z,1676682938.157 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:15:43.451Z,1676682943.451 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:15:43.452Z,1676682943.452 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:15:43.733Z,1676682943.733 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:15:43.952Z,1676682943.952 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:15:44.973Z,1676682944.973 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:15:44.973Z,1676682944.973 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:15:45.165Z,1676682945.165 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:15:45.733Z,1676682945.733 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:15:45.733Z,1676682945.733 [DVL_micro] Communications Fault, FailCount= 3 2023-02-18T01:15:45.733Z,1676682945.733 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:15:45.766Z,1676682945.766 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:15:45.767Z,1676682945.767 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2023-02-18T01:15:46.204Z,1676682946.204 [DVL_micro](INFO): Powering down 2023-02-18T01:15:46.229Z,1676682946.229 [CBIT](INFO): Critical error at 20230218T011545 2023-02-18T01:15:50.455Z,1676682950.455 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:15:50.456Z,1676682950.456 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:15:50.608Z,1676682950.608 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:15:50.609Z,1676682950.609 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:15:50.956Z,1676682950.956 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:18:03.108Z,1676683083.108 [CBIT](INFO): Clearing failed state for component DropWeight 2023-02-18T01:18:03.108Z,1676683083.108 [DropWeight] No Fault, FailCount= 1 2023-02-18T01:18:06.345Z,1676683086.345 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2023-02-18T01:18:06.345Z,1676683086.345 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-18T01:18:06.356Z,1676683086.356 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-18T01:18:06.765Z,1676683086.765 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-18T01:18:06.765Z,1676683086.765 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2023-02-18T01:18:20.502Z,1676683100.502 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:18:20.502Z,1676683100.502 [WetLabsBB2FL] No Fault, FailCount= 5 2023-02-18T01:18:20.841Z,1676683100.841 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:18:26.144Z,1676683106.144 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:18:26.144Z,1676683106.144 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:18:26.154Z,1676683106.154 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:18:26.640Z,1676683106.640 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:18:27.748Z,1676683107.748 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:18:27.748Z,1676683107.748 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:18:27.853Z,1676683107.853 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:18:33.148Z,1676683113.148 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:18:33.148Z,1676683113.148 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:18:33.410Z,1676683113.410 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:18:33.648Z,1676683113.648 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:18:34.649Z,1676683114.649 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:18:34.650Z,1676683114.650 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:18:34.861Z,1676683114.861 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:18:40.151Z,1676683120.151 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:18:40.152Z,1676683120.152 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:18:40.278Z,1676683120.278 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:18:40.656Z,1676683120.656 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:18:41.521Z,1676683121.521 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:18:41.521Z,1676683121.521 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:18:41.869Z,1676683121.869 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:18:45.951Z,1676683125.951 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:18:45.951Z,1676683125.951 [DVL_micro] No Fault, FailCount= 3 2023-02-18T01:18:47.168Z,1676683127.168 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:18:47.168Z,1676683127.168 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:18:47.171Z,1676683127.171 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:18:47.668Z,1676683127.668 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:18:48.784Z,1676683128.784 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:18:48.784Z,1676683128.784 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:18:48.881Z,1676683128.881 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:18:54.175Z,1676683134.175 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:18:54.176Z,1676683134.176 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:18:54.438Z,1676683134.438 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:18:54.439Z,1676683134.439 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:18:54.676Z,1676683134.676 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:19:03.695Z,1676683143.695 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:19:03.695Z,1676683143.695 [DVL_micro] Communications Fault, FailCount= 1 2023-02-18T01:19:03.695Z,1676683143.695 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:19:03.730Z,1676683143.730 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:19:04.172Z,1676683144.172 [DVL_micro](INFO): Powering down 2023-02-18T01:19:04.922Z,1676683144.922 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:19:04.922Z,1676683144.922 [DVL_micro] No Fault, FailCount= 1 2023-02-18T01:19:22.686Z,1676683162.686 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:19:22.686Z,1676683162.686 [DVL_micro] Communications Fault, FailCount= 2 2023-02-18T01:19:22.686Z,1676683162.686 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:19:22.704Z,1676683162.704 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:19:23.156Z,1676683163.156 [DVL_micro](INFO): Powering down 2023-02-18T01:19:23.945Z,1676683163.945 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:19:23.945Z,1676683163.945 [DVL_micro] No Fault, FailCount= 2 2023-02-18T01:19:41.669Z,1676683181.669 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:19:41.670Z,1676683181.670 [DVL_micro] Communications Fault, FailCount= 3 2023-02-18T01:19:41.670Z,1676683181.670 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:19:41.708Z,1676683181.708 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:19:41.708Z,1676683181.708 [CBIT](CRITICAL): Communications Fault in component: DVL_micro 2023-02-18T01:19:42.148Z,1676683182.148 [DVL_micro](INFO): Powering down 2023-02-18T01:19:42.180Z,1676683182.180 [CBIT](INFO): Critical error at 20230218T011941 2023-02-18T01:20:09.553Z,1676683209.553 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-18T01:20:09.553Z,1676683209.553 [Default:CheckIn:C.Wait] Stopped 2023-02-18T01:20:09.553Z,1676683209.553 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-18T01:20:09.553Z,1676683209.553 [Default:CheckIn:D] Running Loop=1 2023-02-18T01:20:09.957Z,1676683209.957 [Default:CheckIn:D] Stopped 2023-02-18T01:20:09.957Z,1676683209.957 [Default:CheckIn:E] Running Loop=1 2023-02-18T01:20:10.389Z,1676683210.389 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.216143 min 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn:E] Stopped 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn] Stopped 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn](INFO): Running loop #2 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn] Running Loop=2 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-18T01:20:10.390Z,1676683210.390 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-18T01:21:07.324Z,1676683267.324 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2023-02-18T01:21:07.324Z,1676683267.324 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-18T01:21:07.354Z,1676683267.354 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-18T01:21:07.738Z,1676683267.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-18T01:21:07.738Z,1676683267.738 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2023-02-18T01:21:24.322Z,1676683284.322 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:21:24.322Z,1676683284.322 [WetLabsBB2FL] No Fault, FailCount= 5 2023-02-18T01:21:24.561Z,1676683284.561 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:21:29.852Z,1676683289.852 [WetLabsBB2FL] Communications Fault, FailCount= 1 2023-02-18T01:21:29.852Z,1676683289.852 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:21:29.957Z,1676683289.957 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:21:30.352Z,1676683290.352 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:21:31.198Z,1676683291.198 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:21:31.199Z,1676683291.199 [WetLabsBB2FL] No Fault, FailCount= 1 2023-02-18T01:21:31.565Z,1676683291.565 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:21:36.859Z,1676683296.859 [WetLabsBB2FL] Communications Fault, FailCount= 2 2023-02-18T01:21:36.860Z,1676683296.860 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:21:37.229Z,1676683297.229 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:21:37.360Z,1676683297.360 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:21:38.467Z,1676683298.467 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:21:38.467Z,1676683298.467 [WetLabsBB2FL] No Fault, FailCount= 2 2023-02-18T01:21:38.573Z,1676683298.573 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:21:43.871Z,1676683303.871 [WetLabsBB2FL] Communications Fault, FailCount= 3 2023-02-18T01:21:43.871Z,1676683303.871 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:21:44.094Z,1676683304.094 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:21:44.373Z,1676683304.373 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:21:45.341Z,1676683305.341 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:21:45.341Z,1676683305.341 [WetLabsBB2FL] No Fault, FailCount= 3 2023-02-18T01:21:45.585Z,1676683305.585 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:21:50.884Z,1676683310.884 [WetLabsBB2FL] Communications Fault, FailCount= 4 2023-02-18T01:21:50.884Z,1676683310.884 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:21:50.967Z,1676683310.967 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:21:51.384Z,1676683311.384 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:21:52.202Z,1676683312.202 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2023-02-18T01:21:52.202Z,1676683312.202 [WetLabsBB2FL] No Fault, FailCount= 4 2023-02-18T01:21:52.597Z,1676683312.597 [WetLabsBB2FL](INFO): Powering up 2023-02-18T01:21:57.888Z,1676683317.888 [WetLabsBB2FL] Communications Fault, FailCount= 5 2023-02-18T01:21:57.888Z,1676683317.888 [WetLabsBB2FL](ERROR): Communications Fault 2023-02-18T01:21:58.241Z,1676683318.241 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:21:58.241Z,1676683318.241 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 2023-02-18T01:21:58.388Z,1676683318.388 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:22:42.020Z,1676683362.020 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:22:42.020Z,1676683362.020 [DVL_micro] No Fault, FailCount= 3 2023-02-18T01:22:59.658Z,1676683379.658 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:22:59.658Z,1676683379.658 [DVL_micro] Communications Fault, FailCount= 1 2023-02-18T01:22:59.659Z,1676683379.659 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:22:59.687Z,1676683379.687 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:23:00.136Z,1676683380.136 [DVL_micro](INFO): Powering down 2023-02-18T01:23:00.941Z,1676683380.941 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-18T01:23:00.941Z,1676683380.941 [DVL_micro] No Fault, FailCount= 1 2023-02-18T01:23:14.884Z,1676683394.884 [CommandExec](IMPORTANT): got command quit 2023-02-18T01:23:15.904Z,1676683395.904 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:15.904Z,1676683395.904 [CommandExec](INFO): Uninitializing the command executive. 2023-02-18T01:23:15.904Z,1676683395.904 [CommandExec](INFO): Uninitializing the command scheduler. 2023-02-18T01:23:15.904Z,1676683395.904 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:16.060Z,1676683396.060 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-02-18T01:23:16.060Z,1676683396.060 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-02-18T01:23:16.060Z,1676683396.060 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:16.061Z,1676683396.061 [NavChartDb](INFO): Join timeout helper Thread ID is 1032 2023-02-18T01:23:16.336Z,1676683396.336 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:16.336Z,1676683396.336 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:16.348Z,1676683396.348 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-02-18T01:23:16.348Z,1676683396.348 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:16.348Z,1676683396.348 [Radio_Surface](INFO): Join timeout helper Thread ID is 1033 2023-02-18T01:23:16.448Z,1676683396.448 [Radio_Surface](INFO): Powering down 2023-02-18T01:23:16.449Z,1676683396.449 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:16.449Z,1676683396.449 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:16.468Z,1676683396.468 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-02-18T01:23:16.468Z,1676683396.468 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:16.468Z,1676683396.468 [Onboard](INFO): Join timeout helper Thread ID is 1034 2023-02-18T01:23:17.252Z,1676683397.252 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-02-18T01:23:18.172Z,1676683398.172 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:18.172Z,1676683398.172 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.200Z,1676683398.200 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-02-18T01:23:18.200Z,1676683398.200 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.201Z,1676683398.201 [DataOverHttps](INFO): Join timeout helper Thread ID is 1035 2023-02-18T01:23:18.256Z,1676683398.256 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:18.256Z,1676683398.256 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.257Z,1676683398.257 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-02-18T01:23:18.257Z,1676683398.257 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.257Z,1676683398.257 [BackseatComponent](INFO): Join timeout helper Thread ID is 1036 2023-02-18T01:23:18.413Z,1676683398.413 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:18.414Z,1676683398.414 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.417Z,1676683398.417 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-02-18T01:23:18.417Z,1676683398.417 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.417Z,1676683398.417 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1037 2023-02-18T01:23:18.645Z,1676683398.645 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-18T01:23:18.645Z,1676683398.645 [DVL_micro] Communications Fault, FailCount= 2 2023-02-18T01:23:18.645Z,1676683398.645 [DVL_micro](ERROR): Communications Fault 2023-02-18T01:23:18.704Z,1676683398.704 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-18T01:23:18.796Z,1676683398.796 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:18.796Z,1676683398.796 [WetLabsBB2FL](INFO): Powering down 2023-02-18T01:23:18.797Z,1676683398.797 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.804Z,1676683398.804 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-02-18T01:23:18.804Z,1676683398.804 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:18.805Z,1676683398.805 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1038 2023-02-18T01:23:19.124Z,1676683399.124 [DVL_micro](INFO): Powering down 2023-02-18T01:23:19.152Z,1676683399.152 [CTD_Seabird](INFO): Powering down 2023-02-18T01:23:19.164Z,1676683399.164 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:19.164Z,1676683399.164 [CTD_Seabird](INFO): Powering down 2023-02-18T01:23:19.176Z,1676683399.176 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.194Z,1676683399.194 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-02-18T01:23:19.194Z,1676683399.194 [logger ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.194Z,1676683399.194 [logger](INFO): Join timeout helper Thread ID is 1039 2023-02-18T01:23:19.229Z,1676683399.229 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:19.230Z,1676683399.230 [logger ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.240Z,1676683399.240 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-02-18T01:23:19.240Z,1676683399.240 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.241Z,1676683399.241 [CommandLine](INFO): Join timeout helper Thread ID is 1040 2023-02-18T01:23:19.288Z,1676683399.288 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:19.288Z,1676683399.288 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.300Z,1676683399.300 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-02-18T01:23:19.301Z,1676683399.301 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.301Z,1676683399.301 [CommandExec](INFO): Join timeout helper Thread ID is 1041 2023-02-18T01:23:19.302Z,1676683399.302 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-02-18T01:23:19.302Z,1676683399.302 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.303Z,1676683399.303 [controlThread](INFO): Join timeout helper Thread ID is 1042 2023-02-18T01:23:19.436Z,1676683399.436 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-18T01:23:19.436Z,1676683399.436 [controlThread](DEBUG): Uninitializing ControlThread 2023-02-18T01:23:19.438Z,1676683399.438 [AHRS_M2](INFO): Powering down 2023-02-18T01:23:19.508Z,1676683399.508 [DVL_micro](INFO): Powering down 2023-02-18T01:23:19.509Z,1676683399.509 [MultiRay](INFO): Powering down. 2023-02-18T01:23:19.510Z,1676683399.510 [NAL9602](INFO): Powering down 2023-02-18T01:23:19.512Z,1676683399.512 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-02-18T01:23:19.513Z,1676683399.513 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-02-18T01:23:19.513Z,1676683399.513 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-02-18T01:23:19.514Z,1676683399.514 [MissionManager](INFO): Uninitializing Mission Default 2023-02-18T01:23:19.514Z,1676683399.514 [Default] Stopped 2023-02-18T01:23:19.514Z,1676683399.514 [Default](DEBUG): Aggregate::uninitialize Default 2023-02-18T01:23:19.514Z,1676683399.514 [Default:B.GoToSurface] Stopped 2023-02-18T01:23:19.514Z,1676683399.514 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-02-18T01:23:19.514Z,1676683399.514 [Default:CheckIn] Stopped 2023-02-18T01:23:19.514Z,1676683399.514 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-18T01:23:19.514Z,1676683399.514 [Default:CheckIn:Read_GPS] Stopped 2023-02-18T01:23:19.517Z,1676683399.517 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-02-18T01:23:19.518Z,1676683399.518 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-02-18T01:23:19.518Z,1676683399.518 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-02-18T01:23:19.518Z,1676683399.518 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-02-18T01:23:19.519Z,1676683399.519 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-02-18T01:23:19.519Z,1676683399.519 [BuoyancyServo](INFO): Powering down 2023-02-18T01:23:19.532Z,1676683399.532 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-02-18T01:23:19.532Z,1676683399.532 [ElevatorServo](INFO): Powering down 2023-02-18T01:23:19.533Z,1676683399.533 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-02-18T01:23:19.533Z,1676683399.533 [MassServo](INFO): Powering down 2023-02-18T01:23:19.534Z,1676683399.534 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-02-18T01:23:19.534Z,1676683399.534 [RudderServo](INFO): Powering down 2023-02-18T01:23:19.535Z,1676683399.535 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-02-18T01:23:19.535Z,1676683399.535 [ThrusterHE](INFO): Powering down 2023-02-18T01:23:19.536Z,1676683399.536 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-02-18T01:23:19.536Z,1676683399.536 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-02-18T01:23:19.536Z,1676683399.536 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-02-18T01:23:19.536Z,1676683399.536 [CBIT](DEBUG): Powering off loads. 2023-02-18T01:23:19.547Z,1676683399.547 [CBIT](DEBUG): Disabling WDT. 2023-02-18T01:23:19.559Z,1676683399.559 [CBIT](DEBUG): Opening all GF detection circuits. 2023-02-18T01:23:19.561Z,1676683399.561 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.612Z,1676683399.612 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.619Z,1676683399.619 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.652Z,1676683399.652 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.655Z,1676683399.655 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.663Z,1676683399.663 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.707Z,1676683399.707 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.765Z,1676683399.765 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-18T01:23:19.828Z,1676683399.828 [logger ThreadHandler](INFO): Thread cancelled.