2023-12-21T19:24:01.949Z,1703186641.949 [Supervisor](DEBUG): Initializing supervisor. 2023-12-21T19:24:01.955Z,1703186641.955 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-12-21T19:24:01.955Z,1703186641.955 [SyncHandler](INFO): Protected caller Thread ID is 1061 2023-12-21T19:24:01.956Z,1703186641.956 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-12-21T19:24:01.957Z,1703186641.957 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-12-21T19:24:01.957Z,1703186641.957 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1062 2023-12-21T19:24:01.961Z,1703186641.961 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-12-21T19:24:01.981Z,1703186641.981 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-12-21T19:24:01.982Z,1703186641.982 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-12-21T19:24:01.983Z,1703186641.983 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1063 2023-12-21T19:24:01.987Z,1703186641.987 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-12-21T19:24:01.988Z,1703186641.988 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-12-21T19:24:01.988Z,1703186641.988 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1064 2023-12-21T19:24:01.990Z,1703186641.990 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-12-21T19:24:01.991Z,1703186641.991 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-12-21T19:24:01.992Z,1703186641.992 [logger ThreadHandler](INFO): Protected caller Thread ID is 1065 2023-12-21T19:24:01.995Z,1703186641.995 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-12-21T19:24:01.996Z,1703186641.996 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-12-21T19:24:01.997Z,1703186641.997 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-12-21T19:24:02.158Z,1703186642.158 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-12-21T19:24:02.158Z,1703186642.158 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-12-21T19:24:02.931Z,1703186642.931 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-12-21T19:24:02.934Z,1703186642.934 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-12-21T19:24:03.153Z,1703186643.153 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-12-21T19:24:03.154Z,1703186643.154 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-12-21T19:24:03.234Z,1703186643.234 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-12-21T19:24:03.366Z,1703186643.366 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-12-21T19:24:03.367Z,1703186643.367 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-12-21T19:24:03.449Z,1703186643.449 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-12-21T19:24:03.555Z,1703186643.555 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-12-21T19:24:03.556Z,1703186643.556 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-12-21T19:24:03.927Z,1703186643.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-12-21T19:24:03.928Z,1703186643.928 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-12-21T19:24:04.397Z,1703186644.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-12-21T19:24:04.398Z,1703186644.398 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-12-21T19:24:04.608Z,1703186644.608 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-12-21T19:24:04.609Z,1703186644.609 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-12-21T19:24:04.789Z,1703186644.789 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-12-21T19:24:04.789Z,1703186644.789 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-12-21T19:24:05.901Z,1703186645.901 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-12-21T19:24:05.902Z,1703186645.902 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-12-21T19:24:06.181Z,1703186646.181 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-12-21T19:24:06.181Z,1703186646.181 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-12-21T19:24:06.399Z,1703186646.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-12-21T19:24:06.400Z,1703186646.400 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-12-21T19:24:06.762Z,1703186646.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-12-21T19:24:06.763Z,1703186646.763 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-12-21T19:24:07.088Z,1703186647.088 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-12-21T19:24:07.090Z,1703186647.090 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2023-12-21T19:24:07.091Z,1703186647.091 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2023-12-21T19:24:07.176Z,1703186647.176 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2023-12-21T19:24:07.337Z,1703186647.337 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2023-12-21T19:24:07.441Z,1703186647.441 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2023-12-21T19:24:07.529Z,1703186647.529 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2023-12-21T19:24:07.625Z,1703186647.625 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2023-12-21T19:24:07.738Z,1703186647.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2023-12-21T19:24:08.005Z,1703186648.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-12-21T19:24:08.006Z,1703186648.006 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2023-12-21T19:24:08.100Z,1703186648.100 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2023-12-21T19:24:08.199Z,1703186648.199 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2023-12-21T19:24:08.336Z,1703186648.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2023-12-21T19:24:08.437Z,1703186648.437 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2023-12-21T19:24:08.438Z,1703186648.438 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-12-21T19:24:08.447Z,1703186648.447 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-12-21T19:24:08.547Z,1703186648.547 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-12-21T19:24:08.548Z,1703186648.548 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-12-21T19:24:08.600Z,1703186648.600 [VerticalControl](DEBUG): Construct VerticalControl. 2023-12-21T19:24:08.659Z,1703186648.659 [VerticalControl] Loaded 2023-12-21T19:24:08.660Z,1703186648.660 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-12-21T19:24:08.662Z,1703186648.662 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-12-21T19:24:08.703Z,1703186648.703 [HorizontalControl] Loaded 2023-12-21T19:24:08.703Z,1703186648.703 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-12-21T19:24:08.706Z,1703186648.706 [SpeedControl](DEBUG): Construct SpeedControl. 2023-12-21T19:24:08.709Z,1703186648.709 [SpeedControl] Loaded 2023-12-21T19:24:08.709Z,1703186648.709 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-12-21T19:24:08.712Z,1703186648.712 [LoopControl](DEBUG): Construct LoopControl. 2023-12-21T19:24:08.712Z,1703186648.712 [LoopControl] Loaded 2023-12-21T19:24:08.712Z,1703186648.712 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-12-21T19:24:08.713Z,1703186648.713 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-12-21T19:24:08.713Z,1703186648.713 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-12-21T19:24:08.764Z,1703186648.764 [DepthRateCalculator] Loaded 2023-12-21T19:24:08.764Z,1703186648.764 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-12-21T19:24:08.769Z,1703186648.769 [PitchRateCalculator] Loaded 2023-12-21T19:24:08.769Z,1703186648.769 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-12-21T19:24:08.779Z,1703186648.779 [SpeedCalculator] Loaded 2023-12-21T19:24:08.779Z,1703186648.779 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-12-21T19:24:08.784Z,1703186648.784 [YawRateCalculator] Loaded 2023-12-21T19:24:08.784Z,1703186648.784 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-12-21T19:24:08.802Z,1703186648.802 [ElevatorOffsetCalculator] Loaded 2023-12-21T19:24:08.802Z,1703186648.802 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-12-21T19:24:08.802Z,1703186648.802 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-12-21T19:24:08.803Z,1703186648.803 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-12-21T19:24:08.830Z,1703186648.830 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-12-21T19:24:08.831Z,1703186648.831 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-12-21T19:24:08.901Z,1703186648.901 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-12-21T19:24:08.902Z,1703186648.902 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-12-21T19:24:09.213Z,1703186649.213 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-12-21T19:24:09.214Z,1703186649.214 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-12-21T19:24:09.356Z,1703186649.356 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-12-21T19:24:09.356Z,1703186649.356 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-12-21T19:24:10.038Z,1703186650.038 [AHRS_M2] Loaded 2023-12-21T19:24:10.038Z,1703186650.038 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-12-21T19:24:10.288Z,1703186650.288 [BackseatComponent] Loaded 2023-12-21T19:24:10.288Z,1703186650.288 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-12-21T19:24:10.289Z,1703186650.289 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409A44E0 2023-12-21T19:24:10.290Z,1703186650.290 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1148 2023-12-21T19:24:10.293Z,1703186650.293 [LcmUniversalReporter] Loaded 2023-12-21T19:24:10.293Z,1703186650.293 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-12-21T19:24:11.107Z,1703186651.107 [BPC1] Loaded 2023-12-21T19:24:11.107Z,1703186651.107 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-12-21T19:24:11.212Z,1703186651.212 [DATMMP] Loaded 2023-12-21T19:24:11.212Z,1703186651.212 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2023-12-21T19:24:11.213Z,1703186651.213 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409D54E0 2023-12-21T19:24:11.214Z,1703186651.214 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 1149 2023-12-21T19:24:11.621Z,1703186651.621 [DataOverHttps] Loaded 2023-12-21T19:24:11.621Z,1703186651.621 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-12-21T19:24:11.622Z,1703186651.622 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A054E0 2023-12-21T19:24:11.622Z,1703186651.622 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1150 2023-12-21T19:24:11.643Z,1703186651.643 [Depth_Keller] Loaded 2023-12-21T19:24:11.643Z,1703186651.643 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-12-21T19:24:11.648Z,1703186651.648 [DropWeight] Loaded 2023-12-21T19:24:11.648Z,1703186651.648 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-12-21T19:24:11.768Z,1703186651.768 [NAL9602] Loaded 2023-12-21T19:24:11.768Z,1703186651.768 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-12-21T19:24:11.798Z,1703186651.798 [Onboard] Loaded 2023-12-21T19:24:11.798Z,1703186651.798 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-12-21T19:24:11.799Z,1703186651.799 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A354E0 2023-12-21T19:24:11.799Z,1703186651.799 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1151 2023-12-21T19:24:11.805Z,1703186651.805 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1 2023-12-21T19:24:11.817Z,1703186651.817 [PowerOnly] Loaded 2023-12-21T19:24:11.817Z,1703186651.817 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2023-12-21T19:24:11.829Z,1703186651.829 [Power24vConverter] Loaded 2023-12-21T19:24:11.829Z,1703186651.829 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-12-21T19:24:11.842Z,1703186651.842 [Radio_Surface] Loaded 2023-12-21T19:24:11.842Z,1703186651.842 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-12-21T19:24:11.843Z,1703186651.843 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A654E0 2023-12-21T19:24:11.843Z,1703186651.843 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1152 2023-12-21T19:24:11.888Z,1703186651.888 [RDI_Pathfinder] Loaded 2023-12-21T19:24:11.888Z,1703186651.888 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2023-12-21T19:24:11.889Z,1703186651.889 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-12-21T19:24:11.890Z,1703186651.890 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-12-21T19:24:12.162Z,1703186652.162 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-12-21T19:24:12.162Z,1703186652.162 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-12-21T19:24:12.176Z,1703186652.176 [NavChart] Loaded 2023-12-21T19:24:12.176Z,1703186652.176 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-12-21T19:24:12.182Z,1703186652.182 [UniversalFixResidualReporter] Loaded 2023-12-21T19:24:12.182Z,1703186652.182 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-12-21T19:24:12.182Z,1703186652.182 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-12-21T19:24:12.183Z,1703186652.183 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-12-21T19:24:12.324Z,1703186652.324 [SBIT](DEBUG): Construct Startup Built In Test. 2023-12-21T19:24:12.332Z,1703186652.332 [SBIT] Loaded 2023-12-21T19:24:12.333Z,1703186652.333 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-12-21T19:24:12.336Z,1703186652.336 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-12-21T19:24:12.348Z,1703186652.348 [IBIT] Loaded 2023-12-21T19:24:12.348Z,1703186652.348 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-12-21T19:24:12.354Z,1703186652.354 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-12-21T19:24:12.458Z,1703186652.458 [CBIT] Loaded 2023-12-21T19:24:12.458Z,1703186652.458 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-12-21T19:24:12.459Z,1703186652.459 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-12-21T19:24:12.459Z,1703186652.459 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-12-21T19:24:12.588Z,1703186652.588 [BuoyancyServo] Loaded 2023-12-21T19:24:12.588Z,1703186652.588 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-12-21T19:24:12.609Z,1703186652.609 [ElevatorServo] Loaded 2023-12-21T19:24:12.609Z,1703186652.609 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-12-21T19:24:12.628Z,1703186652.628 [MassServo] Loaded 2023-12-21T19:24:12.629Z,1703186652.629 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-12-21T19:24:12.647Z,1703186652.647 [RudderServo] Loaded 2023-12-21T19:24:12.648Z,1703186652.648 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-12-21T19:24:12.665Z,1703186652.665 [ThrusterServo] Loaded 2023-12-21T19:24:12.665Z,1703186652.665 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2023-12-21T19:24:12.665Z,1703186652.665 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-12-21T19:24:12.666Z,1703186652.666 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-12-21T19:24:12.676Z,1703186652.676 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-12-21T19:24:12.677Z,1703186652.677 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-12-21T19:24:12.854Z,1703186652.854 [CTD_Seabird] Loaded 2023-12-21T19:24:12.854Z,1703186652.854 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-12-21T19:24:12.855Z,1703186652.855 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB04E0 2023-12-21T19:24:12.855Z,1703186652.855 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1153 2023-12-21T19:24:12.875Z,1703186652.875 [PAR_Licor] Loaded 2023-12-21T19:24:12.876Z,1703186652.876 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-12-21T19:24:12.916Z,1703186652.916 [WetLabsBB2FL] Loaded 2023-12-21T19:24:12.916Z,1703186652.916 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-12-21T19:24:12.917Z,1703186652.917 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BE04E0 2023-12-21T19:24:12.918Z,1703186652.918 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1154 2023-12-21T19:24:12.938Z,1703186652.938 [WetLabsUBAT] Loaded 2023-12-21T19:24:12.938Z,1703186652.938 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2023-12-21T19:24:12.939Z,1703186652.939 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C104E0 2023-12-21T19:24:12.940Z,1703186652.940 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 1155 2023-12-21T19:24:12.940Z,1703186652.940 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-12-21T19:24:12.946Z,1703186652.946 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-12-21T19:24:12.950Z,1703186652.950 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-12-21T19:24:12.961Z,1703186652.961 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-12-21T19:24:12.962Z,1703186652.962 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C404E0 2023-12-21T19:24:12.962Z,1703186652.962 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1156 2023-12-21T19:24:12.969Z,1703186652.969 [Supervisor](INFO): Main Thread ID is 1060 2023-12-21T19:24:12.969Z,1703186652.969 [Supervisor](DEBUG): Running supervisor. 2023-12-21T19:24:12.970Z,1703186652.970 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1157 2023-12-21T19:24:12.971Z,1703186652.971 [CommandExec](INFO): Initializing the command executive. 2023-12-21T19:24:12.973Z,1703186652.973 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1158 2023-12-21T19:24:12.976Z,1703186652.976 [controlThread ThreadHandler](INFO): Handler Thread ID is 1159 2023-12-21T19:24:12.977Z,1703186652.977 [controlThread](DEBUG): Initializing ControlThread 2023-12-21T19:24:12.978Z,1703186652.978 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-12-21T19:24:12.979Z,1703186652.979 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-12-21T19:24:12.980Z,1703186652.980 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-12-21T19:24:12.981Z,1703186652.981 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-12-21T19:24:12.981Z,1703186652.981 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-12-21T19:24:12.981Z,1703186652.981 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-12-21T19:24:12.982Z,1703186652.982 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-12-21T19:24:12.982Z,1703186652.982 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-12-21T19:24:12.983Z,1703186652.983 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-12-21T19:24:12.991Z,1703186652.991 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-12-21T19:24:12.991Z,1703186652.991 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-12-21T19:24:12.991Z,1703186652.991 [SBIT](INFO): Initialize SBIT Component. 2023-12-21T19:24:12.992Z,1703186652.992 [SBIT](IMPORTANT): git: 2023-09-19-129-gab521801b 2023-12-21T19:24:12.992Z,1703186652.992 [SBIT](INFO): git hash: ab521801bd358af2637988023b5df7aa0b099e2d 2023-12-21T19:24:12.992Z,1703186652.992 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-12-21T19:24:12.994Z,1703186652.994 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-12-21T19:24:12.995Z,1703186652.995 [SBIT](INFO): Beginning SBIT in 36.000000 seconds. 2023-12-21T19:24:12.995Z,1703186652.995 [IBIT](INFO): Initialize IBIT Component. 2023-12-21T19:24:12.996Z,1703186652.996 [CBIT](DEBUG): Initialize CBIT Component. 2023-12-21T19:24:12.997Z,1703186652.997 [logger ThreadHandler](INFO): Handler Thread ID is 1160 2023-12-21T19:24:13.008Z,1703186653.008 [CBIT](DEBUG): Initialized mux pins. 2023-12-21T19:24:13.008Z,1703186653.008 [CBIT](DEBUG): Initializing the watchdog timer. 2023-12-21T19:24:13.016Z,1703186653.016 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1161 2023-12-21T19:24:13.028Z,1703186653.028 [DATMMP ThreadHandler](INFO): Handler Thread ID is 1162 2023-12-21T19:24:13.029Z,1703186653.029 [DATMMP](INFO): Start 2023-12-21T19:24:13.029Z,1703186653.029 [DATMMP](INFO): Powering up 2023-12-21T19:24:13.029Z,1703186653.029 [DATMMP](DEBUG): Initializing DATMMP. 2023-12-21T19:24:13.032Z,1703186653.032 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-12-21T19:24:13.032Z,1703186653.032 [CBIT](DEBUG): Initializing heartbeat. 2023-12-21T19:24:13.034Z,1703186653.034 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1164 2023-12-21T19:24:13.035Z,1703186653.035 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-12-21T19:24:13.045Z,1703186653.045 [Onboard ThreadHandler](INFO): Handler Thread ID is 1165 2023-12-21T19:24:13.075Z,1703186653.075 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1166 2023-12-21T19:24:13.088Z,1703186653.088 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1167 2023-12-21T19:24:13.089Z,1703186653.089 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-12-21T19:24:13.093Z,1703186653.093 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1169 2023-12-21T19:24:13.096Z,1703186653.096 [WetLabsBB2FL](INFO): Powering up 2023-12-21T19:24:13.098Z,1703186653.098 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 1171 2023-12-21T19:24:13.100Z,1703186653.100 [WetLabsUBAT](INFO): Powering up 2023-12-21T19:24:13.102Z,1703186653.102 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1173 2023-12-21T19:24:13.104Z,1703186653.104 [CBIT](DEBUG): Deactivating GF circuits. 2023-12-21T19:24:13.104Z,1703186653.104 [CBIT](DEBUG): Deactivating emergency mode. 2023-12-21T19:24:13.111Z,1703186653.111 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-12-21T19:24:13.111Z,1703186653.111 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-12-21T19:24:13.112Z,1703186653.112 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-12-21T19:24:13.112Z,1703186653.112 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-12-21T19:24:13.112Z,1703186653.112 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-12-21T19:24:13.112Z,1703186653.112 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-12-21T19:24:13.113Z,1703186653.113 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-12-21T19:24:13.113Z,1703186653.113 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-12-21T19:24:13.144Z,1703186653.144 [CBIT](DEBUG): Backplane powered. 2023-12-21T19:24:13.149Z,1703186653.149 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-12-21T19:24:13.165Z,1703186653.165 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-12-21T19:24:13.201Z,1703186653.201 [MissionManager](DEBUG): 2023-12-21T19:24:13.202Z,1703186653.202 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-12-21T19:24:13.280Z,1703186653.280 [DATMMP](INFO): Starting 2023-12-21T19:24:13.307Z,1703186653.307 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-12-21T19:24:13.308Z,1703186653.308 [Default:A.Wait](DEBUG): Construct Wait. 2023-12-21T19:24:13.311Z,1703186653.311 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-12-21T19:24:13.345Z,1703186653.345 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-12-21T19:24:13.347Z,1703186653.347 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-12-21T19:24:13.386Z,1703186653.386 [Default:E.Execute](DEBUG): Construct Execute. 2023-12-21T19:24:13.389Z,1703186653.389 [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-12-21T19:24:13.400Z,1703186653.400 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-12-21T19:24:13.412Z,1703186653.412 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-12-21T19:24:13.476Z,1703186653.476 [Radio_Surface](INFO): Powering up 2023-12-21T19:24:13.524Z,1703186653.524 [PowerOnly](INFO): Powering up loadControl 2023-12-21T19:24:13.532Z,1703186653.532 [DATMMP](INFO): Starting 2023-12-21T19:24:13.542Z,1703186653.542 [Power24vConverter](INFO): Powering up. 2023-12-21T19:24:13.543Z,1703186653.543 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2023-12-21T19:24:13.606Z,1703186653.606 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-12-21T19:24:13.612Z,1703186653.612 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-12-21T19:24:13.613Z,1703186653.613 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-12-21T19:24:13.620Z,1703186653.620 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-12-21T19:24:13.621Z,1703186653.621 [MassServo](DEBUG): Initializing EZServoServo. 2023-12-21T19:24:13.629Z,1703186653.629 [MassServo](DEBUG): Initializing MassServo. 2023-12-21T19:24:13.629Z,1703186653.629 [RudderServo](DEBUG): Initializing EZServoServo. 2023-12-21T19:24:13.636Z,1703186653.636 [RudderServo](DEBUG): Initializing RudderServo. 2023-12-21T19:24:13.637Z,1703186653.637 [ThrusterServo](DEBUG): Initializing EZServoServo. 2023-12-21T19:24:13.664Z,1703186653.664 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2023-12-21T19:24:13.784Z,1703186653.784 [DATMMP](INFO): Starting 2023-12-21T19:24:13.857Z,1703186653.857 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m 2023-12-21T19:24:13.858Z,1703186653.858 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2023-12-21T19:24:13.858Z,1703186653.858 [DropWeight] Hardware Fault, FailCount= 1 2023-12-21T19:24:13.858Z,1703186653.858 [DropWeight](ERROR): Hardware Fault 2023-12-21T19:24:13.895Z,1703186653.895 [CommandExec](FAULT): Scheduling is paused 2023-12-21T19:24:13.895Z,1703186653.895 [CBIT](INFO): Critical error at 20231221T192413 2023-12-21T19:24:13.895Z,1703186653.895 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-12-21T19:24:13.907Z,1703186653.907 [CBIT](ERROR): Hardware Fault in component: DropWeight 2023-12-21T19:24:13.907Z,1703186653.907 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2023-12-21T19:24:14.049Z,1703186654.049 [DATMMP](INFO): Starting 2023-12-21T19:24:14.249Z,1703186654.249 [CBIT](INFO): Critical error at 20231221T192413 2023-12-21T19:24:14.300Z,1703186654.300 [DATMMP](INFO): Starting 2023-12-21T19:24:14.552Z,1703186654.552 [DATMMP](INFO): Starting 2023-12-21T19:24:14.804Z,1703186654.804 [DATMMP](INFO): Starting 2023-12-21T19:24:15.056Z,1703186655.056 [DATMMP](INFO): Starting 2023-12-21T19:24:15.308Z,1703186655.308 [DATMMP](INFO): Starting 2023-12-21T19:24:15.560Z,1703186655.560 [DATMMP](INFO): Starting 2023-12-21T19:24:15.708Z,1703186655.708 [WetLabsBB2FL](INFO): Powering down 2023-12-21T19:24:15.812Z,1703186655.812 [DATMMP](INFO): Starting 2023-12-21T19:24:16.064Z,1703186656.064 [DATMMP](INFO): Starting 2023-12-21T19:24:16.327Z,1703186656.327 [DATMMP](INFO): Starting 2023-12-21T19:24:16.580Z,1703186656.580 [DATMMP](INFO): Starting 2023-12-21T19:24:16.832Z,1703186656.832 [DATMMP](INFO): Starting 2023-12-21T19:24:17.084Z,1703186657.084 [DATMMP](INFO): Starting 2023-12-21T19:24:17.336Z,1703186657.336 [DATMMP](INFO): Starting 2023-12-21T19:24:17.589Z,1703186657.589 [DATMMP](INFO): Starting 2023-12-21T19:24:17.840Z,1703186657.840 [DATMMP](INFO): Starting 2023-12-21T19:24:18.092Z,1703186658.092 [DATMMP](INFO): Starting 2023-12-21T19:24:18.344Z,1703186658.344 [DATMMP](INFO): Starting 2023-12-21T19:24:18.596Z,1703186658.596 [DATMMP](INFO): Starting 2023-12-21T19:24:18.848Z,1703186658.848 [DATMMP](INFO): Starting 2023-12-21T19:24:19.100Z,1703186659.100 [DATMMP](INFO): Starting 2023-12-21T19:24:19.352Z,1703186659.352 [DATMMP](INFO): Starting 2023-12-21T19:24:19.604Z,1703186659.604 [DATMMP](INFO): Starting 2023-12-21T19:24:19.856Z,1703186659.856 [DATMMP](INFO): Starting 2023-12-21T19:24:20.108Z,1703186660.108 [DATMMP](INFO): Starting 2023-12-21T19:24:20.360Z,1703186660.360 [DATMMP](INFO): Starting 2023-12-21T19:24:20.612Z,1703186660.612 [DATMMP](INFO): Starting 2023-12-21T19:24:20.864Z,1703186660.864 [DATMMP](INFO): Starting 2023-12-21T19:24:21.116Z,1703186661.116 [DATMMP](INFO): Starting 2023-12-21T19:24:21.368Z,1703186661.368 [DATMMP](INFO): Starting 2023-12-21T19:24:21.620Z,1703186661.620 [DATMMP](INFO): Starting 2023-12-21T19:24:21.872Z,1703186661.872 [DATMMP](INFO): Starting 2023-12-21T19:24:22.124Z,1703186662.124 [DATMMP](INFO): Starting 2023-12-21T19:24:22.373Z,1703186662.373 [WetLabsUBAT](INFO): Powering down 2023-12-21T19:24:22.376Z,1703186662.376 [DATMMP](INFO): Starting 2023-12-21T19:24:22.628Z,1703186662.628 [DATMMP](INFO): Starting 2023-12-21T19:24:22.880Z,1703186662.880 [DATMMP](INFO): Starting 2023-12-21T19:24:23.132Z,1703186663.132 [DATMMP](INFO): Starting 2023-12-21T19:24:23.384Z,1703186663.384 [DATMMP](INFO): Starting 2023-12-21T19:24:23.636Z,1703186663.636 [DATMMP](INFO): Starting 2023-12-21T19:24:23.888Z,1703186663.888 [DATMMP](INFO): Starting 2023-12-21T19:24:24.140Z,1703186664.140 [DATMMP](INFO): Starting 2023-12-21T19:24:24.392Z,1703186664.392 [DATMMP](INFO): Starting 2023-12-21T19:24:24.644Z,1703186664.644 [DATMMP](INFO): Starting 2023-12-21T19:24:24.896Z,1703186664.896 [DATMMP](INFO): Starting 2023-12-21T19:24:25.148Z,1703186665.148 [DATMMP](INFO): Starting 2023-12-21T19:24:25.400Z,1703186665.400 [DATMMP](INFO): Starting 2023-12-21T19:24:25.652Z,1703186665.652 [DATMMP](INFO): Starting 2023-12-21T19:24:25.904Z,1703186665.904 [DATMMP](INFO): Starting 2023-12-21T19:24:26.156Z,1703186666.156 [DATMMP](INFO): Starting 2023-12-21T19:24:26.409Z,1703186666.409 [DATMMP](INFO): Starting 2023-12-21T19:24:26.660Z,1703186666.660 [DATMMP](INFO): Starting 2023-12-21T19:24:26.912Z,1703186666.912 [DATMMP](INFO): Starting 2023-12-21T19:24:27.164Z,1703186667.164 [DATMMP](INFO): Starting 2023-12-21T19:24:27.416Z,1703186667.416 [DATMMP](INFO): Starting 2023-12-21T19:24:27.458Z,1703186667.458 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004805 2023-12-21T19:24:27.668Z,1703186667.668 [DATMMP](INFO): Starting 2023-12-21T19:24:27.920Z,1703186667.920 [DATMMP](INFO): Starting 2023-12-21T19:24:28.172Z,1703186668.172 [DATMMP](INFO): Starting 2023-12-21T19:24:28.424Z,1703186668.424 [DATMMP](INFO): Starting 2023-12-21T19:24:28.676Z,1703186668.676 [DATMMP](INFO): Starting 2023-12-21T19:24:28.928Z,1703186668.928 [DATMMP](INFO): Starting 2023-12-21T19:24:29.180Z,1703186669.180 [DATMMP](INFO): Starting 2023-12-21T19:24:29.432Z,1703186669.432 [DATMMP](INFO): Starting 2023-12-21T19:24:29.684Z,1703186669.684 [DATMMP](INFO): Starting 2023-12-21T19:24:29.936Z,1703186669.936 [DATMMP](INFO): Starting 2023-12-21T19:24:30.188Z,1703186670.188 [DATMMP](INFO): Starting 2023-12-21T19:24:30.440Z,1703186670.440 [DATMMP](INFO): Starting 2023-12-21T19:24:30.692Z,1703186670.692 [DATMMP](INFO): Starting 2023-12-21T19:24:30.944Z,1703186670.944 [DATMMP](INFO): Starting 2023-12-21T19:24:31.196Z,1703186671.196 [DATMMP](INFO): Starting 2023-12-21T19:24:31.448Z,1703186671.448 [DATMMP](INFO): Starting 2023-12-21T19:24:31.700Z,1703186671.700 [DATMMP](INFO): Starting 2023-12-21T19:24:31.952Z,1703186671.952 [DATMMP](INFO): Starting 2023-12-21T19:24:32.204Z,1703186672.204 [DATMMP](INFO): Starting 2023-12-21T19:24:32.456Z,1703186672.456 [DATMMP](INFO): Starting 2023-12-21T19:24:32.708Z,1703186672.708 [DATMMP](INFO): Starting 2023-12-21T19:24:32.960Z,1703186672.960 [DATMMP](INFO): Starting 2023-12-21T19:24:33.212Z,1703186673.212 [DATMMP](INFO): Starting 2023-12-21T19:24:33.464Z,1703186673.464 [DATMMP](INFO): Starting 2023-12-21T19:24:33.716Z,1703186673.716 [DATMMP](INFO): Starting 2023-12-21T19:24:33.968Z,1703186673.968 [DATMMP](INFO): Starting 2023-12-21T19:24:34.220Z,1703186674.220 [DATMMP](INFO): Starting 2023-12-21T19:24:34.472Z,1703186674.472 [DATMMP](INFO): Starting 2023-12-21T19:24:34.724Z,1703186674.724 [DATMMP](INFO): Starting 2023-12-21T19:24:34.976Z,1703186674.976 [DATMMP](INFO): Starting 2023-12-21T19:24:35.228Z,1703186675.228 [DATMMP](INFO): Starting 2023-12-21T19:24:35.480Z,1703186675.480 [DATMMP](INFO): Starting 2023-12-21T19:24:35.732Z,1703186675.732 [DATMMP](INFO): Starting 2023-12-21T19:24:35.984Z,1703186675.984 [DATMMP](INFO): Starting 2023-12-21T19:24:36.236Z,1703186676.236 [DATMMP](INFO): Starting 2023-12-21T19:24:36.488Z,1703186676.488 [DATMMP](INFO): Starting 2023-12-21T19:24:36.740Z,1703186676.740 [DATMMP](INFO): Starting 2023-12-21T19:24:36.992Z,1703186676.992 [DATMMP](INFO): Starting 2023-12-21T19:24:37.244Z,1703186677.244 [DATMMP](INFO): Starting 2023-12-21T19:24:37.496Z,1703186677.496 [DATMMP](INFO): Starting 2023-12-21T19:24:37.748Z,1703186677.748 [DATMMP](INFO): Starting 2023-12-21T19:24:38.000Z,1703186678.000 [DATMMP](INFO): Starting 2023-12-21T19:24:38.252Z,1703186678.252 [DATMMP](INFO): Starting 2023-12-21T19:24:38.504Z,1703186678.504 [DATMMP](INFO): Starting 2023-12-21T19:24:38.756Z,1703186678.756 [DATMMP](INFO): Starting 2023-12-21T19:24:39.008Z,1703186679.008 [DATMMP](INFO): Starting 2023-12-21T19:24:39.260Z,1703186679.260 [DATMMP](INFO): Starting 2023-12-21T19:24:39.512Z,1703186679.512 [DATMMP](INFO): Starting 2023-12-21T19:24:39.764Z,1703186679.764 [DATMMP](INFO): Starting 2023-12-21T19:24:40.016Z,1703186680.016 [DATMMP](INFO): Starting 2023-12-21T19:24:40.268Z,1703186680.268 [DATMMP](INFO): Starting 2023-12-21T19:24:40.520Z,1703186680.520 [DATMMP](INFO): Starting 2023-12-21T19:24:40.772Z,1703186680.772 [DATMMP](INFO): Starting 2023-12-21T19:24:41.024Z,1703186681.024 [DATMMP](INFO): Starting 2023-12-21T19:24:41.276Z,1703186681.276 [DATMMP](INFO): Starting 2023-12-21T19:24:41.528Z,1703186681.528 [DATMMP](INFO): Starting 2023-12-21T19:24:41.780Z,1703186681.780 [DATMMP](INFO): Starting 2023-12-21T19:24:42.032Z,1703186682.032 [DATMMP](INFO): Starting 2023-12-21T19:24:42.105Z,1703186682.105 [NAL9602](INFO): Powering up NAL9602 2023-12-21T19:24:42.285Z,1703186682.285 [DATMMP](INFO): Starting 2023-12-21T19:24:42.536Z,1703186682.536 [DATMMP](INFO): Starting 2023-12-21T19:24:42.788Z,1703186682.788 [DATMMP](INFO): Starting 2023-12-21T19:24:43.041Z,1703186683.041 [DATMMP](INFO): Starting 2023-12-21T19:24:43.292Z,1703186683.292 [DATMMP](INFO): Starting 2023-12-21T19:24:43.544Z,1703186683.544 [DATMMP](INFO): Starting 2023-12-21T19:24:43.796Z,1703186683.796 [DATMMP](INFO): Starting 2023-12-21T19:24:44.048Z,1703186684.048 [DATMMP](INFO): Starting 2023-12-21T19:24:44.300Z,1703186684.300 [DATMMP](INFO): Starting 2023-12-21T19:24:44.552Z,1703186684.552 [DATMMP](INFO): Starting 2023-12-21T19:24:44.804Z,1703186684.804 [DATMMP](INFO): Starting 2023-12-21T19:24:45.057Z,1703186685.057 [DATMMP](INFO): Starting 2023-12-21T19:24:45.308Z,1703186685.308 [DATMMP](INFO): Starting 2023-12-21T19:24:45.560Z,1703186685.560 [DATMMP](INFO): Starting 2023-12-21T19:24:45.812Z,1703186685.812 [DATMMP](INFO): Starting 2023-12-21T19:24:46.064Z,1703186686.064 [DATMMP](INFO): Starting 2023-12-21T19:24:46.316Z,1703186686.316 [DATMMP](INFO): Starting 2023-12-21T19:24:46.568Z,1703186686.568 [DATMMP](INFO): Starting 2023-12-21T19:24:46.820Z,1703186686.820 [DATMMP](INFO): Starting 2023-12-21T19:24:47.073Z,1703186687.073 [DATMMP](INFO): Starting 2023-12-21T19:24:47.324Z,1703186687.324 [DATMMP](INFO): Starting 2023-12-21T19:24:47.576Z,1703186687.576 [DATMMP](INFO): Starting 2023-12-21T19:24:47.828Z,1703186687.828 [DATMMP](INFO): Starting 2023-12-21T19:24:48.081Z,1703186688.081 [DATMMP](INFO): Starting 2023-12-21T19:24:48.332Z,1703186688.332 [DATMMP](INFO): Starting 2023-12-21T19:24:48.584Z,1703186688.584 [DATMMP](INFO): Starting 2023-12-21T19:24:48.836Z,1703186688.836 [DATMMP](INFO): Starting 2023-12-21T19:24:49.089Z,1703186689.089 [DATMMP](INFO): Starting 2023-12-21T19:24:49.340Z,1703186689.340 [DATMMP](INFO): Starting 2023-12-21T19:24:49.458Z,1703186689.458 [SBIT](IMPORTANT): Beginning Startup BIT 2023-12-21T19:24:49.471Z,1703186689.471 [CBIT](IMPORTANT): Beginning ground fault scan 2023-12-21T19:24:49.592Z,1703186689.592 [DATMMP](INFO): Starting 2023-12-21T19:24:49.844Z,1703186689.844 [DATMMP](INFO): Starting 2023-12-21T19:24:50.096Z,1703186690.096 [DATMMP](INFO): Starting 2023-12-21T19:24:50.348Z,1703186690.348 [DATMMP](INFO): Starting 2023-12-21T19:24:50.600Z,1703186690.600 [DATMMP](INFO): Starting 2023-12-21T19:24:50.852Z,1703186690.852 [DATMMP](INFO): Starting 2023-12-21T19:24:51.105Z,1703186691.105 [DATMMP](INFO): Starting 2023-12-21T19:24:51.356Z,1703186691.356 [DATMMP](INFO): Starting 2023-12-21T19:24:51.608Z,1703186691.608 [DATMMP](INFO): Starting 2023-12-21T19:24:51.861Z,1703186691.861 [DATMMP](INFO): Starting 2023-12-21T19:24:52.112Z,1703186692.112 [DATMMP](INFO): Starting 2023-12-21T19:24:52.364Z,1703186692.364 [DATMMP](INFO): Starting 2023-12-21T19:24:52.616Z,1703186692.616 [DATMMP](INFO): Starting 2023-12-21T19:24:52.868Z,1703186692.868 [DATMMP](INFO): Starting 2023-12-21T19:24:53.013Z,1703186693.013 [NAL9602](INFO): NAL9602 initialized 2023-12-21T19:24:53.121Z,1703186693.121 [DATMMP](INFO): Starting 2023-12-21T19:24:53.372Z,1703186693.372 [DATMMP](INFO): Starting 2023-12-21T19:24:53.624Z,1703186693.624 [DATMMP](INFO): Starting 2023-12-21T19:24:53.876Z,1703186693.876 [DATMMP](INFO): Starting 2023-12-21T19:24:54.128Z,1703186694.128 [DATMMP](INFO): Starting 2023-12-21T19:24:54.383Z,1703186694.383 [DATMMP](INFO): Starting 2023-12-21T19:24:54.636Z,1703186694.636 [DATMMP](INFO): Starting 2023-12-21T19:24:54.888Z,1703186694.888 [DATMMP](INFO): Starting 2023-12-21T19:24:55.140Z,1703186695.140 [DATMMP](INFO): Starting 2023-12-21T19:24:55.392Z,1703186695.392 [DATMMP](INFO): Starting 2023-12-21T19:24:55.644Z,1703186695.644 [DATMMP](INFO): Starting 2023-12-21T19:24:55.896Z,1703186695.896 [DATMMP](INFO): Starting 2023-12-21T19:24:56.148Z,1703186696.148 [DATMMP](INFO): Starting 2023-12-21T19:24:56.400Z,1703186696.400 [DATMMP](INFO): Starting 2023-12-21T19:24:56.653Z,1703186696.653 [DATMMP](INFO): Starting 2023-12-21T19:24:56.904Z,1703186696.904 [DATMMP](INFO): Starting 2023-12-21T19:24:57.156Z,1703186697.156 [DATMMP](INFO): Starting 2023-12-21T19:24:57.408Z,1703186697.408 [DATMMP](INFO): Starting 2023-12-21T19:24:57.660Z,1703186697.660 [DATMMP](INFO): Starting 2023-12-21T19:24:57.912Z,1703186697.912 [DATMMP](INFO): Starting 2023-12-21T19:24:58.164Z,1703186698.164 [DATMMP](INFO): Starting 2023-12-21T19:24:58.416Z,1703186698.416 [DATMMP](INFO): Starting 2023-12-21T19:24:58.668Z,1703186698.668 [DATMMP](INFO): Starting 2023-12-21T19:24:58.920Z,1703186698.920 [DATMMP](INFO): Starting 2023-12-21T19:24:59.174Z,1703186699.174 [DATMMP](INFO): Starting 2023-12-21T19:24:59.424Z,1703186699.424 [DATMMP](INFO): Starting 2023-12-21T19:24:59.676Z,1703186699.676 [DATMMP](INFO): Starting 2023-12-21T19:24:59.928Z,1703186699.928 [DATMMP](INFO): Starting 2023-12-21T19:25:00.180Z,1703186700.180 [DATMMP](INFO): Starting 2023-12-21T19:25:00.379Z,1703186700.379 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.011420 CHAN A1 (24V): 0.004609 CHAN A2 (12V): -0.005185 CHAN A3 (5V): -0.001557 CHAN B0 (3.3V): 0.000123 CHAN B1 (3.15aV): 0.000579 CHAN B2 (3.15bV): 0.000572 CHAN B3 (GND): 0.001615 OPEN: 0.005364 Full Scale: +/- 1 mA 2023-12-21T19:25:00.432Z,1703186700.432 [DATMMP](INFO): Starting 2023-12-21T19:25:00.684Z,1703186700.684 [DATMMP](INFO): Starting 2023-12-21T19:25:00.936Z,1703186700.936 [DATMMP](INFO): Starting 2023-12-21T19:25:01.188Z,1703186701.188 [DATMMP](INFO): Starting 2023-12-21T19:25:01.440Z,1703186701.440 [DATMMP](INFO): Starting 2023-12-21T19:25:01.692Z,1703186701.692 [DATMMP](INFO): Starting 2023-12-21T19:25:01.944Z,1703186701.944 [DATMMP](INFO): Starting 2023-12-21T19:25:02.196Z,1703186702.196 [DATMMP](INFO): Starting 2023-12-21T19:25:02.448Z,1703186702.448 [DATMMP](INFO): Starting 2023-12-21T19:25:02.704Z,1703186702.704 [DATMMP](INFO): Starting 2023-12-21T19:25:02.952Z,1703186702.952 [DATMMP](INFO): Starting 2023-12-21T19:25:03.204Z,1703186703.204 [DATMMP](INFO): Starting 2023-12-21T19:25:03.456Z,1703186703.456 [DATMMP](INFO): Starting 2023-12-21T19:25:03.708Z,1703186703.708 [DATMMP](INFO): Starting 2023-12-21T19:25:03.960Z,1703186703.960 [DATMMP](INFO): Starting 2023-12-21T19:25:04.212Z,1703186704.212 [DATMMP](INFO): Starting 2023-12-21T19:25:04.464Z,1703186704.464 [DATMMP](INFO): Starting 2023-12-21T19:25:04.716Z,1703186704.716 [DATMMP](INFO): Starting 2023-12-21T19:25:04.968Z,1703186704.968 [DATMMP](INFO): Starting 2023-12-21T19:25:05.220Z,1703186705.220 [DATMMP](INFO): Starting 2023-12-21T19:25:05.472Z,1703186705.472 [DATMMP](INFO): Starting 2023-12-21T19:25:05.724Z,1703186705.724 [DATMMP](INFO): Starting 2023-12-21T19:25:05.976Z,1703186705.976 [DATMMP](INFO): Starting 2023-12-21T19:25:06.228Z,1703186706.228 [DATMMP](INFO): Starting 2023-12-21T19:25:06.480Z,1703186706.480 [DATMMP](INFO): Starting 2023-12-21T19:25:06.732Z,1703186706.732 [DATMMP](INFO): Starting 2023-12-21T19:25:06.984Z,1703186706.984 [DATMMP](INFO): Starting 2023-12-21T19:25:07.236Z,1703186707.236 [DATMMP](INFO): Starting 2023-12-21T19:25:07.488Z,1703186707.488 [DATMMP](INFO): Starting 2023-12-21T19:25:07.740Z,1703186707.740 [DATMMP](INFO): Starting 2023-12-21T19:25:07.993Z,1703186707.993 [DATMMP](INFO): Starting 2023-12-21T19:25:08.244Z,1703186708.244 [DATMMP](INFO): Starting 2023-12-21T19:25:08.497Z,1703186708.497 [DATMMP](INFO): Starting 2023-12-21T19:25:08.748Z,1703186708.748 [DATMMP](INFO): Starting 2023-12-21T19:25:09.000Z,1703186709.000 [DATMMP](INFO): Starting 2023-12-21T19:25:09.252Z,1703186709.252 [DATMMP](INFO): Starting 2023-12-21T19:25:09.504Z,1703186709.504 [DATMMP](INFO): Starting 2023-12-21T19:25:09.756Z,1703186709.756 [DATMMP](INFO): Starting 2023-12-21T19:25:10.008Z,1703186710.008 [DATMMP](INFO): Starting 2023-12-21T19:25:10.260Z,1703186710.260 [DATMMP](INFO): Starting 2023-12-21T19:25:10.512Z,1703186710.512 [DATMMP](INFO): Starting 2023-12-21T19:25:10.764Z,1703186710.764 [DATMMP](INFO): Starting 2023-12-21T19:25:11.016Z,1703186711.016 [DATMMP](INFO): Starting 2023-12-21T19:25:11.268Z,1703186711.268 [DATMMP](INFO): Starting 2023-12-21T19:25:11.520Z,1703186711.520 [DATMMP](INFO): Starting 2023-12-21T19:25:11.772Z,1703186711.772 [DATMMP](INFO): Starting 2023-12-21T19:25:12.024Z,1703186712.024 [DATMMP](INFO): Starting 2023-12-21T19:25:12.276Z,1703186712.276 [DATMMP](INFO): Starting 2023-12-21T19:25:12.528Z,1703186712.528 [DATMMP](INFO): Starting 2023-12-21T19:25:12.780Z,1703186712.780 [DATMMP](INFO): Starting 2023-12-21T19:25:13.032Z,1703186713.032 [DATMMP](INFO): Starting 2023-12-21T19:25:13.284Z,1703186713.284 [DATMMP](INFO): Starting 2023-12-21T19:25:13.284Z,1703186713.284 [DATMMP](FAULT): failed to initialize, no bytes available on serial interface 2023-12-21T19:25:13.284Z,1703186713.284 [DATMMP] Communications Fault, FailCount= 1 2023-12-21T19:25:13.284Z,1703186713.284 [DATMMP](ERROR): Communications Fault 2023-12-21T19:25:13.337Z,1703186713.337 [CBIT](ERROR): Communications Fault in component: DATMMP 2023-12-21T19:25:13.688Z,1703186713.688 [DATMMP](INFO): Stop 2023-12-21T19:25:13.688Z,1703186713.688 [DATMMP](INFO): uninitialize 2023-12-21T19:25:13.688Z,1703186713.688 [DATMMP](INFO): Powering down 2023-12-21T19:25:14.168Z,1703186714.168 [DATMMP](INFO): Stopping 2023-12-21T19:25:14.572Z,1703186714.572 [DATMMP](INFO): Stopped 2023-12-21T19:25:14.901Z,1703186714.901 [CBIT](INFO): Clearing failed state for component DATMMP 2023-12-21T19:25:14.901Z,1703186714.901 [DATMMP] No Fault, FailCount= 1 2023-12-21T19:25:14.976Z,1703186714.976 [DATMMP](INFO): Start 2023-12-21T19:25:15.228Z,1703186715.228 [DATMMP](INFO): Start 2023-12-21T19:25:15.480Z,1703186715.480 [DATMMP](INFO): Start 2023-12-21T19:25:15.732Z,1703186715.732 [DATMMP](INFO): Start 2023-12-21T19:25:15.984Z,1703186715.984 [DATMMP](INFO): Start 2023-12-21T19:25:16.236Z,1703186716.236 [DATMMP](INFO): Start 2023-12-21T19:25:16.488Z,1703186716.488 [DATMMP](INFO): Start 2023-12-21T19:25:16.740Z,1703186716.740 [DATMMP](INFO): Start 2023-12-21T19:25:16.740Z,1703186716.740 [DATMMP](INFO): Powering up 2023-12-21T19:25:16.740Z,1703186716.740 [DATMMP](DEBUG): Initializing DATMMP. 2023-12-21T19:25:16.992Z,1703186716.992 [DATMMP](INFO): Starting 2023-12-21T19:25:17.244Z,1703186717.244 [DATMMP](INFO): Starting 2023-12-21T19:25:17.496Z,1703186717.496 [DATMMP](INFO): Starting 2023-12-21T19:25:17.752Z,1703186717.752 [DATMMP](INFO): Starting 2023-12-21T19:25:18.004Z,1703186718.004 [DATMMP](INFO): Starting 2023-12-21T19:25:18.256Z,1703186718.256 [DATMMP](INFO): Starting 2023-12-21T19:25:18.508Z,1703186718.508 [DATMMP](INFO): Starting 2023-12-21T19:25:18.760Z,1703186718.760 [DATMMP](INFO): Starting 2023-12-21T19:25:19.012Z,1703186719.012 [DATMMP](INFO): Starting 2023-12-21T19:25:19.268Z,1703186719.268 [DATMMP](INFO): Starting 2023-12-21T19:25:19.520Z,1703186719.520 [DATMMP](INFO): Starting 2023-12-21T19:25:19.695Z,1703186719.695 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:25:19.772Z,1703186719.772 [DATMMP](INFO): Starting 2023-12-21T19:25:20.024Z,1703186720.024 [DATMMP](INFO): Starting 2023-12-21T19:25:20.276Z,1703186720.276 [DATMMP](INFO): Starting 2023-12-21T19:25:20.528Z,1703186720.528 [DATMMP](INFO): Starting 2023-12-21T19:25:20.780Z,1703186720.780 [DATMMP](INFO): Starting 2023-12-21T19:25:21.032Z,1703186721.032 [DATMMP](INFO): Starting 2023-12-21T19:25:21.292Z,1703186721.292 [DATMMP](INFO): Starting 2023-12-21T19:25:21.544Z,1703186721.544 [DATMMP](INFO): Starting 2023-12-21T19:25:21.796Z,1703186721.796 [DATMMP](INFO): Starting 2023-12-21T19:25:22.048Z,1703186722.048 [DATMMP](INFO): Starting 2023-12-21T19:25:22.300Z,1703186722.300 [DATMMP](INFO): Starting 2023-12-21T19:25:22.552Z,1703186722.552 [DATMMP](INFO): Starting 2023-12-21T19:25:22.804Z,1703186722.804 [DATMMP](INFO): Starting 2023-12-21T19:25:23.057Z,1703186723.057 [DATMMP](INFO): Starting 2023-12-21T19:25:23.308Z,1703186723.308 [DATMMP](INFO): Starting 2023-12-21T19:25:23.560Z,1703186723.560 [DATMMP](INFO): Starting 2023-12-21T19:25:23.812Z,1703186723.812 [DATMMP](INFO): Starting 2023-12-21T19:25:24.064Z,1703186724.064 [DATMMP](INFO): Starting 2023-12-21T19:25:24.316Z,1703186724.316 [DATMMP](INFO): Starting 2023-12-21T19:25:24.568Z,1703186724.568 [DATMMP](INFO): Starting 2023-12-21T19:25:24.820Z,1703186724.820 [DATMMP](INFO): Starting 2023-12-21T19:25:25.073Z,1703186725.073 [DATMMP](INFO): Starting 2023-12-21T19:25:25.325Z,1703186725.325 [DATMMP](INFO): Starting 2023-12-21T19:25:25.576Z,1703186725.576 [DATMMP](INFO): Starting 2023-12-21T19:25:25.828Z,1703186725.828 [DATMMP](INFO): Starting 2023-12-21T19:25:26.080Z,1703186726.080 [DATMMP](INFO): Starting 2023-12-21T19:25:26.332Z,1703186726.332 [DATMMP](INFO): Starting 2023-12-21T19:25:26.584Z,1703186726.584 [DATMMP](INFO): Starting 2023-12-21T19:25:26.836Z,1703186726.836 [DATMMP](INFO): Starting 2023-12-21T19:25:27.089Z,1703186727.089 [DATMMP](INFO): Starting 2023-12-21T19:25:27.340Z,1703186727.340 [DATMMP](INFO): Starting 2023-12-21T19:25:27.592Z,1703186727.592 [DATMMP](INFO): Starting 2023-12-21T19:25:27.845Z,1703186727.845 [DATMMP](INFO): Starting 2023-12-21T19:25:28.096Z,1703186728.096 [DATMMP](INFO): Starting 2023-12-21T19:25:28.348Z,1703186728.348 [DATMMP](INFO): Starting 2023-12-21T19:25:28.600Z,1703186728.600 [DATMMP](INFO): Starting 2023-12-21T19:25:28.852Z,1703186728.852 [DATMMP](INFO): Starting 2023-12-21T19:25:29.105Z,1703186729.105 [DATMMP](INFO): Starting 2023-12-21T19:25:29.106Z,1703186729.106 [DATMMP](INFO): DAT read: 2023-12-21T19:25:29.108Z,1703186729.108 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2023-12-21T19:25:29.356Z,1703186729.356 [DATMMP](INFO): Starting 2023-12-21T19:25:29.608Z,1703186729.608 [DATMMP](INFO): Starting 2023-12-21T19:25:29.860Z,1703186729.860 [DATMMP](INFO): Starting 2023-12-21T19:25:30.112Z,1703186730.112 [DATMMP](INFO): Starting 2023-12-21T19:25:30.364Z,1703186730.364 [DATMMP](INFO): Starting 2023-12-21T19:25:30.616Z,1703186730.616 [DATMMP](INFO): Starting 2023-12-21T19:25:30.868Z,1703186730.868 [DATMMP](INFO): Starting 2023-12-21T19:25:30.869Z,1703186730.869 [DATMMP](INFO): DAT read: MF Frequency Band 2023-12-21T19:25:30.870Z,1703186730.870 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2023-12-21T19:25:30.871Z,1703186730.871 [DATMMP](INFO): DAT read: Dec 18 2023 23:37:53 2023-12-21T19:25:31.085Z,1703186731.085 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:25:31.120Z,1703186731.120 [DATMMP](INFO): Starting 2023-12-21T19:25:31.372Z,1703186731.372 [DATMMP](INFO): Starting 2023-12-21T19:25:31.624Z,1703186731.624 [DATMMP](INFO): Starting 2023-12-21T19:25:31.877Z,1703186731.877 [DATMMP](INFO): Starting 2023-12-21T19:25:31.878Z,1703186731.878 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2023-12-21T19:25:31.879Z,1703186731.879 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2023-12-21T19:25:31.879Z,1703186731.879 [DATMMP](INFO): commRate: 800 2023-12-21T19:25:32.128Z,1703186732.128 [DATMMP](INFO): Starting 2023-12-21T19:25:32.380Z,1703186732.380 [DATMMP](INFO): Starting 2023-12-21T19:25:32.632Z,1703186732.632 [DATMMP](INFO): Starting 2023-12-21T19:25:32.884Z,1703186732.884 [DATMMP](INFO): Starting 2023-12-21T19:25:33.137Z,1703186733.137 [DATMMP](INFO): Starting 2023-12-21T19:25:33.388Z,1703186733.388 [DATMMP](INFO): Starting 2023-12-21T19:25:33.466Z,1703186733.466 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, +0.00, +0.00, , 0.00 2023-12-21T19:25:33.640Z,1703186733.640 [DATMMP](INFO): Starting 2023-12-21T19:25:33.892Z,1703186733.892 [DATMMP](INFO): Starting 2023-12-21T19:25:33.944Z,1703186733.944 [DATMMP](INFO): entering command mode 2023-12-21T19:25:34.144Z,1703186734.144 [DATMMP](INFO): Starting 2023-12-21T19:25:34.144Z,1703186734.144 [DATMMP](INFO): DAT read: 2023-12-21T19:25:34.145Z,1703186734.145 [DATMMP](INFO): DAT read: user:1> 2023-12-21T19:25:34.145Z,1703186734.145 [DATMMP](DEBUG): read user prompt 1: user:1> 2023-12-21T19:25:34.145Z,1703186734.145 [DATMMP](INFO): entering MMP mode 2023-12-21T19:25:34.397Z,1703186734.397 [DATMMP](INFO): Starting 2023-12-21T19:25:34.398Z,1703186734.398 [DATMMP](INFO): GSXN notify for xid: 0 2023-12-21T19:25:34.399Z,1703186734.399 [DATMMP](INFO): status rx: x1 2023-12-21T19:25:34.399Z,1703186734.399 [DATMMP](INFO): MMP status: 1: started 2023-12-21T19:25:34.400Z,1703186734.400 [DATMMP](INFO): Received message type: status 2023-12-21T19:25:34.400Z,1703186734.400 [DATMMP](INFO): Handled 2023-12-21T19:25:34.648Z,1703186734.648 [DATMMP](INFO): Starting 2023-12-21T19:25:34.649Z,1703186734.649 [DATMMP](INFO): Sent Tx Power Config 2 2023-12-21T19:25:34.650Z,1703186734.650 [DATMMP](INFO): Setting local address: 10 2023-12-21T19:25:34.651Z,1703186734.651 [DATMMP](INFO): Setting time to: 19:25:34 And date to:12/21/2023 2023-12-21T19:25:34.900Z,1703186734.900 [DATMMP](INFO): Starting 2023-12-21T19:25:34.901Z,1703186734.901 [DATMMP](INFO): GSXN notify for xid: 0 2023-12-21T19:25:34.901Z,1703186734.901 [DATMMP](INFO): mdmpower rx: x2 x0 x5 x0 2023-12-21T19:25:34.902Z,1703186734.902 [DATMMP](INFO): Received message type: mdmpower 2023-12-21T19:25:34.902Z,1703186734.902 [DATMMP](INFO): Handled 2023-12-21T19:25:35.152Z,1703186735.152 [DATMMP](INFO): Starting 2023-12-21T19:25:35.153Z,1703186735.153 [DATMMP](INFO): GSXN notify for xid: 10 2023-12-21T19:25:35.154Z,1703186735.154 [DATMMP](INFO): sreg_txpower rx: x2 2023-12-21T19:25:35.154Z,1703186735.154 [DATMMP](INFO): Received message type: sreg_txpower 2023-12-21T19:25:35.154Z,1703186735.154 [DATMMP](INFO): Match for : sreg_txpower 2023-12-21T19:25:35.154Z,1703186735.154 [DATMMP](INFO): ACK 2023-12-21T19:25:35.404Z,1703186735.404 [DATMMP](INFO): Starting 2023-12-21T19:25:35.404Z,1703186735.404 [DATMMP](INFO): GSXN notify for xid: 0 2023-12-21T19:25:35.405Z,1703186735.405 [DATMMP](INFO): mdmlocal rx: xA x0 x0 x0 2023-12-21T19:25:35.405Z,1703186735.405 [DATMMP](INFO): Received message type: mdmlocal 2023-12-21T19:25:35.406Z,1703186735.406 [DATMMP](INFO): Handled 2023-12-21T19:25:35.656Z,1703186735.656 [DATMMP](INFO): Starting 2023-12-21T19:25:35.656Z,1703186735.656 [DATMMP](INFO): GSXN notify for xid: 11 2023-12-21T19:25:35.657Z,1703186735.657 [DATMMP](INFO): sreg_locaddr rx: xA 2023-12-21T19:25:35.657Z,1703186735.657 [DATMMP](INFO): Received message type: sreg_locaddr 2023-12-21T19:25:35.657Z,1703186735.657 [DATMMP](INFO): Match for : sreg_locaddr 2023-12-21T19:25:35.658Z,1703186735.658 [DATMMP](INFO): ACK 2023-12-21T19:25:35.908Z,1703186735.908 [DATMMP](INFO): Starting 2023-12-21T19:25:35.908Z,1703186735.908 [DATMMP](INFO): GSXN notify for xid: 12 2023-12-21T19:25:35.910Z,1703186735.910 [DATMMP](INFO): timedate rx: x0 x13 x19 x22 xB x15 x7B x0 2023-12-21T19:25:35.910Z,1703186735.910 [DATMMP](INFO): Received message type: timedate 2023-12-21T19:25:35.910Z,1703186735.910 [DATMMP](INFO): Match for : timedate 2023-12-21T19:25:35.910Z,1703186735.910 [DATMMP](INFO): ACK 2023-12-21T19:25:36.160Z,1703186736.160 [DATMMP](INFO): Starting 2023-12-21T19:25:36.160Z,1703186736.160 [DATMMP](INFO): GSXN notify for xid: 0 2023-12-21T19:25:36.161Z,1703186736.161 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2023-12-21T19:25:36.161Z,1703186736.161 [DATMMP](INFO): Received message type: sys_verb 2023-12-21T19:25:36.162Z,1703186736.162 [DATMMP](INFO): Handled 2023-12-21T19:25:36.412Z,1703186736.412 [DATMMP](INFO): Starting 2023-12-21T19:25:36.413Z,1703186736.413 [DATMMP](INFO): GSXN notify for xid: 13 2023-12-21T19:25:36.413Z,1703186736.413 [DATMMP](INFO): sreg_verbosity rx: x0 2023-12-21T19:25:36.413Z,1703186736.413 [DATMMP](INFO): Received message type: sreg_verbosity 2023-12-21T19:25:36.413Z,1703186736.413 [DATMMP](INFO): Match for : sreg_verbosity 2023-12-21T19:25:36.414Z,1703186736.414 [DATMMP](INFO): ACK 2023-12-21T19:25:36.664Z,1703186736.664 [DATMMP](INFO): Starting 2023-12-21T19:25:36.665Z,1703186736.665 [DATMMP](INFO): GSXN notify for xid: 14 2023-12-21T19:25:36.665Z,1703186736.665 [DATMMP](INFO): version rx: x2 x5 2023-12-21T19:25:36.666Z,1703186736.666 [DATMMP](INFO): DatMMPVersion: 2.5 2023-12-21T19:25:36.666Z,1703186736.666 [DATMMP](INFO): Received message type: version 2023-12-21T19:25:36.666Z,1703186736.666 [DATMMP](INFO): Match for : version 2023-12-21T19:25:36.666Z,1703186736.666 [DATMMP](INFO): ACK 2023-12-21T19:25:36.666Z,1703186736.666 [DATMMP](INFO): in MMP mode: config complete going to runnable 2023-12-21T19:25:41.969Z,1703186741.969 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:25:43.221Z,1703186743.221 [SBIT](IMPORTANT): SBIT PASSED 2023-12-21T19:25:43.221Z,1703186743.221 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-12-21T19:25:43.222Z,1703186743.222 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2023-12-21T19:25:43.222Z,1703186743.222 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2023-12-21T19:25:43.223Z,1703186743.223 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2023-12-21T19:25:43.223Z,1703186743.223 [SBIT](IMPORTANT): Express linearApproximation downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter; 2023-12-21T19:25:43.223Z,1703186743.223 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour; 2023-12-21T19:25:43.223Z,1703186743.223 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2023-12-21T19:25:43.223Z,1703186743.223 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=329.481969 cubic_centimeter; 2023-12-21T19:25:43.223Z,1703186743.223 [SBIT](IMPORTANT): VerticalControl.massDefault=4.064477 millimeter; 2023-12-21T19:25:43.546Z,1703186743.546 [MissionManager](IMPORTANT): Started mission Startup 2023-12-21T19:25:43.546Z,1703186743.546 [Startup] Running Loop=1 2023-12-21T19:25:43.547Z,1703186743.547 [Startup](DEBUG): Aggregate::initialize Startup 2023-12-21T19:25:43.547Z,1703186743.547 [Startup:A.GoToSurface] Running Loop=1 2023-12-21T19:25:43.547Z,1703186743.547 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-12-21T19:25:43.547Z,1703186743.547 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-12-21T19:25:43.548Z,1703186743.548 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-12-21T19:25:43.548Z,1703186743.548 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-12-21T19:25:43.549Z,1703186743.549 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-12-21T19:25:43.549Z,1703186743.549 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-12-21T19:25:43.550Z,1703186743.550 [Startup:StartupSatComms] Running Loop=1 2023-12-21T19:25:43.551Z,1703186743.551 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-12-21T19:25:43.551Z,1703186743.551 [Startup:StartupSatComms:A] Running Loop=1 2023-12-21T19:25:43.950Z,1703186743.950 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-12-21T19:25:51.033Z,1703186751.033 [DATMMP](INFO): GSXN notify for xid: 0 2023-12-21T19:25:51.034Z,1703186751.034 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2023-12-21T19:25:51.034Z,1703186751.034 [DATMMP](INFO): Received message type: timesync 2023-12-21T19:25:51.034Z,1703186751.034 [DATMMP](INFO): Handled 2023-12-21T19:25:52.871Z,1703186752.871 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:01.115Z,1703186761.115 [DATMMP](INFO): GSXN notify for xid: 0 2023-12-21T19:26:01.117Z,1703186761.117 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2023-12-21T19:26:01.118Z,1703186761.118 [DATMMP](INFO): Received message type: timesync 2023-12-21T19:26:01.118Z,1703186761.118 [DATMMP](INFO): Handled 2023-12-21T19:26:04.246Z,1703186764.246 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:15.497Z,1703186775.497 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:24.825Z,1703186784.825 [CommandExec](IMPORTANT): got command failComponent 2023-12-21T19:26:24.825Z,1703186784.825 [CommandExec](IMPORTANT): Failed components: 2023-12-21T19:26:24.825Z,1703186784.825 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2023-12-21T19:26:26.416Z,1703186786.416 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:36.256Z,1703186796.256 [CommandExec](IMPORTANT): got command configSet DropWeight.loadAtStartup 0 bool persist 2023-12-21T19:26:36.256Z,1703186796.256 [CommandExec](IMPORTANT): configSet DropWeight.loadAtStartup requires a restart to take effect. 2023-12-21T19:26:37.366Z,1703186797.366 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:42.153Z,1703186802.153 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:43.723Z,1703186803.723 [Startup:StartupSatComms:A](INFO): Timed out from 2023-12-21T19:25:43.6Z 2023-12-21T19:26:43.723Z,1703186803.723 [Startup:StartupSatComms:A] Stopped 2023-12-21T19:26:43.723Z,1703186803.723 [Startup:StartupSatComms:B] Running Loop=1 2023-12-21T19:26:44.126Z,1703186804.126 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-12-21T19:26:48.693Z,1703186808.693 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2023-12-21T19:26:51.161Z,1703186811.161 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20231218T184442/Courier0060.lzma 2023-12-21T19:26:52.162Z,1703186812.162 [DataOverHttps](INFO): Moved sent file to Logs/20231218T184442/Courier0060.lzma.bak 2023-12-21T19:26:52.162Z,1703186812.162 [DataOverHttps](INFO): SBD MOMSN=19126560 2023-12-21T19:27:06.388Z,1703186826.388 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20231221T192401/Courier0000.lzma 2023-12-21T19:27:07.366Z,1703186827.366 [DataOverHttps](INFO): Moved sent file to Logs/20231221T192401/Courier0000.lzma.bak 2023-12-21T19:27:07.366Z,1703186827.366 [DataOverHttps](INFO): SBD MOMSN=19126562 2023-12-21T19:27:13.304Z,1703186833.304 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-12-21T19:27:13.304Z,1703186833.304 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-12-21T19:27:13.344Z,1703186833.344 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-12-21T19:27:13.664Z,1703186833.664 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-12-21T19:27:13.669Z,1703186833.669 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-12-21T19:27:25.286Z,1703186845.286 [DataOverHttps](INFO): Sending 298 bytes from file Logs/20231218T184442/Express0061.lzma 2023-12-21T19:27:26.286Z,1703186846.286 [DataOverHttps](INFO): Moved sent file to Logs/20231218T184442/Express0061.lzma.bak 2023-12-21T19:27:26.286Z,1703186846.286 [DataOverHttps](INFO): SBD MOMSN=19126567 2023-12-21T19:27:43.384Z,1703186863.384 [DataOverHttps](INFO): Sending 1196 bytes from file Logs/20231221T192401/Express0001.lzma 2023-12-21T19:27:43.932Z,1703186863.932 [Startup:StartupSatComms:B](INFO): Timed out from 2023-12-21T19:26:43.7Z 2023-12-21T19:27:43.932Z,1703186863.932 [Startup:StartupSatComms:B] Stopped 2023-12-21T19:27:43.932Z,1703186863.932 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-12-21T19:27:43.932Z,1703186863.932 [Startup:StartupSatComms] Stopped 2023-12-21T19:27:43.933Z,1703186863.933 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-12-21T19:27:43.953Z,1703186863.953 [Startup](INFO): Completed Startup 2023-12-21T19:27:43.954Z,1703186863.954 [MissionManager](INFO): Startup is completed. 2023-12-21T19:27:43.954Z,1703186863.954 [MissionManager](INFO): Uninitializing Mission Startup 2023-12-21T19:27:43.954Z,1703186863.954 [Startup] Stopped 2023-12-21T19:27:43.954Z,1703186863.954 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-12-21T19:27:43.954Z,1703186863.954 [Startup:A.GoToSurface] Stopped 2023-12-21T19:27:43.954Z,1703186863.954 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-12-21T19:27:44.344Z,1703186864.344 [MissionManager](IMPORTANT): Started mission Default 2023-12-21T19:27:44.344Z,1703186864.344 [Default] Running Loop=1 2023-12-21T19:27:44.344Z,1703186864.344 [Default](DEBUG): Aggregate::initialize Default 2023-12-21T19:27:44.344Z,1703186864.344 [Default:B.GoToSurface] Running Loop=1 2023-12-21T19:27:44.344Z,1703186864.344 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-12-21T19:27:44.345Z,1703186864.345 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-12-21T19:27:44.345Z,1703186864.345 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-12-21T19:27:44.345Z,1703186864.345 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-12-21T19:27:44.346Z,1703186864.346 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-12-21T19:27:44.346Z,1703186864.346 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-12-21T19:27:44.346Z,1703186864.346 [Default:A.Wait] Running Loop=1 2023-12-21T19:27:44.346Z,1703186864.346 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-12-21T19:27:44.383Z,1703186864.383 [DataOverHttps](INFO): Moved sent file to Logs/20231221T192401/Express0001.lzma.bak 2023-12-21T19:27:44.383Z,1703186864.383 [DataOverHttps](INFO): SBD MOMSN=19126575 2023-12-21T19:27:49.259Z,1703186869.259 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2023-12-21T19:27:52.959Z,1703186872.959 [DataOverHttps](IMPORTANT): SBD MTMSN=20231221T192751 2023-12-21T19:27:57.419Z,1703186877.419 [Default:A.Wait](INFO): Done Waiting. 2023-12-21T19:27:57.419Z,1703186877.419 [Default:A.Wait] Stopped 2023-12-21T19:27:57.419Z,1703186877.419 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-12-21T19:27:57.692Z,1703186877.692 [Default:CheckIn] Running Loop=1 2023-12-21T19:27:57.692Z,1703186877.692 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-12-21T19:27:57.692Z,1703186877.692 [Default:CheckIn:Read_GPS] Running Loop=1 2023-12-21T19:27:58.084Z,1703186878.084 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-12-21T19:28:00.546Z,1703186880.546 [DataOverHttps](INFO): Received command: restart app 2023-12-21T19:28:00.631Z,1703186880.631 [CommandExec](IMPORTANT): got command restart application 2023-12-21T19:28:01.634Z,1703186881.634 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:01.634Z,1703186881.634 [CommandExec](INFO): Uninitializing the command executive. 2023-12-21T19:28:01.634Z,1703186881.634 [CommandExec](INFO): Uninitializing the command scheduler. 2023-12-21T19:28:01.634Z,1703186881.634 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:01.706Z,1703186881.706 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-12-21T19:28:01.706Z,1703186881.706 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-12-21T19:28:01.706Z,1703186881.706 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:01.707Z,1703186881.707 [NavChartDb](INFO): Join timeout helper Thread ID is 1218 2023-12-21T19:28:01.966Z,1703186881.966 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:01.966Z,1703186881.966 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:01.985Z,1703186881.985 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2023-12-21T19:28:01.985Z,1703186881.985 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:01.986Z,1703186881.986 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1219 2023-12-21T19:28:02.210Z,1703186882.210 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:02.210Z,1703186882.210 [WetLabsUBAT](INFO): Powering down 2023-12-21T19:28:02.211Z,1703186882.211 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:02.225Z,1703186882.225 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-12-21T19:28:02.225Z,1703186882.225 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:02.226Z,1703186882.226 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1220 2023-12-21T19:28:02.494Z,1703186882.494 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:02.494Z,1703186882.494 [WetLabsBB2FL](INFO): Powering down 2023-12-21T19:28:02.495Z,1703186882.495 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:02.505Z,1703186882.505 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-12-21T19:28:02.506Z,1703186882.506 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:02.506Z,1703186882.506 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1221 2023-12-21T19:28:03.014Z,1703186883.014 [CTD_Seabird](INFO): Powering down 2023-12-21T19:28:03.029Z,1703186883.029 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:03.030Z,1703186883.030 [CTD_Seabird](INFO): Powering down 2023-12-21T19:28:03.042Z,1703186883.042 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:03.062Z,1703186883.062 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-12-21T19:28:03.062Z,1703186883.062 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:03.063Z,1703186883.063 [Radio_Surface](INFO): Join timeout helper Thread ID is 1222 2023-12-21T19:28:03.421Z,1703186883.421 [Radio_Surface](INFO): Powering down 2023-12-21T19:28:03.422Z,1703186883.422 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:03.423Z,1703186883.423 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:03.442Z,1703186883.442 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-12-21T19:28:03.442Z,1703186883.442 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:03.443Z,1703186883.443 [Onboard](INFO): Join timeout helper Thread ID is 1223 2023-12-21T19:28:03.554Z,1703186883.554 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-12-21T19:28:08.218Z,1703186888.218 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:08.218Z,1703186888.218 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.222Z,1703186888.222 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-12-21T19:28:08.222Z,1703186888.222 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.223Z,1703186888.223 [DataOverHttps](INFO): Join timeout helper Thread ID is 1224 2023-12-21T19:28:08.574Z,1703186888.574 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:08.574Z,1703186888.574 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.586Z,1703186888.586 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2023-12-21T19:28:08.586Z,1703186888.586 [DATMMP ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.587Z,1703186888.587 [DATMMP](INFO): Join timeout helper Thread ID is 1225 2023-12-21T19:28:08.677Z,1703186888.677 [DATMMP](INFO): Stop 2023-12-21T19:28:08.678Z,1703186888.678 [DATMMP](INFO): uninitialize 2023-12-21T19:28:08.678Z,1703186888.678 [DATMMP](INFO): Powering down 2023-12-21T19:28:08.750Z,1703186888.750 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:08.750Z,1703186888.750 [DATMMP](INFO): uninitialize 2023-12-21T19:28:08.750Z,1703186888.750 [DATMMP](INFO): Powering down 2023-12-21T19:28:08.751Z,1703186888.751 [DATMMP ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.754Z,1703186888.754 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-12-21T19:28:08.754Z,1703186888.754 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.755Z,1703186888.755 [BackseatComponent](INFO): Join timeout helper Thread ID is 1226 2023-12-21T19:28:08.866Z,1703186888.866 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:08.866Z,1703186888.866 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.886Z,1703186888.886 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-12-21T19:28:08.886Z,1703186888.886 [logger ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.887Z,1703186888.887 [logger](INFO): Join timeout helper Thread ID is 1227 2023-12-21T19:28:08.894Z,1703186888.894 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:08.894Z,1703186888.894 [logger ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.906Z,1703186888.906 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-12-21T19:28:08.906Z,1703186888.906 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:08.907Z,1703186888.907 [CommandLine](INFO): Join timeout helper Thread ID is 1228 2023-12-21T19:28:09.002Z,1703186889.002 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:09.002Z,1703186889.002 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.010Z,1703186889.010 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-12-21T19:28:09.010Z,1703186889.010 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.011Z,1703186889.011 [CommandExec](INFO): Join timeout helper Thread ID is 1229 2023-12-21T19:28:09.012Z,1703186889.012 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-12-21T19:28:09.012Z,1703186889.012 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.012Z,1703186889.012 [controlThread](INFO): Join timeout helper Thread ID is 1230 2023-12-21T19:28:09.338Z,1703186889.338 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-12-21T19:28:09.338Z,1703186889.338 [controlThread](DEBUG): Uninitializing ControlThread 2023-12-21T19:28:09.338Z,1703186889.338 [AHRS_M2](INFO): Powering down 2023-12-21T19:28:09.411Z,1703186889.411 [NAL9602](INFO): Powering down 2023-12-21T19:28:09.481Z,1703186889.481 [RDI_Pathfinder](INFO): Powering down 2023-12-21T19:28:09.483Z,1703186889.483 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-12-21T19:28:09.484Z,1703186889.484 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-12-21T19:28:09.484Z,1703186889.484 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-12-21T19:28:09.485Z,1703186889.485 [MissionManager](INFO): Uninitializing Mission Default 2023-12-21T19:28:09.485Z,1703186889.485 [Default] Stopped 2023-12-21T19:28:09.485Z,1703186889.485 [Default](DEBUG): Aggregate::uninitialize Default 2023-12-21T19:28:09.485Z,1703186889.485 [Default:B.GoToSurface] Stopped 2023-12-21T19:28:09.485Z,1703186889.485 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-12-21T19:28:09.485Z,1703186889.485 [Default:CheckIn] Stopped 2023-12-21T19:28:09.485Z,1703186889.485 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-12-21T19:28:09.485Z,1703186889.485 [Default:CheckIn:Read_GPS] Stopped 2023-12-21T19:28:09.488Z,1703186889.488 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-12-21T19:28:09.488Z,1703186889.488 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-12-21T19:28:09.489Z,1703186889.489 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-12-21T19:28:09.489Z,1703186889.489 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-12-21T19:28:09.489Z,1703186889.489 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-12-21T19:28:09.489Z,1703186889.489 [BuoyancyServo](INFO): Powering down 2023-12-21T19:28:09.502Z,1703186889.502 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-12-21T19:28:09.502Z,1703186889.502 [ElevatorServo](INFO): Powering down 2023-12-21T19:28:09.502Z,1703186889.503 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-12-21T19:28:09.503Z,1703186889.503 [MassServo](INFO): Powering down 2023-12-21T19:28:09.503Z,1703186889.503 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-12-21T19:28:09.504Z,1703186889.504 [RudderServo](INFO): Powering down 2023-12-21T19:28:09.504Z,1703186889.504 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2023-12-21T19:28:09.504Z,1703186889.504 [ThrusterServo](INFO): Powering down 2023-12-21T19:28:09.505Z,1703186889.505 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-12-21T19:28:09.506Z,1703186889.506 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-12-21T19:28:09.506Z,1703186889.506 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-12-21T19:28:09.506Z,1703186889.506 [CBIT](DEBUG): Powering off loads. 2023-12-21T19:28:09.517Z,1703186889.517 [CBIT](DEBUG): Disabling WDT. 2023-12-21T19:28:09.529Z,1703186889.529 [CBIT](DEBUG): Opening all GF detection circuits. 2023-12-21T19:28:09.530Z,1703186889.530 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.595Z,1703186889.595 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.599Z,1703186889.599 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.604Z,1703186889.604 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.611Z,1703186889.611 [DATMMP ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.652Z,1703186889.652 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.711Z,1703186889.711 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.713Z,1703186889.713 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.717Z,1703186889.717 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.725Z,1703186889.725 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-12-21T19:28:09.788Z,1703186889.788 [logger ThreadHandler](INFO): Thread cancelled.