2024-05-09T11:49:34.199Z,1715255374.199 [Supervisor](DEBUG): Initializing supervisor.
2024-05-09T11:49:34.203Z,1715255374.203 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-05-09T11:49:34.203Z,1715255374.203 [SyncHandler](INFO): Protected caller Thread ID is 4935
2024-05-09T11:49:34.204Z,1715255374.204 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-05-09T11:49:34.205Z,1715255374.205 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-05-09T11:49:34.205Z,1715255374.205 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4936
2024-05-09T11:49:34.209Z,1715255374.209 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-05-09T11:49:34.226Z,1715255374.226 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-05-09T11:49:34.227Z,1715255374.227 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-05-09T11:49:34.228Z,1715255374.228 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4937
2024-05-09T11:49:34.232Z,1715255374.232 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-05-09T11:49:34.233Z,1715255374.233 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-05-09T11:49:34.233Z,1715255374.233 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4938
2024-05-09T11:49:34.235Z,1715255374.235 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-05-09T11:49:34.236Z,1715255374.236 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-05-09T11:49:34.237Z,1715255374.237 [logger ThreadHandler](INFO): Protected caller Thread ID is 4939
2024-05-09T11:49:34.240Z,1715255374.240 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-05-09T11:49:34.241Z,1715255374.241 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-05-09T11:49:34.242Z,1715255374.242 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-05-09T11:49:34.350Z,1715255374.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-05-09T11:49:34.350Z,1715255374.350 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-05-09T11:49:34.598Z,1715255374.598 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-05-09T11:49:34.598Z,1715255374.598 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-05-09T11:49:34.888Z,1715255374.888 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-05-09T11:49:34.889Z,1715255374.889 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-05-09T11:49:35.009Z,1715255375.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-05-09T11:49:35.010Z,1715255375.010 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-05-09T11:49:35.869Z,1715255375.869 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-05-09T11:49:35.869Z,1715255375.869 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-05-09T11:49:36.401Z,1715255376.401 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-05-09T11:49:36.401Z,1715255376.401 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-05-09T11:49:36.965Z,1715255376.965 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-05-09T11:49:36.966Z,1715255376.966 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-05-09T11:49:37.401Z,1715255377.401 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-05-09T11:49:37.401Z,1715255377.401 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-05-09T11:49:37.762Z,1715255377.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-05-09T11:49:37.762Z,1715255377.762 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-05-09T11:49:38.159Z,1715255378.159 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-05-09T11:49:38.159Z,1715255378.159 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-05-09T11:49:38.402Z,1715255378.402 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-05-09T11:49:38.402Z,1715255378.402 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-05-09T11:49:38.558Z,1715255378.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-05-09T11:49:38.559Z,1715255378.559 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-05-09T11:49:38.652Z,1715255378.652 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-05-09T11:49:38.743Z,1715255378.743 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-05-09T11:49:38.944Z,1715255378.944 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-05-09T11:49:38.945Z,1715255378.945 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-05-09T11:49:39.421Z,1715255379.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-05-09T11:49:39.423Z,1715255379.423 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2024-05-09T11:49:39.424Z,1715255379.424 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2024-05-09T11:49:39.520Z,1715255379.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2024-05-09T11:49:39.798Z,1715255379.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-05-09T11:49:39.799Z,1715255379.799 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2024-05-09T11:49:39.906Z,1715255379.906 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2024-05-09T11:49:40.082Z,1715255380.082 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2024-05-09T11:49:40.193Z,1715255380.193 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2024-05-09T11:49:40.315Z,1715255380.315 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2024-05-09T11:49:40.440Z,1715255380.440 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2024-05-09T11:49:40.558Z,1715255380.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2024-05-09T11:49:40.733Z,1715255380.733 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2024-05-09T11:49:40.842Z,1715255380.842 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2024-05-09T11:49:40.951Z,1715255380.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2024-05-09T11:49:41.053Z,1715255381.053 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2024-05-09T11:49:41.053Z,1715255381.053 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-05-09T11:49:41.064Z,1715255381.064 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-05-09T11:49:41.253Z,1715255381.253 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-05-09T11:49:41.253Z,1715255381.253 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-05-09T11:49:41.394Z,1715255381.394 [BuoyancyServo] Loaded
2024-05-09T11:49:41.394Z,1715255381.394 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-05-09T11:49:41.415Z,1715255381.415 [ElevatorServo] Loaded
2024-05-09T11:49:41.415Z,1715255381.415 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-05-09T11:49:41.435Z,1715255381.435 [MassServo] Loaded
2024-05-09T11:49:41.436Z,1715255381.436 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-05-09T11:49:41.456Z,1715255381.456 [RudderServo] Loaded
2024-05-09T11:49:41.456Z,1715255381.456 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-05-09T11:49:41.472Z,1715255381.472 [ThrusterHE] Loaded
2024-05-09T11:49:41.472Z,1715255381.472 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-05-09T11:49:41.473Z,1715255381.473 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-05-09T11:49:41.473Z,1715255381.473 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-05-09T11:49:41.625Z,1715255381.625 [SBIT](DEBUG): Construct Startup Built In Test.
2024-05-09T11:49:41.639Z,1715255381.639 [SBIT] Loaded
2024-05-09T11:49:41.639Z,1715255381.639 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-05-09T11:49:41.642Z,1715255381.642 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-05-09T11:49:41.663Z,1715255381.663 [IBIT] Loaded
2024-05-09T11:49:41.663Z,1715255381.663 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-05-09T11:49:41.668Z,1715255381.668 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-05-09T11:49:41.885Z,1715255381.885 [CBIT] Loaded
2024-05-09T11:49:41.885Z,1715255381.885 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-05-09T11:49:41.886Z,1715255381.886 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-05-09T11:49:41.886Z,1715255381.886 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-05-09T11:49:42.065Z,1715255382.065 [CTD_Seabird] Loaded
2024-05-09T11:49:42.065Z,1715255382.065 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-05-09T11:49:42.066Z,1715255382.066 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0
2024-05-09T11:49:42.067Z,1715255382.067 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5025
2024-05-09T11:49:42.099Z,1715255382.099 [ESPComponent] Loaded
2024-05-09T11:49:42.099Z,1715255382.099 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-05-09T11:49:42.118Z,1715255382.118 [PAR_Licor] Loaded
2024-05-09T11:49:42.118Z,1715255382.118 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-05-09T11:49:42.161Z,1715255382.161 [WetLabsBB2FL] Loaded
2024-05-09T11:49:42.161Z,1715255382.161 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-05-09T11:49:42.162Z,1715255382.162 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0
2024-05-09T11:49:42.162Z,1715255382.162 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5026
2024-05-09T11:49:42.163Z,1715255382.163 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-05-09T11:49:42.164Z,1715255382.164 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-05-09T11:49:42.216Z,1715255382.216 [DepthRateCalculator] Loaded
2024-05-09T11:49:42.216Z,1715255382.216 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-05-09T11:49:42.222Z,1715255382.222 [PitchRateCalculator] Loaded
2024-05-09T11:49:42.222Z,1715255382.222 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-05-09T11:49:42.232Z,1715255382.232 [SpeedCalculator] Loaded
2024-05-09T11:49:42.232Z,1715255382.232 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-05-09T11:49:42.237Z,1715255382.237 [YawRateCalculator] Loaded
2024-05-09T11:49:42.237Z,1715255382.237 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-05-09T11:49:42.257Z,1715255382.257 [ElevatorOffsetCalculator] Loaded
2024-05-09T11:49:42.257Z,1715255382.257 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-05-09T11:49:42.257Z,1715255382.257 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-05-09T11:49:42.258Z,1715255382.258 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-05-09T11:49:42.379Z,1715255382.379 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-05-09T11:49:42.379Z,1715255382.379 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-05-09T11:49:42.407Z,1715255382.407 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-05-09T11:49:42.408Z,1715255382.408 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-05-09T11:49:42.521Z,1715255382.521 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-05-09T11:49:42.522Z,1715255382.522 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-05-09T11:49:42.535Z,1715255382.535 [NavChart] Loaded
2024-05-09T11:49:42.536Z,1715255382.536 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-05-09T11:49:42.541Z,1715255382.541 [UniversalFixResidualReporter] Loaded
2024-05-09T11:49:42.542Z,1715255382.542 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-05-09T11:49:42.542Z,1715255382.542 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-05-09T11:49:42.543Z,1715255382.543 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-05-09T11:49:43.006Z,1715255383.006 [AHRS_M2] Loaded
2024-05-09T11:49:43.006Z,1715255383.006 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-05-09T11:49:43.042Z,1715255383.042 [BackseatComponent] Loaded
2024-05-09T11:49:43.042Z,1715255383.042 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-05-09T11:49:43.043Z,1715255383.043 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0
2024-05-09T11:49:43.043Z,1715255383.043 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 5027
2024-05-09T11:49:43.046Z,1715255383.046 [LcmUniversalReporter] Loaded
2024-05-09T11:49:43.047Z,1715255383.047 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-05-09T11:49:43.787Z,1715255383.787 [BPC1] Loaded
2024-05-09T11:49:43.787Z,1715255383.787 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-05-09T11:49:43.860Z,1715255383.860 [DataOverHttps] Loaded
2024-05-09T11:49:43.860Z,1715255383.860 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-05-09T11:49:43.861Z,1715255383.861 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0
2024-05-09T11:49:43.862Z,1715255383.862 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5028
2024-05-09T11:49:43.883Z,1715255383.883 [Depth_Keller] Loaded
2024-05-09T11:49:43.883Z,1715255383.883 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-05-09T11:49:43.888Z,1715255383.888 [DropWeight] Loaded
2024-05-09T11:49:43.888Z,1715255383.888 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-05-09T11:49:43.928Z,1715255383.928 [DVL_micro] Loaded
2024-05-09T11:49:43.928Z,1715255383.928 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2024-05-09T11:49:43.989Z,1715255383.989 [NAL9602] Loaded
2024-05-09T11:49:43.989Z,1715255383.989 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-05-09T11:49:44.016Z,1715255384.016 [Onboard] Loaded
2024-05-09T11:49:44.016Z,1715255384.016 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-05-09T11:49:44.017Z,1715255384.017 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AB34E0
2024-05-09T11:49:44.017Z,1715255384.017 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5029
2024-05-09T11:49:44.030Z,1715255384.030 [Power24vConverter] Loaded
2024-05-09T11:49:44.030Z,1715255384.030 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-05-09T11:49:44.043Z,1715255384.043 [Radio_Surface] Loaded
2024-05-09T11:49:44.044Z,1715255384.044 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-05-09T11:49:44.045Z,1715255384.045 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AE34E0
2024-05-09T11:49:44.045Z,1715255384.045 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5030
2024-05-09T11:49:44.139Z,1715255384.139 [DAT] Loaded
2024-05-09T11:49:44.139Z,1715255384.139 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-05-09T11:49:44.141Z,1715255384.141 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B134E0
2024-05-09T11:49:44.141Z,1715255384.141 [DAT ThreadHandler](INFO): Protected caller Thread ID is 5031
2024-05-09T11:49:44.142Z,1715255384.142 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-05-09T11:49:44.142Z,1715255384.142 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-05-09T11:49:44.212Z,1715255384.212 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-05-09T11:49:44.213Z,1715255384.213 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-05-09T11:49:44.335Z,1715255384.335 [VerticalControl](DEBUG): Construct VerticalControl.
2024-05-09T11:49:44.512Z,1715255384.512 [VerticalControl] Loaded
2024-05-09T11:49:44.512Z,1715255384.512 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-05-09T11:49:44.515Z,1715255384.515 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-05-09T11:49:44.559Z,1715255384.559 [HorizontalControl] Loaded
2024-05-09T11:49:44.559Z,1715255384.559 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-05-09T11:49:44.561Z,1715255384.561 [SpeedControl](DEBUG): Construct SpeedControl.
2024-05-09T11:49:44.563Z,1715255384.563 [SpeedControl] Loaded
2024-05-09T11:49:44.563Z,1715255384.563 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-05-09T11:49:44.566Z,1715255384.566 [LoopControl](DEBUG): Construct LoopControl.
2024-05-09T11:49:44.567Z,1715255384.567 [LoopControl] Loaded
2024-05-09T11:49:44.567Z,1715255384.567 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-05-09T11:49:44.567Z,1715255384.567 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-05-09T11:49:44.568Z,1715255384.568 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-05-09T11:49:44.587Z,1715255384.587 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-05-09T11:49:44.588Z,1715255384.588 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-05-09T11:49:44.960Z,1715255384.960 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-05-09T11:49:44.966Z,1715255384.966 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-05-09T11:49:44.969Z,1715255384.969 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-05-09T11:49:44.980Z,1715255384.980 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-05-09T11:49:44.981Z,1715255384.981 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0
2024-05-09T11:49:44.982Z,1715255384.982 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5032
2024-05-09T11:49:44.986Z,1715255384.986 [Supervisor](INFO): Main Thread ID is 4934
2024-05-09T11:49:44.986Z,1715255384.986 [Supervisor](DEBUG): Running supervisor.
2024-05-09T11:49:44.987Z,1715255384.987 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5033
2024-05-09T11:49:44.987Z,1715255384.987 [CommandExec](INFO): Initializing the command executive.
2024-05-09T11:49:44.989Z,1715255384.989 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5034
2024-05-09T11:49:44.991Z,1715255384.991 [controlThread ThreadHandler](INFO): Handler Thread ID is 5035
2024-05-09T11:49:44.992Z,1715255384.992 [controlThread](DEBUG): Initializing ControlThread
2024-05-09T11:49:44.993Z,1715255384.993 [SBIT](INFO): Initialize SBIT Component.
2024-05-09T11:49:44.994Z,1715255384.994 [SBIT](IMPORTANT): git: 2024-05-06
2024-05-09T11:49:44.994Z,1715255384.994 [SBIT](INFO): git hash: 5fc11fab0683feef1094efea7282b340ac202615
2024-05-09T11:49:44.994Z,1715255384.994 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-05-09T11:49:44.996Z,1715255384.996 [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-09T11:49:44.997Z,1715255384.997 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2024-05-09T11:49:44.998Z,1715255384.998 [IBIT](INFO): Initialize IBIT Component.
2024-05-09T11:49:44.998Z,1715255384.998 [CBIT](DEBUG): Initialize CBIT Component.
2024-05-09T11:49:44.999Z,1715255384.999 [logger ThreadHandler](INFO): Handler Thread ID is 5036
2024-05-09T11:49:45.012Z,1715255385.012 [CBIT](DEBUG): Initialized mux pins.
2024-05-09T11:49:45.013Z,1715255385.013 [CBIT](DEBUG): Initializing the watchdog timer.
2024-05-09T11:49:45.025Z,1715255385.025 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5037
2024-05-09T11:49:45.026Z,1715255385.026 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-05-09T11:49:45.033Z,1715255385.033 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5039
2024-05-09T11:49:45.037Z,1715255385.037 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-05-09T11:49:45.037Z,1715255385.037 [CBIT](DEBUG): Initializing heartbeat.
2024-05-09T11:49:45.038Z,1715255385.038 [WetLabsBB2FL](INFO): Powering up
2024-05-09T11:49:45.039Z,1715255385.039 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 5041
2024-05-09T11:49:45.051Z,1715255385.051 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5042
2024-05-09T11:49:45.053Z,1715255385.053 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-05-09T11:49:45.073Z,1715255385.073 [Onboard ThreadHandler](INFO): Handler Thread ID is 5043
2024-05-09T11:49:45.091Z,1715255385.091 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5044
2024-05-09T11:49:45.108Z,1715255385.108 [CBIT](DEBUG): Deactivating GF circuits.
2024-05-09T11:49:45.109Z,1715255385.109 [CBIT](DEBUG): Deactivating emergency mode.
2024-05-09T11:49:45.109Z,1715255385.109 [DAT ThreadHandler](INFO): Handler Thread ID is 5045
2024-05-09T11:49:45.110Z,1715255385.110 [DAT](INFO): Powering up
2024-05-09T11:49:45.110Z,1715255385.110 [DAT](DEBUG): Initializing DAT.
2024-05-09T11:49:45.114Z,1715255385.114 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5047
2024-05-09T11:49:45.116Z,1715255385.116 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-05-09T11:49:45.116Z,1715255385.116 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-05-09T11:49:45.116Z,1715255385.116 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-05-09T11:49:45.117Z,1715255385.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-05-09T11:49:45.117Z,1715255385.117 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-05-09T11:49:45.117Z,1715255385.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-05-09T11:49:45.117Z,1715255385.117 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-05-09T11:49:45.117Z,1715255385.117 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-05-09T11:49:45.149Z,1715255385.149 [CBIT](DEBUG): Backplane powered.
2024-05-09T11:49:45.153Z,1715255385.153 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-05-09T11:49:45.153Z,1715255385.153 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-05-09T11:49:45.154Z,1715255385.154 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-05-09T11:49:45.154Z,1715255385.154 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-05-09T11:49:45.154Z,1715255385.154 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-05-09T11:49:45.155Z,1715255385.155 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-05-09T11:49:45.156Z,1715255385.156 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-05-09T11:49:45.163Z,1715255385.163 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-05-09T11:49:45.172Z,1715255385.172 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-05-09T11:49:45.173Z,1715255385.173 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-05-09T11:49:45.174Z,1715255385.174 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-05-09T11:49:45.174Z,1715255385.174 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-05-09T11:49:45.175Z,1715255385.175 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-05-09T11:49:45.175Z,1715255385.175 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-05-09T11:49:45.185Z,1715255385.185 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-05-09T11:49:45.250Z,1715255385.250 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-05-09T11:49:45.279Z,1715255385.279 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-09T11:49:45.303Z,1715255385.303 [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-09T11:49:45.304Z,1715255385.304 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-05-09T11:49:45.304Z,1715255385.304 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-05-09T11:49:45.325Z,1715255385.325 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-05-09T11:49:45.497Z,1715255385.497 [Radio_Surface](INFO): Powering up
2024-05-09T11:49:45.619Z,1715255385.619 [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-09T11:49:45.641Z,1715255385.641 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-05-09T11:49:45.642Z,1715255385.642 [Default:A.Wait](DEBUG): Construct Wait.
2024-05-09T11:49:45.661Z,1715255385.661 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-09T11:49:45.701Z,1715255385.701 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-05-09T11:49:45.703Z,1715255385.703 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-05-09T11:49:45.737Z,1715255385.737 [Default:E.Execute](DEBUG): Construct Execute.
2024-05-09T11:49:45.740Z,1715255385.740 [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-09T11:49:45.745Z,1715255385.745 [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-09T11:49:45.774Z,1715255385.774 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-05-09T11:49:45.849Z,1715255385.849 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m
2024-05-09T11:49:45.858Z,1715255385.858 [Power24vConverter](INFO): Powering up.
2024-05-09T11:49:45.866Z,1715255385.866 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-05-09T11:49:45.890Z,1715255385.890 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-05-09T11:49:45.897Z,1715255385.897 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-05-09T11:49:45.898Z,1715255385.898 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-05-09T11:49:45.905Z,1715255385.905 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-05-09T11:49:45.906Z,1715255385.906 [MassServo](DEBUG): Initializing EZServoServo.
2024-05-09T11:49:45.913Z,1715255385.913 [MassServo](DEBUG): Initializing MassServo.
2024-05-09T11:49:45.914Z,1715255385.914 [RudderServo](DEBUG): Initializing EZServoServo.
2024-05-09T11:49:45.921Z,1715255385.921 [RudderServo](DEBUG): Initializing RudderServo.
2024-05-09T11:49:45.922Z,1715255385.922 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-05-09T11:49:45.929Z,1715255385.929 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-05-09T11:49:46.192Z,1715255386.192 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2024-05-09T11:49:46.192Z,1715255386.192 [DropWeight] Hardware Fault, FailCount= 1
2024-05-09T11:49:46.192Z,1715255386.192 [DropWeight](ERROR): Hardware Fault
2024-05-09T11:49:46.238Z,1715255386.238 [CommandExec](FAULT): Scheduling is paused
2024-05-09T11:49:46.239Z,1715255386.239 [CBIT](INFO): Critical error at 20240509T114946
2024-05-09T11:49:46.239Z,1715255386.239 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-05-09T11:49:46.250Z,1715255386.250 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-05-09T11:49:46.250Z,1715255386.250 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-05-09T11:49:46.582Z,1715255386.582 [CBIT](INFO): Critical error at 20240509T114946
2024-05-09T11:49:47.145Z,1715255387.145 [WetLabsBB2FL](INFO): Powering down
2024-05-09T11:49:51.621Z,1715255391.621 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-05-09T11:49:55.125Z,1715255395.125 [CBIT](CRITICAL): Environmental Failure. Press:14.684661 PSI. Humidity:27%. Temp:26 C. ABORTING MISSION
2024-05-09T11:49:55.527Z,1715255395.527 [CBIT](INFO): Critical error at 20240509T114955
2024-05-09T11:49:56.954Z,1715255396.954 [DAT](INFO): DAT read:
2024-05-09T11:49:56.955Z,1715255396.955 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-05-09T11:49:58.717Z,1715255398.717 [DAT](INFO): DAT read: MF Frequency Band
2024-05-09T11:49:58.719Z,1715255398.719 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-05-09T11:49:58.719Z,1715255398.719 [DAT](INFO): DAT read: May 9 2024 11:49:53
2024-05-09T11:49:59.726Z,1715255399.726 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-05-09T11:49:59.727Z,1715255399.727 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2024-05-09T11:49:59.727Z,1715255399.727 [DAT](INFO): commRate: 1200
2024-05-09T11:50:01.793Z,1715255401.793 [DAT](INFO): entering command mode
2024-05-09T11:50:01.993Z,1715255401.993 [DAT](INFO): DAT read:
2024-05-09T11:50:01.994Z,1715255401.994 [DAT](INFO): DAT read: user:1>
2024-05-09T11:50:01.994Z,1715255401.994 [DAT](INFO): setting verbose to 3
2024-05-09T11:50:02.245Z,1715255402.245 [DAT](INFO): DAT read: user:1>
2024-05-09T11:50:02.246Z,1715255402.246 [DAT](INFO): DAT read: Verbose | 3
2024-05-09T11:50:02.247Z,1715255402.247 [DAT](INFO): set verbose to 3
2024-05-09T11:50:02.247Z,1715255402.247 [DAT](INFO): setting DatVerbose to 27440
2024-05-09T11:50:02.497Z,1715255402.497 [DAT](INFO): DAT read: user:2>
2024-05-09T11:50:02.498Z,1715255402.498 [DAT](INFO): DAT read: DatVerbose | 27440
2024-05-09T11:50:02.499Z,1715255402.499 [DAT](INFO): set DatVerbose to 27440
2024-05-09T11:50:02.499Z,1715255402.499 [DAT](INFO): setting transmit power to 8
2024-05-09T11:50:02.749Z,1715255402.749 [DAT](INFO): DAT read: user:3>
2024-05-09T11:50:02.750Z,1715255402.750 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-05-09T11:50:02.750Z,1715255402.750 [DAT](INFO): set transmit power to 8
2024-05-09T11:50:02.751Z,1715255402.751 [DAT](INFO): setting local address to 5
2024-05-09T11:50:03.001Z,1715255403.001 [DAT](INFO): DAT read: user:4>
2024-05-09T11:50:03.002Z,1715255403.002 [DAT](INFO): DAT read: LocalAddr | 5
2024-05-09T11:50:03.002Z,1715255403.002 [DAT](INFO): set local address to 5
2024-05-09T11:50:03.003Z,1715255403.003 [DAT](INFO): Setting time to: 11:50:3 And date to:5/9/2024
2024-05-09T11:50:03.253Z,1715255403.253 [DAT](INFO): DAT read: user:5>
2024-05-09T11:50:03.254Z,1715255403.254 [DAT](INFO): DAT read: Thu May 9, 2024 11:50:03
2024-05-09T11:50:03.254Z,1715255403.254 [DAT](INFO): Local DAT time set to Thu May 9, 2024 11:50:03
2024-05-09T11:50:14.066Z,1715255414.066 [NAL9602](INFO): Powering up NAL9602
2024-05-09T11:50:24.962Z,1715255424.962 [NAL9602](INFO): NAL9602 initialized
2024-05-09T11:50:26.729Z,1715255426.729 [CommandExec](IMPORTANT): got command failComponent
2024-05-09T11:50:26.729Z,1715255426.729 [CommandExec](IMPORTANT): Failed components:
2024-05-09T11:50:26.730Z,1715255426.730 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2024-05-09T11:50:36.361Z,1715255436.361 [CommandExec](IMPORTANT): got command get height_above_sea_floor
2024-05-09T11:50:36.361Z,1715255436.361 [CommandExec](FAULT): Element has no value
2024-05-09T11:50:44.758Z,1715255444.758 [SBIT](IMPORTANT): Beginning Startup BIT
2024-05-09T11:50:44.779Z,1715255444.779 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-09T11:50:56.142Z,1715255456.142 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.015491
CHAN A1 (24V): 0.001639
CHAN A2 (12V): -0.004364
CHAN A3 (5V): -0.002446
CHAN B0 (3.3V): -0.001160
CHAN B1 (3.15aV): -0.000952
CHAN B2 (3.15bV): -0.000185
CHAN B3 (GND): 0.000561
OPEN: 0.007019
Full Scale: +/- 1 mA
2024-05-09T11:51:38.994Z,1715255498.994 [SBIT](IMPORTANT): SBIT PASSED
2024-05-09T11:51:38.994Z,1715255498.994 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-05-09T11:51:38.995Z,1715255498.995 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute;
2024-05-09T11:51:38.995Z,1715255498.995 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=0.7 degree;
2024-05-09T11:51:38.995Z,1715255498.995 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_mean_sea_water_temperature 5.000000 celsius;
2024-05-09T11:51:38.996Z,1715255498.996 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;
2024-05-09T11:51:38.998Z,1715255498.998 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;
2024-05-09T11:51:38.998Z,1715255498.998 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;
2024-05-09T11:51:38.998Z,1715255498.998 [SBIT](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_petroleum_hydrocarbons_in_sea_water 1.000000 kilogram_per_cubic_meter;
2024-05-09T11:51:38.998Z,1715255498.998 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 0.500000 meter;
2024-05-09T11:51:38.998Z,1715255498.998 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=100 cubic_centimeter;
2024-05-09T11:51:38.998Z,1715255498.998 [SBIT](IMPORTANT): VerticalControl.massDefault=-1 centimeter;
2024-05-09T11:51:39.338Z,1715255499.338 [MissionManager](IMPORTANT): Started mission Startup
2024-05-09T11:51:39.339Z,1715255499.339 [Startup] Running Loop=1
2024-05-09T11:51:39.339Z,1715255499.339 [Startup](DEBUG): Aggregate::initialize Startup
2024-05-09T11:51:39.339Z,1715255499.339 [Startup:A.GoToSurface] Running Loop=1
2024-05-09T11:51:39.339Z,1715255499.339 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-09T11:51:39.340Z,1715255499.340 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-09T11:51:39.340Z,1715255499.340 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-09T11:51:39.357Z,1715255499.357 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-09T11:51:39.357Z,1715255499.357 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-09T11:51:39.357Z,1715255499.357 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-09T11:51:39.359Z,1715255499.359 [Startup:StartupSatComms] Running Loop=1
2024-05-09T11:51:39.359Z,1715255499.359 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-05-09T11:51:39.359Z,1715255499.359 [Startup:StartupSatComms:A] Running Loop=1
2024-05-09T11:51:39.831Z,1715255499.831 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-05-09T11:52:09.361Z,1715255529.361 [CommandExec](IMPORTANT): got command report mod PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water
2024-05-09T11:52:09.673Z,1715255529.673 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.601327 umol/s/m2
2024-05-09T11:52:10.026Z,1715255530.026 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.585353 umol/s/m2
2024-05-09T11:52:10.453Z,1715255530.453 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.576640 umol/s/m2
2024-05-09T11:52:10.853Z,1715255530.853 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.572284 umol/s/m2
2024-05-09T11:52:11.235Z,1715255531.235 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.602779 umol/s/m2
2024-05-09T11:52:11.637Z,1715255531.637 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.583901 umol/s/m2
2024-05-09T11:52:12.047Z,1715255532.047 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.553406 umol/s/m2
2024-05-09T11:52:12.458Z,1715255532.458 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.582449 umol/s/m2
2024-05-09T11:52:12.839Z,1715255532.839 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.563571 umol/s/m2
2024-05-09T11:52:13.309Z,1715255533.309 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.567927 umol/s/m2
2024-05-09T11:52:13.662Z,1715255533.662 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.556310 umol/s/m2
2024-05-09T11:52:14.049Z,1715255534.049 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.573736 umol/s/m2
2024-05-09T11:52:14.460Z,1715255534.460 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.556310 umol/s/m2
2024-05-09T11:52:14.885Z,1715255534.885 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.565023 umol/s/m2
2024-05-09T11:52:15.320Z,1715255535.320 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.551954 umol/s/m2
2024-05-09T11:52:15.697Z,1715255535.697 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.533076 umol/s/m2
2024-05-09T11:52:16.092Z,1715255536.092 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.517102 umol/s/m2
2024-05-09T11:52:16.489Z,1715255536.489 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.418356 umol/s/m2
2024-05-09T11:52:16.896Z,1715255536.896 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1.579937 umol/s/m2
2024-05-09T11:52:17.317Z,1715255537.317 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.068251 umol/s/m2
2024-05-09T11:52:17.684Z,1715255537.684 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.223631 umol/s/m2
2024-05-09T11:52:18.103Z,1715255538.103 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.242509 umol/s/m2
2024-05-09T11:52:18.528Z,1715255538.528 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.055182 umol/s/m2
2024-05-09T11:52:18.897Z,1715255538.897 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.092937 umol/s/m2
2024-05-09T11:52:19.374Z,1715255539.374 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.017426 umol/s/m2
2024-05-09T11:52:19.774Z,1715255539.774 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.380600 umol/s/m2
2024-05-09T11:52:20.185Z,1715255540.185 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.504033 umol/s/m2
2024-05-09T11:52:20.593Z,1715255540.593 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.538884 umol/s/m2
2024-05-09T11:52:20.963Z,1715255540.963 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.560667 umol/s/m2
2024-05-09T11:52:21.377Z,1715255541.377 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.570832 umol/s/m2
2024-05-09T11:52:21.738Z,1715255541.738 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.567927 umol/s/m2
2024-05-09T11:52:22.154Z,1715255542.154 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.543241 umol/s/m2
2024-05-09T11:52:22.545Z,1715255542.545 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.582449 umol/s/m2
2024-05-09T11:52:22.946Z,1715255542.946 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.533076 umol/s/m2
2024-05-09T11:52:23.377Z,1715255543.377 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.591162 umol/s/m2
2024-05-09T11:52:23.742Z,1715255543.742 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.601327 umol/s/m2
2024-05-09T11:52:24.163Z,1715255544.163 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.585353 umol/s/m2
2024-05-09T11:52:24.570Z,1715255544.570 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.566475 umol/s/m2
2024-05-09T11:52:24.971Z,1715255544.971 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.544693 umol/s/m2
2024-05-09T11:52:25.412Z,1715255545.412 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.585353 umol/s/m2
2024-05-09T11:52:25.785Z,1715255545.785 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.588257 umol/s/m2
2024-05-09T11:52:26.226Z,1715255546.226 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.575188 umol/s/m2
2024-05-09T11:52:26.601Z,1715255546.601 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.572284 umol/s/m2
2024-05-09T11:52:26.979Z,1715255546.979 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.580997 umol/s/m2
2024-05-09T11:52:27.391Z,1715255547.391 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.547597 umol/s/m2
2024-05-09T11:52:27.794Z,1715255547.794 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.575188 umol/s/m2
2024-05-09T11:52:28.211Z,1715255548.211 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.569380 umol/s/m2
2024-05-09T11:52:28.597Z,1715255548.597 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.556310 umol/s/m2
2024-05-09T11:52:28.878Z,1715255548.878 [CommandExec](IMPORTANT): got command strobe off
2024-05-09T11:52:28.878Z,1715255548.878 [CommandExec](IMPORTANT): Deactivating strobe
2024-05-09T11:52:29.001Z,1715255549.001 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.598422 umol/s/m2
2024-05-09T11:52:29.418Z,1715255549.418 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.551954 umol/s/m2
2024-05-09T11:52:29.823Z,1715255549.823 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.572284 umol/s/m2
2024-05-09T11:52:30.265Z,1715255550.265 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.565023 umol/s/m2
2024-05-09T11:52:30.633Z,1715255550.633 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.578092 umol/s/m2
2024-05-09T11:52:31.074Z,1715255551.074 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.560667 umol/s/m2
2024-05-09T11:52:31.465Z,1715255551.465 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.582449 umol/s/m2
2024-05-09T11:52:31.854Z,1715255551.854 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.583901 umol/s/m2
2024-05-09T11:52:32.238Z,1715255552.238 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.585353 umol/s/m2
2024-05-09T11:52:32.699Z,1715255552.699 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.549049 umol/s/m2
2024-05-09T11:52:33.108Z,1715255553.108 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.586805 umol/s/m2
2024-05-09T11:52:33.529Z,1715255553.529 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.582449 umol/s/m2
2024-05-09T11:52:33.892Z,1715255553.892 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.575188 umol/s/m2
2024-05-09T11:52:34.277Z,1715255554.277 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.599874 umol/s/m2
2024-05-09T11:52:34.672Z,1715255554.672 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.573736 umol/s/m2
2024-05-09T11:52:35.091Z,1715255555.091 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:35.470Z,1715255555.470 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.567927 umol/s/m2
2024-05-09T11:52:35.896Z,1715255555.896 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.556310 umol/s/m2
2024-05-09T11:52:36.306Z,1715255556.306 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.543241 umol/s/m2
2024-05-09T11:52:36.707Z,1715255556.707 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:37.133Z,1715255557.133 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.565023 umol/s/m2
2024-05-09T11:52:37.489Z,1715255557.489 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:37.898Z,1715255557.898 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.583901 umol/s/m2
2024-05-09T11:52:38.314Z,1715255558.314 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.575188 umol/s/m2
2024-05-09T11:52:38.692Z,1715255558.692 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.566475 umol/s/m2
2024-05-09T11:52:39.113Z,1715255559.113 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.594066 umol/s/m2
2024-05-09T11:52:39.493Z,1715255559.493 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-09T11:51:39.4Z
2024-05-09T11:52:39.493Z,1715255559.493 [Startup:StartupSatComms:A] Stopped
2024-05-09T11:52:39.493Z,1715255559.493 [Startup:StartupSatComms:B] Running Loop=1
2024-05-09T11:52:39.524Z,1715255559.524 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.578092 umol/s/m2
2024-05-09T11:52:39.895Z,1715255559.895 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-09T11:52:39.906Z,1715255559.906 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.557762 umol/s/m2
2024-05-09T11:52:40.325Z,1715255560.325 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.565023 umol/s/m2
2024-05-09T11:52:40.720Z,1715255560.720 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.605683 umol/s/m2
2024-05-09T11:52:41.161Z,1715255561.161 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.543241 umol/s/m2
2024-05-09T11:52:41.551Z,1715255561.551 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:41.975Z,1715255561.975 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.611492 umol/s/m2
2024-05-09T11:52:42.381Z,1715255562.381 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.586805 umol/s/m2
2024-05-09T11:52:42.751Z,1715255562.751 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.567927 umol/s/m2
2024-05-09T11:52:43.177Z,1715255563.177 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.572284 umol/s/m2
2024-05-09T11:52:43.543Z,1715255563.543 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.601327 umol/s/m2
2024-05-09T11:52:43.963Z,1715255563.963 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.589710 umol/s/m2
2024-05-09T11:52:44.383Z,1715255564.383 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.585353 umol/s/m2
2024-05-09T11:52:44.750Z,1715255564.750 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:45.157Z,1715255565.157 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-05-09T11:52:45.157Z,1715255565.157 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-09T11:52:45.168Z,1715255565.168 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-09T11:52:45.169Z,1715255565.169 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.570832 umol/s/m2
2024-05-09T11:52:45.571Z,1715255565.571 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-09T11:52:45.571Z,1715255565.571 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-05-09T11:52:45.574Z,1715255565.574 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.580997 umol/s/m2
2024-05-09T11:52:46.099Z,1715255566.099 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.578092 umol/s/m2
2024-05-09T11:52:46.429Z,1715255566.429 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.575188 umol/s/m2
2024-05-09T11:52:46.881Z,1715255566.881 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.566475 umol/s/m2
2024-05-09T11:52:47.246Z,1715255567.246 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.576640 umol/s/m2
2024-05-09T11:52:47.615Z,1715255567.615 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.565023 umol/s/m2
2024-05-09T11:52:48.038Z,1715255568.038 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:48.396Z,1715255568.396 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.595518 umol/s/m2
2024-05-09T11:52:48.814Z,1715255568.814 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.596971 umol/s/m2
2024-05-09T11:52:49.234Z,1715255569.234 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.579545 umol/s/m2
2024-05-09T11:52:49.610Z,1715255569.610 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.589710 umol/s/m2
2024-05-09T11:52:50.033Z,1715255570.033 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.570832 umol/s/m2
2024-05-09T11:52:50.126Z,1715255570.126 [CommandExec](IMPORTANT): got command report clear
2024-05-09T11:52:51.373Z,1715255571.373 [CommandExec](IMPORTANT): got command failComponent
2024-05-09T11:52:51.373Z,1715255571.373 [CommandExec](IMPORTANT): Failed components:
2024-05-09T11:52:51.374Z,1715255571.374 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2024-05-09T11:53:04.082Z,1715255584.082 [CommandExec](IMPORTANT): got command show stack
2024-05-09T11:53:04.082Z,1715255584.082 [CommandExec](IMPORTANT): Behavior Stack:
2024-05-09T11:53:04.082Z,1715255584.082 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2024-05-09T11:53:04.082Z,1715255584.082 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B
2024-05-09T11:53:39.786Z,1715255619.786 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-09T11:52:39.5Z
2024-05-09T11:53:39.786Z,1715255619.786 [Startup:StartupSatComms:B] Stopped
2024-05-09T11:53:39.787Z,1715255619.787 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-05-09T11:53:39.787Z,1715255619.787 [Startup:StartupSatComms] Stopped
2024-05-09T11:53:39.787Z,1715255619.787 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-05-09T11:53:39.788Z,1715255619.788 [Startup](INFO): Completed Startup
2024-05-09T11:53:39.788Z,1715255619.788 [MissionManager](INFO): Startup is completed.
2024-05-09T11:53:39.788Z,1715255619.788 [MissionManager](INFO): Uninitializing Mission Startup
2024-05-09T11:53:39.788Z,1715255619.788 [Startup] Stopped
2024-05-09T11:53:39.788Z,1715255619.788 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-05-09T11:53:39.788Z,1715255619.788 [Startup:A.GoToSurface] Stopped
2024-05-09T11:53:39.788Z,1715255619.788 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-09T11:53:40.099Z,1715255620.099 [MissionManager](IMPORTANT): Started mission Default
2024-05-09T11:53:40.099Z,1715255620.099 [Default] Running Loop=1
2024-05-09T11:53:40.099Z,1715255620.099 [Default](DEBUG): Aggregate::initialize Default
2024-05-09T11:53:40.099Z,1715255620.099 [Default:B.GoToSurface] Running Loop=1
2024-05-09T11:53:40.099Z,1715255620.099 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-09T11:53:40.100Z,1715255620.100 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-09T11:53:40.100Z,1715255620.100 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-09T11:53:40.100Z,1715255620.100 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-09T11:53:40.101Z,1715255620.101 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-09T11:53:40.101Z,1715255620.101 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-09T11:53:40.101Z,1715255620.101 [Default:A.Wait] Running Loop=1
2024-05-09T11:53:40.101Z,1715255620.101 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-05-09T11:53:53.449Z,1715255633.449 [Default:A.Wait](INFO): Done Waiting.
2024-05-09T11:53:53.449Z,1715255633.449 [Default:A.Wait] Stopped
2024-05-09T11:53:53.450Z,1715255633.450 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-05-09T11:53:53.963Z,1715255633.963 [Default:CheckIn] Running Loop=1
2024-05-09T11:53:53.963Z,1715255633.963 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-09T11:53:53.963Z,1715255633.963 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-09T11:53:54.294Z,1715255634.294 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-05-09T11:54:22.203Z,1715255662.203 [CommandExec](IMPORTANT): got command show variable dvl_micro
2024-05-09T11:54:22.344Z,1715255662.344 [CommandExec](IMPORTANT): DVL_micro.loadAtStartup (bool)
2024-05-09T11:54:22.345Z,1715255662.345 [CommandExec](IMPORTANT): DVL_micro.simulateHardware (bool)
2024-05-09T11:54:22.345Z,1715255662.345 [CommandExec](IMPORTANT): DVL_micro.magDeviation (degree)
2024-05-09T11:54:22.346Z,1715255662.346 [CommandExec](IMPORTANT): DVL_micro.pitchOffset (degree)
2024-05-09T11:54:22.346Z,1715255662.346 [CommandExec](IMPORTANT): DVL_micro.power (watt)
2024-05-09T11:54:22.346Z,1715255662.346 [CommandExec](IMPORTANT): DVL_micro.rollOffset (degree)
2024-05-09T11:54:22.401Z,1715255662.401 [CommandExec](IMPORTANT): DVL_micro.loadControl (none)
2024-05-09T11:54:22.402Z,1715255662.402 [CommandExec](IMPORTANT): DVL_micro.uart (none)
2024-05-09T11:54:22.402Z,1715255662.402 [CommandExec](IMPORTANT): DVL_micro.baud (bit_per_second)
2024-05-09T11:54:22.472Z,1715255662.472 [CommandExec](IMPORTANT): DVL_micro.enableBroadcast (bool)
2024-05-09T11:54:22.472Z,1715255662.472 [CommandExec](IMPORTANT): DVL_micro.component_voltage (volt)
2024-05-09T11:54:22.473Z,1715255662.473 [CommandExec](IMPORTANT): DVL_micro.component_avgVoltage (volt)
2024-05-09T11:54:22.473Z,1715255662.473 [CommandExec](IMPORTANT): DVL_micro.component_current (milliampere)
2024-05-09T11:54:22.473Z,1715255662.473 [CommandExec](IMPORTANT): DVL_micro.component_avgCurrent (milliampere)
2024-05-09T11:54:22.474Z,1715255662.474 [CommandExec](IMPORTANT): DVL_micro.height_above_sea_floor (meter)
2024-05-09T11:54:22.474Z,1715255662.474 [CommandExec](IMPORTANT): DVL_micro.platform_velocity_wrt_ground (meter_per_second)
2024-05-09T11:54:22.474Z,1715255662.474 [CommandExec](IMPORTANT): DVL_micro.platform_x_velocity_wrt_ground (meter_per_second)
2024-05-09T11:54:22.475Z,1715255662.475 [CommandExec](IMPORTANT): DVL_micro.platform_y_velocity_wrt_ground (meter_per_second)
2024-05-09T11:54:22.475Z,1715255662.475 [CommandExec](IMPORTANT): DVL_micro.platform_z_velocity_wrt_ground (meter_per_second)
2024-05-09T11:54:22.476Z,1715255662.476 [CommandExec](IMPORTANT): DVL_micro.BottomVelocityFlag (count)
2024-05-09T11:54:22.476Z,1715255662.476 [CommandExec](IMPORTANT): DVL_micro.Beam1Range (meter)
2024-05-09T11:54:22.476Z,1715255662.476 [CommandExec](IMPORTANT): DVL_micro.Beam2Range (meter)
2024-05-09T11:54:22.477Z,1715255662.477 [CommandExec](IMPORTANT): DVL_micro.Beam3Range (meter)
2024-05-09T11:54:22.477Z,1715255662.477 [CommandExec](IMPORTANT): DVL_micro.Beam4Range (meter)
2024-05-09T11:54:30.966Z,1715255670.966 [CommandExec](IMPORTANT): got command get DVL_micro.loadAtStartup
2024-05-09T11:54:30.967Z,1715255670.967 [CommandExec](IMPORTANT): DVL_micro.loadAtStartup 1 bool
2024-05-09T11:54:36.545Z,1715255676.545 [CommandExec](IMPORTANT): got command get DVL_micro.simulateHardware
2024-05-09T11:54:36.546Z,1715255676.546 [CommandExec](IMPORTANT): DVL_micro.simulateHardware 0 bool
2024-05-09T11:55:27.547Z,1715255727.547 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-05-09T11:55:41.682Z,1715255741.682 [CommandExec](IMPORTANT): got command failComponent
2024-05-09T11:55:41.682Z,1715255741.682 [CommandExec](IMPORTANT): Failed components:
2024-05-09T11:55:41.682Z,1715255741.682 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2024-05-09T11:55:46.165Z,1715255746.165 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-05-09T11:55:46.165Z,1715255746.165 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-09T11:55:46.195Z,1715255746.195 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-09T11:55:46.586Z,1715255746.586 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-09T11:55:46.586Z,1715255746.586 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-05-09T11:57:03.791Z,1715255823.791 [CommandExec](IMPORTANT): got command failComponent hardware DVL_micro
2024-05-09T11:57:03.791Z,1715255823.791 [DVL_micro] Hardware Fault, FailCount= 1
2024-05-09T11:57:03.791Z,1715255823.791 [DVL_micro](ERROR): Hardware Fault
2024-05-09T11:57:03.792Z,1715255823.792 [CommandExec](IMPORTANT): DVL_micro failureMode is Hardware Fault
2024-05-09T11:57:03.808Z,1715255823.808 [CBIT](ERROR): Hardware Fault in component: DVL_micro
2024-05-09T11:57:04.213Z,1715255824.213 [DVL_micro](INFO): Powering down
2024-05-09T11:57:04.954Z,1715255824.954 [CBIT](INFO): Clearing failed state for component DVL_micro
2024-05-09T11:57:04.954Z,1715255824.954 [DVL_micro] No Fault, FailCount= 1
2024-05-09T11:57:49.182Z,1715255869.182 [CommandExec](IMPORTANT): got command show variable dvl_micro
2024-05-09T11:57:49.211Z,1715255869.211 [CommandExec](IMPORTANT): DVL_micro.loadAtStartup (bool)
2024-05-09T11:57:49.211Z,1715255869.211 [CommandExec](IMPORTANT): DVL_micro.simulateHardware (bool)
2024-05-09T11:57:49.212Z,1715255869.212 [CommandExec](IMPORTANT): DVL_micro.magDeviation (degree)
2024-05-09T11:57:49.212Z,1715255869.212 [CommandExec](IMPORTANT): DVL_micro.pitchOffset (degree)
2024-05-09T11:57:49.213Z,1715255869.213 [CommandExec](IMPORTANT): DVL_micro.power (watt)
2024-05-09T11:57:49.213Z,1715255869.213 [CommandExec](IMPORTANT): DVL_micro.rollOffset (degree)
2024-05-09T11:57:49.260Z,1715255869.260 [CommandExec](IMPORTANT): DVL_micro.loadControl (none)
2024-05-09T11:57:49.260Z,1715255869.260 [CommandExec](IMPORTANT): DVL_micro.uart (none)
2024-05-09T11:57:49.269Z,1715255869.269 [CommandExec](IMPORTANT): DVL_micro.baud (bit_per_second)
2024-05-09T11:57:49.394Z,1715255869.394 [CommandExec](IMPORTANT): DVL_micro.enableBroadcast (bool)
2024-05-09T11:57:49.394Z,1715255869.394 [CommandExec](IMPORTANT): DVL_micro.component_voltage (volt)
2024-05-09T11:57:49.395Z,1715255869.395 [CommandExec](IMPORTANT): DVL_micro.component_avgVoltage (volt)
2024-05-09T11:57:49.395Z,1715255869.395 [CommandExec](IMPORTANT): DVL_micro.component_current (milliampere)
2024-05-09T11:57:49.396Z,1715255869.396 [CommandExec](IMPORTANT): DVL_micro.component_avgCurrent (milliampere)
2024-05-09T11:57:49.396Z,1715255869.396 [CommandExec](IMPORTANT): DVL_micro.height_above_sea_floor (meter)
2024-05-09T11:57:49.396Z,1715255869.396 [CommandExec](IMPORTANT): DVL_micro.platform_velocity_wrt_ground (meter_per_second)
2024-05-09T11:57:49.397Z,1715255869.397 [CommandExec](IMPORTANT): DVL_micro.platform_x_velocity_wrt_ground (meter_per_second)
2024-05-09T11:57:49.397Z,1715255869.397 [CommandExec](IMPORTANT): DVL_micro.platform_y_velocity_wrt_ground (meter_per_second)
2024-05-09T11:57:49.398Z,1715255869.398 [CommandExec](IMPORTANT): DVL_micro.platform_z_velocity_wrt_ground (meter_per_second)
2024-05-09T11:57:49.398Z,1715255869.398 [CommandExec](IMPORTANT): DVL_micro.BottomVelocityFlag (count)
2024-05-09T11:57:49.398Z,1715255869.398 [CommandExec](IMPORTANT): DVL_micro.Beam1Range (meter)
2024-05-09T11:57:49.399Z,1715255869.399 [CommandExec](IMPORTANT): DVL_micro.Beam2Range (meter)
2024-05-09T11:57:49.399Z,1715255869.399 [CommandExec](IMPORTANT): DVL_micro.Beam3Range (meter)
2024-05-09T11:57:49.399Z,1715255869.399 [CommandExec](IMPORTANT): DVL_micro.Beam4Range (meter)
2024-05-09T11:57:53.412Z,1715255873.412 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2024-05-09T11:57:53.418Z,1715255873.418 [BPC1](INFO): Received data from all battery sticks.
2024-05-09T11:57:58.571Z,1715255878.571 [CommandExec](IMPORTANT): got command get DVL_micro.Beam1Range
2024-05-09T11:57:58.572Z,1715255878.572 [CommandExec](IMPORTANT): DVL_micro.Beam1Range 9999.990234 m
2024-05-09T11:58:11.128Z,1715255891.128 [CommandExec](IMPORTANT): got command get DVL_micro.platform_z_velocity_wrt_ground
2024-05-09T11:58:11.128Z,1715255891.128 [CommandExec](IMPORTANT): DVL_micro.platform_z_velocity_wrt_ground 0.000000 m/s
2024-05-09T11:58:24.365Z,1715255904.365 [CommandExec](IMPORTANT): got command get DVL_micro.height_above_sea_floor
2024-05-09T11:58:24.366Z,1715255904.366 [CommandExec](IMPORTANT): DVL_micro.height_above_sea_floor -1.000000 m
2024-05-09T11:58:31.009Z,1715255911.009 [CommandExec](IMPORTANT): got command get DVL_micro.Beam2Range
2024-05-09T11:58:31.010Z,1715255911.010 [CommandExec](IMPORTANT): DVL_micro.Beam2Range 9999.990234 m
2024-05-09T11:58:47.156Z,1715255927.156 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-05-09T11:58:47.156Z,1715255927.156 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-09T11:58:47.167Z,1715255927.167 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-09T11:58:47.545Z,1715255927.545 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-09T11:58:47.545Z,1715255927.545 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-05-09T11:58:54.022Z,1715255934.022 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-09T11:53:53.0Z
2024-05-09T11:58:54.022Z,1715255934.022 [Default:CheckIn:Read_GPS] Stopped
2024-05-09T11:58:54.023Z,1715255934.023 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-09T11:58:54.408Z,1715255934.408 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-09T11:59:07.322Z,1715255947.322 [DVL_micro](ERROR): No DVL communication! Re-initializing
2024-05-09T11:59:07.322Z,1715255947.322 [DVL_micro] Communications Fault, FailCount= 1
2024-05-09T11:59:07.322Z,1715255947.322 [DVL_micro](ERROR): Communications Fault
2024-05-09T11:59:07.366Z,1715255947.366 [CBIT](ERROR): Communications Fault in component: DVL_micro
2024-05-09T11:59:07.726Z,1715255947.726 [DVL_micro](INFO): Powering down
2024-05-09T11:59:08.558Z,1715255948.558 [CBIT](INFO): Clearing failed state for component DVL_micro
2024-05-09T11:59:08.558Z,1715255948.558 [DVL_micro] No Fault, FailCount= 1
2024-05-09T11:59:17.528Z,1715255957.528 [CommandExec](IMPORTANT): got command get DVL_micro.baud
2024-05-09T11:59:17.528Z,1715255957.528 [CommandExec](IMPORTANT): DVL_micro.baud 19200.000000 bps
2024-05-09T11:59:25.911Z,1715255965.911 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response.
2024-05-09T11:59:25.985Z,1715255965.985 [NAL9602](ERROR): received:
+CSQ:0
OK.
2024-05-09T12:00:08.767Z,1715256008.767 [CBIT](FAULT): WATER ALARM STERN.
2024-05-09T12:00:08.768Z,1715256008.768 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1
2024-05-09T12:00:09.182Z,1715256009.182 [CBIT](FAULT): WATER ALARM STERN.
2024-05-09T12:00:09.183Z,1715256009.183 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2
2024-05-09T12:00:10.651Z,1715256010.651 [CBIT](FAULT): WATER ALARM STERN.
2024-05-09T12:00:10.652Z,1715256010.652 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3
2024-05-09T12:00:10.751Z,1715256010.751 [CBIT](FAULT): WATER ALARM STERN.
2024-05-09T12:00:10.764Z,1715256010.764 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL: STERN. BURNWIRE ACTIVATED
2024-05-09T12:00:10.765Z,1715256010.765 [CBIT](IMPORTANT): Powered off ESP with command: ! echo 0 > /dev/loadA6
2024-05-09T12:00:10.842Z,1715256010.842 [CommandExec](IMPORTANT): got command ! echo 0 > /dev/loadA6
2024-05-09T12:00:11.147Z,1715256011.147 [CBIT](INFO): Critical error at 20240509T120010
2024-05-09T12:00:26.315Z,1715256026.315 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-05-09T12:00:26.315Z,1715256026.315 [NAL9602] Data Fault, FailCount= 1
2024-05-09T12:00:26.315Z,1715256026.315 [NAL9602](ERROR): Data Fault
2024-05-09T12:00:26.331Z,1715256026.331 [CBIT](ERROR): Data Fault in component: NAL9602
2024-05-09T12:00:26.722Z,1715256026.722 [NAL9602](INFO): Powering down
2024-05-09T12:00:27.551Z,1715256027.551 [CBIT](INFO): Clearing failed state for component NAL9602
2024-05-09T12:00:27.551Z,1715256027.551 [NAL9602] No Fault, FailCount= 1
2024-05-09T12:00:57.028Z,1715256057.028 [NAL9602](INFO): Powering up NAL9602
2024-05-09T12:01:07.957Z,1715256067.957 [NAL9602](INFO): NAL9602 initialized
2024-05-09T12:01:27.530Z,1715256087.530 [DVL_micro](ERROR): Failed to parse:
:BI,+00000,+00000,+00000,+00000,I
2024-05-09T12:01:27.999Z,1715256087.999 [CommandExec](IMPORTANT): got command quit
2024-05-09T12:01:29.001Z,1715256089.001 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:29.001Z,1715256089.001 [CommandExec](INFO): Uninitializing the command executive.
2024-05-09T12:01:29.001Z,1715256089.001 [CommandExec](INFO): Uninitializing the command scheduler.
2024-05-09T12:01:29.001Z,1715256089.001 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.059Z,1715256089.059 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-05-09T12:01:29.059Z,1715256089.059 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-05-09T12:01:29.060Z,1715256089.060 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.060Z,1715256089.060 [NavChartDb](INFO): Join timeout helper Thread ID is 5104
2024-05-09T12:01:29.409Z,1715256089.409 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:29.409Z,1715256089.409 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.429Z,1715256089.429 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-05-09T12:01:29.429Z,1715256089.429 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.429Z,1715256089.429 [DAT](INFO): Join timeout helper Thread ID is 5105
2024-05-09T12:01:29.537Z,1715256089.537 [DAT](INFO): Powering down
2024-05-09T12:01:29.613Z,1715256089.613 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:29.613Z,1715256089.613 [DAT](INFO): Powering down
2024-05-09T12:01:29.614Z,1715256089.614 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.617Z,1715256089.617 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-05-09T12:01:29.617Z,1715256089.617 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.617Z,1715256089.617 [Radio_Surface](INFO): Join timeout helper Thread ID is 5106
2024-05-09T12:01:29.721Z,1715256089.721 [Radio_Surface](INFO): Powering down
2024-05-09T12:01:29.722Z,1715256089.722 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:29.722Z,1715256089.722 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.725Z,1715256089.725 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-05-09T12:01:29.725Z,1715256089.725 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:29.725Z,1715256089.725 [Onboard](INFO): Join timeout helper Thread ID is 5107
2024-05-09T12:01:30.673Z,1715256090.673 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:30.673Z,1715256090.673 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:30.693Z,1715256090.693 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-05-09T12:01:30.693Z,1715256090.693 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:30.693Z,1715256090.693 [DataOverHttps](INFO): Join timeout helper Thread ID is 5108
2024-05-09T12:01:30.957Z,1715256090.957 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:30.957Z,1715256090.957 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:30.970Z,1715256090.970 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-05-09T12:01:30.970Z,1715256090.970 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:30.970Z,1715256090.970 [BackseatComponent](INFO): Join timeout helper Thread ID is 5109
2024-05-09T12:01:31.049Z,1715256091.049 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:31.049Z,1715256091.049 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:31.053Z,1715256091.053 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-05-09T12:01:31.053Z,1715256091.053 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:31.054Z,1715256091.054 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5110
2024-05-09T12:01:31.389Z,1715256091.389 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:31.389Z,1715256091.389 [WetLabsBB2FL](INFO): Powering down
2024-05-09T12:01:31.390Z,1715256091.390 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:31.393Z,1715256091.393 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-05-09T12:01:31.394Z,1715256091.394 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:31.394Z,1715256091.394 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5111
2024-05-09T12:01:31.965Z,1715256091.965 [CTD_Seabird](INFO): Powering down
2024-05-09T12:01:31.977Z,1715256091.977 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:31.977Z,1715256091.977 [CTD_Seabird](INFO): Powering down
2024-05-09T12:01:31.989Z,1715256091.989 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.005Z,1715256092.005 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-05-09T12:01:32.005Z,1715256092.005 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.007Z,1715256092.007 [logger](INFO): Join timeout helper Thread ID is 5112
2024-05-09T12:01:32.008Z,1715256092.008 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:32.010Z,1715256092.010 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.012Z,1715256092.012 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-05-09T12:01:32.013Z,1715256092.013 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.013Z,1715256092.013 [CommandLine](INFO): Join timeout helper Thread ID is 5113
2024-05-09T12:01:32.109Z,1715256092.109 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:32.109Z,1715256092.109 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.113Z,1715256092.113 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-05-09T12:01:32.113Z,1715256092.113 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.114Z,1715256092.114 [CommandExec](INFO): Join timeout helper Thread ID is 5114
2024-05-09T12:01:32.115Z,1715256092.115 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-05-09T12:01:32.115Z,1715256092.115 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.115Z,1715256092.115 [controlThread](INFO): Join timeout helper Thread ID is 5115
2024-05-09T12:01:32.309Z,1715256092.309 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-09T12:01:32.309Z,1715256092.309 [controlThread](DEBUG): Uninitializing ControlThread
2024-05-09T12:01:32.312Z,1715256092.312 [AHRS_M2](INFO): Powering down
2024-05-09T12:01:32.481Z,1715256092.481 [DVL_micro](INFO): Powering down
2024-05-09T12:01:32.482Z,1715256092.482 [NAL9602](INFO): Powering down
2024-05-09T12:01:32.483Z,1715256092.483 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-05-09T12:01:32.484Z,1715256092.484 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-05-09T12:01:32.484Z,1715256092.484 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-05-09T12:01:32.485Z,1715256092.485 [MissionManager](INFO): Uninitializing Mission Default
2024-05-09T12:01:32.485Z,1715256092.485 [Default] Stopped
2024-05-09T12:01:32.485Z,1715256092.485 [Default](DEBUG): Aggregate::uninitialize Default
2024-05-09T12:01:32.485Z,1715256092.485 [Default:B.GoToSurface] Stopped
2024-05-09T12:01:32.485Z,1715256092.485 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-09T12:01:32.485Z,1715256092.485 [Default:CheckIn] Stopped
2024-05-09T12:01:32.486Z,1715256092.486 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-09T12:01:32.486Z,1715256092.486 [Default:CheckIn:Read_Iridium] Stopped
2024-05-09T12:01:32.488Z,1715256092.488 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-05-09T12:01:32.489Z,1715256092.489 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-05-09T12:01:32.489Z,1715256092.489 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-05-09T12:01:32.489Z,1715256092.489 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-05-09T12:01:32.490Z,1715256092.490 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-05-09T12:01:32.490Z,1715256092.490 [BuoyancyServo](INFO): Powering down
2024-05-09T12:01:32.505Z,1715256092.505 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-05-09T12:01:32.505Z,1715256092.505 [ElevatorServo](INFO): Powering down
2024-05-09T12:01:32.506Z,1715256092.506 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-05-09T12:01:32.506Z,1715256092.506 [MassServo](INFO): Powering down
2024-05-09T12:01:32.507Z,1715256092.507 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-05-09T12:01:32.507Z,1715256092.507 [RudderServo](INFO): Powering down
2024-05-09T12:01:32.508Z,1715256092.508 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-05-09T12:01:32.508Z,1715256092.508 [ThrusterHE](INFO): Powering down
2024-05-09T12:01:32.509Z,1715256092.509 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-05-09T12:01:32.509Z,1715256092.509 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-05-09T12:01:32.509Z,1715256092.509 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-05-09T12:01:32.509Z,1715256092.509 [CBIT](DEBUG): Powering off loads.
2024-05-09T12:01:32.520Z,1715256092.520 [CBIT](DEBUG): Disabling WDT.
2024-05-09T12:01:32.532Z,1715256092.532 [CBIT](DEBUG): Opening all GF detection circuits.
2024-05-09T12:01:32.534Z,1715256092.534 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.585Z,1715256092.585 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.591Z,1715256092.591 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.621Z,1715256092.621 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.625Z,1715256092.625 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.627Z,1715256092.627 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.634Z,1715256092.634 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.678Z,1715256092.678 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.731Z,1715256092.731 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-09T12:01:32.796Z,1715256092.796 [logger ThreadHandler](INFO): Thread cancelled.