2024-05-24T17:02:39.203Z,1716570159.203 [Supervisor](DEBUG): Initializing supervisor. 2024-05-24T17:02:39.233Z,1716570159.233 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-24T17:02:39.240Z,1716570159.240 [SyncHandler](INFO): Protected caller Thread ID is 899 2024-05-24T17:02:39.242Z,1716570159.242 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-24T17:02:39.262Z,1716570159.262 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-24T17:02:39.263Z,1716570159.263 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 900 2024-05-24T17:02:39.267Z,1716570159.267 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-24T17:02:39.289Z,1716570159.289 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-24T17:02:39.296Z,1716570159.296 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-24T17:02:39.297Z,1716570159.297 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 901 2024-05-24T17:02:39.301Z,1716570159.301 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-24T17:02:39.302Z,1716570159.302 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-24T17:02:39.302Z,1716570159.302 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 902 2024-05-24T17:02:39.304Z,1716570159.304 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-24T17:02:39.305Z,1716570159.305 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-24T17:02:39.306Z,1716570159.306 [logger ThreadHandler](INFO): Protected caller Thread ID is 903 2024-05-24T17:02:39.309Z,1716570159.309 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-24T17:02:39.310Z,1716570159.310 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-24T17:02:39.312Z,1716570159.312 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-24T17:02:39.601Z,1716570159.601 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-24T17:02:39.601Z,1716570159.601 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-24T17:02:40.542Z,1716570160.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-24T17:02:40.543Z,1716570160.543 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-24T17:02:40.794Z,1716570160.794 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-24T17:02:40.794Z,1716570160.794 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-24T17:02:40.887Z,1716570160.887 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-24T17:02:41.092Z,1716570161.092 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-24T17:02:41.092Z,1716570161.092 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-24T17:02:41.725Z,1716570161.725 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-24T17:02:41.846Z,1716570161.846 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-24T17:02:41.847Z,1716570161.847 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-24T17:02:42.263Z,1716570162.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-24T17:02:42.263Z,1716570162.263 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-24T17:02:42.828Z,1716570162.828 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-24T17:02:42.828Z,1716570162.828 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-24T17:02:43.071Z,1716570163.071 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-24T17:02:43.071Z,1716570163.071 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-24T17:02:43.274Z,1716570163.274 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-24T17:02:43.275Z,1716570163.275 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-24T17:02:43.834Z,1716570163.834 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-24T17:02:43.835Z,1716570163.835 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-24T17:02:44.148Z,1716570164.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-24T17:02:44.148Z,1716570164.148 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-24T17:02:44.437Z,1716570164.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-24T17:02:44.438Z,1716570164.438 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-24T17:02:45.256Z,1716570165.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-24T17:02:45.256Z,1716570165.256 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-24T17:02:45.651Z,1716570165.651 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-24T17:02:45.653Z,1716570165.653 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-05-24T17:02:45.654Z,1716570165.654 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-05-24T17:02:45.751Z,1716570165.751 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-05-24T17:02:45.932Z,1716570165.932 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-05-24T17:02:46.040Z,1716570166.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-05-24T17:02:46.185Z,1716570166.185 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-05-24T17:02:46.658Z,1716570166.658 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-05-24T17:02:47.308Z,1716570167.308 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-05-24T17:02:47.436Z,1716570167.436 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-05-24T17:02:47.713Z,1716570167.713 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-24T17:02:47.714Z,1716570167.714 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-05-24T17:02:47.822Z,1716570167.822 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-05-24T17:02:47.929Z,1716570167.929 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-05-24T17:02:48.086Z,1716570168.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-05-24T17:02:48.200Z,1716570168.200 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-05-24T17:02:48.200Z,1716570168.200 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-24T17:02:48.212Z,1716570168.212 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-24T17:02:48.322Z,1716570168.322 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-24T17:02:48.323Z,1716570168.323 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-24T17:02:48.375Z,1716570168.375 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-24T17:02:48.435Z,1716570168.435 [VerticalControl] Loaded 2024-05-24T17:02:48.435Z,1716570168.435 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-24T17:02:48.438Z,1716570168.438 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-24T17:02:48.485Z,1716570168.485 [HorizontalControl] Loaded 2024-05-24T17:02:48.485Z,1716570168.485 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-24T17:02:48.488Z,1716570168.488 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-24T17:02:48.491Z,1716570168.491 [SpeedControl] Loaded 2024-05-24T17:02:48.491Z,1716570168.491 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-24T17:02:48.494Z,1716570168.494 [LoopControl](DEBUG): Construct LoopControl. 2024-05-24T17:02:48.494Z,1716570168.494 [LoopControl] Loaded 2024-05-24T17:02:48.495Z,1716570168.495 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-24T17:02:48.495Z,1716570168.495 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-24T17:02:48.496Z,1716570168.496 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-24T17:02:48.545Z,1716570168.545 [DepthRateCalculator] Loaded 2024-05-24T17:02:48.545Z,1716570168.545 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-24T17:02:48.550Z,1716570168.550 [PitchRateCalculator] Loaded 2024-05-24T17:02:48.551Z,1716570168.551 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-24T17:02:48.560Z,1716570168.560 [SpeedCalculator] Loaded 2024-05-24T17:02:48.561Z,1716570168.561 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-24T17:02:48.565Z,1716570168.565 [YawRateCalculator] Loaded 2024-05-24T17:02:48.565Z,1716570168.565 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-24T17:02:48.584Z,1716570168.584 [ElevatorOffsetCalculator] Loaded 2024-05-24T17:02:48.584Z,1716570168.584 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-24T17:02:48.584Z,1716570168.584 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-24T17:02:48.585Z,1716570168.585 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-24T17:02:48.612Z,1716570168.612 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-24T17:02:48.613Z,1716570168.613 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-24T17:02:48.669Z,1716570168.669 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-24T17:02:48.670Z,1716570168.670 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-24T17:02:49.005Z,1716570169.005 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-24T17:02:49.005Z,1716570169.005 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-24T17:02:49.180Z,1716570169.180 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-24T17:02:49.180Z,1716570169.180 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-24T17:02:49.766Z,1716570169.766 [AHRS_M2] Loaded 2024-05-24T17:02:49.766Z,1716570169.766 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-24T17:02:50.026Z,1716570170.026 [BackseatComponent] Loaded 2024-05-24T17:02:50.026Z,1716570170.026 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-05-24T17:02:50.027Z,1716570170.027 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C34E0 2024-05-24T17:02:50.028Z,1716570170.028 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 988 2024-05-24T17:02:50.031Z,1716570170.031 [LcmUniversalReporter] Loaded 2024-05-24T17:02:50.031Z,1716570170.031 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-05-24T17:02:50.842Z,1716570170.842 [BPC1] Loaded 2024-05-24T17:02:50.843Z,1716570170.843 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-24T17:02:51.078Z,1716570171.078 [DataOverHttps] Loaded 2024-05-24T17:02:51.078Z,1716570171.078 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-24T17:02:51.079Z,1716570171.079 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F34E0 2024-05-24T17:02:51.080Z,1716570171.080 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 989 2024-05-24T17:02:51.103Z,1716570171.103 [Depth_Keller] Loaded 2024-05-24T17:02:51.103Z,1716570171.103 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-24T17:02:51.108Z,1716570171.108 [DropWeight] Loaded 2024-05-24T17:02:51.108Z,1716570171.108 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-05-24T17:02:51.172Z,1716570171.172 [NAL9602] Loaded 2024-05-24T17:02:51.172Z,1716570171.172 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-24T17:02:51.203Z,1716570171.203 [Onboard] Loaded 2024-05-24T17:02:51.203Z,1716570171.203 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-24T17:02:51.204Z,1716570171.204 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A234E0 2024-05-24T17:02:51.204Z,1716570171.204 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 990 2024-05-24T17:02:51.218Z,1716570171.218 [Power24vConverter] Loaded 2024-05-24T17:02:51.219Z,1716570171.219 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-24T17:02:51.234Z,1716570171.234 [Radio_Surface] Loaded 2024-05-24T17:02:51.234Z,1716570171.234 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-24T17:02:51.235Z,1716570171.235 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0 2024-05-24T17:02:51.235Z,1716570171.235 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 991 2024-05-24T17:02:51.283Z,1716570171.283 [RDI_Pathfinder] Loaded 2024-05-24T17:02:51.283Z,1716570171.283 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-05-24T17:02:51.378Z,1716570171.378 [DAT] Loaded 2024-05-24T17:02:51.378Z,1716570171.378 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-05-24T17:02:51.379Z,1716570171.379 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0 2024-05-24T17:02:51.380Z,1716570171.380 [DAT ThreadHandler](INFO): Protected caller Thread ID is 992 2024-05-24T17:02:51.380Z,1716570171.380 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-24T17:02:51.381Z,1716570171.381 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-24T17:02:51.605Z,1716570171.605 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-24T17:02:51.605Z,1716570171.605 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-24T17:02:51.620Z,1716570171.620 [NavChart] Loaded 2024-05-24T17:02:51.620Z,1716570171.620 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-24T17:02:51.625Z,1716570171.625 [UniversalFixResidualReporter] Loaded 2024-05-24T17:02:51.626Z,1716570171.626 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-24T17:02:51.626Z,1716570171.626 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-24T17:02:51.627Z,1716570171.627 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-24T17:02:51.880Z,1716570171.880 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-24T17:02:51.889Z,1716570171.889 [SBIT] Loaded 2024-05-24T17:02:51.890Z,1716570171.890 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-24T17:02:51.893Z,1716570171.893 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-24T17:02:51.906Z,1716570171.906 [IBIT] Loaded 2024-05-24T17:02:51.906Z,1716570171.906 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-24T17:02:51.912Z,1716570171.912 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-24T17:02:52.016Z,1716570172.016 [CBIT] Loaded 2024-05-24T17:02:52.017Z,1716570172.017 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-24T17:02:52.017Z,1716570172.017 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-24T17:02:52.018Z,1716570172.018 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-24T17:02:52.151Z,1716570172.151 [BuoyancyServo] Loaded 2024-05-24T17:02:52.151Z,1716570172.151 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-24T17:02:52.174Z,1716570172.174 [ElevatorServo] Loaded 2024-05-24T17:02:52.175Z,1716570172.175 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-24T17:02:52.205Z,1716570172.205 [DockingStepper] Loaded 2024-05-24T17:02:52.205Z,1716570172.205 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-05-24T17:02:52.227Z,1716570172.227 [MassServo] Loaded 2024-05-24T17:02:52.227Z,1716570172.227 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-24T17:02:52.248Z,1716570172.248 [RudderServo] Loaded 2024-05-24T17:02:52.248Z,1716570172.248 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-24T17:02:52.267Z,1716570172.267 [ThrusterServo] Loaded 2024-05-24T17:02:52.267Z,1716570172.267 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-05-24T17:02:52.268Z,1716570172.268 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-24T17:02:52.268Z,1716570172.268 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-24T17:02:52.278Z,1716570172.278 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-24T17:02:52.279Z,1716570172.279 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-24T17:02:52.464Z,1716570172.464 [CTD_Seabird] Loaded 2024-05-24T17:02:52.464Z,1716570172.464 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-24T17:02:52.465Z,1716570172.465 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2024-05-24T17:02:52.466Z,1716570172.466 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 993 2024-05-24T17:02:52.488Z,1716570172.488 [PAR_Licor] Loaded 2024-05-24T17:02:52.489Z,1716570172.489 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-24T17:02:52.533Z,1716570172.533 [WetLabsBB2FL] Loaded 2024-05-24T17:02:52.533Z,1716570172.533 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-24T17:02:52.534Z,1716570172.534 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-05-24T17:02:52.535Z,1716570172.535 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 994 2024-05-24T17:02:52.556Z,1716570172.556 [WetLabsUBAT] Loaded 2024-05-24T17:02:52.556Z,1716570172.556 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-05-24T17:02:52.557Z,1716570172.557 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-05-24T17:02:52.558Z,1716570172.558 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 995 2024-05-24T17:02:52.558Z,1716570172.558 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-24T17:02:52.564Z,1716570172.564 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-24T17:02:52.568Z,1716570172.568 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-24T17:02:52.579Z,1716570172.579 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-24T17:02:52.580Z,1716570172.580 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C674E0 2024-05-24T17:02:52.580Z,1716570172.580 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 996 2024-05-24T17:02:52.585Z,1716570172.585 [Supervisor](INFO): Main Thread ID is 897 2024-05-24T17:02:52.585Z,1716570172.585 [Supervisor](DEBUG): Running supervisor. 2024-05-24T17:02:52.591Z,1716570172.591 [CommandExec ThreadHandler](INFO): Handler Thread ID is 997 2024-05-24T17:02:52.591Z,1716570172.591 [CommandExec](INFO): Initializing the command executive. 2024-05-24T17:02:52.593Z,1716570172.593 [CommandLine ThreadHandler](INFO): Handler Thread ID is 998 2024-05-24T17:02:52.595Z,1716570172.595 [controlThread ThreadHandler](INFO): Handler Thread ID is 999 2024-05-24T17:02:52.596Z,1716570172.596 [controlThread](DEBUG): Initializing ControlThread 2024-05-24T17:02:52.596Z,1716570172.596 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-24T17:02:52.598Z,1716570172.598 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-24T17:02:52.599Z,1716570172.599 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-24T17:02:52.599Z,1716570172.599 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-24T17:02:52.600Z,1716570172.600 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-24T17:02:52.600Z,1716570172.600 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-24T17:02:52.600Z,1716570172.600 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-24T17:02:52.601Z,1716570172.601 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-24T17:02:52.601Z,1716570172.601 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-24T17:02:52.610Z,1716570172.610 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-24T17:02:52.610Z,1716570172.610 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-24T17:02:52.610Z,1716570172.610 [SBIT](INFO): Initialize SBIT Component. 2024-05-24T17:02:52.611Z,1716570172.611 [SBIT](IMPORTANT): git: 2024-05-22-2-gd2983461b 2024-05-24T17:02:52.611Z,1716570172.611 [SBIT](INFO): git hash: d2983461b0afca1bb4c5ae8a9b5bc51c90c2e86f 2024-05-24T17:02:52.611Z,1716570172.611 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-24T17:02:52.612Z,1716570172.612 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-05-24T17:02:52.614Z,1716570172.614 [SBIT](INFO): Beginning SBIT in 139.000000 seconds. 2024-05-24T17:02:52.614Z,1716570172.614 [IBIT](INFO): Initialize IBIT Component. 2024-05-24T17:02:52.615Z,1716570172.615 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-24T17:02:52.616Z,1716570172.616 [logger ThreadHandler](INFO): Handler Thread ID is 1000 2024-05-24T17:02:52.627Z,1716570172.627 [CBIT](DEBUG): Initialized mux pins. 2024-05-24T17:02:52.627Z,1716570172.627 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-24T17:02:52.635Z,1716570172.635 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1001 2024-05-24T17:02:52.647Z,1716570172.647 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1002 2024-05-24T17:02:52.648Z,1716570172.648 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-24T17:02:52.650Z,1716570172.650 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-24T17:02:52.651Z,1716570172.651 [CBIT](DEBUG): Initializing heartbeat. 2024-05-24T17:02:52.659Z,1716570172.659 [Onboard ThreadHandler](INFO): Handler Thread ID is 1003 2024-05-24T17:02:52.676Z,1716570172.676 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1004 2024-05-24T17:02:52.707Z,1716570172.707 [DAT ThreadHandler](INFO): Handler Thread ID is 1005 2024-05-24T17:02:52.707Z,1716570172.707 [DAT](INFO): Powering up 2024-05-24T17:02:52.708Z,1716570172.708 [DAT](DEBUG): Initializing DAT. 2024-05-24T17:02:52.715Z,1716570172.715 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1007 2024-05-24T17:02:52.715Z,1716570172.715 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-24T17:02:52.720Z,1716570172.720 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1009 2024-05-24T17:02:52.723Z,1716570172.723 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-24T17:02:52.723Z,1716570172.723 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-24T17:02:52.723Z,1716570172.723 [WetLabsBB2FL](INFO): Powering up 2024-05-24T17:02:52.725Z,1716570172.725 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 1011 2024-05-24T17:02:52.727Z,1716570172.727 [WetLabsUBAT](INFO): Powering up 2024-05-24T17:02:52.728Z,1716570172.728 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1013 2024-05-24T17:02:52.736Z,1716570172.736 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-05-24T17:02:52.736Z,1716570172.736 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-05-24T17:02:52.736Z,1716570172.736 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-05-24T17:02:52.736Z,1716570172.736 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-05-24T17:02:52.737Z,1716570172.737 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-05-24T17:02:52.737Z,1716570172.737 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-05-24T17:02:52.737Z,1716570172.737 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-05-24T17:02:52.737Z,1716570172.737 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-05-24T17:02:52.762Z,1716570172.762 [CBIT](DEBUG): Backplane powered. 2024-05-24T17:02:52.767Z,1716570172.767 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-24T17:02:52.768Z,1716570172.768 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2024-05-24T17:02:52.768Z,1716570172.768 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2024-05-24T17:02:52.771Z,1716570172.771 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2024-05-24T17:02:52.777Z,1716570172.777 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2024-05-24T17:02:52.777Z,1716570172.777 [MissionManager](ERROR): Top node has no child nodes: Mission 2024-05-24T17:02:52.778Z,1716570172.778 [MissionManager](ERROR): Could not load startup mission. 2024-05-24T17:02:52.782Z,1716570172.782 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2024-05-24T17:02:52.782Z,1716570172.782 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2024-05-24T17:02:52.785Z,1716570172.785 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2024-05-24T17:02:53.082Z,1716570173.082 [Radio_Surface](INFO): Powering up 2024-05-24T17:02:53.317Z,1716570173.317 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into: 0 30 2.5 1 30 Timed out while trying to detach from dock at current depth of . Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-05-24T17:02:53.384Z,1716570173.384 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-24T17:02:53.396Z,1716570173.396 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 30.000000 min 2024-05-24T17:02:53.400Z,1716570173.400 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 201 count 2024-05-24T17:02:53.414Z,1716570173.414 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 2.500000 s 2024-05-24T17:02:53.439Z,1716570173.439 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2024-05-24T17:02:53.440Z,1716570173.440 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2024-05-24T17:02:53.587Z,1716570173.587 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2024-05-24T17:02:53.587Z,1716570173.587 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2024-05-24T17:02:53.635Z,1716570173.635 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-24T17:02:53.688Z,1716570173.688 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-24T17:02:53.710Z,1716570173.710 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-24T17:02:53.717Z,1716570173.717 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2024-05-24T17:02:53.738Z,1716570173.738 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission DefaultWithUndock { arguments { ElapsedSinceDefaultStarted = 0 minute DetachTimeout = 30 minute """ Maximum time duration for the vehicle to detach form the dock. """ TransponderCode = Dock:Dock.transponderCode """ Dock transponder address. """ TrackingUpdatePeriod = 2.5 second """ Time duration between acoustic range queries while the mission is detaching from the dock. """ NumberOfPings = 1 count """ Number of pings requested each time. """ } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 30 second } aggregate LeaveDock { run in sequence timeout duration=DetachTimeout { syslog important "Timed out while trying to detach from dock at current depth of " + Universal:depth~meter + "." } # Acoustic tracking directives behavior Estimation:TrackAcousticContact { run in parallel set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } # Leave the dock behavior Dock:Undock { run in sequence } } aggregate SurfaceDefault { run in sequence # This mission assumes open water so from here on it's the same old default that's always used behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P2H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-05-24T17:02:53.742Z,1716570173.742 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-24T17:02:53.758Z,1716570173.758 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-24T17:02:53.991Z,1716570173.991 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1650.297119 decibar, 0.000000 m 2024-05-24T17:02:53.992Z,1716570173.992 [Power24vConverter](INFO): Powering up. 2024-05-24T17:02:53.993Z,1716570173.993 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-05-24T17:02:54.008Z,1716570174.008 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-05-24T17:02:54.091Z,1716570174.091 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-24T17:02:54.099Z,1716570174.099 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-24T17:02:54.100Z,1716570174.100 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-24T17:02:54.107Z,1716570174.107 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-24T17:02:54.107Z,1716570174.107 [DockingStepper](INFO): Start 2024-05-24T17:02:54.108Z,1716570174.108 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-24T17:02:54.115Z,1716570174.115 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-24T17:02:54.115Z,1716570174.115 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-24T17:02:54.123Z,1716570174.123 [MassServo](DEBUG): Initializing MassServo. 2024-05-24T17:02:54.123Z,1716570174.123 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-24T17:02:54.131Z,1716570174.131 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-24T17:02:54.131Z,1716570174.131 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-05-24T17:02:54.139Z,1716570174.139 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-05-24T17:02:54.287Z,1716570174.287 [DockingStepper](INFO): Starting 2024-05-24T17:02:54.578Z,1716570174.578 [DockingStepper](INFO): Starting 2024-05-24T17:02:55.135Z,1716570175.135 [DockingStepper](INFO): Starting 2024-05-24T17:02:55.183Z,1716570175.183 [DockingStepper](INFO): Init string: /1z14975aE13561N3m50 2024-05-24T17:02:55.335Z,1716570175.335 [WetLabsBB2FL](INFO): Powering down 2024-05-24T17:02:55.427Z,1716570175.427 [DockingStepper](INFO): Starting 2024-05-24T17:02:55.832Z,1716570175.832 [DockingStepper](INFO): Starting 2024-05-24T17:02:56.206Z,1716570176.206 [DockingStepper](INFO): Starting 2024-05-24T17:02:56.691Z,1716570176.691 [DockingStepper](INFO): Starting 2024-05-24T17:02:57.140Z,1716570177.140 [DockingStepper](INFO): Starting 2024-05-24T17:02:57.172Z,1716570177.172 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-24T17:02:57.460Z,1716570177.460 [DockingStepper](INFO): Starting 2024-05-24T17:02:58.407Z,1716570178.407 [DockingStepper](INFO): Pause 2024-05-24T17:03:01.998Z,1716570181.998 [WetLabsUBAT](INFO): Powering down 2024-05-24T17:03:05.559Z,1716570185.559 [DAT](INFO): DAT read: 2024-05-24T17:03:05.560Z,1716570185.560 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-05-24T17:03:07.323Z,1716570187.323 [DAT](INFO): DAT read: MF Frequency Band 2024-05-24T17:03:07.324Z,1716570187.324 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-05-24T17:03:07.325Z,1716570187.325 [DAT](INFO): DAT read: May 24 2024 01:14:31 2024-05-24T17:03:07.409Z,1716570187.409 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004744 2024-05-24T17:03:08.331Z,1716570188.331 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-05-24T17:03:08.333Z,1716570188.333 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-05-24T17:03:08.333Z,1716570188.333 [DAT](INFO): commRate: 800 2024-05-24T17:03:10.398Z,1716570190.398 [DAT](INFO): entering command mode 2024-05-24T17:03:10.599Z,1716570190.599 [DAT](INFO): DAT read: 2024-05-24T17:03:10.599Z,1716570190.599 [DAT](INFO): DAT read: user:1> 2024-05-24T17:03:10.600Z,1716570190.600 [DAT](INFO): setting verbose to 3 2024-05-24T17:03:10.851Z,1716570190.851 [DAT](INFO): DAT read: user:1> 2024-05-24T17:03:10.852Z,1716570190.852 [DAT](INFO): DAT read: Verbose | 3 2024-05-24T17:03:10.852Z,1716570190.852 [DAT](INFO): set verbose to 3 2024-05-24T17:03:10.852Z,1716570190.852 [DAT](INFO): setting DatVerbose to 27440 2024-05-24T17:03:11.103Z,1716570191.103 [DAT](INFO): DAT read: user:2> 2024-05-24T17:03:11.104Z,1716570191.104 [DAT](INFO): DAT read: DatVerbose | 27440 2024-05-24T17:03:11.104Z,1716570191.104 [DAT](INFO): set DatVerbose to 27440 2024-05-24T17:03:11.105Z,1716570191.105 [DAT](INFO): setting transmit power to 8 2024-05-24T17:03:11.355Z,1716570191.355 [DAT](INFO): DAT read: user:3> 2024-05-24T17:03:11.356Z,1716570191.356 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-05-24T17:03:11.356Z,1716570191.356 [DAT](INFO): set transmit power to 8 2024-05-24T17:03:11.357Z,1716570191.357 [DAT](INFO): setting local address to 10 2024-05-24T17:03:11.607Z,1716570191.607 [DAT](INFO): DAT read: user:4> 2024-05-24T17:03:11.608Z,1716570191.608 [DAT](INFO): DAT read: LocalAddr | 10 2024-05-24T17:03:11.608Z,1716570191.608 [DAT](INFO): set local address to 10 2024-05-24T17:03:11.609Z,1716570191.609 [DAT](INFO): Setting time to: 17:3:11 And date to:5/24/2024 2024-05-24T17:03:11.859Z,1716570191.859 [DAT](INFO): DAT read: user:5> 2024-05-24T17:03:11.860Z,1716570191.860 [DAT](INFO): DAT read: Fri May 24, 2024 17:03:11 2024-05-24T17:03:11.860Z,1716570191.860 [DAT](INFO): Local DAT time set to Fri May 24, 2024 17:03:11 2024-05-24T17:03:21.348Z,1716570201.348 [NAL9602](INFO): Powering up NAL9602 2024-05-24T17:03:32.256Z,1716570212.256 [NAL9602](INFO): NAL9602 initialized 2024-05-24T17:04:00.936Z,1716570240.936 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-24T17:04:16.287Z,1716570256.287 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-24T17:04:31.645Z,1716570271.645 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-24T17:04:46.991Z,1716570286.991 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-24T17:05:02.343Z,1716570302.343 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-24T17:05:12.064Z,1716570312.064 [SBIT](IMPORTANT): Beginning Startup BIT 2024-05-24T17:05:12.069Z,1716570312.069 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-24T17:05:17.695Z,1716570317.695 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-24T17:05:23.015Z,1716570323.015 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.005869 CHAN A1 (24V): 0.006107 CHAN A2 (12V): -0.005043 CHAN A3 (5V): -0.001703 CHAN B0 (3.3V): 0.000144 CHAN B1 (3.15aV): -0.000169 CHAN B2 (3.15bV): -0.000102 CHAN B3 (GND): 0.001885 OPEN: 0.005182 Full Scale: +/- 1 mA 2024-05-24T17:05:41.915Z,1716570341.915 [CommandExec](IMPORTANT): got command show stack 2024-05-24T17:05:41.916Z,1716570341.916 [CommandExec](IMPORTANT): Behavior Stack: 2024-05-24T17:05:41.916Z,1716570341.916 [MissionManager](IMPORTANT): Mission loaded, but not running. 2024-05-24T17:05:43.272Z,1716570343.272 [CommandExec](IMPORTANT): got command failComponent 2024-05-24T17:05:43.273Z,1716570343.273 [CommandExec](IMPORTANT): Failed components: 2024-05-24T17:05:43.273Z,1716570343.273 [CommandExec](IMPORTANT): No failed Components. 2024-05-24T17:05:47.123Z,1716570347.123 [CommandExec](IMPORTANT): got command quit 2024-05-24T17:05:48.126Z,1716570348.126 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-05-24T17:05:48.127Z,1716570348.127 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:48.127Z,1716570348.127 [CommandExec](INFO): Uninitializing the command executive. 2024-05-24T17:05:48.127Z,1716570348.127 [CommandExec](INFO): Uninitializing the command scheduler. 2024-05-24T17:05:48.127Z,1716570348.127 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.166Z,1716570348.166 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-05-24T17:05:48.166Z,1716570348.166 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-05-24T17:05:48.167Z,1716570348.167 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.167Z,1716570348.167 [NavChartDb](INFO): Join timeout helper Thread ID is 1027 2024-05-24T17:05:48.251Z,1716570348.251 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:48.251Z,1716570348.251 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.270Z,1716570348.270 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-05-24T17:05:48.270Z,1716570348.270 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.271Z,1716570348.271 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1028 2024-05-24T17:05:48.351Z,1716570348.351 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:48.351Z,1716570348.351 [WetLabsUBAT](INFO): Powering down 2024-05-24T17:05:48.352Z,1716570348.352 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.370Z,1716570348.370 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-05-24T17:05:48.371Z,1716570348.371 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.371Z,1716570348.371 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1029 2024-05-24T17:05:48.643Z,1716570348.643 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:48.643Z,1716570348.643 [WetLabsBB2FL](INFO): Powering down 2024-05-24T17:05:48.643Z,1716570348.643 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.662Z,1716570348.662 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-05-24T17:05:48.662Z,1716570348.662 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:48.663Z,1716570348.663 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1030 2024-05-24T17:05:49.430Z,1716570349.430 [CTD_Seabird](INFO): Powering down 2024-05-24T17:05:49.443Z,1716570349.443 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:49.444Z,1716570349.444 [CTD_Seabird](INFO): Powering down 2024-05-24T17:05:49.458Z,1716570349.458 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:49.478Z,1716570349.478 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-05-24T17:05:49.479Z,1716570349.479 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:49.479Z,1716570349.479 [DAT](INFO): Join timeout helper Thread ID is 1031 2024-05-24T17:05:49.634Z,1716570349.634 [DAT](INFO): Powering down 2024-05-24T17:05:49.707Z,1716570349.707 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:49.708Z,1716570349.708 [DAT](INFO): Powering down 2024-05-24T17:05:49.708Z,1716570349.708 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:49.710Z,1716570349.710 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-05-24T17:05:49.710Z,1716570349.710 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:49.710Z,1716570349.710 [Radio_Surface](INFO): Join timeout helper Thread ID is 1032 2024-05-24T17:05:49.727Z,1716570349.727 [Radio_Surface](INFO): Powering down 2024-05-24T17:05:49.727Z,1716570349.727 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:49.728Z,1716570349.728 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:49.731Z,1716570349.731 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-05-24T17:05:49.731Z,1716570349.731 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:49.732Z,1716570349.732 [Onboard](INFO): Join timeout helper Thread ID is 1033 2024-05-24T17:05:50.367Z,1716570350.367 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-05-24T17:05:52.810Z,1716570352.810 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:52.811Z,1716570352.811 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:52.827Z,1716570352.827 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-05-24T17:05:52.827Z,1716570352.827 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:52.827Z,1716570352.827 [DataOverHttps](INFO): Join timeout helper Thread ID is 1034 2024-05-24T17:05:52.911Z,1716570352.911 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-05-24T17:05:52.911Z,1716570352.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-24T17:05:52.922Z,1716570352.922 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-24T17:05:53.289Z,1716570353.289 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-24T17:05:53.290Z,1716570353.290 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-05-24T17:05:53.379Z,1716570353.379 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:53.379Z,1716570353.379 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.399Z,1716570353.399 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-05-24T17:05:53.399Z,1716570353.399 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.400Z,1716570353.400 [BackseatComponent](INFO): Join timeout helper Thread ID is 1038 2024-05-24T17:05:53.554Z,1716570353.554 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:53.555Z,1716570353.555 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.560Z,1716570353.560 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-05-24T17:05:53.561Z,1716570353.561 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.562Z,1716570353.562 [logger](INFO): Join timeout helper Thread ID is 1039 2024-05-24T17:05:53.580Z,1716570353.580 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:53.581Z,1716570353.581 [logger ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.601Z,1716570353.601 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-05-24T17:05:53.602Z,1716570353.602 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.603Z,1716570353.603 [CommandLine](INFO): Join timeout helper Thread ID is 1040 2024-05-24T17:05:53.695Z,1716570353.695 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:53.695Z,1716570353.695 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.707Z,1716570353.707 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-05-24T17:05:53.707Z,1716570353.707 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.708Z,1716570353.708 [CommandExec](INFO): Join timeout helper Thread ID is 1041 2024-05-24T17:05:53.709Z,1716570353.709 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-05-24T17:05:53.709Z,1716570353.709 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:53.709Z,1716570353.709 [controlThread](INFO): Join timeout helper Thread ID is 1042 2024-05-24T17:05:54.047Z,1716570354.047 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-24T17:05:54.047Z,1716570354.047 [controlThread](DEBUG): Uninitializing ControlThread 2024-05-24T17:05:54.047Z,1716570354.047 [AHRS_M2](INFO): Powering down 2024-05-24T17:05:54.120Z,1716570354.120 [NAL9602](INFO): Powering down 2024-05-24T17:05:54.191Z,1716570354.191 [RDI_Pathfinder](INFO): Powering down 2024-05-24T17:05:54.192Z,1716570354.192 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-05-24T17:05:54.193Z,1716570354.193 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-05-24T17:05:54.193Z,1716570354.193 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-05-24T17:05:54.194Z,1716570354.194 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2024-05-24T17:05:54.201Z,1716570354.201 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-05-24T17:05:54.201Z,1716570354.201 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-05-24T17:05:54.201Z,1716570354.201 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-05-24T17:05:54.201Z,1716570354.201 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-05-24T17:05:54.202Z,1716570354.202 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-05-24T17:05:54.202Z,1716570354.202 [BuoyancyServo](INFO): Powering down 2024-05-24T17:05:54.215Z,1716570354.215 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-05-24T17:05:54.215Z,1716570354.215 [ElevatorServo](INFO): Powering down 2024-05-24T17:05:54.215Z,1716570354.215 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-05-24T17:05:54.216Z,1716570354.216 [DockingStepper](INFO): Powering down 2024-05-24T17:05:54.216Z,1716570354.216 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-05-24T17:05:54.216Z,1716570354.216 [MassServo](INFO): Powering down 2024-05-24T17:05:54.217Z,1716570354.217 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-05-24T17:05:54.217Z,1716570354.217 [RudderServo](INFO): Powering down 2024-05-24T17:05:54.218Z,1716570354.218 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-05-24T17:05:54.218Z,1716570354.218 [ThrusterServo](INFO): Powering down 2024-05-24T17:05:54.219Z,1716570354.219 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-05-24T17:05:54.219Z,1716570354.219 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-05-24T17:05:54.220Z,1716570354.220 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-05-24T17:05:54.220Z,1716570354.220 [CBIT](DEBUG): Powering off loads. 2024-05-24T17:05:54.230Z,1716570354.230 [CBIT](DEBUG): Disabling WDT. 2024-05-24T17:05:54.242Z,1716570354.242 [CBIT](DEBUG): Opening all GF detection circuits. 2024-05-24T17:05:54.243Z,1716570354.243 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.293Z,1716570354.293 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.300Z,1716570354.300 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.302Z,1716570354.302 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.308Z,1716570354.308 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.350Z,1716570354.350 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.763Z,1716570354.763 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.765Z,1716570354.765 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.769Z,1716570354.769 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.777Z,1716570354.777 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-24T17:05:54.841Z,1716570354.841 [logger ThreadHandler](INFO): Thread cancelled.