2024-05-09T12:02:17.329Z,1715256137.329 [Supervisor](DEBUG): Initializing supervisor. 2024-05-09T12:02:17.333Z,1715256137.333 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-09T12:02:17.333Z,1715256137.333 [SyncHandler](INFO): Protected caller Thread ID is 5382 2024-05-09T12:02:17.334Z,1715256137.334 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-09T12:02:17.335Z,1715256137.335 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-09T12:02:17.335Z,1715256137.335 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5383 2024-05-09T12:02:17.339Z,1715256137.339 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-09T12:02:17.356Z,1715256137.356 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-09T12:02:17.357Z,1715256137.357 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-09T12:02:17.358Z,1715256137.358 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5384 2024-05-09T12:02:17.362Z,1715256137.362 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-09T12:02:17.363Z,1715256137.363 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-09T12:02:17.363Z,1715256137.363 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5385 2024-05-09T12:02:17.365Z,1715256137.365 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-09T12:02:17.366Z,1715256137.366 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-09T12:02:17.366Z,1715256137.366 [logger ThreadHandler](INFO): Protected caller Thread ID is 5386 2024-05-09T12:02:17.370Z,1715256137.370 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-09T12:02:17.370Z,1715256137.370 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-09T12:02:17.372Z,1715256137.372 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-09T12:02:17.479Z,1715256137.479 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-09T12:02:17.479Z,1715256137.479 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-09T12:02:17.725Z,1715256137.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-09T12:02:17.726Z,1715256137.726 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-09T12:02:18.015Z,1715256138.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-09T12:02:18.015Z,1715256138.015 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-09T12:02:18.135Z,1715256138.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-09T12:02:18.135Z,1715256138.135 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-09T12:02:18.995Z,1715256138.995 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-09T12:02:18.995Z,1715256138.995 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-09T12:02:19.520Z,1715256139.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-09T12:02:19.521Z,1715256139.521 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-09T12:02:20.079Z,1715256140.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-09T12:02:20.080Z,1715256140.080 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-09T12:02:20.512Z,1715256140.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-09T12:02:20.513Z,1715256140.513 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-09T12:02:20.871Z,1715256140.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-09T12:02:20.872Z,1715256140.872 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-09T12:02:21.265Z,1715256141.265 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-09T12:02:21.265Z,1715256141.265 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-09T12:02:21.505Z,1715256141.505 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-09T12:02:21.506Z,1715256141.506 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-09T12:02:21.660Z,1715256141.660 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-09T12:02:21.661Z,1715256141.661 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-09T12:02:21.754Z,1715256141.754 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-09T12:02:21.872Z,1715256141.872 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-09T12:02:22.072Z,1715256142.072 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-09T12:02:22.072Z,1715256142.072 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-09T12:02:22.319Z,1715256142.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-09T12:02:22.321Z,1715256142.321 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2024-05-09T12:02:22.321Z,1715256142.321 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2024-05-09T12:02:22.417Z,1715256142.417 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2024-05-09T12:02:22.690Z,1715256142.690 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-09T12:02:22.690Z,1715256142.690 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2024-05-09T12:02:22.797Z,1715256142.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2024-05-09T12:02:22.973Z,1715256142.973 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2024-05-09T12:02:23.084Z,1715256143.084 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2024-05-09T12:02:23.206Z,1715256143.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2024-05-09T12:02:23.330Z,1715256143.330 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2024-05-09T12:02:23.449Z,1715256143.449 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2024-05-09T12:02:23.623Z,1715256143.623 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2024-05-09T12:02:23.732Z,1715256143.732 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2024-05-09T12:02:23.842Z,1715256143.842 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2024-05-09T12:02:23.943Z,1715256143.943 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2024-05-09T12:02:23.944Z,1715256143.944 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-09T12:02:23.954Z,1715256143.954 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-09T12:02:24.124Z,1715256144.124 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-09T12:02:24.125Z,1715256144.125 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-09T12:02:24.256Z,1715256144.256 [BuoyancyServo] Loaded 2024-05-09T12:02:24.256Z,1715256144.256 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-09T12:02:24.277Z,1715256144.277 [ElevatorServo] Loaded 2024-05-09T12:02:24.277Z,1715256144.277 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-09T12:02:24.297Z,1715256144.297 [MassServo] Loaded 2024-05-09T12:02:24.297Z,1715256144.297 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-09T12:02:24.317Z,1715256144.317 [RudderServo] Loaded 2024-05-09T12:02:24.317Z,1715256144.317 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-09T12:02:24.333Z,1715256144.333 [ThrusterHE] Loaded 2024-05-09T12:02:24.333Z,1715256144.333 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-05-09T12:02:24.333Z,1715256144.333 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-09T12:02:24.334Z,1715256144.334 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-09T12:02:24.472Z,1715256144.472 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-09T12:02:24.486Z,1715256144.486 [SBIT] Loaded 2024-05-09T12:02:24.487Z,1715256144.487 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-09T12:02:24.489Z,1715256144.489 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-09T12:02:24.510Z,1715256144.510 [IBIT] Loaded 2024-05-09T12:02:24.510Z,1715256144.510 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-09T12:02:24.515Z,1715256144.515 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-09T12:02:24.731Z,1715256144.731 [CBIT] Loaded 2024-05-09T12:02:24.731Z,1715256144.731 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-09T12:02:24.732Z,1715256144.732 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-09T12:02:24.732Z,1715256144.732 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-09T12:02:24.901Z,1715256144.901 [CTD_Seabird] Loaded 2024-05-09T12:02:24.901Z,1715256144.901 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-09T12:02:24.902Z,1715256144.902 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0 2024-05-09T12:02:24.902Z,1715256144.902 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5472 2024-05-09T12:02:24.934Z,1715256144.934 [ESPComponent] Loaded 2024-05-09T12:02:24.934Z,1715256144.934 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-05-09T12:02:24.953Z,1715256144.953 [PAR_Licor] Loaded 2024-05-09T12:02:24.954Z,1715256144.954 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-09T12:02:24.995Z,1715256144.995 [WetLabsBB2FL] Loaded 2024-05-09T12:02:24.995Z,1715256144.995 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-09T12:02:24.996Z,1715256144.996 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0 2024-05-09T12:02:24.997Z,1715256144.997 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5473 2024-05-09T12:02:24.998Z,1715256144.998 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-09T12:02:24.998Z,1715256144.998 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-09T12:02:25.047Z,1715256145.047 [DepthRateCalculator] Loaded 2024-05-09T12:02:25.047Z,1715256145.047 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-09T12:02:25.052Z,1715256145.052 [PitchRateCalculator] Loaded 2024-05-09T12:02:25.053Z,1715256145.053 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-09T12:02:25.063Z,1715256145.063 [SpeedCalculator] Loaded 2024-05-09T12:02:25.063Z,1715256145.063 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-09T12:02:25.068Z,1715256145.068 [YawRateCalculator] Loaded 2024-05-09T12:02:25.068Z,1715256145.068 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-09T12:02:25.087Z,1715256145.087 [ElevatorOffsetCalculator] Loaded 2024-05-09T12:02:25.087Z,1715256145.087 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-09T12:02:25.088Z,1715256145.088 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-09T12:02:25.088Z,1715256145.088 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-09T12:02:25.200Z,1715256145.200 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-09T12:02:25.200Z,1715256145.200 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-09T12:02:25.226Z,1715256145.226 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-09T12:02:25.227Z,1715256145.227 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-09T12:02:25.335Z,1715256145.335 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-09T12:02:25.336Z,1715256145.336 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-09T12:02:25.349Z,1715256145.349 [NavChart] Loaded 2024-05-09T12:02:25.350Z,1715256145.350 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-09T12:02:25.355Z,1715256145.355 [UniversalFixResidualReporter] Loaded 2024-05-09T12:02:25.355Z,1715256145.355 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-09T12:02:25.356Z,1715256145.356 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-09T12:02:25.356Z,1715256145.356 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-09T12:02:25.787Z,1715256145.787 [AHRS_M2] Loaded 2024-05-09T12:02:25.788Z,1715256145.788 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-09T12:02:25.823Z,1715256145.823 [BackseatComponent] Loaded 2024-05-09T12:02:25.824Z,1715256145.824 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-05-09T12:02:25.825Z,1715256145.825 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0 2024-05-09T12:02:25.825Z,1715256145.825 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5474 2024-05-09T12:02:25.828Z,1715256145.828 [LcmUniversalReporter] Loaded 2024-05-09T12:02:25.828Z,1715256145.828 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-05-09T12:02:26.548Z,1715256146.548 [BPC1] Loaded 2024-05-09T12:02:26.548Z,1715256146.548 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-09T12:02:26.620Z,1715256146.620 [DataOverHttps] Loaded 2024-05-09T12:02:26.620Z,1715256146.620 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-09T12:02:26.621Z,1715256146.621 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0 2024-05-09T12:02:26.622Z,1715256146.622 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5475 2024-05-09T12:02:26.642Z,1715256146.642 [Depth_Keller] Loaded 2024-05-09T12:02:26.642Z,1715256146.642 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-09T12:02:26.647Z,1715256146.647 [DropWeight] Loaded 2024-05-09T12:02:26.647Z,1715256146.647 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-05-09T12:02:26.686Z,1715256146.686 [DVL_micro] Loaded 2024-05-09T12:02:26.686Z,1715256146.686 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2024-05-09T12:02:26.746Z,1715256146.746 [NAL9602] Loaded 2024-05-09T12:02:26.746Z,1715256146.746 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-09T12:02:26.772Z,1715256146.772 [Onboard] Loaded 2024-05-09T12:02:26.772Z,1715256146.772 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-09T12:02:26.773Z,1715256146.773 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AB34E0 2024-05-09T12:02:26.773Z,1715256146.773 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5476 2024-05-09T12:02:26.786Z,1715256146.786 [Power24vConverter] Loaded 2024-05-09T12:02:26.786Z,1715256146.786 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-09T12:02:26.799Z,1715256146.799 [Radio_Surface] Loaded 2024-05-09T12:02:26.799Z,1715256146.799 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-09T12:02:26.801Z,1715256146.801 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AE34E0 2024-05-09T12:02:26.801Z,1715256146.801 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5477 2024-05-09T12:02:26.895Z,1715256146.895 [DAT] Loaded 2024-05-09T12:02:26.895Z,1715256146.895 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-05-09T12:02:26.896Z,1715256146.896 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B134E0 2024-05-09T12:02:26.896Z,1715256146.896 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5478 2024-05-09T12:02:26.897Z,1715256146.897 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-09T12:02:26.897Z,1715256146.897 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-09T12:02:26.972Z,1715256146.972 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-09T12:02:26.973Z,1715256146.973 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-09T12:02:27.086Z,1715256147.086 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-09T12:02:27.136Z,1715256147.136 [VerticalControl] Loaded 2024-05-09T12:02:27.136Z,1715256147.136 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-09T12:02:27.139Z,1715256147.139 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-09T12:02:27.183Z,1715256147.183 [HorizontalControl] Loaded 2024-05-09T12:02:27.183Z,1715256147.183 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-09T12:02:27.186Z,1715256147.186 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-09T12:02:27.187Z,1715256147.187 [SpeedControl] Loaded 2024-05-09T12:02:27.188Z,1715256147.188 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-09T12:02:27.190Z,1715256147.190 [LoopControl](DEBUG): Construct LoopControl. 2024-05-09T12:02:27.191Z,1715256147.191 [LoopControl] Loaded 2024-05-09T12:02:27.191Z,1715256147.191 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-09T12:02:27.191Z,1715256147.191 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-09T12:02:27.192Z,1715256147.192 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-09T12:02:27.202Z,1715256147.202 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-09T12:02:27.203Z,1715256147.203 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-09T12:02:27.539Z,1715256147.539 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-09T12:02:27.546Z,1715256147.546 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-09T12:02:27.548Z,1715256147.548 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-09T12:02:27.559Z,1715256147.559 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-09T12:02:27.561Z,1715256147.561 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-05-09T12:02:27.561Z,1715256147.561 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5479 2024-05-09T12:02:27.565Z,1715256147.565 [Supervisor](INFO): Main Thread ID is 5381 2024-05-09T12:02:27.565Z,1715256147.565 [Supervisor](DEBUG): Running supervisor. 2024-05-09T12:02:27.566Z,1715256147.566 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5480 2024-05-09T12:02:27.567Z,1715256147.567 [CommandExec](INFO): Initializing the command executive. 2024-05-09T12:02:27.568Z,1715256147.568 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5481 2024-05-09T12:02:27.570Z,1715256147.570 [controlThread ThreadHandler](INFO): Handler Thread ID is 5482 2024-05-09T12:02:27.571Z,1715256147.571 [controlThread](DEBUG): Initializing ControlThread 2024-05-09T12:02:27.573Z,1715256147.573 [SBIT](INFO): Initialize SBIT Component. 2024-05-09T12:02:27.573Z,1715256147.573 [SBIT](IMPORTANT): git: 2024-05-06 2024-05-09T12:02:27.573Z,1715256147.573 [SBIT](INFO): git hash: 5fc11fab0683feef1094efea7282b340ac202615 2024-05-09T12:02:27.574Z,1715256147.574 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-09T12:02:27.575Z,1715256147.575 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-05-09T12:02:27.576Z,1715256147.576 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2024-05-09T12:02:27.577Z,1715256147.577 [IBIT](INFO): Initialize IBIT Component. 2024-05-09T12:02:27.577Z,1715256147.577 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-09T12:02:27.578Z,1715256147.578 [logger ThreadHandler](INFO): Handler Thread ID is 5483 2024-05-09T12:02:27.588Z,1715256147.588 [CBIT](DEBUG): Initialized mux pins. 2024-05-09T12:02:27.589Z,1715256147.589 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-09T12:02:27.597Z,1715256147.597 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5484 2024-05-09T12:02:27.598Z,1715256147.598 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-09T12:02:27.602Z,1715256147.602 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5486 2024-05-09T12:02:27.605Z,1715256147.605 [WetLabsBB2FL](INFO): Powering up 2024-05-09T12:02:27.606Z,1715256147.606 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5488 2024-05-09T12:02:27.613Z,1715256147.613 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-09T12:02:27.613Z,1715256147.613 [CBIT](DEBUG): Initializing heartbeat. 2024-05-09T12:02:27.614Z,1715256147.614 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5489 2024-05-09T12:02:27.616Z,1715256147.616 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-09T12:02:27.629Z,1715256147.629 [Onboard ThreadHandler](INFO): Handler Thread ID is 5490 2024-05-09T12:02:27.646Z,1715256147.646 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5491 2024-05-09T12:02:27.669Z,1715256147.669 [DAT ThreadHandler](INFO): Handler Thread ID is 5492 2024-05-09T12:02:27.670Z,1715256147.670 [DAT](INFO): Powering up 2024-05-09T12:02:27.670Z,1715256147.670 [DAT](DEBUG): Initializing DAT. 2024-05-09T12:02:27.673Z,1715256147.673 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5494 2024-05-09T12:02:27.675Z,1715256147.675 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-05-09T12:02:27.676Z,1715256147.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-05-09T12:02:27.676Z,1715256147.676 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-05-09T12:02:27.676Z,1715256147.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-05-09T12:02:27.676Z,1715256147.676 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-05-09T12:02:27.676Z,1715256147.676 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-05-09T12:02:27.677Z,1715256147.677 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-05-09T12:02:27.677Z,1715256147.677 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-05-09T12:02:27.684Z,1715256147.684 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-09T12:02:27.685Z,1715256147.685 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-09T12:02:27.725Z,1715256147.725 [CBIT](DEBUG): Backplane powered. 2024-05-09T12:02:27.729Z,1715256147.729 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-09T12:02:27.729Z,1715256147.729 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-09T12:02:27.730Z,1715256147.730 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-09T12:02:27.730Z,1715256147.730 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-09T12:02:27.730Z,1715256147.730 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-09T12:02:27.731Z,1715256147.731 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-09T12:02:27.732Z,1715256147.732 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-09T12:02:27.739Z,1715256147.739 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-09T12:02:27.740Z,1715256147.740 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-09T12:02:27.745Z,1715256147.745 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-09T12:02:27.746Z,1715256147.746 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-09T12:02:27.746Z,1715256147.746 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-09T12:02:27.747Z,1715256147.747 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-05-09T12:02:27.747Z,1715256147.747 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-05-09T12:02:27.753Z,1715256147.753 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-05-09T12:02:27.831Z,1715256147.831 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-05-09T12:02:27.835Z,1715256147.835 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-09T12:02:27.885Z,1715256147.885 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-05-09T12:02:27.886Z,1715256147.886 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-05-09T12:02:27.886Z,1715256147.886 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-05-09T12:02:27.887Z,1715256147.887 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-05-09T12:02:28.053Z,1715256148.053 [Radio_Surface](INFO): Powering up 2024-05-09T12:02:28.244Z,1715256148.244 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-05-09T12:02:28.260Z,1715256148.260 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-09T12:02:28.261Z,1715256148.261 [Default:A.Wait](DEBUG): Construct Wait. 2024-05-09T12:02:28.263Z,1715256148.263 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-09T12:02:28.307Z,1715256148.307 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-09T12:02:28.326Z,1715256148.326 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-09T12:02:28.331Z,1715256148.331 [Default:E.Execute](DEBUG): Construct Execute. 2024-05-09T12:02:28.351Z,1715256148.351 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-05-09T12:02:28.355Z,1715256148.355 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-09T12:02:28.383Z,1715256148.383 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-09T12:02:28.449Z,1715256148.449 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m 2024-05-09T12:02:28.458Z,1715256148.458 [Power24vConverter](INFO): Powering up. 2024-05-09T12:02:28.473Z,1715256148.473 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-05-09T12:02:28.498Z,1715256148.498 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-09T12:02:28.509Z,1715256148.509 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-09T12:02:28.510Z,1715256148.510 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-09T12:02:28.517Z,1715256148.517 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-09T12:02:28.518Z,1715256148.518 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-09T12:02:28.525Z,1715256148.525 [MassServo](DEBUG): Initializing MassServo. 2024-05-09T12:02:28.526Z,1715256148.526 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-09T12:02:28.533Z,1715256148.533 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-09T12:02:28.534Z,1715256148.534 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-05-09T12:02:28.546Z,1715256148.546 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-05-09T12:02:28.799Z,1715256148.799 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-05-09T12:02:28.799Z,1715256148.799 [DropWeight] Hardware Fault, FailCount= 1 2024-05-09T12:02:28.800Z,1715256148.800 [DropWeight](ERROR): Hardware Fault 2024-05-09T12:02:28.831Z,1715256148.831 [CommandExec](FAULT): Scheduling is paused 2024-05-09T12:02:28.831Z,1715256148.831 [CBIT](INFO): Critical error at 20240509T120228 2024-05-09T12:02:28.831Z,1715256148.831 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-05-09T12:02:28.842Z,1715256148.842 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-05-09T12:02:28.843Z,1715256148.843 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-05-09T12:02:29.203Z,1715256149.203 [CBIT](INFO): Critical error at 20240509T120228 2024-05-09T12:02:29.714Z,1715256149.714 [WetLabsBB2FL](INFO): Powering down 2024-05-09T12:02:34.369Z,1715256154.369 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-05-09T12:02:34.629Z,1715256154.629 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-05-09T12:02:37.737Z,1715256157.737 [CBIT](CRITICAL): Environmental Failure. Press:14.713790 PSI. Humidity:26%. Temp:26 C. ABORTING MISSION 2024-05-09T12:02:38.135Z,1715256158.135 [CBIT](INFO): Critical error at 20240509T120237 2024-05-09T12:02:39.517Z,1715256159.517 [DAT](INFO): DAT read: 2024-05-09T12:02:39.518Z,1715256159.518 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-05-09T12:02:41.282Z,1715256161.282 [DAT](INFO): DAT read: MF Frequency Band 2024-05-09T12:02:41.283Z,1715256161.283 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-05-09T12:02:41.283Z,1715256161.283 [DAT](INFO): DAT read: May 9 2024 12:02:36 2024-05-09T12:02:42.541Z,1715256162.541 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-05-09T12:02:42.542Z,1715256162.542 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2024-05-09T12:02:42.543Z,1715256162.543 [DAT](INFO): commRate: 1200 2024-05-09T12:02:44.609Z,1715256164.609 [DAT](INFO): entering command mode 2024-05-09T12:02:44.810Z,1715256164.810 [DAT](INFO): DAT read: 2024-05-09T12:02:44.810Z,1715256164.810 [DAT](INFO): DAT read: user:1> 2024-05-09T12:02:44.811Z,1715256164.811 [DAT](INFO): setting verbose to 3 2024-05-09T12:02:45.062Z,1715256165.062 [DAT](INFO): DAT read: user:1> 2024-05-09T12:02:45.063Z,1715256165.063 [DAT](INFO): DAT read: Verbose | 3 2024-05-09T12:02:45.063Z,1715256165.063 [DAT](INFO): set verbose to 3 2024-05-09T12:02:45.064Z,1715256165.064 [DAT](INFO): setting DatVerbose to 27440 2024-05-09T12:02:45.313Z,1715256165.313 [DAT](INFO): DAT read: user:2> 2024-05-09T12:02:45.314Z,1715256165.314 [DAT](INFO): DAT read: DatVerbose | 27440 2024-05-09T12:02:45.314Z,1715256165.314 [DAT](INFO): set DatVerbose to 27440 2024-05-09T12:02:45.315Z,1715256165.315 [DAT](INFO): setting transmit power to 8 2024-05-09T12:02:45.565Z,1715256165.565 [DAT](INFO): DAT read: user:3> 2024-05-09T12:02:45.566Z,1715256165.566 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-05-09T12:02:45.566Z,1715256165.566 [DAT](INFO): set transmit power to 8 2024-05-09T12:02:45.567Z,1715256165.567 [DAT](INFO): setting local address to 5 2024-05-09T12:02:45.818Z,1715256165.818 [DAT](INFO): DAT read: user:4> 2024-05-09T12:02:45.819Z,1715256165.819 [DAT](INFO): DAT read: LocalAddr | 5 2024-05-09T12:02:45.820Z,1715256165.820 [DAT](INFO): set local address to 5 2024-05-09T12:02:45.822Z,1715256165.822 [DAT](INFO): Setting time to: 12:2:45 And date to:5/9/2024 2024-05-09T12:02:46.069Z,1715256166.069 [DAT](INFO): DAT read: user:5> 2024-05-09T12:02:46.070Z,1715256166.070 [DAT](INFO): DAT read: Thu May 9, 2024 12:02:45 2024-05-09T12:02:46.070Z,1715256166.070 [DAT](INFO): Local DAT time set to Thu May 9, 2024 12:02:45 2024-05-09T12:02:46.727Z,1715256166.727 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 39 millimeter 2024-05-09T12:02:46.759Z,1715256166.759 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2024-05-09T12:02:47.102Z,1715256167.102 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-09T12:02:57.087Z,1715256177.087 [NAL9602](INFO): Powering up NAL9602 2024-05-09T12:03:07.990Z,1715256187.990 [NAL9602](INFO): NAL9602 initialized 2024-05-09T12:03:17.890Z,1715256197.890 [CommandExec](IMPORTANT): got command strobe off 2024-05-09T12:03:17.890Z,1715256197.890 [CommandExec](IMPORTANT): Deactivating strobe 2024-05-09T12:03:27.045Z,1715256207.045 [SBIT](IMPORTANT): Beginning Startup BIT 2024-05-09T12:03:27.050Z,1715256207.050 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-09T12:03:37.949Z,1715256217.949 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.015006 CHAN A1 (24V): 0.001811 CHAN A2 (12V): -0.004298 CHAN A3 (5V): -0.002727 CHAN B0 (3.3V): -0.001416 CHAN B1 (3.15aV): -0.001009 CHAN B2 (3.15bV): -0.000705 CHAN B3 (GND): 0.000179 OPEN: 0.006872 Full Scale: +/- 1 mA 2024-05-09T12:03:40.321Z,1715256220.321 [SBIT](FAULT): Mass: EXPECTED:-0.002200 ACTUAL:0.039000 2024-05-09T12:04:06.989Z,1715256246.989 [SBIT](FAULT): Mass: EXPECTED:-0.012143 ACTUAL:0.039000 2024-05-09T12:04:06.989Z,1715256246.989 [SBIT](FAULT): Control surface position failure. 2024-05-09T12:04:20.735Z,1715256260.735 [SBIT](FAULT): Mass: EXPECTED:-0.010000 ACTUAL:0.039000 2024-05-09T12:04:20.735Z,1715256260.735 [SBIT](FAULT): Control surface position failure. 2024-05-09T12:04:21.132Z,1715256261.132 [SBIT](CRITICAL): SBIT FAILED 2024-05-09T12:04:21.149Z,1715256261.149 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-05-09T12:04:21.150Z,1715256261.150 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute; 2024-05-09T12:04:21.150Z,1715256261.150 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=0.7 degree; 2024-05-09T12:04:21.150Z,1715256261.150 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_mean_sea_water_temperature 5.000000 celsius; 2024-05-09T12:04:21.150Z,1715256261.150 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2024-05-09T12:04:21.150Z,1715256261.150 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2024-05-09T12:04:21.151Z,1715256261.151 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water; 2024-05-09T12:04:21.151Z,1715256261.151 [SBIT](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_petroleum_hydrocarbons_in_sea_water 1.000000 kilogram_per_cubic_meter; 2024-05-09T12:04:21.151Z,1715256261.151 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 0.500000 meter; 2024-05-09T12:04:21.151Z,1715256261.151 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=100 cubic_centimeter; 2024-05-09T12:04:21.151Z,1715256261.151 [SBIT](IMPORTANT): VerticalControl.massDefault=-1 centimeter; 2024-05-09T12:04:21.158Z,1715256261.158 [CBIT](INFO): Critical error at 20240509T120421 2024-05-09T12:04:21.531Z,1715256261.531 [MissionManager](IMPORTANT): Started mission Startup 2024-05-09T12:04:21.532Z,1715256261.532 [Startup] Running Loop=1 2024-05-09T12:04:21.532Z,1715256261.532 [Startup](DEBUG): Aggregate::initialize Startup 2024-05-09T12:04:21.532Z,1715256261.532 [Startup:A.GoToSurface] Running Loop=1 2024-05-09T12:04:21.532Z,1715256261.532 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-09T12:04:21.533Z,1715256261.533 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-09T12:04:21.534Z,1715256261.534 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-09T12:04:21.534Z,1715256261.534 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-09T12:04:21.534Z,1715256261.534 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-09T12:04:21.535Z,1715256261.535 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-09T12:04:21.537Z,1715256261.537 [Startup:StartupSatComms] Running Loop=1 2024-05-09T12:04:21.537Z,1715256261.537 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-05-09T12:04:21.537Z,1715256261.537 [Startup:StartupSatComms:A] Running Loop=1 2024-05-09T12:04:21.988Z,1715256261.988 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-05-09T12:05:21.773Z,1715256321.773 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-09T12:04:21.5Z 2024-05-09T12:05:21.773Z,1715256321.773 [Startup:StartupSatComms:A] Stopped 2024-05-09T12:05:21.773Z,1715256321.773 [Startup:StartupSatComms:B] Running Loop=1 2024-05-09T12:05:22.155Z,1715256322.155 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-09T12:05:27.846Z,1715256327.846 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-05-09T12:05:27.846Z,1715256327.846 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-09T12:05:27.857Z,1715256327.857 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-09T12:05:28.193Z,1715256328.193 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-09T12:05:28.193Z,1715256328.193 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-05-09T12:06:21.920Z,1715256381.920 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-09T12:05:21.8Z 2024-05-09T12:06:21.920Z,1715256381.920 [Startup:StartupSatComms:B] Stopped 2024-05-09T12:06:21.920Z,1715256381.920 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-05-09T12:06:21.920Z,1715256381.920 [Startup:StartupSatComms] Stopped 2024-05-09T12:06:21.920Z,1715256381.920 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-05-09T12:06:21.921Z,1715256381.921 [Startup](INFO): Completed Startup 2024-05-09T12:06:21.921Z,1715256381.921 [MissionManager](INFO): Startup is completed. 2024-05-09T12:06:21.921Z,1715256381.921 [MissionManager](INFO): Uninitializing Mission Startup 2024-05-09T12:06:21.922Z,1715256381.922 [Startup] Stopped 2024-05-09T12:06:21.922Z,1715256381.922 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-05-09T12:06:21.922Z,1715256381.922 [Startup:A.GoToSurface] Stopped 2024-05-09T12:06:21.922Z,1715256381.922 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-09T12:06:22.337Z,1715256382.337 [MissionManager](IMPORTANT): Started mission Default 2024-05-09T12:06:22.337Z,1715256382.337 [Default] Running Loop=1 2024-05-09T12:06:22.337Z,1715256382.337 [Default](DEBUG): Aggregate::initialize Default 2024-05-09T12:06:22.338Z,1715256382.338 [Default:B.GoToSurface] Running Loop=1 2024-05-09T12:06:22.338Z,1715256382.338 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-09T12:06:22.338Z,1715256382.338 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-09T12:06:22.338Z,1715256382.338 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-09T12:06:22.339Z,1715256382.339 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-09T12:06:22.339Z,1715256382.339 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-09T12:06:22.340Z,1715256382.340 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-09T12:06:22.340Z,1715256382.340 [Default:A.Wait] Running Loop=1 2024-05-09T12:06:22.340Z,1715256382.340 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-05-09T12:06:35.347Z,1715256395.347 [Default:A.Wait](INFO): Done Waiting. 2024-05-09T12:06:35.347Z,1715256395.347 [Default:A.Wait] Stopped 2024-05-09T12:06:35.347Z,1715256395.347 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-05-09T12:06:35.693Z,1715256395.693 [Default:CheckIn] Running Loop=1 2024-05-09T12:06:35.694Z,1715256395.694 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-09T12:06:35.694Z,1715256395.694 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-09T12:06:36.096Z,1715256396.096 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-05-09T12:08:10.607Z,1715256490.607 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-05-09T12:08:28.805Z,1715256508.805 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-05-09T12:08:28.805Z,1715256508.805 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-09T12:08:28.816Z,1715256508.816 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-09T12:08:29.201Z,1715256509.201 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-09T12:08:29.201Z,1715256509.201 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-05-09T12:10:18.246Z,1715256618.246 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2024-05-09T12:10:18.249Z,1715256618.249 [BPC1](INFO): Received data from all battery sticks. 2024-05-09T12:11:29.766Z,1715256689.766 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-05-09T12:11:29.766Z,1715256689.766 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-09T12:11:29.777Z,1715256689.777 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-09T12:11:30.191Z,1715256690.191 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-09T12:11:30.191Z,1715256690.191 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-05-09T12:11:35.850Z,1715256695.850 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-09T12:06:35.7Z 2024-05-09T12:11:35.850Z,1715256695.850 [Default:CheckIn:Read_GPS] Stopped 2024-05-09T12:11:35.850Z,1715256695.850 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-09T12:11:36.249Z,1715256696.249 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-09T12:12:06.917Z,1715256726.917 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 2024-05-09T12:12:07.001Z,1715256727.001 [NAL9602](ERROR): received: +CSQ:0 OK. 2024-05-09T12:12:22.083Z,1715256742.083 [DVL_micro](ERROR): Failed to parse: :BI,+00000,+00000,+00000,+00000,I 2024-05-09T12:12:51.961Z,1715256771.961 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2024-05-09T12:13:01.898Z,1715256781.898 [DVL_micro](ERROR): Failed to parse: :SA,+75.51,-00.83,212.5 2024-05-09T12:13:10.086Z,1715256790.086 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-05-09T12:13:10.086Z,1715256790.086 [NAL9602] Data Fault, FailCount= 1 2024-05-09T12:13:10.086Z,1715256790.086 [NAL9602](ERROR): Data Fault 2024-05-09T12:13:10.103Z,1715256790.103 [CBIT](ERROR): Data Fault in component: NAL9602 2024-05-09T12:13:10.488Z,1715256790.488 [NAL9602](INFO): Powering down 2024-05-09T12:13:11.333Z,1715256791.333 [CBIT](INFO): Clearing failed state for component NAL9602 2024-05-09T12:13:11.333Z,1715256791.333 [NAL9602] No Fault, FailCount= 1 2024-05-09T12:13:40.799Z,1715256820.799 [NAL9602](INFO): Powering up NAL9602 2024-05-09T12:13:51.702Z,1715256831.702 [NAL9602](INFO): NAL9602 initialized 2024-05-09T12:14:06.397Z,1715256846.397 [DVL_micro](ERROR): Failed to parse: :WI,-02616,-07793,-20853,+00000,A 2024-05-09T12:14:30.608Z,1715256870.608 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-05-09T12:14:30.608Z,1715256870.608 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-09T12:14:30.619Z,1715256870.619 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-09T12:14:30.994Z,1715256870.994 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-09T12:14:30.995Z,1715256870.995 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-05-09T12:15:57.695Z,1715256957.695 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2024-05-09T12:16:17.534Z,1715256977.534 [DVL_micro](ERROR): Failed to parse: :WI,-02616,-07793,-20853,+00000,A 2024-05-09T12:16:26.564Z,1715256986.564 [DVL_micro](ERROR): Failed to parse: :SA,+75.65,-00.81,213.0 2024-05-09T12:16:47.433Z,1715257007.433 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2024-05-09T12:16:54.455Z,1715257014.455 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300 revolution_per_minute 2024-05-09T12:16:54.459Z,1715257014.459 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2024-05-09T12:16:54.713Z,1715257014.713 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-09T12:17:28.832Z,1715257048.832 [CBIT](INFO): Clearing failed state for component DropWeight 2024-05-09T12:17:28.832Z,1715257048.832 [DropWeight] No Fault, FailCount= 1 2024-05-09T12:17:31.683Z,1715257051.683 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-05-09T12:17:31.683Z,1715257051.683 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-09T12:17:31.764Z,1715257051.764 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-09T12:17:32.132Z,1715257052.132 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-09T12:17:32.132Z,1715257052.132 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-05-09T12:18:17.266Z,1715257097.266 [DVL_micro](ERROR): No DVL communication! Re-initializing 2024-05-09T12:18:17.266Z,1715257097.266 [DVL_micro] Communications Fault, FailCount= 1 2024-05-09T12:18:17.266Z,1715257097.266 [DVL_micro](ERROR): Communications Fault 2024-05-09T12:18:17.324Z,1715257097.324 [CBIT](ERROR): Communications Fault in component: DVL_micro 2024-05-09T12:18:17.765Z,1715257097.765 [DVL_micro](INFO): Powering down 2024-05-09T12:18:18.624Z,1715257098.624 [CBIT](INFO): Clearing failed state for component DVL_micro 2024-05-09T12:18:18.624Z,1715257098.624 [DVL_micro] No Fault, FailCount= 1 2024-05-09T12:20:31.628Z,1715257231.628 [DVL_micro](ERROR): Failed to parse: :WI,-00137,-00065,-00244,+00000,A 2024-05-09T12:20:32.847Z,1715257232.847 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-05-09T12:20:32.847Z,1715257232.847 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-09T12:20:32.936Z,1715257232.936 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-09T12:20:33.352Z,1715257233.352 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-09T12:20:33.352Z,1715257233.352 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-05-09T12:21:01.506Z,1715257261.506 [DVL_micro](ERROR): Failed to parse: :SA,+76.25,-00.84,213.9 2024-05-09T12:21:34.446Z,1715257294.446 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 0 revolution_per_minute 2024-05-09T12:22:38.127Z,1715257358.127 [CBIT](FAULT): WATER ALARM BOW. 2024-05-09T12:22:38.129Z,1715257358.129 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2024-05-09T12:22:38.226Z,1715257358.226 [CBIT](FAULT): WATER ALARM BOW. 2024-05-09T12:22:38.227Z,1715257358.227 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2024-05-09T12:22:38.621Z,1715257358.621 [CBIT](FAULT): WATER ALARM BOW. 2024-05-09T12:22:38.622Z,1715257358.622 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3 2024-05-09T12:22:39.004Z,1715257359.004 [CBIT](FAULT): WATER ALARM BOW. 2024-05-09T12:22:39.020Z,1715257359.020 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL: BOW. BURNWIRE ACTIVATED 2024-05-09T12:22:39.021Z,1715257359.021 [CBIT](IMPORTANT): Powered off ESP with command: ! echo 0 > /dev/loadA6 2024-05-09T12:22:39.082Z,1715257359.082 [CommandExec](IMPORTANT): got command ! echo 0 > /dev/loadA6 2024-05-09T12:22:39.407Z,1715257359.407 [CBIT](INFO): Critical error at 20240509T122239 2024-05-09T12:22:40.168Z,1715257360.168 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-05-09T12:22:40.168Z,1715257360.168 [DropWeight] Hardware Fault, FailCount= 1 2024-05-09T12:22:40.168Z,1715257360.168 [DropWeight](ERROR): Hardware Fault 2024-05-09T12:22:40.246Z,1715257360.246 [CBIT](INFO): Critical error at 20240509T122240 2024-05-09T12:22:40.253Z,1715257360.253 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-05-09T12:22:40.253Z,1715257360.253 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-05-09T12:22:40.617Z,1715257360.617 [CBIT](INFO): Critical error at 20240509T122240 2024-05-09T12:22:43.735Z,1715257363.735 [DVL_micro](ERROR): Failed to parse: :BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2024-05-09T12:22:55.001Z,1715257375.001 [CommandExec](IMPORTANT): got command quit 2024-05-09T12:22:56.005Z,1715257376.005 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:56.005Z,1715257376.005 [CommandExec](INFO): Uninitializing the command executive. 2024-05-09T12:22:56.005Z,1715257376.005 [CommandExec](INFO): Uninitializing the command scheduler. 2024-05-09T12:22:56.005Z,1715257376.005 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.085Z,1715257376.085 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-05-09T12:22:56.085Z,1715257376.085 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-05-09T12:22:56.085Z,1715257376.085 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.086Z,1715257376.086 [NavChartDb](INFO): Join timeout helper Thread ID is 5511 2024-05-09T12:22:56.241Z,1715257376.241 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:56.241Z,1715257376.241 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.245Z,1715257376.245 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-05-09T12:22:56.245Z,1715257376.245 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.245Z,1715257376.245 [DAT](INFO): Join timeout helper Thread ID is 5512 2024-05-09T12:22:56.313Z,1715257376.313 [DAT](INFO): Powering down 2024-05-09T12:22:56.385Z,1715257376.385 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:56.385Z,1715257376.385 [DAT](INFO): Powering down 2024-05-09T12:22:56.386Z,1715257376.386 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.405Z,1715257376.405 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-05-09T12:22:56.405Z,1715257376.405 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.405Z,1715257376.405 [Radio_Surface](INFO): Join timeout helper Thread ID is 5513 2024-05-09T12:22:56.457Z,1715257376.457 [Radio_Surface](INFO): Powering down 2024-05-09T12:22:56.458Z,1715257376.458 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:56.458Z,1715257376.458 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.469Z,1715257376.469 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-05-09T12:22:56.469Z,1715257376.469 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:56.469Z,1715257376.469 [Onboard](INFO): Join timeout helper Thread ID is 5514 2024-05-09T12:22:58.677Z,1715257378.677 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:58.677Z,1715257378.677 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:58.694Z,1715257378.694 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-05-09T12:22:58.694Z,1715257378.694 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:58.694Z,1715257378.694 [DataOverHttps](INFO): Join timeout helper Thread ID is 5515 2024-05-09T12:22:59.641Z,1715257379.641 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:59.641Z,1715257379.641 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:59.645Z,1715257379.645 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-05-09T12:22:59.646Z,1715257379.646 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:59.646Z,1715257379.646 [BackseatComponent](INFO): Join timeout helper Thread ID is 5516 2024-05-09T12:22:59.693Z,1715257379.693 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:59.693Z,1715257379.693 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:59.709Z,1715257379.709 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-05-09T12:22:59.709Z,1715257379.709 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:59.710Z,1715257379.710 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5517 2024-05-09T12:22:59.817Z,1715257379.817 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:22:59.817Z,1715257379.817 [WetLabsBB2FL](INFO): Powering down 2024-05-09T12:22:59.818Z,1715257379.818 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:59.833Z,1715257379.833 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-05-09T12:22:59.833Z,1715257379.833 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:22:59.834Z,1715257379.834 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5518 2024-05-09T12:23:00.670Z,1715257380.670 [CTD_Seabird](INFO): Powering down 2024-05-09T12:23:00.685Z,1715257380.685 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:23:00.685Z,1715257380.685 [CTD_Seabird](INFO): Powering down 2024-05-09T12:23:00.697Z,1715257380.697 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.717Z,1715257380.717 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-05-09T12:23:00.717Z,1715257380.717 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.718Z,1715257380.718 [logger](INFO): Join timeout helper Thread ID is 5519 2024-05-09T12:23:00.721Z,1715257380.721 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:23:00.721Z,1715257380.721 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.733Z,1715257380.733 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-05-09T12:23:00.733Z,1715257380.733 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.734Z,1715257380.734 [CommandLine](INFO): Join timeout helper Thread ID is 5520 2024-05-09T12:23:00.769Z,1715257380.769 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:23:00.769Z,1715257380.769 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.785Z,1715257380.785 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-05-09T12:23:00.786Z,1715257380.786 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.786Z,1715257380.786 [CommandExec](INFO): Join timeout helper Thread ID is 5521 2024-05-09T12:23:00.797Z,1715257380.797 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-05-09T12:23:00.797Z,1715257380.797 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:00.798Z,1715257380.798 [controlThread](INFO): Join timeout helper Thread ID is 5522 2024-05-09T12:23:01.483Z,1715257381.483 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-09T12:23:01.484Z,1715257381.484 [controlThread](DEBUG): Uninitializing ControlThread 2024-05-09T12:23:01.486Z,1715257381.486 [AHRS_M2](INFO): Powering down 2024-05-09T12:23:01.653Z,1715257381.653 [DVL_micro](INFO): Powering down 2024-05-09T12:23:01.654Z,1715257381.654 [NAL9602](INFO): Powering down 2024-05-09T12:23:01.655Z,1715257381.655 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-05-09T12:23:01.656Z,1715257381.656 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-05-09T12:23:01.656Z,1715257381.656 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-05-09T12:23:01.657Z,1715257381.657 [MissionManager](INFO): Uninitializing Mission Default 2024-05-09T12:23:01.657Z,1715257381.657 [Default] Stopped 2024-05-09T12:23:01.657Z,1715257381.657 [Default](DEBUG): Aggregate::uninitialize Default 2024-05-09T12:23:01.657Z,1715257381.657 [Default:B.GoToSurface] Stopped 2024-05-09T12:23:01.657Z,1715257381.657 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-09T12:23:01.657Z,1715257381.657 [Default:CheckIn] Stopped 2024-05-09T12:23:01.658Z,1715257381.658 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-09T12:23:01.658Z,1715257381.658 [Default:CheckIn:Read_Iridium] Stopped 2024-05-09T12:23:01.660Z,1715257381.660 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-05-09T12:23:01.661Z,1715257381.661 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-05-09T12:23:01.661Z,1715257381.661 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-05-09T12:23:01.661Z,1715257381.661 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-05-09T12:23:01.662Z,1715257381.662 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-05-09T12:23:01.662Z,1715257381.662 [BuoyancyServo](INFO): Powering down 2024-05-09T12:23:01.677Z,1715257381.677 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-09T12:23:01.677Z,1715257381.677 [ElevatorServo](INFO): Powering down 2024-05-09T12:23:01.678Z,1715257381.678 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-05-09T12:23:01.678Z,1715257381.678 [MassServo](INFO): Powering down 2024-05-09T12:23:01.679Z,1715257381.679 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-05-09T12:23:01.679Z,1715257381.679 [RudderServo](INFO): Powering down 2024-05-09T12:23:01.680Z,1715257381.680 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-05-09T12:23:01.680Z,1715257381.680 [ThrusterHE](INFO): Powering down 2024-05-09T12:23:01.681Z,1715257381.681 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-05-09T12:23:01.681Z,1715257381.681 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-05-09T12:23:01.681Z,1715257381.681 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-05-09T12:23:01.681Z,1715257381.681 [CBIT](DEBUG): Powering off loads. 2024-05-09T12:23:01.692Z,1715257381.692 [CBIT](DEBUG): Disabling WDT. 2024-05-09T12:23:01.704Z,1715257381.704 [CBIT](DEBUG): Opening all GF detection circuits. 2024-05-09T12:23:01.706Z,1715257381.706 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.742Z,1715257381.742 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.748Z,1715257381.748 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.779Z,1715257381.779 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.783Z,1715257381.783 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.785Z,1715257381.785 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.792Z,1715257381.792 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.838Z,1715257381.838 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.891Z,1715257381.891 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-09T12:23:01.955Z,1715257381.955 [logger ThreadHandler](INFO): Thread cancelled.