1868726 – [ERROR] subscription-manager: No such file or directory: '/etc/ostree/remotes.d/redhat.conf'

RHEL Engineering is moving the tracking of its product development work on RHEL 6 through RHEL 9 to Red Hat Jira (issues.redhat.com). If you're a Red Hat customer, please continue to file support cases via the Red Hat customer portal. If you're not, please head to the "RHEL project" in Red Hat Jira and file new tickets here. Individual Bugzilla bugs in the statuses "NEW", "ASSIGNED", and "POST" are being migrated throughout September 2023. Bugs of Red Hat partners with an assigned Engineering Partner Manager (EPM) are migrated in late September as per pre-agreed dates. Bugs against components "kernel", "kernel-rt", and "kpatch" are only migrated if still in "NEW" or "ASSIGNED". If you cannot log in to RH Jira, please consult article #7032570. That failing, please send an e-mail to the RH Jira admins at rh-issues@redhat.com to troubleshoot your issue as a user management inquiry. The email creates a ServiceNow ticket with Red Hat. Individual Bugzilla bugs that are migrated will be moved to status "CLOSED", resolution "MIGRATED", and set with "MigratedToJIRA" in "Keywords". The link to the successor Jira issue will be found under "Links", have a little "two-footprint" icon next to it, and direct you to the "RHEL project" in Red Hat Jira (issue links are of type "https://issues.redhat.com/browse/RHEL-XXXX", where "X" is a digit). This same link will be available in a blue banner at the top of the page informing you that that bug has been migrated.

Bug 1868726 - [ERROR] subscription-manager: No such file or directory: '/etc/ostree/remotes.d/redhat.conf'

Summary: [ERROR] subscription-manager: No such file or directory: '/etc/ostree/remotes...

Keywords:
Status:	CLOSED ERRATA
Alias:	None
Product:	Red Hat Enterprise Linux 8
Classification:	Red Hat
Component:	subscription-manager
Sub Component:
Version:	8.3
Hardware:	Unspecified
OS:	Unspecified
Priority:	low
Severity:	low
Target Milestone:	rc
Target Release:	---
Assignee:	candlepin-bugs
QA Contact:	Red Hat subscription-manager QE Team
Docs Contact:
URL:
Whiteboard:
Depends On:	1860434
Blocks:	1842946
TreeView+	depends on / blocked

Reported:	2020-08-13 15:34 UTC by John Sefler
Modified:	2021-05-18 13:33 UTC (History)
CC List:	3 users (show)
Fixed In Version:	subscription-manager-1.28.1-1
Doc Type:	If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed:	2021-05-18 13:32:41 UTC
Type:	Bug
Target Upstream Version:
Embargoed:
Dependent Products:

Attachments	(Terms of Use)

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

Note You need to log in before you can comment on or make changes to this bug.