Bug 1242798
| Summary: | DBus traceback happens when registration and attaching subscriptions. | ||||||
|---|---|---|---|---|---|---|---|
| Product: | Red Hat Enterprise Linux 7 | Reporter: | qianzhan | ||||
| Component: | subscription-manager | Assignee: | candlepin-bugs | ||||
| Status: | CLOSED DUPLICATE | QA Contact: | John Sefler <jsefler> | ||||
| Severity: | unspecified | Docs Contact: | |||||
| Priority: | unspecified | ||||||
| Version: | 7.2 | CC: | alikins, gxing, shihliu | ||||
| Target Milestone: | rc | ||||||
| Target Release: | --- | ||||||
| Hardware: | Unspecified | ||||||
| OS: | Unspecified | ||||||
| Whiteboard: | |||||||
| Fixed In Version: | subscription-manager-1.15.7-1 | Doc Type: | Bug Fix | ||||
| Doc Text: | Story Points: | --- | |||||
| Clone Of: | Environment: | ||||||
| Last Closed: | 2015-07-30 22:50:04 UTC | Type: | Bug | ||||
| Regression: | --- | Mount Type: | --- | ||||
| Documentation: | --- | CRM: | |||||
| Verified Versions: | Category: | --- | |||||
| oVirt Team: | --- | RHEL 7.3 requirements from Atomic Host: | |||||
| Cloudforms Team: | --- | Target Upstream Version: | |||||
| Embargoed: | |||||||
| Attachments: |
|
||||||
Created attachment 1051692 [details]
rhsm.log
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
The import error was reported in bug 1241247 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 ~]#
(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. This is a part of 1241247, fixed in 1.15.7 *** This bug has been marked as a duplicate of bug 1241247 *** |
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'