Bug 1868726

Summary: [ERROR] subscription-manager: No such file or directory: '/etc/ostree/remotes.d/redhat.conf'
Product: Red Hat Enterprise Linux 8 Reporter: John Sefler <jsefler>
Component: subscription-managerAssignee: candlepin-bugs
Status: CLOSED ERRATA QA Contact: Red Hat subscription-manager QE Team <rhsm-qe>
Severity: low Docs Contact:
Priority: low    
Version: 8.3CC: arpandey, redakkan, wpoteat
Target Milestone: rcKeywords: EasyFix, Regression, Triaged
Target Release: ---Flags: pm-rhel: mirror+
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: subscription-manager-1.28.1-1 Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2021-05-18 13:32:41 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:
Bug Depends On: 1860434    
Bug Blocks: 1842946    

Description John Sefler 2020-08-13 15:34:09 UTC 
Description of problem:

On the current builds of subscription-manager for RHEL8.3 with subscription-manager-plugin-ostree installed, a benign Traceback is being caught and logged to rhsm.log because...
    FileNotFoundError: [Errno 2] No such file or directory: '/etc/ostree/remotes.d/redhat.conf'




Version-Release number of selected component (if applicable):
[root@intel-chiefriver-02 ~]# rpm -q subscription-manager-plugin-ostree ostree
subscription-manager-plugin-ostree-1.27.13-1.el8.x86_64
ostree-2020.4-1.el8.x86_64


How reproducible:
 when optional package subscription-manager-plugin-ostree is installed but not consuming ostree subscription content

Steps to Reproduce:
[root@intel-chiefriver-02 ~]# subscription-manager config --logging.default_log_level=DEBUG
[root@intel-chiefriver-02 ~]# 
[root@intel-chiefriver-02 ~]# subscription-manager register --serverurl=subscription.rhsm.stage.redhat.com
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
Username: stage_auto_testuser
Password: 
The system has been registered with ID: 43673e51-746f-427e-97f5-6680cdee5476
The registered system name is: intel-chiefriver-02.khw2.lab.eng.bos.redhat.com
Red Hat Insights registration enabled.
To opt out of Red Hat Insights, run "insights-client --unregister" or reregister with "--no-insights".
[root@intel-chiefriver-02 ~]# 
[root@intel-chiefriver-02 ~]# cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory
[root@intel-chiefriver-02 ~]# 
[root@intel-chiefriver-02 ~]# subscription-manager unregister
Unregistering from: subscription.rhsm.stage.redhat.com:443/subscription
System has been unregistered.
Red Hat Insights will also unregister.
[root@intel-chiefriver-02 ~]# 
[root@intel-chiefriver-02 ~]# cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory
[root@intel-chiefriver-02 ~]# 
[root@intel-chiefriver-02 ~]# tail -100 /var/log/rhsm/rhsm.log 
2020-08-13 11:27:21,793 [DEBUG] subscription-manager:354220:MainThread @connection.py:992 - Server has the following capabilities: ['instance_multiplier', 'derived_product', 'vcpu', 'cert_v3', 'hypervisors_heartbeat', 'remove_by_pool_id', 'syspurpose', 'storage_band', 'cores', 'hypervisors_async', 'org_level_content_access', 'guest_limit', 'ram', 'batch_bind', 'combined_reporting']
2020-08-13 11:27:21,793 [DEBUG] subscription-manager:354220:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentActionClient object at 0x7f67b0468cc0>
2020-08-13 11:27:21,794 [DEBUG] subscription-manager:354220:MainThread @base_action_client.py:88 - running lib: <subscription_manager.repolib.RepoActionInvoker object at 0x7f67b0468fd0>
2020-08-13 11:27:21,795 [DEBUG] subscription-manager:354220:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-08-13 11:27:21,795 [DEBUG] subscription-manager:354220:MainThread @repofile.py:364 - The directory /var/lib/rhsm/repo_server_val/ already exists
2020-08-13 11:27:21,795 [DEBUG] subscription-manager:354220:MainThread @__init__.py:92 - Searching for content of type: yum
2020-08-13 11:27:21,795 [DEBUG] subscription-manager:354220:MainThread @__init__.py:92 - Searching for content of type: deb
2020-08-13 11:27:21,796 [DEBUG] subscription-manager:354220:MainThread @repolib.py:463 - repos updated: Repo updates

Total repo updates: 0
Updated
    <NONE>
Added (new)
    <NONE>
Deleted
    <NONE>
2020-08-13 11:27:21,796 [DEBUG] subscription-manager:354220:MainThread @plugins.py:778 - Running update_content_hook in ostree_content.OstreeContentPlugin
2020-08-13 11:27:21,796 [DEBUG] subscription-manager:354220:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentPluginActionInvoker object at 0x7f67b021e438>
2020-08-13 11:27:21,796 [DEBUG] subscription-manager:354220:MainThread @__init__.py:92 - Searching for content of type: ostree
2020-08-13 11:27:21,797 [ERROR] subscription-manager:354220:MainThread @plugins.py:491 - [Errno 2] No such file or directory: '/etc/ostree/remotes.d/redhat.conf'
Traceback (most recent call last):
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugins.py", line 489, in run
    self.func(self.conduit)
  File "/usr/share/rhsm-plugins/ostree_content.py", line 38, in update_content_hook
    report = action_invoker.OstreeContentUpdateActionCommand(ent_source=conduit.ent_source).perform()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/action_invoker.py", line 66, in perform
    return self.update_repo_config()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/action_invoker.py", line 80, in update_repo_config
    contents=entitled_contents)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/action_invoker.py", line 109, in update_config
    updates.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 461, in save
    self.orig.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 424, in save
    self.repo_file_store.save(self)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 297, in save
    writer.save(ostree_config)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 317, in save
    self.repo_file.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/config.py", line 135, in save
    self.config_parser.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/config.py", line 121, in save
    super(KeyFileConfigParser, self).save()
  File "/usr/lib64/python3.6/site-packages/rhsm/config.py", line 139, in save
    mode = os.stat(self.config_file).st_mode
FileNotFoundError: [Errno 2] No such file or directory: '/etc/ostree/remotes.d/redhat.conf'
2020-08-13 11:27:21,798 [WARNING] subscription-manager:354220:MainThread @base_action_client.py:72 - Exception caught while running <subscription_manager.content_action_client.ContentPluginActionInvoker object at 0x7f67b021e438> update
2020-08-13 11:27:21,798 [ERROR] subscription-manager:354220:MainThread @base_action_client.py:73 - [Errno 2] No such file or directory: '/etc/ostree/remotes.d/redhat.conf'
Traceback (most recent call last):
  File "/usr/lib64/python3.6/site-packages/subscription_manager/base_action_client.py", line 63, in _run_update
    update_report = lib.update()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/certlib.py", line 32, in update
    self.report = self.locker.run(self._do_update)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/certlib.py", line 18, in run
    return action()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/content_action_client.py", line 83, in _do_update
    return action.perform()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/content_action_client.py", line 61, in perform
    self.runner.run()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugins.py", line 489, in run
    self.func(self.conduit)
  File "/usr/share/rhsm-plugins/ostree_content.py", line 38, in update_content_hook
    report = action_invoker.OstreeContentUpdateActionCommand(ent_source=conduit.ent_source).perform()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/action_invoker.py", line 66, in perform
    return self.update_repo_config()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/action_invoker.py", line 80, in update_repo_config
    contents=entitled_contents)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/action_invoker.py", line 109, in update_config
    updates.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 461, in save
    self.orig.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 424, in save
    self.repo_file_store.save(self)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 297, in save
    writer.save(ostree_config)
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/model.py", line 317, in save
    self.repo_file.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/config.py", line 135, in save
    self.config_parser.save()
  File "/usr/lib64/python3.6/site-packages/subscription_manager/plugin/ostree/config.py", line 121, in save
    super(KeyFileConfigParser, self).save()
  File "/usr/lib64/python3.6/site-packages/rhsm/config.py", line 139, in save
    mode = os.stat(self.config_file).st_mode
FileNotFoundError: [Errno 2] No such file or directory: '/etc/ostree/remotes.d/redhat.conf'
2020-08-13 11:27:21,798 [DEBUG] subscription-manager:354220:MainThread @certdirectory.py:217 - Installed product IDs: ['230']
2020-08-13 11:27:21,799 [DEBUG] subscription-manager:354220:MainThread @cert_sorter.py:141 - Unregistered, skipping server compliance check.
2020-08-13 11:27:21,799 [DEBUG] subscription-manager:354220:MainThread @certdirectory.py:217 - Installed product IDs: ['230']
2020-08-13 11:27:21,799 [DEBUG] subscription-manager:354220:MainThread @cert_sorter.py:141 - Unregistered, skipping server compliance check.
2020-08-13 11:27:21,799 [DEBUG] subscription-manager:354220:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-08-13 11:27:21,800 [DEBUG] subscription-manager:354220:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-08-13 11:27:21,800 [DEBUG] subscription-manager:354220:MainThread @certdirectory.py:217 - Installed product IDs: ['230']
2020-08-13 11:27:21,800 [DEBUG] subscription-manager:354220:MainThread @cert_sorter.py:141 - Unregistered, skipping server compliance check.
2020-08-13 11:27:21,800 [DEBUG] subscription-manager:354220:MainThread @certdirectory.py:217 - Installed product IDs: ['230']
2020-08-13 11:27:21,800 [DEBUG] subscription-manager:354220:MainThread @cert_sorter.py:141 - Unregistered, skipping server compliance check.
2020-08-13 11:27:21,800 [DEBUG] subscription-manager:354220:MainThread @utils.py:388 - No virt-who pid file, not attempting to restart
2020-08-13 11:27:21,812 [DEBUG] subscription-manager:354220:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-08-13 11:27:21,812 [DEBUG] subscription-manager:354220:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-08-13 11:27:21,812 [DEBUG] subscription-manager:354220:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-08-13 11:27:21,813 [DEBUG] subscription-manager:354220:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-08-13 11:27:21,813 [DEBUG] subscription-manager:354220:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
[root@intel-chiefriver-02 ~]# 


Actual results:
  above

Expected results:
  no Traceback in rhsm.log when unregistering


Additional info:
Comment 1 John Sefler 2020-08-13 16:03:15 UTC 
Additional Info... I am marking this as a regression because it did not happen on RHEL8.2.
Interestingly on RHEL8.2, during the unregister step, the '/etc/ostree/remotes.d/redhat.conf' magically appears as an empty file.  This did NOT happen on RHEL8.3.

That appears to be the reason while there is no traceback on RHEL8.2 as demonstrated here...

[root@hpe-dl380pgen8-02-vm-9 ~]# cat /etc/redhat-release 
Red Hat Enterprise Linux release 8.2 (Ootpa)
[root@hpe-dl380pgen8-02-vm-9 ~]# rpm -q subscription-manager-plugin-ostree ostree
subscription-manager-plugin-ostree-1.26.16-1.el8.x86_64
ostree-2019.6-2.el8.x86_64


[root@hpe-dl380pgen8-02-vm-9 ~]# subscription-manager config --logging.default_log_level=DEBUG
[root@hpe-dl380pgen8-02-vm-9 ~]# 
[root@hpe-dl380pgen8-02-vm-9 ~]# subscription-manager register --serverurl=subscription.rhsm.stage.redhat.com
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
Username: stage_auto_testuser
Password: 
The system has been registered with ID: 4643b8a2-c299-4334-9131-732be76c0504
The registered system name is: hpe-dl380pgen8-02-vm-9.hpe2.lab.eng.bos.redhat.com
[root@hpe-dl380pgen8-02-vm-9 ~]# 
[root@hpe-dl380pgen8-02-vm-9 ~]# cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory         <====== FILE DOES NOT EXIST BEFORE UNREGISTER
[root@hpe-dl380pgen8-02-vm-9 ~]# 
[root@hpe-dl380pgen8-02-vm-9 ~]# subscription-manager unregister
Unregistering from: subscription.rhsm.stage.redhat.com:443/subscription
System has been unregistered.
[root@hpe-dl380pgen8-02-vm-9 ~]# 
[root@hpe-dl380pgen8-02-vm-9 ~]# cat /etc/ostree/remotes.d/redhat.conf
[root@hpe-dl380pgen8-02-vm-9 ~]#                                          <====== FILE APPEARS AS EMPTY AFTER UNREGISTER
[root@hpe-dl380pgen8-02-vm-9 ~]# 
[root@hpe-dl380pgen8-02-vm-9 ~]# tail -100 /var/log/rhsm/rhsm.log
2020-08-13 11:39:52,143 [DEBUG] rhsmd:18817:MainThread @https.py:56 - Using standard libs to provide httplib and ssl
2020-08-13 11:39:52,277 [DEBUG] rhsmd:18817:MainThread @rhsm_d.py:281 - rhsmd started
2020-08-13 11:39:52,303 [DEBUG] subscription-manager:18814:MainThread @ga_loader.py:91 - ga_loader GaImporterGtk3
2020-08-13 11:39:52,308 [DEBUG] subscription-manager:18814:MainThread @plugins.py:571 - loaded plugin modules: [<module 'ostree_content' from '/usr/share/rhsm-plugins/ostree_content.py'>]
2020-08-13 11:39:52,308 [DEBUG] subscription-manager:18814:MainThread @plugins.py:572 - loaded plugins: {'ostree_content.OstreeContentPlugin': <ostree_content.OstreeContentPlugin object at 0x7f3b14abf358>}
2020-08-13 11:39:52,308 [DEBUG] subscription-manager:18814:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-08-13 11:39:52,310 [DEBUG] subscription-manager:18814:MainThread @connection.py:808 - Environment variable NO_PROXY= will be used
2020-08-13 11:39:52,311 [INFO] subscription-manager:18814:MainThread @connection.py:905 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-08-13 11:39:52,311 [DEBUG] subscription-manager:18814:MainThread @files.py:326 - Successfully read local syspurpose contents.
2020-08-13 11:39:52,312 [DEBUG] subscription-manager:18814:MainThread @files.py:363 - Successfully read cached syspurpose contents.
2020-08-13 11:39:52,318 [DEBUG] subscription-manager:18814:MainThread @files.py:326 - Successfully read local syspurpose contents.
2020-08-13 11:39:52,318 [DEBUG] subscription-manager:18814:MainThread @files.py:363 - Successfully read cached syspurpose contents.
2020-08-13 11:39:52,320 [DEBUG] subscription-manager:18814:MainThread @files.py:326 - Successfully read local syspurpose contents.
2020-08-13 11:39:52,320 [DEBUG] subscription-manager:18814:MainThread @files.py:363 - Successfully read cached syspurpose contents.
2020-08-13 11:39:52,320 [DEBUG] subscription-manager:18814:MainThread @files.py:326 - Successfully read local syspurpose contents.
2020-08-13 11:39:52,320 [DEBUG] subscription-manager:18814:MainThread @files.py:363 - Successfully read cached syspurpose contents.
2020-08-13 11:39:52,321 [DEBUG] subscription-manager:18814:MainThread @managercli.py:492 - X-Correlation-ID: eaf652e9b7714446b75f8f064327d47e
2020-08-13 11:39:52,321 [DEBUG] subscription-manager:18814:MainThread @managercli.py:381 - Client Versions: {'subscription-manager': '1.26.16-1.el8'}
2020-08-13 11:39:52,321 [DEBUG] subscription-manager:18814:MainThread @connection.py:808 - Environment variable NO_PROXY= will be used
2020-08-13 11:39:52,322 [INFO] subscription-manager:18814:MainThread @connection.py:905 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-08-13 11:39:52,322 [DEBUG] subscription-manager:18814:MainThread @connection.py:808 - Environment variable NO_PROXY= will be used
2020-08-13 11:39:52,322 [INFO] subscription-manager:18814:MainThread @connection.py:905 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=none
2020-08-13 11:39:52,322 [DEBUG] subscription-manager:18814:MainThread @managercli.py:357 - Consumer Identity name=hpe-dl380pgen8-02-vm-9.hpe2.lab.eng.bos.redhat.com uuid=4643b8a2-c299-4334-9131-732be76c0504
2020-08-13 11:39:52,325 [DEBUG] subscription-manager:18814:MainThread @connection.py:523 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-08-13 11:39:52,325 [DEBUG] subscription-manager:18814:MainThread @connection.py:571 - Making request: DELETE /subscription/consumers/4643b8a2-c299-4334-9131-732be76c0504
2020-08-13 11:39:52,929 [DEBUG] subscription-manager:18814:MainThread @connection.py:618 - Response: status=204, requestUuid=a5ce328a-025e-46ea-8c94-256de2d025cc, request="DELETE /subscription/consumers/4643b8a2-c299-4334-9131-732be76c0504"
2020-08-13 11:39:52,930 [INFO] subscription-manager:18814:MainThread @unregister.py:55 - Successfully un-registered.
2020-08-13 11:39:52,931 [DEBUG] subscription-manager:18814:MainThread @managerlib.py:849 - Removing identity cert: /etc/pki/consumer/key.pem
2020-08-13 11:39:52,931 [DEBUG] subscription-manager:18814:MainThread @managerlib.py:849 - Removing identity cert: /etc/pki/consumer/cert.pem
2020-08-13 11:39:52,931 [DEBUG] subscription-manager:18814:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-08-13 11:39:52,932 [DEBUG] subscription-manager:18814:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-08-13 11:39:52,932 [DEBUG] subscription-manager:18814:MainThread @cache.py:90 - Deleting cache: /var/lib/rhsm/cache/profile.json
2020-08-13 11:39:52,932 [DEBUG] subscription-manager:18814:MainThread @cache.py:90 - Deleting cache: /var/lib/rhsm/cache/installed_products.json
2020-08-13 11:39:52,932 [DEBUG] subscription-manager:18814:MainThread @files.py:326 - Successfully read local syspurpose contents.
2020-08-13 11:39:52,933 [DEBUG] subscription-manager:18814:MainThread @files.py:363 - Successfully read cached syspurpose contents.
2020-08-13 11:39:52,933 [DEBUG] subscription-manager:18814:MainThread @files.py:513 - Successfully updated syspurpose values at '/var/lib/rhsm/cache/syspurpose.json'.
2020-08-13 11:39:52,933 [DEBUG] subscription-manager:18814:MainThread @cache.py:90 - Deleting cache: /var/lib/rhsm/cache/entitlement_status.json
2020-08-13 11:39:52,934 [DEBUG] subscription-manager:18814:MainThread @managerlib.py:886 - Cleaned local data
2020-08-13 11:39:52,934 [DEBUG] subscription-manager:18814:MainThread @base_action_client.py:84 - running lib: <subscription_manager.entcertlib.EntCertActionInvoker object at 0x7f3b14ac7dd8>
2020-08-13 11:39:52,935 [DEBUG] subscription-manager:18814:MainThread @connection.py:808 - Environment variable NO_PROXY= will be used
2020-08-13 11:39:52,935 [INFO] subscription-manager:18814:MainThread @connection.py:905 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-08-13 11:39:52,935 [INFO] subscription-manager:18814:MainThread @entcertlib.py:131 - certs updated:
Total updates: 0
Found (local) serial# []
Expected (UEP) serial# []
Added (new)
  <NONE>
Deleted (rogue):
  <NONE>
2020-08-13 11:39:52,936 [DEBUG] subscription-manager:18814:MainThread @connection.py:523 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-08-13 11:39:52,937 [DEBUG] subscription-manager:18814:MainThread @connection.py:571 - Making request: GET /subscription/status
2020-08-13 11:39:53,320 [DEBUG] subscription-manager:18814:MainThread @connection.py:618 - Response: status=200, requestUuid=1c56f3c2-4f66-4396-b76c-699c9d246020, request="GET /subscription/status"
2020-08-13 11:39:53,321 [DEBUG] subscription-manager:18814:MainThread @connection.py:960 - Server has the following capabilities: ['instance_multiplier', 'derived_product', 'vcpu', 'cert_v3', 'hypervisors_heartbeat', 'remove_by_pool_id', 'syspurpose', 'storage_band', 'cores', 'hypervisors_async', 'org_level_content_access', 'guest_limit', 'ram', 'batch_bind', 'combined_reporting']
2020-08-13 11:39:53,322 [DEBUG] subscription-manager:18814:MainThread @base_action_client.py:84 - running lib: <subscription_manager.content_action_client.ContentActionClient object at 0x7f3b14a98320>
2020-08-13 11:39:53,322 [DEBUG] subscription-manager:18814:MainThread @base_action_client.py:84 - running lib: <subscription_manager.repolib.RepoActionInvoker object at 0x7f3b14a98748>
2020-08-13 11:39:53,325 [DEBUG] subscription-manager:18814:MainThread @__init__.py:92 - Searching for content of type: yum
2020-08-13 11:39:53,325 [DEBUG] subscription-manager:18814:MainThread @__init__.py:92 - Searching for content of type: deb
2020-08-13 11:39:53,325 [DEBUG] subscription-manager:18814:MainThread @repolib.py:466 - repos updated: Repo updates

Total repo updates: 0
Updated
    <NONE>
Added (new)
    <NONE>
Deleted
    <NONE>
2020-08-13 11:39:53,326 [DEBUG] subscription-manager:18814:MainThread @plugins.py:778 - Running update_content_hook in ostree_content.OstreeContentPlugin
2020-08-13 11:39:53,326 [DEBUG] subscription-manager:18814:MainThread @base_action_client.py:84 - running lib: <subscription_manager.content_action_client.ContentPluginActionInvoker object at 0x7f3b1483d9e8>
2020-08-13 11:39:53,326 [DEBUG] subscription-manager:18814:MainThread @__init__.py:92 - Searching for content of type: ostree
2020-08-13 11:39:53,327 [DEBUG] subscription-manager:18814:MainThread @action_invoker.py:85 - Ostree update report: Ostree repo updates

Updates:

Added:

Deleted:

2020-08-13 11:39:53,328 [DEBUG] subscription-manager:18814:MainThread @certdirectory.py:217 - Installed product IDs: ['479']
2020-08-13 11:39:53,328 [DEBUG] subscription-manager:18814:MainThread @cert_sorter.py:127 - Unregistered, skipping server compliance check.
2020-08-13 11:39:53,328 [DEBUG] subscription-manager:18814:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-08-13 11:39:53,328 [DEBUG] subscription-manager:18814:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-08-13 11:39:53,328 [DEBUG] subscription-manager:18814:MainThread @certdirectory.py:217 - Installed product IDs: ['479']
2020-08-13 11:39:53,328 [DEBUG] subscription-manager:18814:MainThread @cert_sorter.py:127 - Unregistered, skipping server compliance check.
2020-08-13 11:39:53,329 [DEBUG] subscription-manager:18814:MainThread @certdirectory.py:217 - Installed product IDs: ['479']
2020-08-13 11:39:53,330 [DEBUG] subscription-manager:18814:MainThread @cert_sorter.py:127 - Unregistered, skipping server compliance check.
2020-08-13 11:39:53,330 [DEBUG] subscription-manager:18814:MainThread @certdirectory.py:217 - Installed product IDs: ['479']
2020-08-13 11:39:53,330 [DEBUG] subscription-manager:18814:MainThread @cert_sorter.py:127 - Unregistered, skipping server compliance check.
2020-08-13 11:39:53,331 [DEBUG] rhsmd:18817:MainThread @rhsm_d.py:233 - D-Bus interface com.redhat.SubscriptionManager.EntitlementStatus.update_status called with status = 0
2020-08-13 11:39:53,404 [DEBUG] rhsmd:18817:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-08-13 11:39:53,404 [DEBUG] rhsmd:18817:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-08-13 11:39:53,406 [DEBUG] rhsmd:18817:MainThread @certdirectory.py:217 - Installed product IDs: ['479']
2020-08-13 11:39:53,406 [DEBUG] rhsmd:18817:MainThread @cert_sorter.py:127 - Unregistered, skipping server compliance check.
2020-08-13 11:39:53,406 [DEBUG] rhsmd:18817:MainThread @rhsm_d.py:198 - D-Bus signal com.redhat.SubscriptionManager.EntitlementStatus.entitlement_status_changed emitted
2020-08-13 11:39:53,407 [DEBUG] rhsmd:18817:MainThread @cache.py:114 - Wrote cache: /var/lib/rhsm/cache/rhsm_icon.json
2020-08-13 11:39:53,408 [DEBUG] subscription-manager:18814:MainThread @utils.py:387 - No virt-who pid file, not attempting to restart
2020-08-13 11:39:53,408 [DEBUG] subscription-manager:18814:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-08-13 11:39:53,408 [DEBUG] subscription-manager:18814:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-08-13 11:39:53,409 [DEBUG] subscription-manager:18814:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-08-13 11:39:53,409 [DEBUG] subscription-manager:18814:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-08-13 11:39:53,409 [DEBUG] subscription-manager:18814:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
[root@hpe-dl380pgen8-02-vm-9 ~]#
Comment 2 William Poteat 2020-09-25 15:10:19 UTC 
This is fixed by the solution to https://bugzilla.redhat.com/show_bug.cgi?id=1860434
Comment 4 Archana Pandey 2020-10-05 07:59:04 UTC 
Early testing :

Verifying Issue on master scratch build:  subscription-manager-1.28.3-1.git.17.251435e.el8.x86_64.rpm

[root@hpe-dl380pgen8-02-vm-5 ~]# subscription-manager version
server type: This system is currently not registered.
subscription management server: 3.1.18-1
subscription management rules: 5.41
subscription-manager: 1.28.3-1.git.17.251435e.el8
[root@hpe-dl380pgen8-02-vm-5 ~]# 
[root@hpe-dl380pgen8-02-vm-5 ~]# rpm -qa subscription-manager-plugin-ostree
subscription-manager-plugin-ostree-1.28.3-1.git.17.251435e.el8.x86_64
[root@hpe-dl380pgen8-02-vm-5 ~]# 
[root@hpe-dl380pgen8-02-vm-5 ~]# cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory
[root@hpe-dl380pgen8-02-vm-5 ~]# 
[root@hpe-dl380pgen8-02-vm-5 ~]# subscription-manager register  --username stage-ethel 
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
Password: 
The system has been registered with ID: *************************
The registered system name is: hpe-dl380pgen8-02-vm-5.hpe2.lab.eng.bos.redhat.com
[root@hpe-dl380pgen8-02-vm-5 ~]# 
[root@hpe-dl380pgen8-02-vm-5 ~]#  cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory


[root@hpe-dl380pgen8-02-vm-5 ~]# subscription-manager unregister
Unregistering from: subscription.rhsm.stage.redhat.com:443/subscription
System has been unregistered.
[root@hpe-dl380pgen8-02-vm-5 ~]#  cat /etc/ostree/remotes.d/redhat.conf
[root@hpe-dl380pgen8-02-vm-5 ~]#                                                     <<<<<<<<<<<<<<<<<<<<<< Empty file gets created after un-register and no trace in rhsm.log   

[root@hpe-dl380pgen8-02-vm-5 ~]# tail -100 /var/log/rhsm/rhsm.log 
2020-10-05 03:42:02,536 [DEBUG] subscription-manager:23114:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-10-05 03:42:02,537 [DEBUG] subscription-manager:23114:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-10-05 03:42:02,537 [DEBUG] subscription-manager:23114:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-10-05 03:42:02,537 [DEBUG] subscription-manager:23114:MainThread @cache.py:298 - Reading status from in-memory cache of /var/lib/rhsm/cache/entitlement_status.json file
2020-10-05 03:42:02,537 [DEBUG] subscription-manager:23114:MainThread @cert_sorter.py:223 - Product status: valid_products= partial_products= expired_products= unentitled_producs=486 future_products= valid_until=None
2020-10-05 03:42:02,538 [DEBUG] subscription-manager:23114:MainThread @cert_sorter.py:225 - partial stacks: []
2020-10-05 03:42:02,538 [DEBUG] subscription-manager:23114:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-10-05 03:42:02,538 [DEBUG] subscription-manager:23114:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-10-05 03:42:02,539 [DEBUG] subscription-manager:23114:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-10-05 03:42:02,539 [DEBUG] subscription-manager:23114:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-10-05 03:42:02,539 [DEBUG] subscription-manager:23114:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
2020-10-05 03:44:31,327 [DEBUG] subscription-manager:23316:MainThread @https.py:56 - Using standard libs to provide httplib and ssl
2020-10-05 03:44:31,509 [DEBUG] subscription-manager:23316:MainThread @dbus_interface.py:37 - self.has_main_loop=False
2020-10-05 03:44:31,511 [DEBUG] subscription-manager:23316:MainThread @dbus_interface.py:53 - Unable to connect to D-Bus service: com.redhat.SubscriptionManager
2020-10-05 03:44:31,530 [DEBUG] subscription-manager:23316:MainThread @ga_loader.py:91 - ga_loader GaImporterGtk3
2020-10-05 03:44:31,535 [DEBUG] subscription-manager:23316:MainThread @plugins.py:571 - loaded plugin modules: [<module 'ostree_content' from '/usr/share/rhsm-plugins/ostree_content.py'>]
2020-10-05 03:44:31,535 [DEBUG] subscription-manager:23316:MainThread @plugins.py:572 - loaded plugins: {'ostree_content.OstreeContentPlugin': <ostree_content.OstreeContentPlugin object at 0x7f844b84e0b8>}
2020-10-05 03:44:31,535 [DEBUG] subscription-manager:23316:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-10-05 03:44:31,545 [DEBUG] subscription-manager:23316:MainThread @managercli.py:502 - X-Correlation-ID: 7d731c52b7e745f1a627827c7c11a029
2020-10-05 03:44:31,545 [DEBUG] subscription-manager:23316:MainThread @managercli.py:391 - Client Versions: {'subscription-manager': '1.28.3-1.git.17.251435e.el8'}
2020-10-05 03:44:31,545 [DEBUG] subscription-manager:23316:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-10-05 03:44:31,546 [DEBUG] subscription-manager:23316:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-10-05 03:44:31,546 [DEBUG] subscription-manager:23316:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-10-05 03:44:31,546 [DEBUG] subscription-manager:23316:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=none
2020-10-05 03:44:31,546 [DEBUG] subscription-manager:23316:MainThread @managercli.py:367 - Consumer Identity name=hpe-dl380pgen8-02-vm-5.hpe2.lab.eng.bos.redhat.com uuid=ce3e5ea6-9bd3-442a-8637-22c16564b8cb
2020-10-05 03:44:31,547 [DEBUG] subscription-manager:23316:MainThread @connection.py:698 - Making request: DELETE /subscription/consumers/ce3e5ea6-9bd3-442a-8637-22c16564b8cb
2020-10-05 03:44:31,549 [DEBUG] subscription-manager:23316:MainThread @connection.py:556 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-10-05 03:44:32,093 [DEBUG] subscription-manager:23316:MainThread @connection.py:792 - Response time: 0.41107654571533203, Smoothed response time: 0.41107654571533203
2020-10-05 03:44:32,093 [DEBUG] subscription-manager:23316:MainThread @connection.py:769 - Response: status=204, requestUuid=3db7ed29-eebc-43ca-8011-456e45e6b58d, request="DELETE /subscription/consumers/ce3e5ea6-9bd3-442a-8637-22c16564b8cb"
2020-10-05 03:44:32,094 [INFO] subscription-manager:23316:MainThread @unregister.py:55 - Successfully un-registered.
2020-10-05 03:44:32,095 [DEBUG] subscription-manager:23316:MainThread @managerlib.py:884 - Removing identity cert: /etc/pki/consumer/key.pem
2020-10-05 03:44:32,095 [DEBUG] subscription-manager:23316:MainThread @managerlib.py:884 - Removing identity cert: /etc/pki/consumer/cert.pem
2020-10-05 03:44:32,096 [DEBUG] subscription-manager:23316:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-10-05 03:44:32,096 [DEBUG] subscription-manager:23316:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-10-05 03:44:32,096 [DEBUG] subscription-manager:23316:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/profile.json
2020-10-05 03:44:32,096 [DEBUG] subscription-manager:23316:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/installed_products.json
2020-10-05 03:44:32,097 [DEBUG] subscription-manager:23316:MainThread @files.py:351 - Successfully read local syspurpose contents.
2020-10-05 03:44:32,097 [DEBUG] subscription-manager:23316:MainThread @files.py:388 - Successfully read cached syspurpose contents.
2020-10-05 03:44:32,097 [DEBUG] subscription-manager:23316:MainThread @files.py:591 - Successfully updated syspurpose values at '/var/lib/rhsm/cache/syspurpose.json'.
2020-10-05 03:44:32,097 [DEBUG] subscription-manager:23316:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/entitlement_status.json
2020-10-05 03:44:32,098 [DEBUG] subscription-manager:23316:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-10-05 03:44:32,098 [DEBUG] subscription-manager:23316:MainThread @managerlib.py:921 - Cleaned local data
2020-10-05 03:44:32,098 [DEBUG] subscription-manager:23316:MainThread @base_action_client.py:88 - running lib: <subscription_manager.entcertlib.EntCertActionInvoker object at 0x7f844b79beb8>
2020-10-05 03:44:32,099 [DEBUG] subscription-manager:23316:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-10-05 03:44:32,099 [DEBUG] subscription-manager:23316:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-10-05 03:44:32,099 [INFO] subscription-manager:23316:MainThread @entcertlib.py:131 - certs updated:
Total updates: 0
Found (local) serial# []
Expected (UEP) serial# []
Added (new)
  <NONE>
Deleted (rogue):
  <NONE>
2020-10-05 03:44:32,100 [DEBUG] subscription-manager:23316:MainThread @connection.py:698 - Making request: GET /subscription/status
2020-10-05 03:44:32,101 [DEBUG] subscription-manager:23316:MainThread @connection.py:556 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-10-05 03:44:32,423 [DEBUG] subscription-manager:23316:MainThread @connection.py:792 - Response time: 0.2561802864074707, Smoothed response time: 0.2561802864074707
2020-10-05 03:44:32,423 [DEBUG] subscription-manager:23316:MainThread @connection.py:769 - Response: status=200, requestUuid=4cdd3e23-8c31-4e52-9de3-9c7088a457d0, request="GET /subscription/status"
2020-10-05 03:44:32,424 [DEBUG] subscription-manager:23316:MainThread @connection.py:1007 - Server has the following capabilities: ['instance_multiplier', 'derived_product', 'vcpu', 'cert_v3', 'hypervisors_heartbeat', 'remove_by_pool_id', 'syspurpose', 'insights_auto_register', 'storage_band', 'cores', 'hypervisors_async', 'org_level_content_access', 'guest_limit', 'ram', 'batch_bind', 'combined_reporting']
2020-10-05 03:44:32,425 [DEBUG] subscription-manager:23316:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentActionClient object at 0x7f844b79bf60>
2020-10-05 03:44:32,425 [DEBUG] subscription-manager:23316:MainThread @base_action_client.py:88 - running lib: <subscription_manager.repolib.RepoActionInvoker object at 0x7f844b7aa240>
2020-10-05 03:44:32,427 [DEBUG] subscription-manager:23316:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-10-05 03:44:32,427 [DEBUG] subscription-manager:23316:MainThread @repofile.py:364 - The directory /var/lib/rhsm/repo_server_val/ already exists
2020-10-05 03:44:32,428 [DEBUG] subscription-manager:23316:MainThread @__init__.py:92 - Searching for content of type: yum
2020-10-05 03:44:32,428 [DEBUG] subscription-manager:23316:MainThread @__init__.py:92 - Searching for content of type: deb
2020-10-05 03:44:32,428 [DEBUG] subscription-manager:23316:MainThread @repolib.py:463 - repos updated: Repo updates

Total repo updates: 0
Updated
    <NONE>
Added (new)
    <NONE>
Deleted
    <NONE>
2020-10-05 03:44:32,429 [DEBUG] subscription-manager:23316:MainThread @plugins.py:778 - Running update_content_hook in ostree_content.OstreeContentPlugin
2020-10-05 03:44:32,429 [DEBUG] subscription-manager:23316:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentPluginActionInvoker object at 0x7f844b550630>
2020-10-05 03:44:32,429 [DEBUG] subscription-manager:23316:MainThread @__init__.py:92 - Searching for content of type: ostree
2020-10-05 03:44:32,430 [DEBUG] subscription-manager:23316:MainThread @action_invoker.py:85 - Ostree update report: Ostree repo updates

Updates:

Added:

Deleted:

2020-10-05 03:44:32,431 [DEBUG] subscription-manager:23316:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-10-05 03:44:32,431 [DEBUG] subscription-manager:23316:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-10-05 03:44:32,431 [DEBUG] subscription-manager:23316:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-10-05 03:44:32,431 [DEBUG] subscription-manager:23316:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-10-05 03:44:32,433 [DEBUG] subscription-manager:23316:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-10-05 03:44:32,433 [DEBUG] subscription-manager:23316:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-10-05 03:44:32,433 [DEBUG] subscription-manager:23316:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-10-05 03:44:32,433 [DEBUG] subscription-manager:23316:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-10-05 03:44:32,434 [DEBUG] subscription-manager:23316:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-10-05 03:44:32,434 [DEBUG] subscription-manager:23316:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-10-05 03:44:32,434 [DEBUG] subscription-manager:23316:MainThread @utils.py:385 - No virt-who pid file, not attempting to restart
2020-10-05 03:44:32,434 [DEBUG] subscription-manager:23316:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-10-05 03:44:32,434 [DEBUG] subscription-manager:23316:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-10-05 03:44:32,435 [DEBUG] subscription-manager:23316:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-10-05 03:44:32,435 [DEBUG] subscription-manager:23316:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-10-05 03:44:32,435 [DEBUG] subscription-manager:23316:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.


Additional Info: using auto-attach while registration also creates empty redhat.conf

[root@hpe-dl380pgen8-02-vm-5 ~]# 
[root@hpe-dl380pgen8-02-vm-5 ~]#  cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory
[root@hpe-dl380pgen8-02-vm-5 ~]# subscription-manager register  --username stage-ethel --auto-attach 
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
Password: 
The system has been registered with ID: ***************************
The registered system name is: hpe-dl380pgen8-02-vm-5.hpe2.lab.eng.bos.redhat.com
Installed Product Current Status:
Product Name: Red Hat Enterprise Linux for x86_64 Beta
Status:       Subscribed

[root@hpe-dl380pgen8-02-vm-5 ~]#  cat /etc/ostree/remotes.d/redhat.conf
[root@hpe-dl380pgen8-02-vm-5 ~]#                                           <<<<<<<< empty file gets created after auto-attach



VERIFIED : no Traceback in rhsm.log when /etc/ostree/remotes.d/redhat.conf does not exist, an empty file gets created
Comment 5 Archana Pandey 2020-11-02 14:06:32 UTC 
Early Testing

Verifying issue on latest sub-man build : subscription-manager-1.28.5-1.el8.x86_64

Version-Release number of selected component (if applicable):
[root@kvm-03-guest14 ~]# rpm -qa subscription-manager-plugin-ostree
subscription-manager-plugin-ostree-1.28.5-1.el8.x86_64
[root@kvm-03-guest14 ~]# 
[root@kvm-03-guest14 ~]# rpm -qa ostree
ostree-2020.5-4.el8.x86_64

[root@kvm-03-guest14 ~]# subscription-manager version
server type: This system is currently not registered.
subscription management server: 3.2.0-1
subscription management rules: 5.41
subscription-manager: 1.28.5-1.el8

Steps for verification :
[root@kvm-03-guest14 ~]# subscription-manager config --logging.default_log_level=DEBUG
[root@kvm-03-guest14 ~]# subscription-manager register --username stage-ethel --serverurl=subscription.rhsm.stage.redhat.com
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
Password: 
The system has been registered with ID: 97d56a3e-a10b-413f-b98f-9c7745a82c0d
The registered system name is: kvm-03-guest14.hv2.lab.eng.bos.redhat.com
[root@kvm-03-guest14 ~]# 
[root@kvm-03-guest14 ~]# cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory         <<<<<< redhat.conf doesn't exist
[root@kvm-03-guest14 ~]# 
[root@kvm-03-guest14 ~]# subscription-manager unregister
Unregistering from: subscription.rhsm.stage.redhat.com:443/subscription
System has been unregistered.
[root@kvm-03-guest14 ~]# cat /etc/ostree/remotes.d/redhat.conf
[root@kvm-03-guest14 ~]#                                                 <<<<<< redhat.conf gets generated after unregister
[root@kvm-03-guest14 ~]# tail -100 /var/log/rhsm/rhsm.log
2020-11-02 08:25:57,302 [DEBUG] subscription-manager:15984:MainThread @cache.py:172 - Checking current system info against cache: /var/lib/rhsm/cache/installed_products.json
2020-11-02 08:25:57,303 [DEBUG] subscription-manager:15984:MainThread @cache.py:189 - No changes.
2020-11-02 08:25:57,303 [DEBUG] subscription-manager:15984:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-02 08:25:57,303 [DEBUG] subscription-manager:15984:MainThread @cache.py:298 - Reading status from in-memory cache of /var/lib/rhsm/cache/entitlement_status.json file
2020-11-02 08:25:57,303 [DEBUG] subscription-manager:15984:MainThread @cert_sorter.py:223 - Product status: valid_products= partial_products= expired_products= unentitled_producs=486 future_products= valid_until=None
2020-11-02 08:25:57,304 [DEBUG] subscription-manager:15984:MainThread @cert_sorter.py:225 - partial stacks: []
2020-11-02 08:25:57,304 [DEBUG] subscription-manager:15984:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-11-02 08:25:57,304 [DEBUG] subscription-manager:15984:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-11-02 08:25:57,305 [DEBUG] subscription-manager:15984:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-11-02 08:25:57,305 [DEBUG] subscription-manager:15984:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-11-02 08:25:57,305 [DEBUG] subscription-manager:15984:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
2020-11-02 08:26:13,551 [DEBUG] subscription-manager:16084:MainThread @https.py:56 - Using standard libs to provide httplib and ssl
2020-11-02 08:26:13,675 [DEBUG] subscription-manager:16084:MainThread @dbus_interface.py:37 - self.has_main_loop=False
2020-11-02 08:26:13,677 [DEBUG] subscription-manager:16084:MainThread @dbus_interface.py:53 - Unable to connect to D-Bus service: com.redhat.SubscriptionManager
2020-11-02 08:26:13,690 [DEBUG] subscription-manager:16084:MainThread @ga_loader.py:91 - ga_loader GaImporterGtk3
2020-11-02 08:26:13,693 [DEBUG] subscription-manager:16084:MainThread @plugins.py:571 - loaded plugin modules: [<module 'ostree_content' from '/usr/share/rhsm-plugins/ostree_content.py'>]
2020-11-02 08:26:13,693 [DEBUG] subscription-manager:16084:MainThread @plugins.py:572 - loaded plugins: {'ostree_content.OstreeContentPlugin': <ostree_content.OstreeContentPlugin object at 0x7fc15c764080>}
2020-11-02 08:26:13,693 [DEBUG] subscription-manager:16084:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-11-02 08:26:13,700 [DEBUG] subscription-manager:16084:MainThread @managercli.py:502 - X-Correlation-ID: ad94a696f1ff41ab80a8b2b598f1c110
2020-11-02 08:26:13,700 [DEBUG] subscription-manager:16084:MainThread @managercli.py:391 - Client Versions: {'subscription-manager': '1.28.5-1.el8'}
2020-11-02 08:26:13,700 [DEBUG] subscription-manager:16084:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-11-02 08:26:13,700 [DEBUG] subscription-manager:16084:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-11-02 08:26:13,701 [DEBUG] subscription-manager:16084:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-11-02 08:26:13,701 [DEBUG] subscription-manager:16084:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=none
2020-11-02 08:26:13,701 [DEBUG] subscription-manager:16084:MainThread @managercli.py:367 - Consumer Identity name=kvm-03-guest14.hv2.lab.eng.bos.redhat.com uuid=97d56a3e-a10b-413f-b98f-9c7745a82c0d
2020-11-02 08:26:13,701 [DEBUG] subscription-manager:16084:MainThread @connection.py:698 - Making request: DELETE /subscription/consumers/97d56a3e-a10b-413f-b98f-9c7745a82c0d
2020-11-02 08:26:13,702 [DEBUG] subscription-manager:16084:MainThread @connection.py:556 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-11-02 08:26:14,304 [DEBUG] subscription-manager:16084:MainThread @connection.py:792 - Response time: 0.4641730785369873, Smoothed response time: 0.4641730785369873
2020-11-02 08:26:14,304 [DEBUG] subscription-manager:16084:MainThread @connection.py:769 - Response: status=204, requestUuid=6b785c9e-28d4-4637-b845-8c9377850014, request="DELETE /subscription/consumers/97d56a3e-a10b-413f-b98f-9c7745a82c0d"
2020-11-02 08:26:14,304 [INFO] subscription-manager:16084:MainThread @unregister.py:55 - Successfully un-registered.
2020-11-02 08:26:14,305 [DEBUG] subscription-manager:16084:MainThread @managerlib.py:884 - Removing identity cert: /etc/pki/consumer/key.pem
2020-11-02 08:26:14,305 [DEBUG] subscription-manager:16084:MainThread @managerlib.py:884 - Removing identity cert: /etc/pki/consumer/cert.pem
2020-11-02 08:26:14,305 [DEBUG] subscription-manager:16084:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-11-02 08:26:14,305 [DEBUG] subscription-manager:16084:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-11-02 08:26:14,306 [DEBUG] subscription-manager:16084:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/profile.json
2020-11-02 08:26:14,306 [DEBUG] subscription-manager:16084:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/installed_products.json
2020-11-02 08:26:14,306 [DEBUG] subscription-manager:16084:MainThread @files.py:351 - Successfully read local syspurpose contents.
2020-11-02 08:26:14,306 [DEBUG] subscription-manager:16084:MainThread @files.py:388 - Successfully read cached syspurpose contents.
2020-11-02 08:26:14,306 [DEBUG] subscription-manager:16084:MainThread @files.py:591 - Successfully updated syspurpose values at '/var/lib/rhsm/cache/syspurpose.json'.
2020-11-02 08:26:14,306 [DEBUG] subscription-manager:16084:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/entitlement_status.json
2020-11-02 08:26:14,307 [DEBUG] subscription-manager:16084:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-11-02 08:26:14,307 [DEBUG] subscription-manager:16084:MainThread @managerlib.py:921 - Cleaned local data
2020-11-02 08:26:14,307 [DEBUG] subscription-manager:16084:MainThread @base_action_client.py:88 - running lib: <subscription_manager.entcertlib.EntCertActionInvoker object at 0x7fc15c72fbe0>
2020-11-02 08:26:14,307 [DEBUG] subscription-manager:16084:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-11-02 08:26:14,308 [DEBUG] subscription-manager:16084:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-11-02 08:26:14,308 [INFO] subscription-manager:16084:MainThread @entcertlib.py:131 - certs updated:
Total updates: 0
Found (local) serial# []
Expected (UEP) serial# []
Added (new)
  <NONE>
Deleted (rogue):
  <NONE>
2020-11-02 08:26:14,308 [DEBUG] subscription-manager:16084:MainThread @connection.py:698 - Making request: GET /subscription/status
2020-11-02 08:26:14,309 [DEBUG] subscription-manager:16084:MainThread @connection.py:556 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-11-02 08:26:14,629 [DEBUG] subscription-manager:16084:MainThread @connection.py:792 - Response time: 0.25481557846069336, Smoothed response time: 0.25481557846069336
2020-11-02 08:26:14,630 [DEBUG] subscription-manager:16084:MainThread @connection.py:769 - Response: status=200, requestUuid=371a6602-9cc2-462d-825e-e19e17e913b0, request="GET /subscription/status"
2020-11-02 08:26:14,630 [DEBUG] subscription-manager:16084:MainThread @connection.py:1007 - Server has the following capabilities: ['instance_multiplier', 'derived_product', 'vcpu', 'cert_v3', 'hypervisors_heartbeat', 'remove_by_pool_id', 'syspurpose', 'insights_auto_register', 'storage_band', 'cores', 'hypervisors_async', 'org_level_content_access', 'guest_limit', 'ram', 'batch_bind', 'combined_reporting']
2020-11-02 08:26:14,631 [DEBUG] subscription-manager:16084:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentActionClient object at 0x7fc15c72fe48>
2020-11-02 08:26:14,631 [DEBUG] subscription-manager:16084:MainThread @base_action_client.py:88 - running lib: <subscription_manager.repolib.RepoActionInvoker object at 0x7fc15c73f240>
2020-11-02 08:26:14,632 [DEBUG] subscription-manager:16084:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-11-02 08:26:14,633 [DEBUG] subscription-manager:16084:MainThread @repofile.py:364 - The directory /var/lib/rhsm/repo_server_val/ already exists
2020-11-02 08:26:14,633 [DEBUG] subscription-manager:16084:MainThread @__init__.py:92 - Searching for content of type: yum
2020-11-02 08:26:14,633 [DEBUG] subscription-manager:16084:MainThread @__init__.py:92 - Searching for content of type: deb
2020-11-02 08:26:14,633 [DEBUG] subscription-manager:16084:MainThread @repolib.py:463 - repos updated: Repo updates

Total repo updates: 0
Updated
    <NONE>
Added (new)
    <NONE>
Deleted
    <NONE>
2020-11-02 08:26:14,634 [DEBUG] subscription-manager:16084:MainThread @plugins.py:778 - Running update_content_hook in ostree_content.OstreeContentPlugin
2020-11-02 08:26:14,634 [DEBUG] subscription-manager:16084:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentPluginActionInvoker object at 0x7fc15c4e2518>
2020-11-02 08:26:14,634 [DEBUG] subscription-manager:16084:MainThread @__init__.py:92 - Searching for content of type: ostree
2020-11-02 08:26:14,635 [DEBUG] subscription-manager:16084:MainThread @action_invoker.py:85 - Ostree update report: Ostree repo updates

Updates:

Added:

Deleted:

2020-11-02 08:26:14,635 [DEBUG] subscription-manager:16084:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-02 08:26:14,635 [DEBUG] subscription-manager:16084:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-02 08:26:14,635 [DEBUG] subscription-manager:16084:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-11-02 08:26:14,635 [DEBUG] subscription-manager:16084:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-11-02 08:26:14,635 [DEBUG] subscription-manager:16084:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-02 08:26:14,636 [DEBUG] subscription-manager:16084:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-02 08:26:14,636 [DEBUG] subscription-manager:16084:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-02 08:26:14,636 [DEBUG] subscription-manager:16084:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-02 08:26:14,636 [DEBUG] subscription-manager:16084:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-02 08:26:14,636 [DEBUG] subscription-manager:16084:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-02 08:26:14,636 [DEBUG] subscription-manager:16084:MainThread @utils.py:385 - No virt-who pid file, not attempting to restart
2020-11-02 08:26:14,637 [DEBUG] subscription-manager:16084:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-11-02 08:26:14,637 [DEBUG] subscription-manager:16084:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-11-02 08:26:14,637 [DEBUG] subscription-manager:16084:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-11-02 08:26:14,637 [DEBUG] subscription-manager:16084:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-11-02 08:26:14,637 [DEBUG] subscription-manager:16084:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
[root@kvm-03-guest14 ~]# 

Result: No trace back seen in rhsm.log for missing redhat.conf
Updating Verified field to Tested
Comment 8 Archana Pandey 2020-11-11 08:27:09 UTC 
Verification:

Version-Release number of selected component (if applicable):

[root@kvm-01-guest30 ~]# rpm -qa subscription-manager-plugin-ostree
subscription-manager-plugin-ostree-1.28.5-1.el8.x86_64
[root@kvm-01-guest30 ~]# 
[root@kvm-01-guest30 ~]# rpm -qa ostree
ostree-2020.7-1.el8.x86_64
[root@kvm-01-guest30 ~]# rpm -qa subscription-manager
subscription-manager-1.28.5-1.el8.x86_64

Verification Steps:

[root@kvm-01-guest30 ~]# 
[root@kvm-01-guest30 ~]# subscription-manager config --logging.default_log_level=DEBUG
[root@kvm-01-guest30 ~]# subscription-manager register --username stage-ethel --serverurl=subscription.rhsm.stage.redhat.com
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
Password: 
The system has been registered with ID: 982eb49d-c71e-4b17-8ada-51dc81504b15
The registered system name is: kvm-01-guest30.lab.eng.rdu2.redhat.com
[root@kvm-01-guest30 ~]# 
[root@kvm-01-guest30 ~]# cat /etc/ostree/remotes.d/redhat.conf
cat: /etc/ostree/remotes.d/redhat.conf: No such file or directory          <<<<<< redhat.conf doesn't exist
[root@kvm-01-guest30 ~]# subscription-manager unregister
Unregistering from: subscription.rhsm.stage.redhat.com:443/subscription
System has been unregistered.
[root@kvm-01-guest30 ~]# 
[root@kvm-01-guest30 ~]# cat /etc/ostree/remotes.d/redhat.conf   <<<<<<<< Empty file gets created after un-register and no trace in rhsm.log seen          
[root@kvm-01-guest30 ~]# 
[root@kvm-01-guest30 ~]# tail -100 /var/log/rhsm/rhsm.log
2020-11-11 02:20:18,334 [DEBUG] subscription-manager:16837:MainThread @cache.py:172 - Checking current system info against cache: /var/lib/rhsm/cache/installed_products.json
2020-11-11 02:20:18,335 [DEBUG] subscription-manager:16837:MainThread @cache.py:189 - No changes.
2020-11-11 02:20:18,335 [DEBUG] subscription-manager:16837:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-11 02:20:18,335 [DEBUG] subscription-manager:16837:MainThread @cache.py:298 - Reading status from in-memory cache of /var/lib/rhsm/cache/entitlement_status.json file
2020-11-11 02:20:18,335 [DEBUG] subscription-manager:16837:MainThread @cert_sorter.py:223 - Product status: valid_products= partial_products= expired_products= unentitled_producs=486 future_products= valid_until=None
2020-11-11 02:20:18,335 [DEBUG] subscription-manager:16837:MainThread @cert_sorter.py:225 - partial stacks: []
2020-11-11 02:20:18,336 [DEBUG] subscription-manager:16837:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-11-11 02:20:18,337 [DEBUG] subscription-manager:16837:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-11-11 02:20:18,337 [DEBUG] subscription-manager:16837:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-11-11 02:20:18,337 [DEBUG] subscription-manager:16837:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-11-11 02:20:18,337 [DEBUG] subscription-manager:16837:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
2020-11-11 02:20:33,004 [DEBUG] subscription-manager:16935:MainThread @https.py:56 - Using standard libs to provide httplib and ssl
2020-11-11 02:20:33,151 [DEBUG] subscription-manager:16935:MainThread @dbus_interface.py:37 - self.has_main_loop=False
2020-11-11 02:20:33,153 [DEBUG] subscription-manager:16935:MainThread @dbus_interface.py:53 - Unable to connect to D-Bus service: com.redhat.SubscriptionManager
2020-11-11 02:20:33,169 [DEBUG] subscription-manager:16935:MainThread @ga_loader.py:91 - ga_loader GaImporterGtk3
2020-11-11 02:20:33,173 [DEBUG] subscription-manager:16935:MainThread @plugins.py:571 - loaded plugin modules: [<module 'ostree_content' from '/usr/share/rhsm-plugins/ostree_content.py'>]
2020-11-11 02:20:33,173 [DEBUG] subscription-manager:16935:MainThread @plugins.py:572 - loaded plugins: {'ostree_content.OstreeContentPlugin': <ostree_content.OstreeContentPlugin object at 0x7f6ff9bc6048>}
2020-11-11 02:20:33,173 [DEBUG] subscription-manager:16935:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-11-11 02:20:33,179 [DEBUG] subscription-manager:16935:MainThread @managercli.py:502 - X-Correlation-ID: 72a7675b9e7643d29111e46af3540ac3
2020-11-11 02:20:33,180 [DEBUG] subscription-manager:16935:MainThread @managercli.py:391 - Client Versions: {'subscription-manager': '1.28.5-1.el8'}
2020-11-11 02:20:33,180 [DEBUG] subscription-manager:16935:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-11-11 02:20:33,180 [DEBUG] subscription-manager:16935:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-11-11 02:20:33,180 [DEBUG] subscription-manager:16935:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-11-11 02:20:33,181 [DEBUG] subscription-manager:16935:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=none
2020-11-11 02:20:33,181 [DEBUG] subscription-manager:16935:MainThread @managercli.py:367 - Consumer Identity name=kvm-01-guest30.lab.eng.rdu2.redhat.com uuid=982eb49d-c71e-4b17-8ada-51dc81504b15
2020-11-11 02:20:33,181 [DEBUG] subscription-manager:16935:MainThread @connection.py:698 - Making request: DELETE /subscription/consumers/982eb49d-c71e-4b17-8ada-51dc81504b15
2020-11-11 02:20:33,183 [DEBUG] subscription-manager:16935:MainThread @connection.py:556 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-11-11 02:20:33,665 [DEBUG] subscription-manager:16935:MainThread @connection.py:792 - Response time: 0.3728628158569336, Smoothed response time: 0.3728628158569336
2020-11-11 02:20:33,665 [DEBUG] subscription-manager:16935:MainThread @connection.py:769 - Response: status=204, requestUuid=bbbef7a4-14a5-4474-94ab-c317192737fb, request="DELETE /subscription/consumers/982eb49d-c71e-4b17-8ada-51dc81504b15"
2020-11-11 02:20:33,666 [INFO] subscription-manager:16935:MainThread @unregister.py:55 - Successfully un-registered.
2020-11-11 02:20:33,667 [DEBUG] subscription-manager:16935:MainThread @managerlib.py:884 - Removing identity cert: /etc/pki/consumer/key.pem
2020-11-11 02:20:33,667 [DEBUG] subscription-manager:16935:MainThread @managerlib.py:884 - Removing identity cert: /etc/pki/consumer/cert.pem
2020-11-11 02:20:33,667 [DEBUG] subscription-manager:16935:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-11-11 02:20:33,667 [DEBUG] subscription-manager:16935:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-11-11 02:20:33,668 [DEBUG] subscription-manager:16935:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/profile.json
2020-11-11 02:20:33,668 [DEBUG] subscription-manager:16935:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/installed_products.json
2020-11-11 02:20:33,668 [DEBUG] subscription-manager:16935:MainThread @files.py:351 - Successfully read local syspurpose contents.
2020-11-11 02:20:33,668 [DEBUG] subscription-manager:16935:MainThread @files.py:388 - Successfully read cached syspurpose contents.
2020-11-11 02:20:33,669 [DEBUG] subscription-manager:16935:MainThread @files.py:591 - Successfully updated syspurpose values at '/var/lib/rhsm/cache/syspurpose.json'.
2020-11-11 02:20:33,669 [DEBUG] subscription-manager:16935:MainThread @cache.py:93 - Deleting cache: /var/lib/rhsm/cache/entitlement_status.json
2020-11-11 02:20:33,669 [DEBUG] subscription-manager:16935:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-11-11 02:20:33,669 [DEBUG] subscription-manager:16935:MainThread @managerlib.py:921 - Cleaned local data
2020-11-11 02:20:33,670 [DEBUG] subscription-manager:16935:MainThread @base_action_client.py:88 - running lib: <subscription_manager.entcertlib.EntCertActionInvoker object at 0x7f6ff9b93ba8>
2020-11-11 02:20:33,670 [DEBUG] subscription-manager:16935:MainThread @connection.py:171 - Environment variable NO_PROXY= will be used
2020-11-11 02:20:33,670 [DEBUG] subscription-manager:16935:MainThread @connection.py:267 - Connection built: host=subscription.rhsm.stage.redhat.com port=443 handler=/subscription auth=identity_cert ca_dir=/etc/rhsm/ca/ insecure=False
2020-11-11 02:20:33,671 [INFO] subscription-manager:16935:MainThread @entcertlib.py:131 - certs updated:
Total updates: 0
Found (local) serial# []
Expected (UEP) serial# []
Added (new)
  <NONE>
Deleted (rogue):
  <NONE>
2020-11-11 02:20:33,671 [DEBUG] subscription-manager:16935:MainThread @connection.py:698 - Making request: GET /subscription/status
2020-11-11 02:20:33,672 [DEBUG] subscription-manager:16935:MainThread @connection.py:556 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem
2020-11-11 02:20:33,959 [DEBUG] subscription-manager:16935:MainThread @connection.py:792 - Response time: 0.22872400283813477, Smoothed response time: 0.22872400283813477
2020-11-11 02:20:33,959 [DEBUG] subscription-manager:16935:MainThread @connection.py:769 - Response: status=200, requestUuid=4c67ec59-f895-4751-866d-1d0716d58dda, request="GET /subscription/status"
2020-11-11 02:20:33,960 [DEBUG] subscription-manager:16935:MainThread @connection.py:1007 - Server has the following capabilities: ['instance_multiplier', 'derived_product', 'vcpu', 'cert_v3', 'hypervisors_heartbeat', 'remove_by_pool_id', 'syspurpose', 'insights_auto_register', 'storage_band', 'cores', 'hypervisors_async', 'org_level_content_access', 'guest_limit', 'ram', 'batch_bind', 'combined_reporting']
2020-11-11 02:20:33,960 [DEBUG] subscription-manager:16935:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentActionClient object at 0x7f6ff9b93e10>
2020-11-11 02:20:33,961 [DEBUG] subscription-manager:16935:MainThread @base_action_client.py:88 - running lib: <subscription_manager.repolib.RepoActionInvoker object at 0x7f6ff9ba1208>
2020-11-11 02:20:33,962 [DEBUG] subscription-manager:16935:MainThread @repofile.py:364 - The directory /etc/yum.repos.d/ already exists
2020-11-11 02:20:33,962 [DEBUG] subscription-manager:16935:MainThread @repofile.py:364 - The directory /var/lib/rhsm/repo_server_val/ already exists
2020-11-11 02:20:33,963 [DEBUG] subscription-manager:16935:MainThread @__init__.py:92 - Searching for content of type: yum
2020-11-11 02:20:33,963 [DEBUG] subscription-manager:16935:MainThread @__init__.py:92 - Searching for content of type: deb
2020-11-11 02:20:33,963 [DEBUG] subscription-manager:16935:MainThread @repolib.py:463 - repos updated: Repo updates

Total repo updates: 0
Updated
    <NONE>
Added (new)
    <NONE>
Deleted
    <NONE>
2020-11-11 02:20:33,964 [DEBUG] subscription-manager:16935:MainThread @plugins.py:778 - Running update_content_hook in ostree_content.OstreeContentPlugin
2020-11-11 02:20:33,964 [DEBUG] subscription-manager:16935:MainThread @base_action_client.py:88 - running lib: <subscription_manager.content_action_client.ContentPluginActionInvoker object at 0x7f6ff99454e0>
2020-11-11 02:20:33,964 [DEBUG] subscription-manager:16935:MainThread @__init__.py:92 - Searching for content of type: ostree
2020-11-11 02:20:33,965 [DEBUG] subscription-manager:16935:MainThread @action_invoker.py:85 - Ostree update report: Ostree repo updates

Updates:

Added:

Deleted:

2020-11-11 02:20:33,965 [DEBUG] subscription-manager:16935:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-11 02:20:33,965 [DEBUG] subscription-manager:16935:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-11 02:20:33,966 [DEBUG] subscription-manager:16935:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-11 02:20:33,966 [DEBUG] subscription-manager:16935:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @identity.py:139 - Loading consumer info from identity certificates.
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @identity.py:154 - Reload of consumer identity cert /etc/pki/consumer/cert.pem raised an exception with msg: [Errno 2] No such file or directory: '/etc/pki/consumer/key.pem'
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @certdirectory.py:217 - Installed product IDs: ['486']
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @cert_sorter.py:144 - Unregistered, skipping server compliance check.
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @utils.py:385 - No virt-who pid file, not attempting to restart
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @repolib.py:175 - The rhsm.auto_enable_yum_plugins is enabled
2020-11-11 02:20:33,967 [DEBUG] subscription-manager:16935:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/subscription-manager.conf" already enabled. Nothing to do.
2020-11-11 02:20:33,968 [DEBUG] subscription-manager:16935:MainThread @repolib.py:151 - dnf plugin: "/etc/dnf/plugins/product-id.conf" already enabled. Nothing to do.
2020-11-11 02:20:33,968 [DEBUG] subscription-manager:16935:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/subscription-manager.conf" already enabled. Nothing to do.
2020-11-11 02:20:33,968 [DEBUG] subscription-manager:16935:MainThread @repolib.py:151 - yum plugin: "/etc/yum/pluginconf.d/product-id.conf" already enabled. Nothing to do.
[root@kvm-01-guest30 ~]#
Comment 10 errata-xmlrpc 2021-05-18 13:32:41 UTC 
Since the problem described in this bug report should be
resolved in a recent advisory, it has been closed with a
resolution of ERRATA.

For information on the advisory (subscription-manager bug fix and enhancement update), and where to find the updated
files, follow the link below.

If the solution does not work for you, open a new bug report.

https://access.redhat.com/errata/RHBA-2021:1575