2024-10-22T19:11:27.187Z,1729624287.187 [Supervisor](DEBUG): Initializing supervisor.
2024-10-22T19:11:27.192Z,1729624287.192 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-10-22T19:11:27.192Z,1729624287.192 [SyncHandler](INFO): Protected caller Thread ID is 1170
2024-10-22T19:11:27.193Z,1729624287.193 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-10-22T19:11:27.194Z,1729624287.194 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-10-22T19:11:27.194Z,1729624287.194 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1171
2024-10-22T19:11:27.198Z,1729624287.198 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-10-22T19:11:27.216Z,1729624287.216 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-10-22T19:11:27.217Z,1729624287.217 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-10-22T19:11:27.217Z,1729624287.217 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1172
2024-10-22T19:11:27.221Z,1729624287.221 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-10-22T19:11:27.222Z,1729624287.222 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-10-22T19:11:27.223Z,1729624287.223 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1173
2024-10-22T19:11:27.225Z,1729624287.225 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-10-22T19:11:27.226Z,1729624287.226 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-10-22T19:11:27.226Z,1729624287.226 [logger ThreadHandler](INFO): Protected caller Thread ID is 1174
2024-10-22T19:11:27.230Z,1729624287.230 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-10-22T19:11:27.230Z,1729624287.230 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-10-22T19:11:27.232Z,1729624287.232 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-10-22T19:11:27.471Z,1729624287.471 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-10-22T19:11:27.471Z,1729624287.471 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-10-22T19:11:27.703Z,1729624287.703 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-10-22T19:11:27.703Z,1729624287.703 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-10-22T19:11:27.809Z,1729624287.809 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-10-22T19:11:27.810Z,1729624287.810 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-10-22T19:11:28.009Z,1729624288.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-10-22T19:11:28.009Z,1729624288.009 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-10-22T19:11:28.525Z,1729624288.525 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-10-22T19:11:28.526Z,1729624288.526 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-10-22T19:11:28.645Z,1729624288.645 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-10-22T19:11:28.645Z,1729624288.645 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-10-22T19:11:28.933Z,1729624288.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-10-22T19:11:28.933Z,1729624288.933 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-10-22T19:11:29.157Z,1729624289.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-10-22T19:11:29.157Z,1729624289.157 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-10-22T19:11:29.714Z,1729624289.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-10-22T19:11:29.714Z,1729624289.714 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-10-22T19:11:30.151Z,1729624290.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-10-22T19:11:30.151Z,1729624290.151 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-10-22T19:11:30.241Z,1729624290.241 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-10-22T19:11:30.625Z,1729624290.625 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-10-22T19:11:30.625Z,1729624290.625 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-10-22T19:11:30.802Z,1729624290.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-10-22T19:11:30.802Z,1729624290.802 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-10-22T19:11:31.933Z,1729624291.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-10-22T19:11:31.933Z,1729624291.933 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-10-22T19:11:32.298Z,1729624292.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-10-22T19:11:32.298Z,1729624292.298 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-10-22T19:11:32.392Z,1729624292.392 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/
2024-10-22T19:11:32.393Z,1729624292.393 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg
2024-10-22T19:11:32.487Z,1729624292.487 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg
2024-10-22T19:11:32.604Z,1729624292.604 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg
2024-10-22T19:11:32.720Z,1729624292.720 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Navigation.cfg
2024-10-22T19:11:32.874Z,1729624292.874 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg
2024-10-22T19:11:32.973Z,1729624292.973 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg
2024-10-22T19:11:33.069Z,1729624293.069 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg
2024-10-22T19:11:33.184Z,1729624293.184 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg
2024-10-22T19:11:33.340Z,1729624293.340 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg
2024-10-22T19:11:33.514Z,1729624293.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg
2024-10-22T19:11:33.622Z,1729624293.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg
2024-10-22T19:11:33.956Z,1729624293.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-10-22T19:11:33.958Z,1729624293.958 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/root/
2024-10-22T19:11:33.958Z,1729624293.958 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-10-22T19:11:33.961Z,1729624293.961 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-10-22T19:11:34.294Z,1729624294.294 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-10-22T19:11:34.294Z,1729624294.294 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-10-22T19:11:34.754Z,1729624294.754 [AHRS_M2] Loaded
2024-10-22T19:11:34.755Z,1729624294.755 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-10-22T19:11:35.549Z,1729624295.549 [BPC1] Loaded
2024-10-22T19:11:35.549Z,1729624295.549 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-10-22T19:11:35.657Z,1729624295.657 [DAT] Loaded
2024-10-22T19:11:35.657Z,1729624295.657 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-10-22T19:11:35.658Z,1729624295.658 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408914E0
2024-10-22T19:11:35.659Z,1729624295.659 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1256
2024-10-22T19:11:35.731Z,1729624295.731 [DataOverHttps] Loaded
2024-10-22T19:11:35.732Z,1729624295.732 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-10-22T19:11:35.733Z,1729624295.733 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408C14E0
2024-10-22T19:11:35.733Z,1729624295.733 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1257
2024-10-22T19:11:35.755Z,1729624295.755 [Depth_Keller] Loaded
2024-10-22T19:11:35.755Z,1729624295.755 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-10-22T19:11:35.760Z,1729624295.760 [DropWeight] Loaded
2024-10-22T19:11:35.760Z,1729624295.760 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-10-22T19:11:35.824Z,1729624295.824 [NAL9602] Loaded
2024-10-22T19:11:35.824Z,1729624295.824 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-10-22T19:11:35.853Z,1729624295.853 [Onboard] Loaded
2024-10-22T19:11:35.853Z,1729624295.853 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-10-22T19:11:35.854Z,1729624295.854 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408F14E0
2024-10-22T19:11:35.855Z,1729624295.855 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1258
2024-10-22T19:11:35.868Z,1729624295.868 [Power24vConverter] Loaded
2024-10-22T19:11:35.869Z,1729624295.869 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-10-22T19:11:35.885Z,1729624295.885 [Radio_Surface] Loaded
2024-10-22T19:11:35.885Z,1729624295.885 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-10-22T19:11:35.886Z,1729624295.886 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409214E0
2024-10-22T19:11:35.886Z,1729624295.886 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1259
2024-10-22T19:11:35.902Z,1729624295.902 [Sonardyne_Nano] Loaded
2024-10-22T19:11:35.902Z,1729624295.902 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-10-22T19:11:35.902Z,1729624295.902 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-10-22T19:11:35.903Z,1729624295.903 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-10-22T19:11:36.013Z,1729624296.013 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-10-22T19:11:36.013Z,1729624296.013 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-10-22T19:11:36.065Z,1729624296.065 [VerticalControl](DEBUG): Construct VerticalControl.
2024-10-22T19:11:36.124Z,1729624296.124 [VerticalControl] Loaded
2024-10-22T19:11:36.125Z,1729624296.125 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-10-22T19:11:36.127Z,1729624296.127 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-10-22T19:11:36.175Z,1729624296.175 [HorizontalControl] Loaded
2024-10-22T19:11:36.175Z,1729624296.175 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-10-22T19:11:36.178Z,1729624296.178 [SpeedControl](DEBUG): Construct SpeedControl.
2024-10-22T19:11:36.181Z,1729624296.181 [SpeedControl] Loaded
2024-10-22T19:11:36.181Z,1729624296.181 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-10-22T19:11:36.184Z,1729624296.184 [LoopControl](DEBUG): Construct LoopControl.
2024-10-22T19:11:36.184Z,1729624296.184 [LoopControl] Loaded
2024-10-22T19:11:36.185Z,1729624296.185 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-10-22T19:11:36.185Z,1729624296.185 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-10-22T19:11:36.185Z,1729624296.185 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-10-22T19:11:36.196Z,1729624296.196 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-10-22T19:11:36.196Z,1729624296.196 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-10-22T19:11:36.222Z,1729624296.222 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-10-22T19:11:36.223Z,1729624296.223 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-10-22T19:11:36.333Z,1729624296.333 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-10-22T19:11:36.334Z,1729624296.334 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-10-22T19:11:36.376Z,1729624296.376 [DeadReckonUsingSpeedCalculator] Loaded
2024-10-22T19:11:36.376Z,1729624296.376 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2024-10-22T19:11:36.418Z,1729624296.418 [DeadReckonWithRespectToSeafloor] Loaded
2024-10-22T19:11:36.418Z,1729624296.418 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2024-10-22T19:11:36.432Z,1729624296.432 [NavChart] Loaded
2024-10-22T19:11:36.432Z,1729624296.432 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-10-22T19:11:36.438Z,1729624296.438 [UniversalFixResidualReporter] Loaded
2024-10-22T19:11:36.438Z,1729624296.438 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-10-22T19:11:36.438Z,1729624296.438 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-10-22T19:11:36.439Z,1729624296.439 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-10-22T19:11:36.594Z,1729624296.594 [SBIT](DEBUG): Construct Startup Built In Test.
2024-10-22T19:11:36.604Z,1729624296.604 [SBIT] Loaded
2024-10-22T19:11:36.604Z,1729624296.604 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-10-22T19:11:36.607Z,1729624296.607 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-10-22T19:11:36.620Z,1729624296.620 [IBIT] Loaded
2024-10-22T19:11:36.620Z,1729624296.620 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-10-22T19:11:36.626Z,1729624296.626 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-10-22T19:11:36.732Z,1729624296.732 [CBIT] Loaded
2024-10-22T19:11:36.733Z,1729624296.733 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-10-22T19:11:36.733Z,1729624296.733 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-10-22T19:11:36.733Z,1729624296.733 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-10-22T19:11:36.905Z,1729624296.905 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-10-22T19:11:36.906Z,1729624296.906 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-10-22T19:11:37.039Z,1729624297.039 [BuoyancyServo] Loaded
2024-10-22T19:11:37.039Z,1729624297.039 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-10-22T19:11:37.062Z,1729624297.062 [ElevatorServo] Loaded
2024-10-22T19:11:37.062Z,1729624297.062 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-10-22T19:11:37.084Z,1729624297.084 [MassServo] Loaded
2024-10-22T19:11:37.084Z,1729624297.084 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-10-22T19:11:37.104Z,1729624297.104 [RudderServo] Loaded
2024-10-22T19:11:37.104Z,1729624297.104 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-10-22T19:11:37.122Z,1729624297.122 [ThrusterHE] Loaded
2024-10-22T19:11:37.122Z,1729624297.122 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-10-22T19:11:37.122Z,1729624297.122 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-10-22T19:11:37.123Z,1729624297.123 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-10-22T19:11:37.297Z,1729624297.297 [CTD_Seabird] Loaded
2024-10-22T19:11:37.298Z,1729624297.298 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-10-22T19:11:37.299Z,1729624297.299 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B4B4E0
2024-10-22T19:11:37.299Z,1729624297.299 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1260
2024-10-22T19:11:37.321Z,1729624297.321 [PAR_Licor] Loaded
2024-10-22T19:11:37.321Z,1729624297.321 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-10-22T19:11:37.366Z,1729624297.366 [WetLabsBB2FL] Loaded
2024-10-22T19:11:37.366Z,1729624297.366 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-10-22T19:11:37.367Z,1729624297.367 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B7B4E0
2024-10-22T19:11:37.368Z,1729624297.368 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1261
2024-10-22T19:11:37.368Z,1729624297.368 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-10-22T19:11:37.369Z,1729624297.369 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-10-22T19:11:37.418Z,1729624297.418 [DepthRateCalculator] Loaded
2024-10-22T19:11:37.418Z,1729624297.418 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-10-22T19:11:37.423Z,1729624297.423 [PitchRateCalculator] Loaded
2024-10-22T19:11:37.424Z,1729624297.424 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-10-22T19:11:37.444Z,1729624297.444 [SpeedCalculator] Loaded
2024-10-22T19:11:37.444Z,1729624297.444 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-10-22T19:11:37.449Z,1729624297.449 [YawRateCalculator] Loaded
2024-10-22T19:11:37.449Z,1729624297.449 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-10-22T19:11:37.468Z,1729624297.468 [ElevatorOffsetCalculator] Loaded
2024-10-22T19:11:37.469Z,1729624297.469 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-10-22T19:11:37.469Z,1729624297.469 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-10-22T19:11:37.470Z,1729624297.470 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-10-22T19:11:37.524Z,1729624297.524 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-10-22T19:11:37.531Z,1729624297.531 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-10-22T19:11:37.534Z,1729624297.534 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-10-22T19:11:37.545Z,1729624297.545 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-10-22T19:11:37.546Z,1729624297.546 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-10-22T19:11:37.546Z,1729624297.546 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1262
2024-10-22T19:11:37.551Z,1729624297.551 [Supervisor](INFO): Main Thread ID is 820
2024-10-22T19:11:37.551Z,1729624297.551 [Supervisor](DEBUG): Running supervisor.
2024-10-22T19:11:37.551Z,1729624297.551 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1263
2024-10-22T19:11:37.552Z,1729624297.552 [CommandExec](INFO): Initializing the command executive.
2024-10-22T19:11:37.553Z,1729624297.553 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1264
2024-10-22T19:11:37.555Z,1729624297.555 [controlThread ThreadHandler](INFO): Handler Thread ID is 1265
2024-10-22T19:11:37.556Z,1729624297.556 [controlThread](DEBUG): Initializing ControlThread
2024-10-22T19:11:37.562Z,1729624297.562 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-10-22T19:11:37.563Z,1729624297.563 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-10-22T19:11:37.564Z,1729624297.564 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-10-22T19:11:37.564Z,1729624297.564 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-10-22T19:11:37.565Z,1729624297.565 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-22T19:11:37.566Z,1729624297.566 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-10-22T19:11:37.566Z,1729624297.566 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-10-22T19:11:37.566Z,1729624297.566 [SBIT](INFO): Initialize SBIT Component.
2024-10-22T19:11:37.567Z,1729624297.567 [SBIT](IMPORTANT): git: 2024-10-22_A
2024-10-22T19:11:37.567Z,1729624297.567 [SBIT](INFO): git hash: a2a4bcf12dfde36db5bd7890264b8f5dc391f296
2024-10-22T19:11:37.567Z,1729624297.567 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-10-22T19:11:37.569Z,1729624297.569 [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-10-22T19:11:37.570Z,1729624297.570 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2024-10-22T19:11:37.571Z,1729624297.571 [IBIT](INFO): Initialize IBIT Component.
2024-10-22T19:11:37.572Z,1729624297.572 [CBIT](DEBUG): Initialize CBIT Component.
2024-10-22T19:11:37.573Z,1729624297.573 [logger ThreadHandler](INFO): Handler Thread ID is 1266
2024-10-22T19:11:37.584Z,1729624297.584 [CBIT](DEBUG): Initialized mux pins.
2024-10-22T19:11:37.584Z,1729624297.584 [CBIT](DEBUG): Initializing the watchdog timer.
2024-10-22T19:11:37.592Z,1729624297.592 [DAT ThreadHandler](INFO): Handler Thread ID is 1267
2024-10-22T19:11:37.593Z,1729624297.593 [DAT](INFO): Powering up
2024-10-22T19:11:37.593Z,1729624297.593 [DAT](DEBUG): Initializing DAT.
2024-10-22T19:11:37.597Z,1729624297.597 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1269
2024-10-22T19:11:37.599Z,1729624297.599 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-10-22T19:11:37.608Z,1729624297.608 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-10-22T19:11:37.608Z,1729624297.608 [CBIT](DEBUG): Initializing heartbeat.
2024-10-22T19:11:37.609Z,1729624297.609 [Onboard ThreadHandler](INFO): Handler Thread ID is 1270
2024-10-22T19:11:37.629Z,1729624297.629 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1271
2024-10-22T19:11:37.644Z,1729624297.644 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1272
2024-10-22T19:11:37.645Z,1729624297.645 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-10-22T19:11:37.649Z,1729624297.649 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1274
2024-10-22T19:11:37.652Z,1729624297.652 [WetLabsBB2FL](INFO): Powering up
2024-10-22T19:11:37.654Z,1729624297.654 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1276
2024-10-22T19:11:37.657Z,1729624297.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2024-10-22T19:11:37.657Z,1729624297.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2024-10-22T19:11:37.657Z,1729624297.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2024-10-22T19:11:37.657Z,1729624297.657 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2024-10-22T19:11:37.657Z,1729624297.657 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2024-10-22T19:11:37.658Z,1729624297.658 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2024-10-22T19:11:37.680Z,1729624297.680 [CBIT](DEBUG): Deactivating GF circuits.
2024-10-22T19:11:37.680Z,1729624297.680 [CBIT](DEBUG): Deactivating emergency mode.
2024-10-22T19:11:37.720Z,1729624297.720 [CBIT](DEBUG): Backplane powered.
2024-10-22T19:11:37.724Z,1729624297.724 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-10-22T19:11:37.724Z,1729624297.724 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-10-22T19:11:37.725Z,1729624297.725 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-10-22T19:11:37.725Z,1729624297.725 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-10-22T19:11:37.726Z,1729624297.726 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-10-22T19:11:37.726Z,1729624297.726 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-10-22T19:11:37.727Z,1729624297.727 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-10-22T19:11:37.727Z,1729624297.727 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-10-22T19:11:37.729Z,1729624297.729 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-10-22T19:11:37.786Z,1729624297.786 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-10-22T19:11:37.790Z,1729624297.790 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-10-22T19:11:37.802Z,1729624297.802 [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-10-22T19:11:37.803Z,1729624297.803 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-10-22T19:11:37.803Z,1729624297.803 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-10-22T19:11:37.804Z,1729624297.804 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-10-22T19:11:38.018Z,1729624298.018 [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-10-22T19:11:38.025Z,1729624298.025 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-10-22T19:11:38.026Z,1729624298.026 [Default:A.Wait](DEBUG): Construct Wait.
2024-10-22T19:11:38.028Z,1729624298.028 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-10-22T19:11:38.036Z,1729624298.036 [Radio_Surface](INFO): Powering up
2024-10-22T19:11:38.080Z,1729624298.080 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-10-22T19:11:38.082Z,1729624298.082 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-10-22T19:11:38.088Z,1729624298.088 [Default:E.Execute](DEBUG): Construct Execute.
2024-10-22T19:11:38.091Z,1729624298.091 [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-10-22T19:11:38.100Z,1729624298.100 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2024-10-22T19:11:38.108Z,1729624298.108 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-10-22T19:11:38.170Z,1729624298.170 [Power24vConverter](INFO): Powering up.
2024-10-22T19:11:38.171Z,1729624298.171 [Sonardyne_Nano](INFO): Initializing.
2024-10-22T19:11:38.245Z,1729624298.245 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-10-22T19:11:38.252Z,1729624298.252 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-10-22T19:11:38.253Z,1729624298.253 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-10-22T19:11:38.260Z,1729624298.260 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-10-22T19:11:38.261Z,1729624298.261 [MassServo](DEBUG): Initializing EZServoServo.
2024-10-22T19:11:38.268Z,1729624298.268 [MassServo](DEBUG): Initializing MassServo.
2024-10-22T19:11:38.269Z,1729624298.269 [RudderServo](DEBUG): Initializing EZServoServo.
2024-10-22T19:11:38.292Z,1729624298.292 [RudderServo](DEBUG): Initializing RudderServo.
2024-10-22T19:11:38.293Z,1729624298.293 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-10-22T19:11:38.300Z,1729624298.300 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-10-22T19:11:39.760Z,1729624299.760 [WetLabsBB2FL](INFO): Powering down
2024-10-22T19:11:40.128Z,1729624300.128 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-10-22T19:11:41.416Z,1729624301.416 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409
2024-10-22T19:11:43.953Z,1729624303.953 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-10-22T19:11:49.196Z,1729624309.196 [DAT](INFO): DAT read:
2024-10-22T19:11:49.198Z,1729624309.198 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-10-22T19:11:50.709Z,1729624310.709 [DAT](INFO): DAT read: MF Frequency Band
2024-10-22T19:11:50.710Z,1729624310.710 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-10-22T19:11:50.710Z,1729624310.710 [DAT](INFO): DAT read: Oct 22 2024 19:11:45
2024-10-22T19:11:51.717Z,1729624311.717 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-10-22T19:11:51.718Z,1729624311.718 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-10-22T19:11:51.718Z,1729624311.718 [DAT](INFO): commRate: 800
2024-10-22T19:11:53.784Z,1729624313.784 [DAT](INFO): entering command mode
2024-10-22T19:11:53.984Z,1729624313.984 [DAT](INFO): DAT read:
2024-10-22T19:11:53.985Z,1729624313.985 [DAT](INFO): DAT read: user:1>
2024-10-22T19:11:53.985Z,1729624313.985 [DAT](INFO): setting verbose to 3
2024-10-22T19:11:54.236Z,1729624314.236 [DAT](INFO): DAT read: user:1>
2024-10-22T19:11:54.237Z,1729624314.237 [DAT](INFO): DAT read: Verbose | 3
2024-10-22T19:11:54.238Z,1729624314.238 [DAT](INFO): set verbose to 3
2024-10-22T19:11:54.238Z,1729624314.238 [DAT](INFO): setting DatVerbose to 27440
2024-10-22T19:11:54.488Z,1729624314.488 [DAT](INFO): DAT read: user:2>
2024-10-22T19:11:54.489Z,1729624314.489 [DAT](INFO): DAT read: DatVerbose | 27440
2024-10-22T19:11:54.490Z,1729624314.490 [DAT](INFO): set DatVerbose to 27440
2024-10-22T19:11:54.490Z,1729624314.490 [DAT](INFO): setting transmit power to 8
2024-10-22T19:11:54.741Z,1729624314.741 [DAT](INFO): DAT read: user:3>
2024-10-22T19:11:54.741Z,1729624314.741 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-10-22T19:11:54.742Z,1729624314.742 [DAT](INFO): set transmit power to 8
2024-10-22T19:11:54.742Z,1729624314.742 [DAT](INFO): setting local address to 2
2024-10-22T19:11:54.992Z,1729624314.992 [DAT](INFO): DAT read: user:4>
2024-10-22T19:11:54.993Z,1729624314.993 [DAT](INFO): DAT read: LocalAddr | 2
2024-10-22T19:11:54.993Z,1729624314.993 [DAT](INFO): set local address to 2
2024-10-22T19:11:54.995Z,1729624314.995 [DAT](INFO): Setting time to: 19:11:54 And date to:10/22/2024
2024-10-22T19:11:55.244Z,1729624315.244 [DAT](INFO): DAT read: user:5>
2024-10-22T19:11:55.245Z,1729624315.245 [DAT](INFO): DAT read: Tue Oct 22, 2024 19:11:54
2024-10-22T19:11:55.246Z,1729624315.246 [DAT](INFO): Local DAT time set to Tue Oct 22, 2024 19:11:54
2024-10-22T19:11:58.331Z,1729624318.331 [SBIT](IMPORTANT): Beginning Startup BIT
2024-10-22T19:11:58.359Z,1729624318.359 [CBIT](IMPORTANT): Beginning ground fault scan
2024-10-22T19:12:05.993Z,1729624325.993 [NAL9602](INFO): Powering up NAL9602
2024-10-22T19:12:09.291Z,1729624329.291 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.005719
CHAN A1 (24V): -0.000290
CHAN A2 (12V): 0.000156
CHAN A3 (5V): -0.001628
CHAN B0 (3.3V): -0.000304
CHAN B1 (3.15aV): -0.001646
CHAN B2 (3.15bV): -0.000932
CHAN B3 (GND): -0.001899
OPEN: 0.004535
Full Scale: +/- 1 mA
2024-10-22T19:12:16.898Z,1729624336.898 [NAL9602](INFO): NAL9602 initialized
2024-10-22T19:12:52.493Z,1729624372.493 [SBIT](IMPORTANT): SBIT PASSED
2024-10-22T19:12:52.493Z,1729624372.493 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-10-22T19:12:52.494Z,1729624372.494 [SBIT](IMPORTANT): CBIT.gf24Offset=162 microampere;
2024-10-22T19:12:52.879Z,1729624372.879 [MissionManager](IMPORTANT): Started mission Startup
2024-10-22T19:12:52.879Z,1729624372.879 [Startup] Running Loop=1
2024-10-22T19:12:52.879Z,1729624372.879 [Startup](DEBUG): Aggregate::initialize Startup
2024-10-22T19:12:52.879Z,1729624372.879 [Startup:A.GoToSurface] Running Loop=1
2024-10-22T19:12:52.879Z,1729624372.879 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-10-22T19:12:52.880Z,1729624372.880 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-10-22T19:12:52.880Z,1729624372.880 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-10-22T19:12:52.881Z,1729624372.881 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-10-22T19:12:52.881Z,1729624372.881 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-10-22T19:12:52.881Z,1729624372.881 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-10-22T19:12:52.882Z,1729624372.882 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-10-22T19:12:52.883Z,1729624372.883 [Startup:StartupSatComms] Running Loop=1
2024-10-22T19:12:52.883Z,1729624372.883 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-10-22T19:12:52.912Z,1729624372.912 [Startup:StartupSatComms:A] Running Loop=1
2024-10-22T19:12:53.271Z,1729624373.271 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-10-22T19:13:17.963Z,1729624397.963 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-10-22T19:13:18.363Z,1729624398.363 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-10-22T19:13:49.583Z,1729624429.583 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005083
2024-10-22T19:13:53.063Z,1729624433.063 [Startup:StartupSatComms:A](INFO): Timed out from 2024-10-22T19:12:52.9Z
2024-10-22T19:13:53.063Z,1729624433.063 [Startup:StartupSatComms:A] Stopped
2024-10-22T19:13:53.063Z,1729624433.063 [Startup:StartupSatComms:B] Running Loop=1
2024-10-22T19:13:53.467Z,1729624433.467 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-10-22T19:14:00.039Z,1729624440.039 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241022T185628/Courier0007.lzma
2024-10-22T19:14:01.044Z,1729624441.044 [DataOverHttps](INFO): Moved sent file to Logs/20241022T185628/Courier0007.lzma.bak
2024-10-22T19:14:01.044Z,1729624441.044 [DataOverHttps](INFO): SBD MOMSN=23327200
2024-10-22T19:14:11.283Z,1729624451.283 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-10-22T19:14:15.669Z,1729624455.669 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:14:16.576Z,1729624456.576 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20241022T191127/Courier0000.lzma
2024-10-22T19:14:17.577Z,1729624457.577 [DataOverHttps](INFO): Moved sent file to Logs/20241022T191127/Courier0000.lzma.bak
2024-10-22T19:14:17.578Z,1729624457.578 [DataOverHttps](INFO): SBD MOMSN=23327202
2024-10-22T19:14:21.729Z,1729624461.729 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:14:33.224Z,1729624473.224 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20241022T185628/Express0008.lzma
2024-10-22T19:14:34.226Z,1729624474.226 [DataOverHttps](INFO): Moved sent file to Logs/20241022T185628/Express0008.lzma.bak
2024-10-22T19:14:34.226Z,1729624474.226 [DataOverHttps](INFO): SBD MOMSN=23327205
2024-10-22T19:14:35.061Z,1729624475.061 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:14:37.916Z,1729624477.916 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-10-22T19:14:37.916Z,1729624477.916 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-22T19:14:37.917Z,1729624477.917 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2024-10-22T19:14:37.917Z,1729624477.917 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-22T19:14:37.918Z,1729624477.918 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-10-22T19:14:37.918Z,1729624477.918 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-22T19:14:37.974Z,1729624477.974 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-22T19:14:37.975Z,1729624477.975 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-22T19:14:37.975Z,1729624477.975 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-22T19:14:38.437Z,1729624478.437 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-22T19:14:38.437Z,1729624478.437 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-10-22T19:14:38.438Z,1729624478.438 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-22T19:14:38.438Z,1729624478.438 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2024-10-22T19:14:38.438Z,1729624478.438 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-22T19:14:38.438Z,1729624478.438 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-10-22T19:14:38.752Z,1729624478.752 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-22T19:14:48.393Z,1729624488.393 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:14:49.944Z,1729624489.944 [DataOverHttps](INFO): Sending 681 bytes from file Logs/20241022T191127/Express0001.lzma
2024-10-22T19:14:50.938Z,1729624490.938 [DataOverHttps](INFO): Moved sent file to Logs/20241022T191127/Express0001.lzma.bak
2024-10-22T19:14:50.938Z,1729624490.938 [DataOverHttps](INFO): SBD MOMSN=23327210
2024-10-22T19:14:52.086Z,1729624492.086 [Startup:StartupSatComms:B] Stopped
2024-10-22T19:14:52.086Z,1729624492.086 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-10-22T19:14:52.086Z,1729624492.086 [Startup:StartupSatComms] Stopped
2024-10-22T19:14:52.086Z,1729624492.086 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-10-22T19:14:52.087Z,1729624492.087 [Startup](INFO): Completed Startup
2024-10-22T19:14:52.108Z,1729624492.108 [MissionManager](INFO): Startup is completed.
2024-10-22T19:14:52.108Z,1729624492.108 [MissionManager](INFO): Uninitializing Mission Startup
2024-10-22T19:14:52.108Z,1729624492.108 [Startup] Stopped
2024-10-22T19:14:52.108Z,1729624492.108 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-10-22T19:14:52.108Z,1729624492.108 [Startup:A.GoToSurface] Stopped
2024-10-22T19:14:52.108Z,1729624492.108 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-10-22T19:14:52.480Z,1729624492.480 [MissionManager](IMPORTANT): Started mission Default
2024-10-22T19:14:52.480Z,1729624492.480 [Default] Running Loop=1
2024-10-22T19:14:52.480Z,1729624492.480 [Default](DEBUG): Aggregate::initialize Default
2024-10-22T19:14:52.481Z,1729624492.481 [Default:B.GoToSurface] Running Loop=1
2024-10-22T19:14:52.481Z,1729624492.481 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-10-22T19:14:52.481Z,1729624492.481 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-10-22T19:14:52.481Z,1729624492.481 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-10-22T19:14:52.481Z,1729624492.481 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-10-22T19:14:52.482Z,1729624492.482 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-10-22T19:14:52.482Z,1729624492.482 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-10-22T19:14:52.482Z,1729624492.482 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-10-22T19:14:52.483Z,1729624492.483 [Default:A.Wait] Running Loop=1
2024-10-22T19:14:52.483Z,1729624492.483 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-10-22T19:15:02.533Z,1729624502.533 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:15:05.783Z,1729624505.783 [Default:A.Wait](INFO): Done Waiting.
2024-10-22T19:15:05.784Z,1729624505.784 [Default:A.Wait] Stopped
2024-10-22T19:15:05.784Z,1729624505.784 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-10-22T19:15:06.198Z,1729624506.198 [Default:CheckIn] Running Loop=1
2024-10-22T19:15:06.198Z,1729624506.198 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-22T19:15:06.198Z,1729624506.198 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-22T19:15:06.591Z,1729624506.591 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-10-22T19:15:16.673Z,1729624516.673 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:15:29.634Z,1729624529.634 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-10-22T19:15:43.741Z,1729624543.741 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:15:57.073Z,1729624557.073 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:16:10.035Z,1729624570.035 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-10-22T19:16:23.737Z,1729624583.737 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2024-10-22T19:16:52.073Z,1729624612.073 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-10-22T19:17:19.902Z,1729624639.902 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-10-22T19:17:21.567Z,1729624641.567 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-10-22T19:17:38.912Z,1729624658.912 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-10-22T19:17:38.912Z,1729624658.912 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-22T19:17:38.913Z,1729624658.913 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2024-10-22T19:17:38.913Z,1729624658.913 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-22T19:17:38.914Z,1729624658.914 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-10-22T19:17:38.915Z,1729624658.915 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-22T19:17:38.926Z,1729624658.926 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-22T19:17:38.926Z,1729624658.926 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-22T19:17:38.926Z,1729624658.926 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-22T19:17:39.338Z,1729624659.338 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-22T19:17:39.338Z,1729624659.338 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-10-22T19:17:39.339Z,1729624659.339 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-22T19:17:39.339Z,1729624659.339 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2024-10-22T19:17:39.339Z,1729624659.339 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-22T19:17:39.340Z,1729624659.340 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-10-22T19:17:39.721Z,1729624659.721 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-22T19:18:28.275Z,1729624708.275 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-10-22T19:19:08.226Z,1729624748.226 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-10-22T19:19:09.438Z,1729624749.438 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-10-22T19:19:49.808Z,1729624789.808 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2024-10-22T19:19:49.809Z,1729624789.809 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2024-10-22T19:19:49.812Z,1729624789.812 [BPC1](INFO): Received data from all battery sticks.
2024-10-22T19:20:06.380Z,1729624806.380 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-10-22T19:15:06.2Z
2024-10-22T19:20:06.381Z,1729624806.381 [Default:CheckIn:Read_GPS] Stopped
2024-10-22T19:20:06.381Z,1729624806.381 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-10-22T19:20:06.792Z,1729624806.792 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-10-22T19:20:13.720Z,1729624813.720 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20241022T191127/Courier0004.lzma
2024-10-22T19:20:14.722Z,1729624814.722 [DataOverHttps](INFO): Moved sent file to Logs/20241022T191127/Courier0004.lzma.bak
2024-10-22T19:20:14.722Z,1729624814.722 [DataOverHttps](INFO): SBD MOMSN=23327224
2024-10-22T19:20:30.424Z,1729624830.424 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20241022T191127/Express0005.lzma
2024-10-22T19:20:31.478Z,1729624831.478 [DataOverHttps](INFO): Moved sent file to Logs/20241022T191127/Express0005.lzma.bak
2024-10-22T19:20:31.478Z,1729624831.478 [DataOverHttps](INFO): SBD MOMSN=23327226
2024-10-22T19:20:32.627Z,1729624832.627 [Default:CheckIn:Read_Iridium] Stopped
2024-10-22T19:20:32.627Z,1729624832.627 [Default:CheckIn:C.Wait] Running Loop=1
2024-10-22T19:20:32.627Z,1729624832.627 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-10-22T19:20:39.906Z,1729624839.906 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-10-22T19:20:39.906Z,1729624839.906 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-22T19:20:39.907Z,1729624839.907 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2024-10-22T19:20:39.907Z,1729624839.907 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-22T19:20:39.908Z,1729624839.908 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2024-10-22T19:20:39.909Z,1729624839.909 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-22T19:20:39.919Z,1729624839.919 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-22T19:20:39.919Z,1729624839.919 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-22T19:20:39.920Z,1729624839.920 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-22T19:20:40.333Z,1729624840.333 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-22T19:20:40.333Z,1729624840.333 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-10-22T19:20:40.334Z,1729624840.334 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-22T19:20:40.334Z,1729624840.334 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2024-10-22T19:20:40.334Z,1729624840.334 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-22T19:20:40.334Z,1729624840.334 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2024-10-22T19:20:40.725Z,1729624840.725 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-22T19:21:42.118Z,1729624902.118 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging
2024-10-22T19:22:18.465Z,1729624938.465 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-10-22T19:22:18.466Z,1729624938.466 [NAL9602] Data Fault, FailCount= 1
2024-10-22T19:22:18.466Z,1729624938.466 [NAL9602](ERROR): Data Fault
2024-10-22T19:22:18.517Z,1729624938.517 [CBIT](ERROR): Data Fault in component: NAL9602
2024-10-22T19:22:18.862Z,1729624938.862 [NAL9602](INFO): Powering down
2024-10-22T19:22:19.696Z,1729624939.696 [CBIT](INFO): Clearing failed state for component NAL9602
2024-10-22T19:22:19.696Z,1729624939.696 [NAL9602] No Fault, FailCount= 1
2024-10-22T19:22:49.169Z,1729624969.169 [NAL9602](INFO): Powering up NAL9602
2024-10-22T19:23:00.077Z,1729624980.077 [NAL9602](INFO): NAL9602 initialized
2024-10-22T19:23:40.888Z,1729625020.888 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-10-22T19:23:40.888Z,1729625020.888 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-22T19:23:40.890Z,1729625020.890 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2024-10-22T19:23:40.890Z,1729625020.890 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-22T19:23:40.891Z,1729625020.891 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2024-10-22T19:23:40.891Z,1729625020.891 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-22T19:23:40.901Z,1729625020.901 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-22T19:23:40.902Z,1729625020.902 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-22T19:23:40.902Z,1729625020.902 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-22T19:23:41.311Z,1729625021.311 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-22T19:23:41.311Z,1729625021.311 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-10-22T19:23:41.312Z,1729625021.312 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-22T19:23:41.312Z,1729625021.312 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2024-10-22T19:23:41.312Z,1729625021.312 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-22T19:23:41.312Z,1729625021.312 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2024-10-22T19:23:41.708Z,1729625021.708 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-22T19:25:33.222Z,1729625133.222 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-10-22T19:25:33.222Z,1729625133.222 [Default:CheckIn:C.Wait] Stopped
2024-10-22T19:25:33.222Z,1729625133.222 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-10-22T19:25:33.223Z,1729625133.223 [Default:CheckIn:D] Running Loop=1
2024-10-22T19:25:33.630Z,1729625133.630 [Default:CheckIn:D] Stopped
2024-10-22T19:25:33.630Z,1729625133.630 [Default:CheckIn:E] Running Loop=1
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.685823 min
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn:E] Stopped
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn] Stopped
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn](INFO): Running loop #2
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn] Running Loop=2
2024-10-22T19:25:34.028Z,1729625134.028 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-10-22T19:25:34.029Z,1729625134.029 [Default:CheckIn:Read_GPS] Running Loop=1
2024-10-22T19:26:41.884Z,1729625201.884 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-10-22T19:26:41.884Z,1729625201.884 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-10-22T19:26:41.886Z,1729625201.886 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2024-10-22T19:26:41.886Z,1729625201.886 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-10-22T19:26:41.887Z,1729625201.887 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2024-10-22T19:26:41.887Z,1729625201.887 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-10-22T19:26:41.939Z,1729625201.939 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-10-22T19:26:41.940Z,1729625201.940 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-10-22T19:26:41.940Z,1729625201.940 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-10-22T19:26:42.300Z,1729625202.300 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-10-22T19:26:42.300Z,1729625202.300 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-10-22T19:26:42.300Z,1729625202.300 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-10-22T19:26:42.300Z,1729625202.300 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2024-10-22T19:26:42.301Z,1729625202.301 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-10-22T19:26:42.301Z,1729625202.301 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2024-10-22T19:26:42.693Z,1729625202.693 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-10-22T19:28:59.033Z,1729625339.033 [CommandExec](IMPORTANT): got command restart application
2024-10-22T19:29:00.036Z,1729625340.036 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-10-22T19:29:00.036Z,1729625340.036 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:00.036Z,1729625340.036 [CommandExec](INFO): Uninitializing the command executive.
2024-10-22T19:29:00.036Z,1729625340.036 [CommandExec](INFO): Uninitializing the command scheduler.
2024-10-22T19:29:00.037Z,1729625340.037 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:00.104Z,1729625340.104 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-10-22T19:29:00.104Z,1729625340.104 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-10-22T19:29:00.104Z,1729625340.104 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:00.105Z,1729625340.105 [NavChartDb](INFO): Join timeout helper Thread ID is 1304
2024-10-22T19:29:00.224Z,1729625340.224 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:00.224Z,1729625340.224 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:00.240Z,1729625340.240 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-10-22T19:29:00.240Z,1729625340.240 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:00.240Z,1729625340.240 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1305
2024-10-22T19:29:00.392Z,1729625340.392 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:00.392Z,1729625340.392 [WetLabsBB2FL](INFO): Powering down
2024-10-22T19:29:00.393Z,1729625340.393 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:00.404Z,1729625340.404 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-10-22T19:29:00.404Z,1729625340.404 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:00.404Z,1729625340.404 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1306
2024-10-22T19:29:01.080Z,1729625341.080 [CTD_Seabird](INFO): Powering down
2024-10-22T19:29:01.092Z,1729625341.092 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:01.092Z,1729625341.092 [CTD_Seabird](INFO): Powering down
2024-10-22T19:29:01.104Z,1729625341.104 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:01.116Z,1729625341.116 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-10-22T19:29:01.116Z,1729625341.116 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:01.116Z,1729625341.116 [Radio_Surface](INFO): Join timeout helper Thread ID is 1307
2024-10-22T19:29:01.240Z,1729625341.240 [Radio_Surface](INFO): Powering down
2024-10-22T19:29:01.241Z,1729625341.241 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:01.242Z,1729625341.242 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:01.256Z,1729625341.256 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-10-22T19:29:01.256Z,1729625341.256 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:01.256Z,1729625341.256 [Onboard](INFO): Join timeout helper Thread ID is 1308
2024-10-22T19:29:01.840Z,1729625341.840 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-10-22T19:29:03.468Z,1729625343.468 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:03.468Z,1729625343.468 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:03.477Z,1729625343.477 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-10-22T19:29:03.477Z,1729625343.477 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:03.477Z,1729625343.477 [DataOverHttps](INFO): Join timeout helper Thread ID is 1309
2024-10-22T19:29:03.848Z,1729625343.848 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:03.848Z,1729625343.848 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:03.861Z,1729625343.861 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-10-22T19:29:03.861Z,1729625343.861 [DAT ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:03.861Z,1729625343.861 [DAT](INFO): Join timeout helper Thread ID is 1310
2024-10-22T19:29:03.988Z,1729625343.988 [DAT](INFO): Powering down
2024-10-22T19:29:04.061Z,1729625344.061 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:04.061Z,1729625344.061 [DAT](INFO): Powering down
2024-10-22T19:29:04.062Z,1729625344.062 [DAT ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.064Z,1729625344.064 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-10-22T19:29:04.065Z,1729625344.065 [logger ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.065Z,1729625344.065 [logger](INFO): Join timeout helper Thread ID is 1311
2024-10-22T19:29:04.112Z,1729625344.112 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:04.113Z,1729625344.113 [logger ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.129Z,1729625344.129 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-10-22T19:29:04.129Z,1729625344.129 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.129Z,1729625344.129 [CommandLine](INFO): Join timeout helper Thread ID is 1312
2024-10-22T19:29:04.136Z,1729625344.136 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:04.136Z,1729625344.136 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.153Z,1729625344.153 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-10-22T19:29:04.153Z,1729625344.153 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.153Z,1729625344.153 [CommandExec](INFO): Join timeout helper Thread ID is 1313
2024-10-22T19:29:04.157Z,1729625344.157 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-10-22T19:29:04.157Z,1729625344.157 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.157Z,1729625344.157 [controlThread](INFO): Join timeout helper Thread ID is 1314
2024-10-22T19:29:04.176Z,1729625344.176 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-10-22T19:29:04.176Z,1729625344.176 [controlThread](DEBUG): Uninitializing ControlThread
2024-10-22T19:29:04.177Z,1729625344.177 [AHRS_M2](INFO): Powering down
2024-10-22T19:29:04.249Z,1729625344.249 [NAL9602](INFO): Powering down
2024-10-22T19:29:04.250Z,1729625344.250 [Sonardyne_Nano](INFO): Powering down
2024-10-22T19:29:04.369Z,1729625344.369 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-10-22T19:29:04.369Z,1729625344.369 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-10-22T19:29:04.370Z,1729625344.370 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-10-22T19:29:04.371Z,1729625344.371 [MissionManager](INFO): Uninitializing Mission Default
2024-10-22T19:29:04.371Z,1729625344.371 [Default] Stopped
2024-10-22T19:29:04.371Z,1729625344.371 [Default](DEBUG): Aggregate::uninitialize Default
2024-10-22T19:29:04.371Z,1729625344.371 [Default:B.GoToSurface] Stopped
2024-10-22T19:29:04.371Z,1729625344.371 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-10-22T19:29:04.371Z,1729625344.371 [Default:CheckIn] Stopped
2024-10-22T19:29:04.371Z,1729625344.371 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-10-22T19:29:04.371Z,1729625344.371 [Default:CheckIn:Read_GPS] Stopped
2024-10-22T19:29:04.374Z,1729625344.374 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-10-22T19:29:04.374Z,1729625344.374 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-10-22T19:29:04.374Z,1729625344.374 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-10-22T19:29:04.375Z,1729625344.375 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-10-22T19:29:04.375Z,1729625344.375 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-10-22T19:29:04.375Z,1729625344.375 [BuoyancyServo](INFO): Powering down
2024-10-22T19:29:04.388Z,1729625344.388 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-10-22T19:29:04.388Z,1729625344.388 [ElevatorServo](INFO): Powering down
2024-10-22T19:29:04.389Z,1729625344.389 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-10-22T19:29:04.389Z,1729625344.389 [MassServo](INFO): Powering down
2024-10-22T19:29:04.390Z,1729625344.390 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-10-22T19:29:04.390Z,1729625344.390 [RudderServo](INFO): Powering down
2024-10-22T19:29:04.391Z,1729625344.391 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-10-22T19:29:04.391Z,1729625344.391 [ThrusterHE](INFO): Powering down
2024-10-22T19:29:04.392Z,1729625344.392 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-10-22T19:29:04.392Z,1729625344.392 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-10-22T19:29:04.392Z,1729625344.392 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-10-22T19:29:04.392Z,1729625344.392 [CBIT](DEBUG): Powering off loads.
2024-10-22T19:29:04.404Z,1729625344.404 [CBIT](DEBUG): Disabling WDT.
2024-10-22T19:29:04.416Z,1729625344.416 [CBIT](DEBUG): Opening all GF detection circuits.
2024-10-22T19:29:04.417Z,1729625344.417 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.433Z,1729625344.433 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.436Z,1729625344.436 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.441Z,1729625344.441 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.448Z,1729625344.448 [DAT ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.573Z,1729625344.573 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.578Z,1729625344.578 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.596Z,1729625344.596 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-10-22T19:29:04.644Z,1729625344.644 [logger ThreadHandler](INFO): Thread cancelled.