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 1242798 - DBus traceback happens when registration and attaching subscriptions.
Summary: DBus traceback happens when registration and attaching subscriptions.
Keywords:
Status: CLOSED DUPLICATE of bug 1241247
Alias: None
Product: Red Hat Enterprise Linux 7
Classification: Red Hat
Component: subscription-manager
Version: 7.2
Hardware: Unspecified
OS: Unspecified
unspecified
unspecified
Target Milestone: rc
: ---
Assignee: candlepin-bugs
QA Contact: John Sefler
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2015-07-14 08:22 UTC by qianzhan
Modified: 2015-07-30 22:50 UTC (History)
3 users (show)

Fixed In Version: subscription-manager-1.15.7-1
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed: 2015-07-30 22:50:04 UTC
Target Upstream Version:
Embargoed:

Attachments (Terms of Use)
rhsm.log (63.74 KB, text/plain)
2015-07-14 08:22 UTC, qianzhan 		no flags Details
View All

Description qianzhan 2015-07-14 08:22:02 UTC 
Description of problem:
DBus traceback happens when registration and attaching subscriptions.

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


How reproducible:
always.

Steps to Reproduce:
1. Remove rhsm.log
[root@dhcp-128-65 ~]# rm -rf /var/log/rhsm/rhsm.log 

2. Register system and check rhsm.log:
[root@dhcp-128-65 ~]# subscription-manager register
Username: admin
Password: 
The system has been registered with ID: 3d523f7c-284c-40ff-9f98-3fe72d50407f 
[root@dhcp-128-65 ~]# tail -20 /var/log/rhsm/rhsm.log 
ImportError: No module named ga

2015-07-14 08:15:28,797 [DEBUG] subscription-manager:6422 @dbus_interface.py:46 - Unable to connect to dbus
2015-07-14 08:15:28,797 [ERROR] subscription-manager:6422 @dbus_interface.py:47 - org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
Traceback (most recent call last):
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 36, in __init__
    follow_name_owner_changes=self.has_main_loop)
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 69, in _get_validity_object
    return self.bus.get_object(*args, **kwargs)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 241, in get_object
    follow_name_owner_changes=follow_name_owner_changes)
  File "/usr/lib64/python2.7/site-packages/dbus/proxies.py", line 248, in __init__
    self._named_service = conn.activate_name_owner(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 180, in activate_name_owner
    self.start_service_by_name(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 278, in start_service_by_name
    'su', (bus_name, flags)))
  File "/usr/lib64/python2.7/site-packages/dbus/connection.py", line 651, in call_blocking
    message, timeout)
DBusException: org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.

3. Attach subscriptions and check rhsm.log:
[root@dhcp-128-65 ~]# subscription-manager attach --auto


Installed Product Current Status:
Product Name: Red Hat Enterprise Linux Server
Status:       Subscribed

[root@dhcp-128-65 ~]# tail -20 /var/log/rhsm/rhsm.log 
ImportError: No module named ga

2015-07-14 08:16:13,590 [DEBUG] subscription-manager:6476 @dbus_interface.py:46 - Unable to connect to dbus
2015-07-14 08:16:13,591 [ERROR] subscription-manager:6476 @dbus_interface.py:47 - org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
Traceback (most recent call last):
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 36, in __init__
    follow_name_owner_changes=self.has_main_loop)
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 69, in _get_validity_object
    return self.bus.get_object(*args, **kwargs)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 241, in get_object
    follow_name_owner_changes=follow_name_owner_changes)
  File "/usr/lib64/python2.7/site-packages/dbus/proxies.py", line 248, in __init__
    self._named_service = conn.activate_name_owner(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 180, in activate_name_owner
    self.start_service_by_name(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 278, in start_service_by_name
    'su', (bus_name, flags)))
  File "/usr/lib64/python2.7/site-packages/dbus/connection.py", line 651, in call_blocking
    message, timeout)
DBusException: org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.

4. Remove subscriptions and check rhsm.log:
[root@dhcp-128-65 ~]# subscription-manager remove --all
1 subscription removed at the server.
1 local certificate has been deleted.
[root@dhcp-128-65 ~]# tail -20 /var/log/rhsm/rhsm.log 
ImportError: No module named ga

2015-07-14 08:16:53,254 [DEBUG] subscription-manager:6533 @dbus_interface.py:46 - Unable to connect to dbus
2015-07-14 08:16:53,254 [ERROR] subscription-manager:6533 @dbus_interface.py:47 - org.freedesktop.DBus.Error.TimedOut: Activation of com.redhat.SubscriptionManager timed out
Traceback (most recent call last):
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 36, in __init__
    follow_name_owner_changes=self.has_main_loop)
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 69, in _get_validity_object
    return self.bus.get_object(*args, **kwargs)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 241, in get_object
    follow_name_owner_changes=follow_name_owner_changes)
  File "/usr/lib64/python2.7/site-packages/dbus/proxies.py", line 248, in __init__
    self._named_service = conn.activate_name_owner(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 180, in activate_name_owner
    self.start_service_by_name(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 278, in start_service_by_name
    'su', (bus_name, flags)))
  File "/usr/lib64/python2.7/site-packages/dbus/connection.py", line 651, in call_blocking
    message, timeout)
DBusException: org.freedesktop.DBus.Error.TimedOut: Activation of com.redhat.SubscriptionManager timed out

5. Unregister and check rhsm.log.
[root@dhcp-128-65 ~]# subscription-manager unregister
System has been unregistered.
[root@dhcp-128-65 ~]# tail -20 /var/log/rhsm/rhsm.log 

2015-07-14 08:17:30,745 [DEBUG] subscription-manager:6539 @dbus_interface.py:46 - Unable to connect to dbus
2015-07-14 08:17:30,745 [ERROR] subscription-manager:6539 @dbus_interface.py:47 - org.freedesktop.DBus.Error.TimedOut: Activation of com.redhat.SubscriptionManager timed out
Traceback (most recent call last):
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 36, in __init__
    follow_name_owner_changes=self.has_main_loop)
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 69, in _get_validity_object
    return self.bus.get_object(*args, **kwargs)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 241, in get_object
    follow_name_owner_changes=follow_name_owner_changes)
  File "/usr/lib64/python2.7/site-packages/dbus/proxies.py", line 248, in __init__
    self._named_service = conn.activate_name_owner(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 180, in activate_name_owner
    self.start_service_by_name(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 278, in start_service_by_name
    'su', (bus_name, flags)))
  File "/usr/lib64/python2.7/site-packages/dbus/connection.py", line 651, in call_blocking
    message, timeout)
DBusException: org.freedesktop.DBus.Error.TimedOut: Activation of com.redhat.SubscriptionManager timed out
2015-07-14 08:17:30,747 [DEBUG] subscription-manager:6539 @utils.py:287 - No virt-who pid file, not attempting to restart


Actual results:
As step 2~ step 5, Dbus traceback happens when registering/unregistering and attaching/removing subscriptions.

Expected results:
There should not be traceback.

Additional info:
Please see attachment 'rhsm.log'
Comment 1 qianzhan 2015-07-14 08:22:49 UTC 
Created attachment 1051692 [details]
rhsm.log
Comment 3 Liushihui 2015-07-16 03:03:39 UTC 
When unregister system , it not only show"DBusException" as the bug's description but also show "ImportError" in the log. please see the detail as the following:
2015-07-16 10:51:01,954 [DEBUG] subscription-manager:32713 @identity.py:146 - 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'
2015-07-16 10:51:01,998 [ERROR] rhsmd:32715 @rhsmd:62 - Unhandled rhsmd exception caught by the logging excepthook: Traceback (most recent call last):
  File "/usr/libexec/rhsmd", line 68, in <module>
    from subscription_manager.ga import GObject as ga_GObject
ImportError: No module named ga

2015-07-16 10:51:26,974 [DEBUG] subscription-manager:32713 @dbus_interface.py:46 - Unable to connect to dbus
2015-07-16 10:51:26,974 [ERROR] subscription-manager:32713 @dbus_interface.py:47 - org.freedesktop.DBus.Error.TimedOut: Activation of com.redhat.SubscriptionManager timed out
Traceback (most recent call last):
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 36, in __init__
    follow_name_owner_changes=self.has_main_loop)
  File "/usr/share/rhsm/subscription_manager/dbus_interface.py", line 69, in _get_validity_object
    return self.bus.get_object(*args, **kwargs)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 241, in get_object
    follow_name_owner_changes=follow_name_owner_changes)
  File "/usr/lib64/python2.7/site-packages/dbus/proxies.py", line 248, in __init__
    self._named_service = conn.activate_name_owner(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 180, in activate_name_owner
    self.start_service_by_name(bus_name)
  File "/usr/lib64/python2.7/site-packages/dbus/bus.py", line 278, in start_service_by_name
    'su', (bus_name, flags)))
  File "/usr/lib64/python2.7/site-packages/dbus/connection.py", line 651, in call_blocking
    message, timeout)
DBusException: org.freedesktop.DBus.Error.TimedOut: Activation of com.redhat.SubscriptionManager timed out
Comment 4 John Sefler 2015-07-16 12:13:15 UTC 
The import error was reported in bug 1241247
Comment 5 qianzhan 2015-07-22 06:52:46 UTC 
More info: When registering RHEL-7.2-20150720.0 to Satellite-6.1.0-RHEL-6-20150716.0, the following exception was displayed in rhsm.log, instead of DbusException:

[root@dhcp-128-17 ~]# subscription-manager register
Username: admin
Password: 
There was an issue with the backend service pulp: Pulp message bus connection issue.
[root@dhcp-128-17 ~]# tail -20 /var/log/rhsm/rhsm.log 
2015-07-22 02:23:00,093 [DEBUG] subscription-manager:5634 @connection.py:528 - Response: status=200
2015-07-22 02:23:00,096 [DEBUG] subscription-manager:5634 @connection.py:758 - Server supports the following resources: {'available_releases': '/katello/api/available_releases', 'status': '/katello/api/status/', 'distributors': '/katello/api/distributors/', 'content_overrides': '/katello/api/content_overrides', 'environments': '/katello/api/environments/', 'content_views': '/katello/api/content_views/', 'content_view_filters': '/katello/api/content_view_filters/', 'puppet_modules': '/katello/api/puppet_modules/', 'host_collections': '/katello/api/host_collections/', 'guestids': '/katello/api/guestids', 'docker_tags': '/katello/api/docker_tags/', 'systems': '/katello/api/systems/', 'gpg_keys': '/katello/api/gpg_keys/', 'grouped_docker_tags': '/katello/api/grouped_docker_tags/', 'capsules': '/katello/api/capsules/', 'users': '/katello/api/users/', 'sync_plans': '/katello/api/sync_plans/', 'subscriptions': '/katello/api/subscriptions/', 'docker_images': '/katello/api/docker_images/', 'content_view_versions': '/katello/api/content_view_versions/', 'packages': '/katello/api/packages/', 'organizations': '/katello/api/organizations/', 'package_groups': '/katello/api/package_groups/', 'repository_sets': '/katello/api/repository_sets/', 'repositories': '/katello/api/repositories/', 'products': '/katello/api/products/', 'activation_keys': '/katello/api/activation_keys/', 'errata': '/katello/api/errata/'}
2015-07-22 02:23:00,096 [DEBUG] subscription-manager:5634 @connection.py:500 - Making request: GET /rhsm/owners/Default_Organization/environments
2015-07-22 02:23:04,127 [DEBUG] subscription-manager:5634 @connection.py:528 - Response: status=200
2015-07-22 02:23:04,128 [DEBUG] subscription-manager:5634 @managercli.py:1171 - Using the only available environment: "Library"
2015-07-22 02:23:04,128 [DEBUG] subscription-manager:5634 @connection.py:500 - Making request: POST /rhsm/environments/1/consumers
2015-07-22 02:23:12,105 [DEBUG] subscription-manager:5634 @connection.py:528 - Response: status=500
2015-07-22 02:23:12,106 [ERROR] subscription-manager:5634 @managercli.py:1074 - There was an issue with the backend service pulp: Pulp message bus connection issue.
Traceback (most recent call last):
  File "/usr/share/rhsm/subscription_manager/managercli.py", line 1069, in _do_command
    content_tags=self.installed_mgr.tags)
  File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 833, in registerConsumer
    return self.conn.request_post(url, params)
  File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 612, in request_post
    return self._request("POST", method, params)
  File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 537, in _request
    self.validateResponse(result, request_type, handler)
  File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 579, in validateResponse
    raise RestlibException(response['status'], error_msg)
RestlibException: There was an issue with the backend service pulp: Pulp message bus connection issue.
[root@dhcp-128-17 ~]#
Comment 6 Adrian Likins 2015-07-30 22:48:06 UTC 
(In reply to qianzhan from comment #5)
> More info: When registering RHEL-7.2-20150720.0 to
> Satellite-6.1.0-RHEL-6-20150716.0, the following exception was displayed in
> rhsm.log, instead of DbusException:
> 
> [root@dhcp-128-17 ~]# subscription-manager register
> Username: admin
> Password: 
> There was an issue with the backend service pulp: Pulp message bus
> connection issue.
> [root@dhcp-128-17 ~]# tail -20 /var/log/rhsm/rhsm.log 
> 2015-07-22 02:23:00,093 [DEBUG] subscription-manager:5634 @connection.py:528
> - Response: status=200
> 2015-07-22 02:23:00,096 [DEBUG] subscription-manager:5634 @connection.py:758
> - Server supports the following resources: {'available_releases':
> '/katello/api/available_releases', 'status': '/katello/api/status/',
> 'distributors': '/katello/api/distributors/', 'content_overrides':
> '/katello/api/content_overrides', 'environments':
> '/katello/api/environments/', 'content_views':
> '/katello/api/content_views/', 'content_view_filters':
> '/katello/api/content_view_filters/', 'puppet_modules':
> '/katello/api/puppet_modules/', 'host_collections':
> '/katello/api/host_collections/', 'guestids': '/katello/api/guestids',
> 'docker_tags': '/katello/api/docker_tags/', 'systems':
> '/katello/api/systems/', 'gpg_keys': '/katello/api/gpg_keys/',
> 'grouped_docker_tags': '/katello/api/grouped_docker_tags/', 'capsules':
> '/katello/api/capsules/', 'users': '/katello/api/users/', 'sync_plans':
> '/katello/api/sync_plans/', 'subscriptions': '/katello/api/subscriptions/',
> 'docker_images': '/katello/api/docker_images/', 'content_view_versions':
> '/katello/api/content_view_versions/', 'packages': '/katello/api/packages/',
> 'organizations': '/katello/api/organizations/', 'package_groups':
> '/katello/api/package_groups/', 'repository_sets':
> '/katello/api/repository_sets/', 'repositories':
> '/katello/api/repositories/', 'products': '/katello/api/products/',
> 'activation_keys': '/katello/api/activation_keys/', 'errata':
> '/katello/api/errata/'}
> 2015-07-22 02:23:00,096 [DEBUG] subscription-manager:5634 @connection.py:500
> - Making request: GET /rhsm/owners/Default_Organization/environments
> 2015-07-22 02:23:04,127 [DEBUG] subscription-manager:5634 @connection.py:528
> - Response: status=200
> 2015-07-22 02:23:04,128 [DEBUG] subscription-manager:5634
> @managercli.py:1171 - Using the only available environment: "Library"
> 2015-07-22 02:23:04,128 [DEBUG] subscription-manager:5634 @connection.py:500
> - Making request: POST /rhsm/environments/1/consumers
> 2015-07-22 02:23:12,105 [DEBUG] subscription-manager:5634 @connection.py:528
> - Response: status=500
> 2015-07-22 02:23:12,106 [ERROR] subscription-manager:5634
> @managercli.py:1074 - There was an issue with the backend service pulp: Pulp
> message bus connection issue.
> Traceback (most recent call last):
>   File "/usr/share/rhsm/subscription_manager/managercli.py", line 1069, in
> _do_command
>     content_tags=self.installed_mgr.tags)
>   File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 833, in
> registerConsumer
>     return self.conn.request_post(url, params)
>   File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 612, in
> request_post
>     return self._request("POST", method, params)
>   File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 537, in
> _request
>     self.validateResponse(result, request_type, handler)
>   File "/usr/lib64/python2.7/site-packages/rhsm/connection.py", line 579, in
> validateResponse
>     raise RestlibException(response['status'], error_msg)
> RestlibException: There was an issue with the backend service pulp: Pulp
> message bus connection issue.
> [root@dhcp-128-17 ~]#

Thats a pulp server error, unrelated to dbus.
Comment 7 Adrian Likins 2015-07-30 22:50:04 UTC 
This is a part of 1241247, fixed in 1.15.7

*** This bug has been marked as a duplicate of bug 1241247 ***
Note You need to log in before you can comment on or make changes to this bug.