2024-08-14T20:17:18.001Z,1723666638.001 [Supervisor](DEBUG): Initializing supervisor.
2024-08-14T20:17:18.006Z,1723666638.006 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-08-14T20:17:18.006Z,1723666638.006 [SyncHandler](INFO): Protected caller Thread ID is 3208
2024-08-14T20:17:18.007Z,1723666638.007 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-08-14T20:17:18.007Z,1723666638.007 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-08-14T20:17:18.008Z,1723666638.008 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3209
2024-08-14T20:17:18.012Z,1723666638.012 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-08-14T20:17:18.029Z,1723666638.029 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-08-14T20:17:18.030Z,1723666638.030 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-08-14T20:17:18.030Z,1723666638.030 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3210
2024-08-14T20:17:18.034Z,1723666638.034 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-08-14T20:17:18.035Z,1723666638.035 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-08-14T20:17:18.035Z,1723666638.035 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3211
2024-08-14T20:17:18.037Z,1723666638.037 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-08-14T20:17:18.038Z,1723666638.038 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-08-14T20:17:18.039Z,1723666638.039 [logger ThreadHandler](INFO): Protected caller Thread ID is 3212
2024-08-14T20:17:18.042Z,1723666638.042 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-08-14T20:17:18.042Z,1723666638.042 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-08-14T20:17:18.044Z,1723666638.044 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-08-14T20:17:18.384Z,1723666638.384 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-08-14T20:17:18.385Z,1723666638.385 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-08-14T20:17:19.143Z,1723666639.143 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-08-14T20:17:19.144Z,1723666639.144 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-08-14T20:17:19.263Z,1723666639.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-08-14T20:17:19.263Z,1723666639.263 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-08-14T20:17:19.826Z,1723666639.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-08-14T20:17:19.827Z,1723666639.827 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-08-14T20:17:19.936Z,1723666639.936 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-08-14T20:17:19.936Z,1723666639.936 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-08-14T20:17:20.028Z,1723666640.028 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-08-14T20:17:20.451Z,1723666640.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-08-14T20:17:20.452Z,1723666640.452 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-08-14T20:17:20.686Z,1723666640.686 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-08-14T20:17:20.687Z,1723666640.687 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-08-14T20:17:20.847Z,1723666640.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-08-14T20:17:20.848Z,1723666640.848 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-08-14T20:17:21.103Z,1723666641.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-08-14T20:17:21.104Z,1723666641.104 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-08-14T20:17:21.667Z,1723666641.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-08-14T20:17:21.667Z,1723666641.667 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-08-14T20:17:22.137Z,1723666642.137 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-08-14T20:17:22.137Z,1723666642.137 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-08-14T20:17:22.231Z,1723666642.231 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-08-14T20:17:22.437Z,1723666642.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-08-14T20:17:22.437Z,1723666642.437 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-08-14T20:17:22.680Z,1723666642.680 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-08-14T20:17:22.681Z,1723666642.681 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-08-14T20:17:23.032Z,1723666643.032 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-08-14T20:17:23.035Z,1723666643.035 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2024-08-14T20:17:23.035Z,1723666643.035 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2024-08-14T20:17:23.351Z,1723666643.351 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2024-08-14T20:17:23.524Z,1723666643.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2024-08-14T20:17:23.671Z,1723666643.671 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2024-08-14T20:17:23.811Z,1723666643.811 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2024-08-14T20:17:23.932Z,1723666643.932 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg
2024-08-14T20:17:24.027Z,1723666644.027 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2024-08-14T20:17:24.144Z,1723666644.144 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2024-08-14T20:17:24.416Z,1723666644.416 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-08-14T20:17:24.417Z,1723666644.417 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2024-08-14T20:17:24.562Z,1723666644.562 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2024-08-14T20:17:24.666Z,1723666644.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2024-08-14T20:17:24.770Z,1723666644.770 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2024-08-14T20:17:24.887Z,1723666644.887 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/
2024-08-14T20:17:24.887Z,1723666644.887 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-08-14T20:17:24.902Z,1723666644.902 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-08-14T20:17:25.009Z,1723666645.009 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-08-14T20:17:25.010Z,1723666645.010 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-08-14T20:17:25.020Z,1723666645.020 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-08-14T20:17:25.020Z,1723666645.020 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-08-14T20:17:25.069Z,1723666645.069 [DepthRateCalculator] Loaded
2024-08-14T20:17:25.069Z,1723666645.069 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-08-14T20:17:25.074Z,1723666645.074 [PitchRateCalculator] Loaded
2024-08-14T20:17:25.075Z,1723666645.075 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-08-14T20:17:25.085Z,1723666645.085 [SpeedCalculator] Loaded
2024-08-14T20:17:25.085Z,1723666645.085 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-08-14T20:17:25.089Z,1723666645.089 [YawRateCalculator] Loaded
2024-08-14T20:17:25.090Z,1723666645.090 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-08-14T20:17:25.110Z,1723666645.110 [ElevatorOffsetCalculator] Loaded
2024-08-14T20:17:25.110Z,1723666645.110 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-08-14T20:17:25.111Z,1723666645.111 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-08-14T20:17:25.111Z,1723666645.111 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-08-14T20:17:25.161Z,1723666645.161 [VerticalControl](DEBUG): Construct VerticalControl.
2024-08-14T20:17:25.215Z,1723666645.215 [VerticalControl] Loaded
2024-08-14T20:17:25.215Z,1723666645.215 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-08-14T20:17:25.218Z,1723666645.218 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-08-14T20:17:25.263Z,1723666645.263 [HorizontalControl] Loaded
2024-08-14T20:17:25.263Z,1723666645.263 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-08-14T20:17:25.266Z,1723666645.266 [SpeedControl](DEBUG): Construct SpeedControl.
2024-08-14T20:17:25.268Z,1723666645.268 [SpeedControl] Loaded
2024-08-14T20:17:25.269Z,1723666645.269 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-08-14T20:17:25.271Z,1723666645.271 [LoopControl](DEBUG): Construct LoopControl.
2024-08-14T20:17:25.272Z,1723666645.272 [LoopControl] Loaded
2024-08-14T20:17:25.272Z,1723666645.272 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-08-14T20:17:25.272Z,1723666645.272 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-08-14T20:17:25.273Z,1723666645.273 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-08-14T20:17:25.380Z,1723666645.380 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-08-14T20:17:25.381Z,1723666645.381 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-08-14T20:17:25.394Z,1723666645.394 [NavChart] Loaded
2024-08-14T20:17:25.395Z,1723666645.395 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-08-14T20:17:25.400Z,1723666645.400 [UniversalFixResidualReporter] Loaded
2024-08-14T20:17:25.400Z,1723666645.400 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-08-14T20:17:25.401Z,1723666645.401 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-08-14T20:17:25.401Z,1723666645.401 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-08-14T20:17:25.567Z,1723666645.567 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-08-14T20:17:25.567Z,1723666645.567 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-08-14T20:17:26.010Z,1723666646.010 [AHRS_M2] Loaded
2024-08-14T20:17:26.011Z,1723666646.011 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-08-14T20:17:26.049Z,1723666646.049 [BackseatComponent] Loaded
2024-08-14T20:17:26.049Z,1723666646.049 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-08-14T20:17:26.050Z,1723666646.050 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409384E0
2024-08-14T20:17:26.051Z,1723666646.051 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3298
2024-08-14T20:17:26.053Z,1723666646.053 [LcmUniversalReporter] Loaded
2024-08-14T20:17:26.054Z,1723666646.054 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-08-14T20:17:26.880Z,1723666646.880 [BPC1] Loaded
2024-08-14T20:17:26.881Z,1723666646.881 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-08-14T20:17:26.966Z,1723666646.966 [DATMMP] Loaded
2024-08-14T20:17:26.966Z,1723666646.966 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2024-08-14T20:17:26.967Z,1723666646.967 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409694E0
2024-08-14T20:17:26.968Z,1723666646.968 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 3299
2024-08-14T20:17:27.037Z,1723666647.037 [DataOverHttps] Loaded
2024-08-14T20:17:27.038Z,1723666647.038 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-08-14T20:17:27.039Z,1723666647.039 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409994E0
2024-08-14T20:17:27.039Z,1723666647.039 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3300
2024-08-14T20:17:27.061Z,1723666647.061 [Depth_Keller] Loaded
2024-08-14T20:17:27.062Z,1723666647.062 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-08-14T20:17:27.101Z,1723666647.101 [DVL_micro] Loaded
2024-08-14T20:17:27.101Z,1723666647.101 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2024-08-14T20:17:27.164Z,1723666647.164 [NAL9602] Loaded
2024-08-14T20:17:27.164Z,1723666647.164 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-08-14T20:17:27.193Z,1723666647.193 [Onboard] Loaded
2024-08-14T20:17:27.194Z,1723666647.194 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-08-14T20:17:27.195Z,1723666647.195 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409C94E0
2024-08-14T20:17:27.195Z,1723666647.195 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3301
2024-08-14T20:17:27.209Z,1723666647.209 [Power24vConverter] Loaded
2024-08-14T20:17:27.209Z,1723666647.209 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-08-14T20:17:27.224Z,1723666647.224 [Radio_Surface] Loaded
2024-08-14T20:17:27.224Z,1723666647.224 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-08-14T20:17:27.225Z,1723666647.225 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F94E0
2024-08-14T20:17:27.225Z,1723666647.225 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3302
2024-08-14T20:17:27.240Z,1723666647.240 [Sonardyne_Nano] Loaded
2024-08-14T20:17:27.241Z,1723666647.241 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-08-14T20:17:27.241Z,1723666647.241 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-08-14T20:17:27.242Z,1723666647.242 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-08-14T20:17:27.370Z,1723666647.370 [BuoyancyServo] Loaded
2024-08-14T20:17:27.370Z,1723666647.370 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-08-14T20:17:27.391Z,1723666647.391 [MassServo] Loaded
2024-08-14T20:17:27.392Z,1723666647.392 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-08-14T20:17:27.412Z,1723666647.412 [RudderServo] Loaded
2024-08-14T20:17:27.412Z,1723666647.412 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-08-14T20:17:27.428Z,1723666647.428 [ThrusterHE] Loaded
2024-08-14T20:17:27.428Z,1723666647.428 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-08-14T20:17:27.429Z,1723666647.429 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-08-14T20:17:27.429Z,1723666647.429 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-08-14T20:17:27.497Z,1723666647.497 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-08-14T20:17:27.497Z,1723666647.497 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-08-14T20:17:27.523Z,1723666647.523 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-08-14T20:17:27.523Z,1723666647.523 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-08-14T20:17:27.848Z,1723666647.848 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-08-14T20:17:27.848Z,1723666647.848 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-08-14T20:17:28.020Z,1723666648.020 [CTD_Seabird] Loaded
2024-08-14T20:17:28.021Z,1723666648.021 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-08-14T20:17:28.022Z,1723666648.022 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BB34E0
2024-08-14T20:17:28.022Z,1723666648.022 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3303
2024-08-14T20:17:28.054Z,1723666648.054 [ESPComponent] Loaded
2024-08-14T20:17:28.055Z,1723666648.055 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-08-14T20:17:28.076Z,1723666648.076 [PAR_Licor] Loaded
2024-08-14T20:17:28.076Z,1723666648.076 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-08-14T20:17:28.077Z,1723666648.077 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-08-14T20:17:28.078Z,1723666648.078 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-08-14T20:17:28.389Z,1723666648.389 [SBIT](DEBUG): Construct Startup Built In Test.
2024-08-14T20:17:28.418Z,1723666648.418 [SBIT] Loaded
2024-08-14T20:17:28.418Z,1723666648.418 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-08-14T20:17:28.452Z,1723666648.452 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-08-14T20:17:28.474Z,1723666648.474 [IBIT] Loaded
2024-08-14T20:17:28.474Z,1723666648.474 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-08-14T20:17:28.480Z,1723666648.480 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-08-14T20:17:28.589Z,1723666648.589 [CBIT] Loaded
2024-08-14T20:17:28.589Z,1723666648.589 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-08-14T20:17:28.589Z,1723666648.589 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-08-14T20:17:28.595Z,1723666648.595 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-08-14T20:17:28.598Z,1723666648.598 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-08-14T20:17:28.610Z,1723666648.610 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-08-14T20:17:28.611Z,1723666648.611 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0
2024-08-14T20:17:28.611Z,1723666648.611 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3304
2024-08-14T20:17:28.616Z,1723666648.616 [Supervisor](INFO): Main Thread ID is 3207
2024-08-14T20:17:28.616Z,1723666648.616 [Supervisor](DEBUG): Running supervisor.
2024-08-14T20:17:28.617Z,1723666648.617 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3305
2024-08-14T20:17:28.617Z,1723666648.617 [CommandExec](INFO): Initializing the command executive.
2024-08-14T20:17:28.618Z,1723666648.618 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3306
2024-08-14T20:17:28.621Z,1723666648.621 [controlThread ThreadHandler](INFO): Handler Thread ID is 3307
2024-08-14T20:17:28.621Z,1723666648.621 [controlThread](DEBUG): Initializing ControlThread
2024-08-14T20:17:28.622Z,1723666648.622 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-08-14T20:17:28.622Z,1723666648.622 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-08-14T20:17:28.623Z,1723666648.623 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-08-14T20:17:28.623Z,1723666648.623 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-08-14T20:17:28.623Z,1723666648.623 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-08-14T20:17:28.624Z,1723666648.624 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-08-14T20:17:28.626Z,1723666648.626 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-08-14T20:17:28.626Z,1723666648.626 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-08-14T20:17:28.627Z,1723666648.627 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-08-14T20:17:28.628Z,1723666648.628 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-08-14T20:17:28.628Z,1723666648.628 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-08-14T20:17:28.637Z,1723666648.637 [SBIT](INFO): Initialize SBIT Component.
2024-08-14T20:17:28.637Z,1723666648.637 [SBIT](IMPORTANT): git: 2024-08-12-95-g598b95f60
2024-08-14T20:17:28.637Z,1723666648.637 [SBIT](INFO): git hash: 598b95f6033d24136933a3d5d1ddac5d4570ac95
2024-08-14T20:17:28.638Z,1723666648.638 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-08-14T20:17:28.639Z,1723666648.639 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-08-14T20:17:28.640Z,1723666648.640 [SBIT](INFO): Beginning SBIT in 68.000000 seconds.
2024-08-14T20:17:28.641Z,1723666648.641 [IBIT](INFO): Initialize IBIT Component.
2024-08-14T20:17:28.642Z,1723666648.642 [CBIT](DEBUG): Initialize CBIT Component.
2024-08-14T20:17:28.642Z,1723666648.642 [logger ThreadHandler](INFO): Handler Thread ID is 3308
2024-08-14T20:17:28.653Z,1723666648.653 [CBIT](DEBUG): Initialized mux pins.
2024-08-14T20:17:28.653Z,1723666648.653 [CBIT](DEBUG): Initializing the watchdog timer.
2024-08-14T20:17:28.661Z,1723666648.661 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3309
2024-08-14T20:17:28.673Z,1723666648.673 [DATMMP ThreadHandler](INFO): Handler Thread ID is 3310
2024-08-14T20:17:28.674Z,1723666648.674 [DATMMP](INFO): Start
2024-08-14T20:17:28.674Z,1723666648.674 [DATMMP](INFO): Powering up
2024-08-14T20:17:28.674Z,1723666648.674 [DATMMP](DEBUG): Initializing DATMMP.
2024-08-14T20:17:28.677Z,1723666648.677 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-08-14T20:17:28.678Z,1723666648.678 [CBIT](FAULT): Found backtrace file:
1723666451.818579 [CBIT]: Backtrace:
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1b3ca8]
./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xc8) [0x1b36f4]
2024-08-14T20:17:28.679Z,1723666648.679 [CBIT](FAULT): Renaming backtrace file to Data/backtrace2
2024-08-14T20:17:28.679Z,1723666648.679 [CBIT](DEBUG): Initializing heartbeat.
2024-08-14T20:17:28.681Z,1723666648.681 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3312
2024-08-14T20:17:28.683Z,1723666648.683 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-08-14T20:17:28.697Z,1723666648.697 [Onboard ThreadHandler](INFO): Handler Thread ID is 3313
2024-08-14T20:17:28.715Z,1723666648.715 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3314
2024-08-14T20:17:28.737Z,1723666648.737 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3315
2024-08-14T20:17:28.738Z,1723666648.738 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-08-14T20:17:28.742Z,1723666648.742 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3317
2024-08-14T20:17:28.744Z,1723666648.744 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000
2024-08-14T20:17:28.744Z,1723666648.744 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000
2024-08-14T20:17:28.745Z,1723666648.745 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000
2024-08-14T20:17:28.745Z,1723666648.745 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000
2024-08-14T20:17:28.745Z,1723666648.745 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000
2024-08-14T20:17:28.745Z,1723666648.745 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000
2024-08-14T20:17:28.749Z,1723666648.749 [CBIT](DEBUG): Deactivating GF circuits.
2024-08-14T20:17:28.749Z,1723666648.749 [CBIT](DEBUG): Deactivating emergency mode.
2024-08-14T20:17:28.788Z,1723666648.788 [CBIT](DEBUG): Backplane powered.
2024-08-14T20:17:28.789Z,1723666648.789 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-08-14T20:17:28.790Z,1723666648.790 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-08-14T20:17:28.790Z,1723666648.790 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-08-14T20:17:28.791Z,1723666648.791 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-08-14T20:17:28.835Z,1723666648.835 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-08-14T20:17:28.839Z,1723666648.839 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-14T20:17:28.884Z,1723666648.884 [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-08-14T20:17:28.885Z,1723666648.885 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-08-14T20:17:28.885Z,1723666648.885 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-08-14T20:17:28.886Z,1723666648.886 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-08-14T20:17:28.925Z,1723666648.925 [DATMMP](INFO): Starting
2024-08-14T20:17:29.121Z,1723666649.121 [Radio_Surface](INFO): Powering up
2024-08-14T20:17:29.177Z,1723666649.177 [DATMMP](INFO): Starting
2024-08-14T20:17:29.199Z,1723666649.199 [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-08-14T20:17:29.221Z,1723666649.221 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-08-14T20:17:29.222Z,1723666649.222 [Default:A.Wait](DEBUG): Construct Wait.
2024-08-14T20:17:29.224Z,1723666649.224 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-14T20:17:29.269Z,1723666649.269 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-08-14T20:17:29.271Z,1723666649.271 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-08-14T20:17:29.293Z,1723666649.293 [Default:E.Execute](DEBUG): Construct Execute.
2024-08-14T20:17:29.296Z,1723666649.296 [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-08-14T20:17:29.300Z,1723666649.300 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-08-14T20:17:29.317Z,1723666649.317 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-14T20:17:29.394Z,1723666649.394 [Power24vConverter](INFO): Powering up.
2024-08-14T20:17:29.395Z,1723666649.395 [Sonardyne_Nano](INFO): Initializing.
2024-08-14T20:17:29.429Z,1723666649.429 [DATMMP](INFO): Starting
2024-08-14T20:17:29.470Z,1723666649.470 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-08-14T20:17:29.477Z,1723666649.477 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-08-14T20:17:29.478Z,1723666649.478 [MassServo](DEBUG): Initializing EZServoServo.
2024-08-14T20:17:29.485Z,1723666649.485 [MassServo](DEBUG): Initializing MassServo.
2024-08-14T20:17:29.486Z,1723666649.486 [RudderServo](DEBUG): Initializing EZServoServo.
2024-08-14T20:17:29.493Z,1723666649.493 [RudderServo](DEBUG): Initializing RudderServo.
2024-08-14T20:17:29.494Z,1723666649.494 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-08-14T20:17:29.501Z,1723666649.501 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-08-14T20:17:29.681Z,1723666649.681 [DATMMP](INFO): Starting
2024-08-14T20:17:29.933Z,1723666649.933 [DATMMP](INFO): Starting
2024-08-14T20:17:30.185Z,1723666650.185 [DATMMP](INFO): Starting
2024-08-14T20:17:30.437Z,1723666650.437 [DATMMP](INFO): Starting
2024-08-14T20:17:30.689Z,1723666650.689 [DATMMP](INFO): Starting
2024-08-14T20:17:30.941Z,1723666650.941 [DATMMP](INFO): Starting
2024-08-14T20:17:31.193Z,1723666651.193 [DATMMP](INFO): Starting
2024-08-14T20:17:31.331Z,1723666651.331 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-08-14T20:17:31.445Z,1723666651.445 [DATMMP](INFO): Starting
2024-08-14T20:17:31.697Z,1723666651.697 [DATMMP](INFO): Starting
2024-08-14T20:17:31.949Z,1723666651.949 [DATMMP](INFO): Starting
2024-08-14T20:17:32.202Z,1723666652.202 [DATMMP](INFO): Starting
2024-08-14T20:17:32.453Z,1723666652.453 [DATMMP](INFO): Starting
2024-08-14T20:17:32.621Z,1723666652.621 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207
2024-08-14T20:17:32.705Z,1723666652.705 [DATMMP](INFO): Starting
2024-08-14T20:17:32.958Z,1723666652.958 [DATMMP](INFO): Starting
2024-08-14T20:17:33.209Z,1723666653.209 [DATMMP](INFO): Starting
2024-08-14T20:17:33.461Z,1723666653.461 [DATMMP](INFO): Starting
2024-08-14T20:17:33.713Z,1723666653.713 [DATMMP](INFO): Starting
2024-08-14T20:17:33.965Z,1723666653.965 [DATMMP](INFO): Starting
2024-08-14T20:17:34.218Z,1723666654.218 [DATMMP](INFO): Starting
2024-08-14T20:17:34.469Z,1723666654.469 [DATMMP](INFO): Starting
2024-08-14T20:17:34.721Z,1723666654.721 [DATMMP](INFO): Starting
2024-08-14T20:17:34.974Z,1723666654.974 [DATMMP](INFO): Starting
2024-08-14T20:17:35.078Z,1723666655.078 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-08-14T20:17:35.225Z,1723666655.225 [DATMMP](INFO): Starting
2024-08-14T20:17:35.477Z,1723666655.477 [DATMMP](INFO): Starting
2024-08-14T20:17:35.729Z,1723666655.729 [DATMMP](INFO): Starting
2024-08-14T20:17:35.981Z,1723666655.981 [DATMMP](INFO): Starting
2024-08-14T20:17:36.233Z,1723666656.233 [DATMMP](INFO): Starting
2024-08-14T20:17:36.485Z,1723666656.485 [DATMMP](INFO): Starting
2024-08-14T20:17:36.737Z,1723666656.737 [DATMMP](INFO): Starting
2024-08-14T20:17:36.989Z,1723666656.989 [DATMMP](INFO): Starting
2024-08-14T20:17:37.241Z,1723666657.241 [DATMMP](INFO): Starting
2024-08-14T20:17:37.493Z,1723666657.493 [DATMMP](INFO): Starting
2024-08-14T20:17:37.745Z,1723666657.745 [DATMMP](INFO): Starting
2024-08-14T20:17:37.997Z,1723666657.997 [DATMMP](INFO): Starting
2024-08-14T20:17:38.249Z,1723666658.249 [DATMMP](INFO): Starting
2024-08-14T20:17:38.501Z,1723666658.501 [DATMMP](INFO): Starting
2024-08-14T20:17:38.753Z,1723666658.753 [DATMMP](INFO): Starting
2024-08-14T20:17:39.005Z,1723666659.005 [DATMMP](INFO): Starting
2024-08-14T20:17:39.257Z,1723666659.257 [DATMMP](INFO): Starting
2024-08-14T20:17:39.509Z,1723666659.509 [DATMMP](INFO): Starting
2024-08-14T20:17:39.761Z,1723666659.761 [DATMMP](INFO): Starting
2024-08-14T20:17:40.013Z,1723666660.013 [DATMMP](INFO): Starting
2024-08-14T20:17:40.265Z,1723666660.265 [DATMMP](INFO): Starting
2024-08-14T20:17:40.517Z,1723666660.517 [DATMMP](INFO): Starting
2024-08-14T20:17:40.769Z,1723666660.769 [DATMMP](INFO): Starting
2024-08-14T20:17:40.769Z,1723666660.769 [DATMMP](INFO): DAT read:
2024-08-14T20:17:40.770Z,1723666660.770 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-08-14T20:17:41.021Z,1723666661.021 [DATMMP](INFO): Starting
2024-08-14T20:17:41.273Z,1723666661.273 [DATMMP](INFO): Starting
2024-08-14T20:17:41.525Z,1723666661.525 [DATMMP](INFO): Starting
2024-08-14T20:17:41.777Z,1723666661.777 [DATMMP](INFO): Starting
2024-08-14T20:17:42.029Z,1723666662.029 [DATMMP](INFO): Starting
2024-08-14T20:17:42.281Z,1723666662.281 [DATMMP](INFO): Starting
2024-08-14T20:17:42.282Z,1723666662.282 [DATMMP](INFO): DAT read: MF Frequency Band
2024-08-14T20:17:42.283Z,1723666662.283 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-08-14T20:17:42.284Z,1723666662.284 [DATMMP](INFO): DAT read: Jul 14 2000 20:17:37
2024-08-14T20:17:42.533Z,1723666662.533 [DATMMP](INFO): Starting
2024-08-14T20:17:42.785Z,1723666662.785 [DATMMP](INFO): Starting
2024-08-14T20:17:43.037Z,1723666663.037 [DATMMP](INFO): Starting
2024-08-14T20:17:43.289Z,1723666663.289 [DATMMP](INFO): Starting
2024-08-14T20:17:43.541Z,1723666663.541 [DATMMP](INFO): Starting
2024-08-14T20:17:43.542Z,1723666663.542 [DATMMP](INFO): DAT read: Features enabled [Bearing]
2024-08-14T20:17:43.544Z,1723666663.544 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-08-14T20:17:43.544Z,1723666663.544 [DATMMP](INFO): commRate: 800
2024-08-14T20:17:43.793Z,1723666663.793 [DATMMP](INFO): Starting
2024-08-14T20:17:44.045Z,1723666664.045 [DATMMP](INFO): Starting
2024-08-14T20:17:44.297Z,1723666664.297 [DATMMP](INFO): Starting
2024-08-14T20:17:44.549Z,1723666664.549 [DATMMP](INFO): Starting
2024-08-14T20:17:44.801Z,1723666664.801 [DATMMP](INFO): Starting
2024-08-14T20:17:45.053Z,1723666665.053 [DATMMP](INFO): Starting
2024-08-14T20:17:45.305Z,1723666665.305 [DATMMP](INFO): Starting
2024-08-14T20:17:45.557Z,1723666665.557 [DATMMP](INFO): Starting
2024-08-14T20:17:45.609Z,1723666665.609 [DATMMP](INFO): entering command mode
2024-08-14T20:17:45.809Z,1723666665.809 [DATMMP](INFO): Starting
2024-08-14T20:17:45.809Z,1723666665.809 [DATMMP](INFO): DAT read:
2024-08-14T20:17:45.809Z,1723666665.809 [DATMMP](INFO): DAT read: user:1>
2024-08-14T20:17:45.810Z,1723666665.810 [DATMMP](DEBUG): read user prompt 1: user:1>
2024-08-14T20:17:45.810Z,1723666665.810 [DATMMP](INFO): entering MMP mode
2024-08-14T20:17:46.061Z,1723666666.061 [DATMMP](INFO): Starting
2024-08-14T20:17:46.062Z,1723666666.062 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-14T20:17:46.063Z,1723666666.063 [DATMMP](INFO): status rx: x1
2024-08-14T20:17:46.064Z,1723666666.064 [DATMMP](INFO): MMP status: 1: started
2024-08-14T20:17:46.064Z,1723666666.064 [DATMMP](INFO): Received message type: status
2024-08-14T20:17:46.064Z,1723666666.064 [DATMMP](INFO): Handled
2024-08-14T20:17:46.313Z,1723666666.313 [DATMMP](INFO): Starting
2024-08-14T20:17:46.314Z,1723666666.314 [DATMMP](INFO): Sent Tx Power Config 8
2024-08-14T20:17:46.314Z,1723666666.314 [DATMMP](INFO): Setting local address: 11
2024-08-14T20:17:46.316Z,1723666666.316 [DATMMP](INFO): Setting time to: 20:17:46 And date to:8/14/2024
2024-08-14T20:17:46.565Z,1723666666.565 [DATMMP](INFO): Starting
2024-08-14T20:17:46.565Z,1723666666.565 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-14T20:17:46.566Z,1723666666.566 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0
2024-08-14T20:17:46.566Z,1723666666.566 [DATMMP](INFO): Received message type: mdmpower
2024-08-14T20:17:46.566Z,1723666666.566 [DATMMP](INFO): Handled
2024-08-14T20:17:46.817Z,1723666666.817 [DATMMP](INFO): Starting
2024-08-14T20:17:46.817Z,1723666666.817 [DATMMP](INFO): GSXN notify for xid: 10
2024-08-14T20:17:46.818Z,1723666666.818 [DATMMP](INFO): sreg_txpower rx: x8
2024-08-14T20:17:46.818Z,1723666666.818 [DATMMP](INFO): Received message type: sreg_txpower
2024-08-14T20:17:46.818Z,1723666666.818 [DATMMP](INFO): Match for : sreg_txpower
2024-08-14T20:17:46.818Z,1723666666.818 [DATMMP](INFO): ACK
2024-08-14T20:17:47.069Z,1723666667.069 [DATMMP](INFO): Starting
2024-08-14T20:17:47.069Z,1723666667.069 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-14T20:17:47.070Z,1723666667.070 [DATMMP](INFO): mdmlocal rx: xB x0 x0 x0
2024-08-14T20:17:47.070Z,1723666667.070 [DATMMP](INFO): Received message type: mdmlocal
2024-08-14T20:17:47.070Z,1723666667.070 [DATMMP](INFO): Handled
2024-08-14T20:17:47.321Z,1723666667.321 [DATMMP](INFO): Starting
2024-08-14T20:17:47.321Z,1723666667.321 [DATMMP](INFO): GSXN notify for xid: 11
2024-08-14T20:17:47.322Z,1723666667.322 [DATMMP](INFO): sreg_locaddr rx: xB
2024-08-14T20:17:47.322Z,1723666667.322 [DATMMP](INFO): Received message type: sreg_locaddr
2024-08-14T20:17:47.322Z,1723666667.322 [DATMMP](INFO): Match for : sreg_locaddr
2024-08-14T20:17:47.322Z,1723666667.322 [DATMMP](INFO): ACK
2024-08-14T20:17:47.573Z,1723666667.573 [DATMMP](INFO): Starting
2024-08-14T20:17:47.573Z,1723666667.573 [DATMMP](INFO): GSXN notify for xid: 12
2024-08-14T20:17:47.574Z,1723666667.574 [DATMMP](INFO): timedate rx: x0 x14 x11 x2E x7 xE x7C x0
2024-08-14T20:17:47.574Z,1723666667.574 [DATMMP](INFO): Received message type: timedate
2024-08-14T20:17:47.575Z,1723666667.575 [DATMMP](INFO): Match for : timedate
2024-08-14T20:17:47.575Z,1723666667.575 [DATMMP](INFO): ACK
2024-08-14T20:17:47.825Z,1723666667.825 [DATMMP](INFO): Starting
2024-08-14T20:17:47.825Z,1723666667.825 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-14T20:17:47.826Z,1723666667.826 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0
2024-08-14T20:17:47.826Z,1723666667.826 [DATMMP](INFO): Received message type: sys_verb
2024-08-14T20:17:47.826Z,1723666667.826 [DATMMP](INFO): Handled
2024-08-14T20:17:48.077Z,1723666668.077 [DATMMP](INFO): Starting
2024-08-14T20:17:48.078Z,1723666668.078 [DATMMP](INFO): GSXN notify for xid: 13
2024-08-14T20:17:48.078Z,1723666668.078 [DATMMP](INFO): sreg_verbosity rx: x0
2024-08-14T20:17:48.078Z,1723666668.078 [DATMMP](INFO): Received message type: sreg_verbosity
2024-08-14T20:17:48.079Z,1723666668.079 [DATMMP](INFO): Match for : sreg_verbosity
2024-08-14T20:17:48.079Z,1723666668.079 [DATMMP](INFO): ACK
2024-08-14T20:17:48.330Z,1723666668.330 [DATMMP](INFO): Starting
2024-08-14T20:17:48.330Z,1723666668.330 [DATMMP](INFO): GSXN notify for xid: 14
2024-08-14T20:17:48.331Z,1723666668.331 [DATMMP](INFO): version rx: x2 x5
2024-08-14T20:17:48.331Z,1723666668.331 [DATMMP](INFO): DatMMPVersion: 2.5
2024-08-14T20:17:48.332Z,1723666668.332 [DATMMP](INFO): Received message type: version
2024-08-14T20:17:48.332Z,1723666668.332 [DATMMP](INFO): Match for : version
2024-08-14T20:17:48.332Z,1723666668.332 [DATMMP](INFO): ACK
2024-08-14T20:17:48.332Z,1723666668.332 [DATMMP](INFO): in MMP mode: config complete going to runnable
2024-08-14T20:17:57.199Z,1723666677.199 [NAL9602](INFO): Powering up NAL9602
2024-08-14T20:18:02.441Z,1723666682.441 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-14T20:18:02.442Z,1723666682.442 [DATMMP](INFO): timesync rx: x0 x1 x1 x0
2024-08-14T20:18:02.442Z,1723666682.442 [DATMMP](INFO): Received message type: timesync
2024-08-14T20:18:02.442Z,1723666682.442 [DATMMP](INFO): Handled
2024-08-14T20:18:08.107Z,1723666688.107 [NAL9602](INFO): NAL9602 initialized
2024-08-14T20:18:12.529Z,1723666692.529 [DATMMP](INFO): GSXN notify for xid: 0
2024-08-14T20:18:12.530Z,1723666692.530 [DATMMP](INFO): timesync rx: x1 x0 x1 x0
2024-08-14T20:18:12.530Z,1723666692.530 [DATMMP](INFO): Received message type: timesync
2024-08-14T20:18:12.530Z,1723666692.530 [DATMMP](INFO): Handled
2024-08-14T20:18:24.302Z,1723666704.302 [CommandExec](IMPORTANT): got command strobe on
2024-08-14T20:18:24.302Z,1723666704.302 [CommandExec](IMPORTANT): Activating strobe
2024-08-14T20:18:35.165Z,1723666715.165 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:18:37.227Z,1723666717.227 [SBIT](IMPORTANT): Beginning Startup BIT
2024-08-14T20:18:37.231Z,1723666717.231 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-14T20:18:48.181Z,1723666728.181 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.003986
CHAN A1 (24V): -0.002951
CHAN A2 (12V): -0.000640
CHAN A3 (5V): 0.000445
CHAN B0 (3.3V): 0.000483
CHAN B1 (3.15aV): 0.000512
CHAN B2 (3.15bV): 0.000639
CHAN B3 (GND): 0.000776
OPEN: -0.001168
Full Scale: +/- 1 mA
2024-08-14T20:18:49.305Z,1723666729.305 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:18:50.541Z,1723666730.541 [SBIT](ERROR): Could not read elevatorAngleReader_.
2024-08-14T20:19:03.446Z,1723666743.446 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:19:17.307Z,1723666757.307 [SBIT](ERROR): Could not read elevatorAngleReader_.
2024-08-14T20:19:17.307Z,1723666757.307 [SBIT](FAULT): Control surface position failure.
2024-08-14T20:19:17.585Z,1723666757.585 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:19:21.515Z,1723666761.515 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005179
2024-08-14T20:19:30.940Z,1723666770.940 [SBIT](ERROR): Could not read elevatorAngleReader_.
2024-08-14T20:19:30.940Z,1723666770.940 [SBIT](FAULT): Control surface position failure.
2024-08-14T20:19:31.384Z,1723666771.384 [SBIT](CRITICAL): SBIT FAILED
2024-08-14T20:19:31.384Z,1723666771.384 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=5 meter;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): Depth_Keller.offset=3.6 decibar;
2024-08-14T20:19:31.385Z,1723666771.385 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): ElevatorServo.currLimit=75 percent;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): ElevatorServo.limitHi=16369 count;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): ElevatorServo.limitLo=0 count;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=0 bool;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt;
2024-08-14T20:19:31.386Z,1723666771.386 [SBIT](IMPORTANT): Radio_Surface.loadAtStartup=1 bool;
2024-08-14T20:19:31.387Z,1723666771.387 [SBIT](IMPORTANT): VerticalControl.massDefault=12.059213 millimeter;
2024-08-14T20:19:31.387Z,1723666771.387 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;
2024-08-14T20:19:31.388Z,1723666771.388 [CommandExec](FAULT): Scheduling is paused
2024-08-14T20:19:31.389Z,1723666771.389 [CBIT](INFO): Critical error at 20240814T201931
2024-08-14T20:19:31.389Z,1723666771.389 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-08-14T20:19:31.726Z,1723666771.726 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:19:31.766Z,1723666771.766 [MissionManager](IMPORTANT): Started mission Startup
2024-08-14T20:19:31.766Z,1723666771.766 [Startup] Running Loop=1
2024-08-14T20:19:31.766Z,1723666771.766 [Startup](DEBUG): Aggregate::initialize Startup
2024-08-14T20:19:31.767Z,1723666771.767 [Startup:A.GoToSurface] Running Loop=1
2024-08-14T20:19:31.767Z,1723666771.767 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-08-14T20:19:31.768Z,1723666771.768 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-08-14T20:19:31.768Z,1723666771.768 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-08-14T20:19:31.768Z,1723666771.768 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-08-14T20:19:31.769Z,1723666771.769 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-08-14T20:19:31.769Z,1723666771.769 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-08-14T20:19:31.770Z,1723666771.770 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-08-14T20:19:31.771Z,1723666771.771 [Startup:StartupSatComms] Running Loop=1
2024-08-14T20:19:31.771Z,1723666771.771 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-08-14T20:19:31.771Z,1723666771.771 [Startup:StartupSatComms:A] Running Loop=1
2024-08-14T20:19:32.164Z,1723666772.164 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-08-14T20:19:46.112Z,1723666786.112 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:20:00.252Z,1723666800.252 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:20:14.392Z,1723666814.392 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:20:28.642Z,1723666828.642 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-08-14T20:20:28.642Z,1723666828.642 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-14T20:20:28.698Z,1723666828.698 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-14T20:20:29.032Z,1723666829.032 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-14T20:20:29.032Z,1723666829.032 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-08-14T20:20:31.782Z,1723666831.782 [Startup:StartupSatComms:A](INFO): Timed out from 2024-08-14T20:19:31.8Z
2024-08-14T20:20:31.782Z,1723666831.782 [Startup:StartupSatComms:A] Stopped
2024-08-14T20:20:31.782Z,1723666831.782 [Startup:StartupSatComms:B] Running Loop=1
2024-08-14T20:20:32.208Z,1723666832.208 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-08-14T20:20:40.832Z,1723666840.832 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20240814T175817/Courier0003.lzma
2024-08-14T20:20:41.835Z,1723666841.835 [DataOverHttps](INFO): Moved sent file to Logs/20240814T175817/Courier0003.lzma.bak
2024-08-14T20:20:41.835Z,1723666841.835 [DataOverHttps](INFO): SBD MOMSN=21501636
2024-08-14T20:20:59.804Z,1723666859.804 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20240814T201339/Courier0000.lzma
2024-08-14T20:21:00.805Z,1723666860.805 [DataOverHttps](INFO): Moved sent file to Logs/20240814T201339/Courier0000.lzma.bak
2024-08-14T20:21:00.805Z,1723666860.805 [DataOverHttps](INFO): SBD MOMSN=21501639
2024-08-14T20:21:18.147Z,1723666878.147 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20240814T201717/Courier0000.lzma
2024-08-14T20:21:19.150Z,1723666879.150 [DataOverHttps](INFO): Moved sent file to Logs/20240814T201717/Courier0000.lzma.bak
2024-08-14T20:21:19.150Z,1723666879.150 [DataOverHttps](INFO): SBD MOMSN=21501644
2024-08-14T20:21:31.974Z,1723666891.974 [Startup:StartupSatComms:B](INFO): Timed out from 2024-08-14T20:20:31.8Z
2024-08-14T20:21:31.974Z,1723666891.974 [Startup:StartupSatComms:B] Stopped
2024-08-14T20:21:31.974Z,1723666891.974 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-08-14T20:21:31.974Z,1723666891.974 [Startup:StartupSatComms] Stopped
2024-08-14T20:21:31.974Z,1723666891.974 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-08-14T20:21:31.975Z,1723666891.975 [Startup](INFO): Completed Startup
2024-08-14T20:21:31.976Z,1723666891.976 [MissionManager](INFO): Startup is completed.
2024-08-14T20:21:31.976Z,1723666891.976 [MissionManager](INFO): Uninitializing Mission Startup
2024-08-14T20:21:31.976Z,1723666891.976 [Startup] Stopped
2024-08-14T20:21:31.976Z,1723666891.976 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-08-14T20:21:31.976Z,1723666891.976 [Startup:A.GoToSurface] Stopped
2024-08-14T20:21:31.976Z,1723666891.976 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-08-14T20:21:32.445Z,1723666892.445 [MissionManager](IMPORTANT): Started mission Default
2024-08-14T20:21:32.445Z,1723666892.445 [Default] Running Loop=1
2024-08-14T20:21:32.445Z,1723666892.445 [Default](DEBUG): Aggregate::initialize Default
2024-08-14T20:21:32.445Z,1723666892.445 [Default:B.GoToSurface] Running Loop=1
2024-08-14T20:21:32.445Z,1723666892.445 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-08-14T20:21:32.445Z,1723666892.445 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-08-14T20:21:32.446Z,1723666892.446 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-08-14T20:21:32.446Z,1723666892.446 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-08-14T20:21:32.446Z,1723666892.446 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-08-14T20:21:32.447Z,1723666892.447 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-08-14T20:21:32.447Z,1723666892.447 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-08-14T20:21:32.447Z,1723666892.447 [Default:A.Wait] Running Loop=1
2024-08-14T20:21:32.447Z,1723666892.447 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-08-14T20:21:39.168Z,1723666899.168 [DataOverHttps](INFO): Sending 497 bytes from file Logs/20240814T175817/Express0004.lzma
2024-08-14T20:21:40.169Z,1723666900.169 [DataOverHttps](INFO): Moved sent file to Logs/20240814T175817/Express0004.lzma.bak
2024-08-14T20:21:40.169Z,1723666900.169 [DataOverHttps](INFO): SBD MOMSN=21501648
2024-08-14T20:21:45.750Z,1723666905.750 [Default:A.Wait](INFO): Done Waiting.
2024-08-14T20:21:45.750Z,1723666905.750 [Default:A.Wait] Stopped
2024-08-14T20:21:45.750Z,1723666905.750 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-08-14T20:21:46.149Z,1723666906.149 [Default:CheckIn] Running Loop=1
2024-08-14T20:21:46.149Z,1723666906.149 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-14T20:21:46.149Z,1723666906.149 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-14T20:21:46.517Z,1723666906.517 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-08-14T20:23:10.548Z,1723666990.548 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-08-14T20:23:23.217Z,1723667003.217 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-08-14T20:23:29.573Z,1723667009.573 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-08-14T20:23:29.573Z,1723667009.573 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-14T20:23:29.608Z,1723667009.608 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-14T20:23:29.994Z,1723667009.994 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-14T20:23:29.994Z,1723667009.994 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-08-14T20:24:12.423Z,1723667052.423 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-08-14T20:25:03.149Z,1723667103.149 [CommandExec](IMPORTANT): got command strobe on
2024-08-14T20:25:03.149Z,1723667103.149 [CommandExec](IMPORTANT): Activating strobe
2024-08-14T20:25:10.987Z,1723667110.987 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-08-14T20:25:19.824Z,1723667119.824 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-08-14T20:25:19.831Z,1723667119.831 [BPC1](INFO): Calculating totals. Valid battery stick count: 39. Valid reserve battery stick count: 4.
2024-08-14T20:25:19.834Z,1723667119.834 [BPC1](INFO): Received data from all battery sticks.
2024-08-14T20:26:30.549Z,1723667190.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-08-14T20:26:30.549Z,1723667190.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-14T20:26:30.561Z,1723667190.561 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-14T20:26:30.990Z,1723667190.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-14T20:26:30.990Z,1723667190.990 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-08-14T20:26:46.298Z,1723667206.298 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-14T20:21:46.1Z
2024-08-14T20:26:46.298Z,1723667206.298 [Default:CheckIn:Read_GPS] Stopped
2024-08-14T20:26:46.298Z,1723667206.298 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-14T20:26:46.743Z,1723667206.743 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-08-14T20:26:52.040Z,1723667212.040 [CommandExec](IMPORTANT): got command quit
2024-08-14T20:26:53.044Z,1723667213.044 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:26:53.044Z,1723667213.044 [CommandExec](INFO): Uninitializing the command executive.
2024-08-14T20:26:53.044Z,1723667213.044 [CommandExec](INFO): Uninitializing the command scheduler.
2024-08-14T20:26:53.044Z,1723667213.044 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:53.131Z,1723667213.131 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-08-14T20:26:53.132Z,1723667213.132 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-08-14T20:26:53.132Z,1723667213.132 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:53.132Z,1723667213.132 [NavChartDb](INFO): Join timeout helper Thread ID is 3338
2024-08-14T20:26:53.412Z,1723667213.412 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:26:53.412Z,1723667213.412 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:53.428Z,1723667213.428 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-08-14T20:26:53.428Z,1723667213.428 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:53.428Z,1723667213.428 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3339
2024-08-14T20:26:54.412Z,1723667214.412 [CTD_Seabird](INFO): Powering down
2024-08-14T20:26:54.433Z,1723667214.433 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:26:54.436Z,1723667214.436 [CTD_Seabird](INFO): Powering down
2024-08-14T20:26:54.452Z,1723667214.452 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:54.452Z,1723667214.452 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-08-14T20:26:54.452Z,1723667214.452 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:54.453Z,1723667214.453 [Radio_Surface](INFO): Join timeout helper Thread ID is 3340
2024-08-14T20:26:54.580Z,1723667214.580 [Radio_Surface](INFO): Powering down
2024-08-14T20:26:54.581Z,1723667214.581 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:26:54.582Z,1723667214.582 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:54.596Z,1723667214.596 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-08-14T20:26:54.596Z,1723667214.596 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:54.596Z,1723667214.596 [Onboard](INFO): Join timeout helper Thread ID is 3341
2024-08-14T20:26:55.300Z,1723667215.300 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240814T201717/Courier0004.lzma
2024-08-14T20:26:59.428Z,1723667219.428 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:26:59.428Z,1723667219.428 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:59.435Z,1723667219.435 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-08-14T20:26:59.436Z,1723667219.436 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:26:59.436Z,1723667219.436 [DataOverHttps](INFO): Join timeout helper Thread ID is 3342
2024-08-14T20:27:00.316Z,1723667220.316 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:27:00.319Z,1723667220.319 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.321Z,1723667220.321 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler
2024-08-14T20:27:00.321Z,1723667220.321 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.321Z,1723667220.321 [DATMMP](INFO): Join timeout helper Thread ID is 3343
2024-08-14T20:27:00.548Z,1723667220.548 [DATMMP](INFO): Stop
2024-08-14T20:27:00.548Z,1723667220.548 [DATMMP](INFO): uninitialize
2024-08-14T20:27:00.548Z,1723667220.548 [DATMMP](INFO): Powering down
2024-08-14T20:27:00.621Z,1723667220.621 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:27:00.621Z,1723667220.621 [DATMMP](INFO): uninitialize
2024-08-14T20:27:00.621Z,1723667220.621 [DATMMP](INFO): Powering down
2024-08-14T20:27:00.622Z,1723667220.622 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.624Z,1723667220.624 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-08-14T20:27:00.625Z,1723667220.625 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.625Z,1723667220.625 [BackseatComponent](INFO): Join timeout helper Thread ID is 3344
2024-08-14T20:27:00.792Z,1723667220.792 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:27:00.793Z,1723667220.793 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.804Z,1723667220.804 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-08-14T20:27:00.804Z,1723667220.804 [logger ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.805Z,1723667220.805 [logger](INFO): Join timeout helper Thread ID is 3345
2024-08-14T20:27:00.828Z,1723667220.828 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:27:00.828Z,1723667220.828 [logger ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.832Z,1723667220.832 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-08-14T20:27:00.833Z,1723667220.833 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.833Z,1723667220.833 [CommandLine](INFO): Join timeout helper Thread ID is 3346
2024-08-14T20:27:00.860Z,1723667220.860 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:27:00.860Z,1723667220.860 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.872Z,1723667220.872 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-08-14T20:27:00.872Z,1723667220.872 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.873Z,1723667220.873 [CommandExec](INFO): Join timeout helper Thread ID is 3347
2024-08-14T20:27:00.879Z,1723667220.879 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-08-14T20:27:00.879Z,1723667220.879 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:00.879Z,1723667220.879 [controlThread](INFO): Join timeout helper Thread ID is 3348
2024-08-14T20:27:01.220Z,1723667221.220 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-08-14T20:27:01.220Z,1723667221.220 [controlThread](DEBUG): Uninitializing ControlThread
2024-08-14T20:27:01.220Z,1723667221.220 [AHRS_M2](INFO): Powering down
2024-08-14T20:27:01.388Z,1723667221.388 [DVL_micro](INFO): Powering down
2024-08-14T20:27:01.389Z,1723667221.389 [NAL9602](INFO): Powering down
2024-08-14T20:27:01.390Z,1723667221.390 [Sonardyne_Nano](INFO): Powering down
2024-08-14T20:27:01.509Z,1723667221.509 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-08-14T20:27:01.509Z,1723667221.509 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-08-14T20:27:01.510Z,1723667221.510 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-08-14T20:27:01.510Z,1723667221.510 [MissionManager](INFO): Uninitializing Mission Default
2024-08-14T20:27:01.510Z,1723667221.510 [Default] Stopped
2024-08-14T20:27:01.510Z,1723667221.510 [Default](DEBUG): Aggregate::uninitialize Default
2024-08-14T20:27:01.510Z,1723667221.510 [Default:B.GoToSurface] Stopped
2024-08-14T20:27:01.511Z,1723667221.511 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-08-14T20:27:01.511Z,1723667221.511 [Default:CheckIn] Stopped
2024-08-14T20:27:01.511Z,1723667221.511 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-14T20:27:01.511Z,1723667221.511 [Default:CheckIn:Read_Iridium] Stopped
2024-08-14T20:27:01.513Z,1723667221.513 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-08-14T20:27:01.514Z,1723667221.514 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-08-14T20:27:01.514Z,1723667221.514 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-08-14T20:27:01.514Z,1723667221.514 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-08-14T20:27:01.515Z,1723667221.515 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-08-14T20:27:01.515Z,1723667221.515 [BuoyancyServo](INFO): Powering down
2024-08-14T20:27:01.528Z,1723667221.528 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-08-14T20:27:01.528Z,1723667221.528 [MassServo](INFO): Powering down
2024-08-14T20:27:01.529Z,1723667221.529 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-08-14T20:27:01.529Z,1723667221.529 [RudderServo](INFO): Powering down
2024-08-14T20:27:01.529Z,1723667221.529 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-08-14T20:27:01.530Z,1723667221.530 [ThrusterHE](INFO): Powering down
2024-08-14T20:27:01.530Z,1723667221.530 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-08-14T20:27:01.531Z,1723667221.531 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-08-14T20:27:01.531Z,1723667221.531 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-08-14T20:27:01.531Z,1723667221.531 [CBIT](DEBUG): Powering off loads.
2024-08-14T20:27:01.543Z,1723667221.543 [CBIT](DEBUG): Disabling WDT.
2024-08-14T20:27:01.555Z,1723667221.555 [CBIT](DEBUG): Opening all GF detection circuits.
2024-08-14T20:27:01.556Z,1723667221.556 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.597Z,1723667221.597 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.600Z,1723667221.600 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.607Z,1723667221.607 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.613Z,1723667221.613 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.654Z,1723667221.654 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.710Z,1723667221.710 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.733Z,1723667221.733 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-08-14T20:27:01.794Z,1723667221.794 [logger ThreadHandler](INFO): Thread cancelled.