Attachment 666086 Details for Bug 888790 – rhsm.log output

rhsm.log output

rhsm.log (text/x-log), 8.01 KB, created by spandey on 2012-12-19 13:42:57 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: spandey

Created: 2012-12-19 13:42:57 UTC

Size: 8.01 KB

patch

obsolete

>2012-12-19 17:59:22,259 [ERROR]  @rhsmcertd-worker:37 - Either the consumer is not registered or the certificates are corrupted. Certificate update using daemon failed.
>2012-12-19 17:59:24,908 [INFO]  @connection.py:545 - Using no auth
>2012-12-19 17:59:24,911 [INFO]  @connection.py:549 - Connection Built: host: dhcp201-204.englab.pnq.redhat.com, port: 443, handler: /katello/api
>2012-12-19 17:59:24,914 [DEBUG]  @connection.py:360 - Loading CA PEM certificates from: /etc/rhsm/ca/
>2012-12-19 17:59:24,915 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-ca.pem'
>2012-12-19 17:59:24,919 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/redhat-uep.pem'
>2012-12-19 17:59:24,921 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-stage.pem'
>2012-12-19 17:59:24,924 [DEBUG]  @connection.py:381 - Making request: GET /katello/api/status/
>2012-12-19 17:59:25,070 [DEBUG]  @connection.py:394 - Response status: 200
>2012-12-19 17:59:25,072 [INFO]  @registergui.py:911 - Writing server data to rhsm.conf
>2012-12-19 17:59:25,075 [INFO]  @connection.py:538 - Using certificate authentication: key = /etc/pki/consumer/key.pem, cert = /etc/pki/consumer/cert.pem, ca = /etc/rhsm/ca/, insecure = False
>2012-12-19 17:59:25,075 [INFO]  @connection.py:549 - Connection Built: host: dhcp201-204.englab.pnq.redhat.com, port: 443, handler: /katello/api
>2012-12-19 17:59:25,076 [DEBUG]  @connection.py:165 - ContectConnection
>2012-12-19 17:59:26,959 [INFO]  @connection.py:545 - Using no auth
>2012-12-19 17:59:26,959 [INFO]  @connection.py:549 - Connection Built: host: dhcp201-204.englab.pnq.redhat.com, port: 443, handler: /katello/api
>2012-12-19 17:59:26,960 [INFO]  @registergui.py:326 - Registering to owner: redhat environment: None
>2012-12-19 17:59:26,968 [DEBUG]  @connection.py:360 - Loading CA PEM certificates from: /etc/rhsm/ca/
>2012-12-19 17:59:26,968 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-ca.pem'
>2012-12-19 17:59:26,969 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/redhat-uep.pem'
>2012-12-19 17:59:26,970 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-stage.pem'
>2012-12-19 17:59:26,975 [DEBUG]  @connection.py:381 - Making request: POST /katello/api/consumers?owner=redhat&activation_keys=testactivation1
>2012-12-19 17:59:28,125 [DEBUG]  @connection.py:394 - Response status: 200
>2012-12-19 17:59:28,133 [DEBUG]  @connection.py:360 - Loading CA PEM certificates from: /etc/rhsm/ca/
>2012-12-19 17:59:28,134 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-ca.pem'
>2012-12-19 17:59:28,134 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/redhat-uep.pem'
>2012-12-19 17:59:28,135 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-stage.pem'
>2012-12-19 17:59:28,135 [DEBUG]  @connection.py:381 - Making request: GET /katello/api/
>2012-12-19 17:59:28,187 [DEBUG]  @connection.py:394 - Response status: 200
>2012-12-19 17:59:28,189 [DEBUG]  @connection.py:565 - Server supports the following resources:
>2012-12-19 17:59:28,191 [DEBUG]  @connection.py:566 - {'templates': '/api/templates/', 'organizations': '/api/organizations/', 'subnets': '/api/subnets/', 'tasks': '/api/tasks/', 'smart_proxies': '/api/smart_proxies/', 'users': '/api/users/', 'roles': '/api/roles/', 'changesets': '/api/changesets/', 'architectures': '/api/architectures/', 'providers': '/api/providers/', 'repositories': '/api/repositories/', 'environments': '/api/environments/', 'entitlements': '/api/entitlements/', 'config_templates': '/api/config_templates/', 'status': '/api/status/', 'systems': '/api/systems/', 'gpg_keys': '/api/gpg_keys/', 'activation_keys': '/api/activation_keys/', 'packages': '/api/packages/', 'domains': '/api/domains/', 'consumers': '/api/consumers/'}
>2012-12-19 17:59:28,194 [INFO]  @cache.py:160 - Checking current system info against cache: /var/lib/rhsm/packages/packages.json
>2012-12-19 17:59:28,195 [INFO]  @cache.py:222 - Cache does not exist
>2012-12-19 17:59:28,195 [INFO]  @cache.py:162 - System data has changed, updating server.
>2012-12-19 17:59:28,195 [DEBUG]  @profile.py:95 - Loading current RPM profile.
>2012-12-19 17:59:28,473 [DEBUG]  @connection.py:360 - Loading CA PEM certificates from: /etc/rhsm/ca/
>2012-12-19 17:59:28,480 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-ca.pem'
>2012-12-19 17:59:28,481 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/redhat-uep.pem'
>2012-12-19 17:59:28,482 [DEBUG]  @connection.py:342 - Loading CA certificate: '/etc/rhsm/ca/candlepin-stage.pem'
>2012-12-19 17:59:28,486 [DEBUG]  @connection.py:381 - Making request: PUT /katello/api/consumers/3fb1b788-0fa4-40eb-a9fa-f7b120308081/packages
>2012-12-19 17:59:29,064 [DEBUG]  @connection.py:394 - Response status: 401
>2012-12-19 17:59:29,065 [ERROR]  @connection.py:411 - No JSON object could be decoded
>Traceback (most recent call last):
>  File "/usr/lib64/python2.6/site-packages/rhsm/connection.py", line 409, in validateResponse
>    parsed = json.loads(response['content'], object_hook=self._decode_dict)
>  File "/usr/lib64/python2.6/site-packages/simplejson/__init__.py", line 318, in loads
>    return cls(encoding=encoding, **kw).decode(s)
>  File "/usr/lib64/python2.6/site-packages/simplejson/decoder.py", line 335, in decode
>    obj, end = self.raw_decode(s, idx=_w(s, 0).end())
>  File "/usr/lib64/python2.6/site-packages/simplejson/decoder.py", line 353, in raw_decode
>    raise ValueError("No JSON object could be decoded")
>ValueError: No JSON object could be decoded
>2012-12-19 17:59:29,068 [ERROR]  @connection.py:412 - Response: {'content': 'No Credentials provided', 'status': 401}
>2012-12-19 17:59:29,069 [ERROR]  @cache.py:170 - Error updating system data on the server
>2012-12-19 17:59:29,069 [ERROR]  @cache.py:171 - Network error code: 401
>Traceback (most recent call last):
>  File "/usr/share/rhsm/subscription_manager/cache.py", line 164, in update_check
>    self._update_server(uep, consumer_uuid)
>  File "/usr/share/rhsm/subscription_manager/cache.py", line 230, in _update_server
>    self.current_profile.collect())
>  File "/usr/lib64/python2.6/site-packages/rhsm/connection.py", line 674, in updatePackageProfile
>    ret = self.conn.request_put(method, pkg_dicts)
>  File "/usr/lib64/python2.6/site-packages/rhsm/connection.py", line 446, in request_put
>    return self._request("PUT", method, params)
>  File "/usr/lib64/python2.6/site-packages/rhsm/connection.py", line 399, in _request
>    self.validateResponse(result)
>  File "/usr/lib64/python2.6/site-packages/rhsm/connection.py", line 417, in validateResponse
>    raise NetworkException(response['status'])
>NetworkException: Network error code: 401
>2012-12-19 17:59:29,077 [ERROR]  @utils.py:68 - Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details.
>Traceback (most recent call last):
>  File "/usr/share/rhsm/subscription_manager/gui/registergui.py", line 309, in _on_registration_finished_cb
>    raise error
>Exception: Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details.
>2012-12-19 17:59:29,096 [DEBUG]  @managergui.py:304 - Registration changed, updating main window.
>2012-12-19 17:59:29,098 [DEBUG]  @managergui.py:174 - Loading consumer info from identity certificates.
>2012-12-19 17:59:29,099 [DEBUG]  @cert_sorter.py:116 - Sorting product and entitlement cert status for: 2012-12-19 12:29:29.099403+00:00
>2012-12-19 17:59:29,100 [DEBUG]  @cert_sorter.py:169 - Installed product IDs: ['37060']
>2012-12-19 17:59:29,100 [DEBUG]  @cert_sorter.py:122 - valid entitled products: []
>2012-12-19 17:59:29,100 [DEBUG]  @cert_sorter.py:123 - expired entitled products: []
>2012-12-19 17:59:29,101 [DEBUG]  @cert_sorter.py:124 - partially entitled products: []
>2012-12-19 17:59:29,101 [DEBUG]  @cert_sorter.py:125 - unentitled products: ['37060']
>2012-12-19 17:59:29,102 [DEBUG]  @cert_sorter.py:126 - future products: []
>2012-12-19 17:59:29,102 [DEBUG]  @cert_sorter.py:127 - partial stacks: []
>2012-12-19 17:59:29,102 [DEBUG]  @cert_sorter.py:128 - valid stacks: []
>
>

Actions: View

Attachments on bug 888790: 666085 | 666086