2023-05-16T20:01:32.130Z,1684267292.130 [Supervisor](DEBUG): Initializing supervisor.
2023-05-16T20:01:32.135Z,1684267292.135 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-05-16T20:01:32.135Z,1684267292.135 [SyncHandler](INFO): Protected caller Thread ID is 838
2023-05-16T20:01:32.136Z,1684267292.136 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-05-16T20:01:32.137Z,1684267292.137 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-05-16T20:01:32.137Z,1684267292.137 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 839
2023-05-16T20:01:32.141Z,1684267292.141 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-05-16T20:01:32.158Z,1684267292.158 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-05-16T20:01:32.159Z,1684267292.159 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-05-16T20:01:32.160Z,1684267292.160 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 840
2023-05-16T20:01:32.164Z,1684267292.164 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-05-16T20:01:32.165Z,1684267292.165 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-05-16T20:01:32.165Z,1684267292.165 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 841
2023-05-16T20:01:32.167Z,1684267292.167 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-05-16T20:01:32.168Z,1684267292.168 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-05-16T20:01:32.168Z,1684267292.168 [logger ThreadHandler](INFO): Protected caller Thread ID is 842
2023-05-16T20:01:32.172Z,1684267292.172 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-05-16T20:01:32.172Z,1684267292.172 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-05-16T20:01:32.176Z,1684267292.176 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-05-16T20:01:32.391Z,1684267292.391 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-05-16T20:01:32.393Z,1684267292.393 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-05-16T20:01:32.499Z,1684267292.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-05-16T20:01:32.501Z,1684267292.501 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-05-16T20:01:32.595Z,1684267292.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-05-16T20:01:32.597Z,1684267292.597 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-05-16T20:01:33.068Z,1684267293.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-05-16T20:01:33.070Z,1684267293.070 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-05-16T20:01:33.419Z,1684267293.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-05-16T20:01:33.420Z,1684267293.420 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-05-16T20:01:33.756Z,1684267293.756 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-05-16T20:01:33.757Z,1684267293.757 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-05-16T20:01:33.942Z,1684267293.942 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-05-16T20:01:33.944Z,1684267293.944 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-05-16T20:01:34.023Z,1684267294.023 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-05-16T20:01:34.103Z,1684267294.103 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-05-16T20:01:34.496Z,1684267294.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-05-16T20:01:34.498Z,1684267294.498 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-05-16T20:01:34.773Z,1684267294.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-05-16T20:01:34.774Z,1684267294.774 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-05-16T20:01:35.408Z,1684267295.408 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-05-16T20:01:35.410Z,1684267295.410 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-05-16T20:01:36.154Z,1684267296.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-05-16T20:01:36.155Z,1684267296.155 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-05-16T20:01:36.396Z,1684267296.396 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-05-16T20:01:36.397Z,1684267296.397 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-05-16T20:01:36.536Z,1684267296.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-05-16T20:01:36.537Z,1684267296.537 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-05-16T20:01:37.326Z,1684267297.326 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-05-16T20:01:37.328Z,1684267297.328 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2023-05-16T20:01:37.331Z,1684267297.331 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2023-05-16T20:01:37.415Z,1684267297.415 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2023-05-16T20:01:37.594Z,1684267297.594 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2023-05-16T20:01:37.858Z,1684267297.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-05-16T20:01:37.858Z,1684267297.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2023-05-16T20:01:37.980Z,1684267297.980 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2023-05-16T20:01:38.079Z,1684267298.079 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2023-05-16T20:01:38.173Z,1684267298.173 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2023-05-16T20:01:38.280Z,1684267298.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2023-05-16T20:01:38.374Z,1684267298.374 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2023-05-16T20:01:38.460Z,1684267298.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2023-05-16T20:01:38.558Z,1684267298.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2023-05-16T20:01:38.719Z,1684267298.719 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2023-05-16T20:01:38.719Z,1684267298.719 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2023-05-16T20:01:38.723Z,1684267298.723 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-05-16T20:01:38.797Z,1684267298.797 [DepthRateCalculator] Loaded
2023-05-16T20:01:38.797Z,1684267298.797 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-05-16T20:01:38.803Z,1684267298.803 [PitchRateCalculator] Loaded
2023-05-16T20:01:38.803Z,1684267298.803 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-05-16T20:01:38.813Z,1684267298.813 [SpeedCalculator] Loaded
2023-05-16T20:01:38.814Z,1684267298.814 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-05-16T20:01:38.818Z,1684267298.818 [YawRateCalculator] Loaded
2023-05-16T20:01:38.819Z,1684267298.819 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-05-16T20:01:38.840Z,1684267298.840 [ElevatorOffsetCalculator] Loaded
2023-05-16T20:01:38.840Z,1684267298.840 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-05-16T20:01:38.841Z,1684267298.841 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-05-16T20:01:38.843Z,1684267298.843 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-05-16T20:01:38.886Z,1684267298.886 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-05-16T20:01:38.886Z,1684267298.886 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-05-16T20:01:38.901Z,1684267298.901 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-05-16T20:01:38.902Z,1684267298.902 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-05-16T20:01:39.655Z,1684267299.655 [AHRS_M2] Loaded
2023-05-16T20:01:39.655Z,1684267299.655 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-05-16T20:01:39.904Z,1684267299.904 [BackseatComponent] Loaded
2023-05-16T20:01:39.904Z,1684267299.904 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-05-16T20:01:39.905Z,1684267299.905 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408474E0
2023-05-16T20:01:39.905Z,1684267299.905 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 926
2023-05-16T20:01:39.908Z,1684267299.908 [LcmUniversalReporter] Loaded
2023-05-16T20:01:39.908Z,1684267299.908 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-05-16T20:01:40.701Z,1684267300.701 [BPC1] Loaded
2023-05-16T20:01:40.701Z,1684267300.701 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-05-16T20:01:40.846Z,1684267300.846 [DataOverHttps] Loaded
2023-05-16T20:01:40.846Z,1684267300.846 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-05-16T20:01:40.847Z,1684267300.847 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408774E0
2023-05-16T20:01:40.847Z,1684267300.847 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 927
2023-05-16T20:01:40.868Z,1684267300.868 [Depth_Keller] Loaded
2023-05-16T20:01:40.868Z,1684267300.868 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-05-16T20:01:40.873Z,1684267300.873 [DropWeight] Loaded
2023-05-16T20:01:40.873Z,1684267300.873 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-05-16T20:01:40.934Z,1684267300.934 [NAL9602] Loaded
2023-05-16T20:01:40.935Z,1684267300.935 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-05-16T20:01:40.964Z,1684267300.964 [Onboard] Loaded
2023-05-16T20:01:40.964Z,1684267300.964 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-05-16T20:01:40.965Z,1684267300.965 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408A74E0
2023-05-16T20:01:40.966Z,1684267300.966 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 928
2023-05-16T20:01:40.972Z,1684267300.972 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2023-05-16T20:01:40.982Z,1684267300.982 [PowerOnly] Loaded
2023-05-16T20:01:40.983Z,1684267300.983 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-05-16T20:01:40.994Z,1684267300.994 [Power24vConverter] Loaded
2023-05-16T20:01:40.994Z,1684267300.994 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-05-16T20:01:41.009Z,1684267301.009 [Radio_Surface] Loaded
2023-05-16T20:01:41.009Z,1684267301.009 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-05-16T20:01:41.010Z,1684267301.010 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D74E0
2023-05-16T20:01:41.010Z,1684267301.010 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 929
2023-05-16T20:01:41.033Z,1684267301.033 [Waterlinked] Loaded
2023-05-16T20:01:41.033Z,1684267301.033 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2023-05-16T20:01:41.034Z,1684267301.034 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-05-16T20:01:41.034Z,1684267301.034 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-05-16T20:01:41.385Z,1684267301.385 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-05-16T20:01:41.385Z,1684267301.385 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-05-16T20:01:41.522Z,1684267301.522 [DeadReckonUsingSpeedCalculator] Loaded
2023-05-16T20:01:41.522Z,1684267301.522 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-05-16T20:01:41.538Z,1684267301.538 [NavChart] Loaded
2023-05-16T20:01:41.538Z,1684267301.538 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-05-16T20:01:41.544Z,1684267301.544 [UniversalFixResidualReporter] Loaded
2023-05-16T20:01:41.544Z,1684267301.544 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-05-16T20:01:41.545Z,1684267301.545 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-05-16T20:01:41.719Z,1684267301.719 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-05-16T20:01:41.890Z,1684267301.890 [SBIT](DEBUG): Construct Startup Built In Test.
2023-05-16T20:01:41.904Z,1684267301.904 [SBIT] Loaded
2023-05-16T20:01:41.905Z,1684267301.905 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-05-16T20:01:41.907Z,1684267301.907 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-05-16T20:01:41.920Z,1684267301.920 [IBIT] Loaded
2023-05-16T20:01:41.920Z,1684267301.920 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-05-16T20:01:41.926Z,1684267301.926 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-05-16T20:01:42.191Z,1684267302.191 [CBIT] Loaded
2023-05-16T20:01:42.191Z,1684267302.191 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-05-16T20:01:42.191Z,1684267302.191 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-05-16T20:01:42.200Z,1684267302.200 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-05-16T20:01:42.495Z,1684267302.495 [CTD_Seabird] Loaded
2023-05-16T20:01:42.496Z,1684267302.496 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-05-16T20:01:42.497Z,1684267302.497 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0
2023-05-16T20:01:42.497Z,1684267302.497 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 930
2023-05-16T20:01:42.517Z,1684267302.517 [PAR_Licor] Loaded
2023-05-16T20:01:42.517Z,1684267302.517 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-05-16T20:01:42.548Z,1684267302.548 [WetLabsBB2FL] Loaded
2023-05-16T20:01:42.548Z,1684267302.548 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-05-16T20:01:42.549Z,1684267302.549 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A0B4E0
2023-05-16T20:01:42.550Z,1684267302.550 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 931
2023-05-16T20:01:42.550Z,1684267302.550 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-05-16T20:01:42.551Z,1684267302.551 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-05-16T20:01:42.715Z,1684267302.715 [BuoyancyServo] Loaded
2023-05-16T20:01:42.715Z,1684267302.715 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-05-16T20:01:42.737Z,1684267302.737 [ElevatorServo] Loaded
2023-05-16T20:01:42.737Z,1684267302.737 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-05-16T20:01:42.758Z,1684267302.758 [MassServo] Loaded
2023-05-16T20:01:42.758Z,1684267302.758 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-05-16T20:01:42.779Z,1684267302.779 [RudderServo] Loaded
2023-05-16T20:01:42.779Z,1684267302.779 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-05-16T20:01:42.796Z,1684267302.796 [ThrusterHE] Loaded
2023-05-16T20:01:42.796Z,1684267302.796 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-05-16T20:01:42.797Z,1684267302.797 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-05-16T20:01:42.797Z,1684267302.797 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-05-16T20:01:42.866Z,1684267302.866 [VerticalControl](DEBUG): Construct VerticalControl.
2023-05-16T20:01:42.917Z,1684267302.917 [VerticalControl] Loaded
2023-05-16T20:01:42.917Z,1684267302.917 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-05-16T20:01:42.920Z,1684267302.920 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-05-16T20:01:42.957Z,1684267302.957 [HorizontalControl] Loaded
2023-05-16T20:01:42.957Z,1684267302.957 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-05-16T20:01:42.960Z,1684267302.960 [SpeedControl](DEBUG): Construct SpeedControl.
2023-05-16T20:01:42.961Z,1684267302.961 [SpeedControl] Loaded
2023-05-16T20:01:42.962Z,1684267302.962 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-05-16T20:01:42.964Z,1684267302.964 [LoopControl](DEBUG): Construct LoopControl.
2023-05-16T20:01:42.965Z,1684267302.965 [LoopControl] Loaded
2023-05-16T20:01:42.965Z,1684267302.965 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-05-16T20:01:42.966Z,1684267302.966 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-05-16T20:01:42.966Z,1684267302.966 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-05-16T20:01:43.089Z,1684267303.089 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-05-16T20:01:43.090Z,1684267303.090 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-05-16T20:01:43.274Z,1684267303.274 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-05-16T20:01:43.275Z,1684267303.275 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-05-16T20:01:43.633Z,1684267303.633 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-05-16T20:01:43.634Z,1684267303.634 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-05-16T20:01:43.717Z,1684267303.717 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-05-16T20:01:43.723Z,1684267303.723 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-05-16T20:01:43.726Z,1684267303.726 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-05-16T20:01:43.737Z,1684267303.737 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-05-16T20:01:43.738Z,1684267303.738 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BB74E0
2023-05-16T20:01:43.739Z,1684267303.739 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 932
2023-05-16T20:01:43.743Z,1684267303.743 [Supervisor](INFO): Main Thread ID is 831
2023-05-16T20:01:43.743Z,1684267303.743 [Supervisor](DEBUG): Running supervisor.
2023-05-16T20:01:43.744Z,1684267303.744 [CommandExec ThreadHandler](INFO): Handler Thread ID is 933
2023-05-16T20:01:43.744Z,1684267303.744 [CommandExec](INFO): Initializing the command executive.
2023-05-16T20:01:43.746Z,1684267303.746 [CommandLine ThreadHandler](INFO): Handler Thread ID is 934
2023-05-16T20:01:43.748Z,1684267303.748 [controlThread ThreadHandler](INFO): Handler Thread ID is 935
2023-05-16T20:01:43.748Z,1684267303.748 [controlThread](DEBUG): Initializing ControlThread
2023-05-16T20:01:43.749Z,1684267303.749 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-05-16T20:01:43.749Z,1684267303.749 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-05-16T20:01:43.750Z,1684267303.750 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-05-16T20:01:43.750Z,1684267303.750 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-05-16T20:01:43.750Z,1684267303.750 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-05-16T20:01:43.758Z,1684267303.758 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T20:01:43.759Z,1684267303.759 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-05-16T20:01:43.759Z,1684267303.759 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-05-16T20:01:43.760Z,1684267303.760 [SBIT](INFO): Initialize SBIT Component.
2023-05-16T20:01:43.760Z,1684267303.760 [SBIT](IMPORTANT): git: 2023-05-11-1-g0756d5a45
2023-05-16T20:01:43.760Z,1684267303.760 [SBIT](INFO): git hash: 0756d5a45b55fc759b5de63a78c860713c4b2bf5
2023-05-16T20:01:43.761Z,1684267303.761 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-05-16T20:01:43.762Z,1684267303.762 [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
2023-05-16T20:01:43.763Z,1684267303.763 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2023-05-16T20:01:43.764Z,1684267303.764 [IBIT](INFO): Initialize IBIT Component.
2023-05-16T20:01:43.764Z,1684267303.764 [CBIT](DEBUG): Initialize CBIT Component.
2023-05-16T20:01:43.765Z,1684267303.765 [logger ThreadHandler](INFO): Handler Thread ID is 936
2023-05-16T20:01:43.776Z,1684267303.776 [CBIT](DEBUG): Initialized mux pins.
2023-05-16T20:01:43.776Z,1684267303.776 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2023-05-16T20:01:43.776Z,1684267303.776 [CBIT](DEBUG): Initializing the watchdog timer.
2023-05-16T20:01:43.784Z,1684267303.784 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 937
2023-05-16T20:01:43.796Z,1684267303.796 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 938
2023-05-16T20:01:43.797Z,1684267303.797 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-05-16T20:01:43.800Z,1684267303.800 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2023-05-16T20:01:43.800Z,1684267303.800 [CBIT](DEBUG): Initializing heartbeat.
2023-05-16T20:01:43.808Z,1684267303.808 [Onboard ThreadHandler](INFO): Handler Thread ID is 939
2023-05-16T20:01:43.825Z,1684267303.825 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 940
2023-05-16T20:01:43.844Z,1684267303.844 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 941
2023-05-16T20:01:43.845Z,1684267303.845 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-16T20:01:43.850Z,1684267303.850 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 943
2023-05-16T20:01:43.852Z,1684267303.852 [WetLabsBB2FL](INFO): Powering up
2023-05-16T20:01:43.853Z,1684267303.853 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 945
2023-05-16T20:01:43.861Z,1684267303.861 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-05-16T20:01:43.861Z,1684267303.861 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-05-16T20:01:43.861Z,1684267303.861 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-05-16T20:01:43.861Z,1684267303.861 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-05-16T20:01:43.861Z,1684267303.861 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-05-16T20:01:43.861Z,1684267303.861 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-05-16T20:01:43.862Z,1684267303.862 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-05-16T20:01:43.862Z,1684267303.862 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-05-16T20:01:43.872Z,1684267303.872 [CBIT](DEBUG): Deactivating GF circuits.
2023-05-16T20:01:43.872Z,1684267303.872 [CBIT](DEBUG): Deactivating emergency mode.
2023-05-16T20:01:43.912Z,1684267303.912 [CBIT](DEBUG): Backplane powered.
2023-05-16T20:01:43.917Z,1684267303.917 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-05-16T20:01:43.919Z,1684267303.919 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-05-16T20:01:43.920Z,1684267303.920 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-05-16T20:01:43.920Z,1684267303.920 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-05-16T20:01:43.921Z,1684267303.921 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-05-16T20:01:43.957Z,1684267303.957 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T20:01:43.982Z,1684267303.982 [MissionManager](DEBUG):
2023-05-16T20:01:43.983Z,1684267303.983 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-05-16T20:01:44.041Z,1684267304.041 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-05-16T20:01:44.042Z,1684267304.042 [Default:A.Wait](DEBUG): Construct Wait.
2023-05-16T20:01:44.057Z,1684267304.057 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T20:01:44.068Z,1684267304.068 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-16T20:01:44.071Z,1684267304.071 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-16T20:01:44.106Z,1684267304.106 [Default:E.Execute](DEBUG): Construct Execute.
2023-05-16T20:01:44.122Z,1684267304.122 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2023-05-16T20:01:44.127Z,1684267304.127 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-05-16T20:01:44.145Z,1684267304.145 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-05-16T20:01:44.232Z,1684267304.232 [Radio_Surface](INFO): Powering up
2023-05-16T20:01:44.283Z,1684267304.283 [Power24vConverter](INFO): Powering up.
2023-05-16T20:01:44.330Z,1684267304.330 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-05-16T20:01:44.336Z,1684267304.336 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-05-16T20:01:44.337Z,1684267304.337 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-05-16T20:01:44.344Z,1684267304.344 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-05-16T20:01:44.345Z,1684267304.345 [MassServo](DEBUG): Initializing EZServoServo.
2023-05-16T20:01:44.353Z,1684267304.353 [MassServo](DEBUG): Initializing MassServo.
2023-05-16T20:01:44.353Z,1684267304.353 [RudderServo](DEBUG): Initializing EZServoServo.
2023-05-16T20:01:44.360Z,1684267304.360 [RudderServo](DEBUG): Initializing RudderServo.
2023-05-16T20:01:44.361Z,1684267304.361 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-05-16T20:01:44.369Z,1684267304.369 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-05-16T20:01:44.371Z,1684267304.371 [CommandExec](FAULT): Scheduling is paused
2023-05-16T20:01:44.371Z,1684267304.371 [CBIT](INFO): Critical error at 20230516T200143
2023-05-16T20:01:44.371Z,1684267304.371 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-05-16T20:01:46.464Z,1684267306.464 [WetLabsBB2FL](INFO): Powering down
2023-05-16T20:01:50.049Z,1684267310.049 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-05-16T20:01:50.876Z,1684267310.876 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2023-05-16T20:01:57.801Z,1684267317.801 [CommandExec](IMPORTANT): got command restart application
2023-05-16T20:01:58.804Z,1684267318.804 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:01:58.804Z,1684267318.804 [CommandExec](INFO): Uninitializing the command executive.
2023-05-16T20:01:58.804Z,1684267318.804 [CommandExec](INFO): Uninitializing the command scheduler.
2023-05-16T20:01:58.805Z,1684267318.805 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:58.976Z,1684267318.976 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2023-05-16T20:01:58.976Z,1684267318.976 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-05-16T20:01:58.976Z,1684267318.976 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:58.977Z,1684267318.977 [NavChartDb](INFO): Join timeout helper Thread ID is 953
2023-05-16T20:01:59.320Z,1684267319.320 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:01:59.320Z,1684267319.320 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.339Z,1684267319.339 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-05-16T20:01:59.339Z,1684267319.339 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.340Z,1684267319.340 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 954
2023-05-16T20:01:59.498Z,1684267319.498 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:01:59.499Z,1684267319.499 [WetLabsBB2FL](INFO): Powering down
2023-05-16T20:01:59.499Z,1684267319.499 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.516Z,1684267319.516 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-05-16T20:01:59.516Z,1684267319.516 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.516Z,1684267319.516 [CTD_Seabird](INFO): Join timeout helper Thread ID is 955
2023-05-16T20:01:59.909Z,1684267319.909 [CTD_Seabird](INFO): Powering down
2023-05-16T20:01:59.924Z,1684267319.924 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:01:59.924Z,1684267319.924 [CTD_Seabird](INFO): Powering down
2023-05-16T20:01:59.936Z,1684267319.936 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.956Z,1684267319.956 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-05-16T20:01:59.956Z,1684267319.956 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.956Z,1684267319.956 [Radio_Surface](INFO): Join timeout helper Thread ID is 956
2023-05-16T20:01:59.992Z,1684267319.992 [Radio_Surface](INFO): Powering down
2023-05-16T20:01:59.993Z,1684267319.993 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:01:59.993Z,1684267319.993 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:01:59.000Z,1684267320.000 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-05-16T20:01:59.000Z,1684267320.000 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:00.000Z,1684267320.000 [Onboard](INFO): Join timeout helper Thread ID is 957
2023-05-16T20:02:03.824Z,1684267323.824 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:02:03.824Z,1684267323.824 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:03.837Z,1684267323.837 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-05-16T20:02:03.837Z,1684267323.837 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:03.837Z,1684267323.837 [DataOverHttps](INFO): Join timeout helper Thread ID is 958
2023-05-16T20:02:03.880Z,1684267323.880 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:02:03.880Z,1684267323.880 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:03.899Z,1684267323.899 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-05-16T20:02:03.899Z,1684267323.899 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:03.899Z,1684267323.899 [BackseatComponent](INFO): Join timeout helper Thread ID is 959
2023-05-16T20:02:04.012Z,1684267324.012 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:02:04.012Z,1684267324.012 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.024Z,1684267324.024 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-05-16T20:02:04.025Z,1684267324.025 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.025Z,1684267324.025 [logger](INFO): Join timeout helper Thread ID is 960
2023-05-16T20:02:04.028Z,1684267324.028 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:02:04.028Z,1684267324.028 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.044Z,1684267324.044 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-05-16T20:02:04.045Z,1684267324.045 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.045Z,1684267324.045 [CommandLine](INFO): Join timeout helper Thread ID is 961
2023-05-16T20:02:04.068Z,1684267324.068 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:02:04.068Z,1684267324.068 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.085Z,1684267324.085 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-05-16T20:02:04.085Z,1684267324.085 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.085Z,1684267324.085 [CommandExec](INFO): Join timeout helper Thread ID is 962
2023-05-16T20:02:04.091Z,1684267324.091 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-05-16T20:02:04.091Z,1684267324.091 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.092Z,1684267324.092 [controlThread](INFO): Join timeout helper Thread ID is 963
2023-05-16T20:02:04.324Z,1684267324.324 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T20:02:04.324Z,1684267324.324 [controlThread](DEBUG): Uninitializing ControlThread
2023-05-16T20:02:04.325Z,1684267324.325 [AHRS_M2](INFO): Powering down
2023-05-16T20:02:04.405Z,1684267324.405 [NAL9602](INFO): Powering down
2023-05-16T20:02:04.476Z,1684267324.476 [Waterlinked](INFO): Powering down
2023-05-16T20:02:04.477Z,1684267324.477 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-05-16T20:02:04.478Z,1684267324.478 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-05-16T20:02:04.479Z,1684267324.479 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-05-16T20:02:04.479Z,1684267324.479 [MissionManager](INFO): Uninitializing Mission Default
2023-05-16T20:02:04.482Z,1684267324.482 [MissionManager](INFO): Uninitializing Mission Startup
2023-05-16T20:02:04.483Z,1684267324.483 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-05-16T20:02:04.484Z,1684267324.484 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-05-16T20:02:04.484Z,1684267324.484 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-05-16T20:02:04.484Z,1684267324.484 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-05-16T20:02:04.485Z,1684267324.485 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-05-16T20:02:04.485Z,1684267324.485 [BuoyancyServo](INFO): Powering down
2023-05-16T20:02:04.500Z,1684267324.500 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-05-16T20:02:04.500Z,1684267324.500 [ElevatorServo](INFO): Powering down
2023-05-16T20:02:04.501Z,1684267324.501 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-05-16T20:02:04.501Z,1684267324.501 [MassServo](INFO): Powering down
2023-05-16T20:02:04.502Z,1684267324.502 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-05-16T20:02:04.502Z,1684267324.502 [RudderServo](INFO): Powering down
2023-05-16T20:02:04.503Z,1684267324.503 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-05-16T20:02:04.503Z,1684267324.503 [ThrusterHE](INFO): Powering down
2023-05-16T20:02:04.504Z,1684267324.504 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-05-16T20:02:04.504Z,1684267324.504 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-05-16T20:02:04.504Z,1684267324.504 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-05-16T20:02:04.504Z,1684267324.504 [CBIT](DEBUG): Powering off loads.
2023-05-16T20:02:04.516Z,1684267324.516 [CBIT](DEBUG): Disabling WDT.
2023-05-16T20:02:04.528Z,1684267324.528 [CBIT](DEBUG): Opening all GF detection circuits.
2023-05-16T20:02:04.528Z,1684267324.528 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.546Z,1684267324.546 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.550Z,1684267324.550 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.555Z,1684267324.555 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.599Z,1684267324.599 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.645Z,1684267324.645 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.648Z,1684267324.648 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.934Z,1684267324.934 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T20:02:04.979Z,1684267324.979 [logger ThreadHandler](INFO): Thread cancelled.