Attachment 902472 Details for Bug 1105053 – rhsm.log

rhsm.log

rhsm.log (text/x-log), 27.58 KB, created by Liushihui on 2014-06-05 09:52:22 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Liushihui

Created: 2014-06-05 09:52:22 UTC

Size: 27.58 KB

patch

obsolete

>2014-06-05 05:19:20,066 [DEBUG] subscription-manager @plugins.py:533 - loaded plugin modules: []
>2014-06-05 05:19:20,066 [DEBUG] subscription-manager @plugins.py:534 - loaded plugins: {}
>2014-06-05 05:19:20,091 [DEBUG] subscription-manager @identity.py:131 - Loading consumer info from identity certificates.
>2014-06-05 05:19:20,093 [DEBUG] subscription-manager @profile.py:97 - Loading current RPM profile.
>2014-06-05 05:19:20,180 [INFO] subscription-manager @managercli.py:293 - Client Versions: {'python-rhsm': '1.11.3-3.el5', 'subscription-manager': '1.11.3-5.el5'}
>2014-06-05 05:19:20,180 [INFO] subscription-manager @connection.py:660 - Using certificate authentication: key = /etc/pki/consumer/key.pem, cert = /etc/pki/consumer/cert.pem, ca = /etc/rhsm/ca/, insecure = False
>2014-06-05 05:19:20,180 [INFO] subscription-manager @connection.py:673 - Connection Built: host: samserv.redhat.com, port: 443, handler: /sam/api
>2014-06-05 05:19:20,181 [INFO] subscription-manager @connection.py:670 - Using no auth
>2014-06-05 05:19:20,181 [INFO] subscription-manager @connection.py:673 - Connection Built: host: samserv.redhat.com, port: 443, handler: /sam/api
>2014-06-05 05:19:20,194 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:20,195 [DEBUG] subscription-manager @connection.py:450 - Making request: GET /sam/api/
>2014-06-05 05:19:20,244 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:20,244 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:20,245 [DEBUG] subscription-manager @connection.py:690 - Server supports the following resources:
>2014-06-05 05:19:20,245 [DEBUG] subscription-manager @connection.py:691 - {'status': '/api/status/', 'organizations': '/api/organizations/', 'roles': '/api/roles/', 'sync_plans': '/api/sync_plans/', 'users': '/api/users/', 'distributors': '/api/distributors/', 'providers': '/api/providers/', 'entitlements': '/api/entitlements/', 'content_overrides': '/api/content_overrides', 'content_views': '/api/content_views/', 'guestids': '/api/guestids', 'system_groups': '/api/system_groups/', 'products': '/api/products/', 'systems': '/api/systems/', 'activation_keys': '/api/activation_keys/', 'content_view_definitions': '/api/content_view_definitions/', 'consumers': '/api/consumers/'}
>2014-06-05 05:19:20,246 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:20,247 [DEBUG] subscription-manager @connection.py:450 - Making request: GET /sam/api/status
>2014-06-05 05:19:20,278 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:20,278 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:20,279 [INFO] subscription-manager @managercli.py:304 - Server Versions: {'candlepin': '1.4.3.26-1.el6sam_splice-Headpin', 'server-type': 'This system is currently not registered.'}
>2014-06-05 05:19:20,279 [INFO] subscription-manager @managercli.py:293 - Client Versions: {'python-rhsm': '1.11.3-3.el5', 'subscription-manager': '1.11.3-5.el5'}
>2014-06-05 05:19:20,288 [INFO] subscription-manager @connection.py:652 - Using basic authentication as: admin
>2014-06-05 05:19:20,288 [INFO] subscription-manager @connection.py:673 - Connection Built: host: samserv.redhat.com, port: 443, handler: /sam/api
>2014-06-05 05:19:20,315 [DEBUG] subscription-manager @hwprobe.py:554 - cpu info: {'cpu.cpu(s)': 4, 'cpu.core(s)_per_socket': 4, 'cpu.thread(s)_per_core': 1, 'cpu.topology_source': 'kernel /sys cpu sibling lists', 'cpu.cpu_socket(s)': 1}
>2014-06-05 05:19:20,317 [DEBUG] subscription-manager @hwprobe.py:773 - Running 'virt-what'
>2014-06-05 05:19:20,403 [DEBUG] subscription-manager @hwprobe.py:777 - virt-what stdout: 
>2014-06-05 05:19:20,404 [DEBUG] subscription-manager @hwprobe.py:778 - virt-what stderr: 
>2014-06-05 05:19:20,404 [INFO] subscription-manager @hwprobe.py:766 - virt.is_guest: False
>2014-06-05 05:19:20,404 [INFO] subscription-manager @hwprobe.py:767 - virt.host_type: Not Applicable
>2014-06-05 05:19:20,431 [INFO] subscription-manager @facts.py:138 - Loading custom facts from: /etc/rhsm/facts/custom.facts
>2014-06-05 05:19:20,432 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:20,432 [DEBUG] subscription-manager @connection.py:450 - Making request: GET /sam/api/users/admin/owners
>2014-06-05 05:19:20,462 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:20,462 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:20,464 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:20,464 [DEBUG] subscription-manager @connection.py:450 - Making request: POST /sam/api/consumers?owner=ACME_Corporation
>2014-06-05 05:19:21,355 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:21,355 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:21,357 [DEBUG] subscription-manager @cache.py:141 - Wrote cache: /var/lib/rhsm/cache/installed_products.json
>2014-06-05 05:19:21,359 [INFO] subscription-manager @managerlib.py:72 - Consumer created: {'consumer_name': 'hp-z220-03.qe.lab.eng.nay.redhat.com', 'uuid': '450cbd6d-bf5a-4199-9044-17a2170b3afc'}
>2014-06-05 05:19:21,360 [DEBUG] subscription-manager @utils.py:239 - Restarted virt-who
>2014-06-05 05:19:21,361 [DEBUG] subscription-manager @identity.py:131 - Loading consumer info from identity certificates.
>2014-06-05 05:19:21,367 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:21,367 [DEBUG] subscription-manager @connection.py:450 - Making request: GET /sam/api/status
>2014-06-05 05:19:21,413 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:21,414 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:21,414 [INFO] subscription-manager @managercli.py:304 - Server Versions: {'candlepin': '1.4.3.26-1.el6sam_splice-Headpin', 'server-type': 'Red Hat Subscription Management'}
>2014-06-05 05:19:21,415 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:21,416 [DEBUG] subscription-manager @connection.py:450 - Making request: GET /sam/api/
>2014-06-05 05:19:21,425 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:19:21,427 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:19:21,429 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:19:21,431 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:19:21,433 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:19:21,433 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:19:21,488 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:21,488 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:21,489 [DEBUG] subscription-manager @connection.py:690 - Server supports the following resources:
>2014-06-05 05:19:21,489 [DEBUG] subscription-manager @connection.py:691 - {'status': '/api/status/', 'organizations': '/api/organizations/', 'roles': '/api/roles/', 'sync_plans': '/api/sync_plans/', 'users': '/api/users/', 'distributors': '/api/distributors/', 'providers': '/api/providers/', 'entitlements': '/api/entitlements/', 'content_overrides': '/api/content_overrides', 'content_views': '/api/content_views/', 'guestids': '/api/guestids', 'system_groups': '/api/system_groups/', 'products': '/api/products/', 'systems': '/api/systems/', 'activation_keys': '/api/activation_keys/', 'content_view_definitions': '/api/content_view_definitions/', 'consumers': '/api/consumers/'}
>2014-06-05 05:19:21,489 [INFO] subscription-manager @cache.py:374 - Server does not support packages, skipping profile upload.
>2014-06-05 05:19:21,490 [DEBUG] subscription-manager @cache.py:141 - Wrote cache: /var/lib/rhsm/facts/facts.json
>2014-06-05 05:19:21,491 [INFO] subscription-manager @cache.py:169 - Checking current system info against cache: /var/lib/rhsm/cache/installed_products.json
>2014-06-05 05:19:21,491 [INFO] subscription-manager @cache.py:186 - No changes.
>2014-06-05 05:19:21,491 [INFO] subscription-manager @cache.py:169 - Checking current system info against cache: /var/lib/rhsm/cache/installed_products.json
>2014-06-05 05:19:21,491 [INFO] subscription-manager @cache.py:186 - No changes.
>2014-06-05 05:19:21,492 [DEBUG] subscription-manager @certdirectory.py:204 - Installed product IDs: ['69']
>2014-06-05 05:19:21,493 [DEBUG] subscription-manager @connection.py:418 - Loaded CA certificates from /etc/rhsm/ca/: redhat-uep.pem, candlepin-stage.pem, candlepin-local.pem
>2014-06-05 05:19:21,493 [DEBUG] subscription-manager @connection.py:450 - Making request: GET /sam/api/consumers/450cbd6d-bf5a-4199-9044-17a2170b3afc/compliance
>2014-06-05 05:19:21,713 [DEBUG] subscription-manager @connection.py:473 - Response: status=200
>2014-06-05 05:19:21,714 [WARNING] subscription-manager @connection.py:477 - Clock skew detected, please check your system time
>2014-06-05 05:19:21,715 [DEBUG] subscription-manager @cache.py:290 - Started thread to write cache: /var/lib/rhsm/cache/entitlement_status.json
>2014-06-05 05:19:21,716 [DEBUG] subscription-manager @cert_sorter.py:199 - valid entitled products: []
>2014-06-05 05:19:21,716 [DEBUG] subscription-manager @cert_sorter.py:200 - expired entitled products: []
>2014-06-05 05:19:21,716 [DEBUG] subscription-manager @cert_sorter.py:201 - partially entitled products: []
>2014-06-05 05:19:21,717 [DEBUG] subscription-manager @cert_sorter.py:202 - unentitled products: ['69']
>2014-06-05 05:19:21,717 [DEBUG] subscription-manager @cert_sorter.py:203 - future products: []
>2014-06-05 05:19:21,717 [DEBUG] subscription-manager @cert_sorter.py:204 - partial stacks: []
>2014-06-05 05:19:21,717 [DEBUG] subscription-manager @cert_sorter.py:205 - entitlements valid until: 2014-06-05 09:41:08.292999+00:00
>2014-06-05 05:19:21,718 [DEBUG] subscription-manager @dbus_interface.py:74 - installed python-dbus doesn't support 'get_default_main_loop'
>2014-06-05 05:19:21,720 [DEBUG] subscription-manager @dbus_interface.py:67 - installed python-dbus doesn't support 'follow_name_owner_changes'
>2014-06-05 05:19:21,896 [INFO] rhsmd @rhsmd:193 - rhsmd started
>2014-06-05 05:19:21,899 [INFO] rhsmd @rhsmd:148 - D-Bus interface com.redhat.SubscriptionManager.EntitlementStatus.update_status called with status = 1
>2014-06-05 05:19:21,972 [INFO] rhsmd @rhsmd:116 - D-Bus signal com.redhat.SubscriptionManager.EntitlementStatus.entitlement_status_changed emitted
>2014-06-05 05:19:28,824 [DEBUG]  @virt-who.py:274 - virt-who configution reloaded
>2014-06-05 05:19:28,826 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:19:28,827 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:19:28,828 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:19:28,829 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:19:28,830 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:19:28,830 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:20:28,842 [ERROR]  @virt-who.py:236 - Error in communication with subscription manager, trying to recover:
>Traceback (most recent call last):
>  File "/usr/share/virt-who/virt-who.py", line 215, in _send
>    self.subscriptionManager.sendVirtGuests(virtualGuests)
>  File "/usr/share/virt-who/subscriptionmanager.py", line 104, in sendVirtGuests
>    self.connection.updateConsumer(self.uuid(), guest_uuids=domains)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 782, in updateConsumer
>    params['guestIds'] = self.sanitizeGuestIds(guest_uuids)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 824, in sanitizeGuestIds
>    return [self.sanitizeGuestId(guestId) for guestId in guestIds or []]
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 830, in sanitizeGuestId
>    if self.supports_resource('guestids'):
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 700, in supports_resource
>    self._load_supported_resources()
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 687, in _load_supported_resources
>    resources_list = self.conn.request_get("/")
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 554, in request_get
>    return self._request("GET", method)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 464, in _request
>    response = conn.getresponse()
>  File "/usr/lib64/python2.4/httplib.py", line 872, in getresponse
>    response.begin()
>  File "/usr/lib64/python2.4/httplib.py", line 336, in begin
>    version, status, reason = self._read_status()
>  File "/usr/lib64/python2.4/httplib.py", line 294, in _read_status
>    line = self.fp.readline()
>  File "/usr/lib64/python2.4/socket.py", line 325, in readline
>    data = recv(1)
>  File "/usr/lib64/python2.4/site-packages/M2Crypto/SSL/Connection.py", line 217, in read
>    return self._read_bio(size)
>  File "/usr/lib64/python2.4/site-packages/M2Crypto/SSL/Connection.py", line 202, in _read_bio
>    return m2.ssl_read(self.ssl, size, self._timeout)
>SSLTimeoutError: timed out
>2014-06-05 05:20:28,960 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:20:28,961 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:20:28,962 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:20:28,962 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:20:28,963 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:20:28,963 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:21:24,750 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:21:24,751 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:21:24,751 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:21:24,752 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:21:24,753 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:21:24,753 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:21:31,793 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:21:31,794 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:21:31,795 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:21:31,795 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:21:31,796 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:21:31,796 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:21:49,549 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:21:49,551 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:21:49,553 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:21:49,555 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:21:49,556 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:21:49,556 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:21:50,068 [ERROR]  @virt-who.py:236 - Error in communication with subscription manager, trying to recover:
>Traceback (most recent call last):
>  File "/usr/share/virt-who/virt-who.py", line 215, in _send
>    self.subscriptionManager.sendVirtGuests(virtualGuests)
>  File "/usr/share/virt-who/subscriptionmanager.py", line 104, in sendVirtGuests
>    self.connection.updateConsumer(self.uuid(), guest_uuids=domains)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 799, in updateConsumer
>    ret = self.conn.request_put(method, params)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 563, in request_put
>    return self._request("PUT", method, params)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 482, in _request
>    self.validateResponse(result, request_type, handler)
>  File "/usr/lib64/python2.4/site-packages/rhsm/connection.py", line 524, in validateResponse
>    raise RestlibException(response['status'], error_msg)
>RestlibException: Runtime Error Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1 at org.hibernate.jdbc.Expectations$BasicExpectation.checkBatched:81
>2014-06-05 05:21:50,107 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:21:50,108 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:21:50,110 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:21:50,111 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:21:50,113 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:21:50,113 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:21:56,343 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:21:56,344 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:21:56,346 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:21:56,348 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:21:56,349 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:21:56,350 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:22:08,135 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:22:08,137 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:22:08,138 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:22:08,140 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:22:08,142 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:22:08,142 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:22:13,773 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>2014-06-05 05:22:13,775 [DEBUG]  @virt.py:78 - Virtual machine found: 5.10_Server_x86_64: 7246d5d7-30ad-aa89-2320-83cf71d8c2e9
>2014-06-05 05:22:13,777 [DEBUG]  @virt.py:78 - Virtual machine found: 6.4_Server_x86_64: a469434e-2483-2fa6-ed7b-2e0f15acf1c5
>2014-06-05 05:22:13,778 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Server_x86_64: 8bdc3bb7-cc9a-3b21-1c13-3eece03c3473
>2014-06-05 05:22:13,780 [DEBUG]  @virt.py:78 - Virtual machine found: 6.5_Client_i386: 9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414
>2014-06-05 05:22:13,780 [DEBUG]  @subscriptionmanager.py:101 - Sending list of uuids: [{'guestId': '17bfd5e4-7545-c240-f1ed-ceb4e3f33160', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '7246d5d7-30ad-aa89-2320-83cf71d8c2e9', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '8bdc3bb7-cc9a-3b21-1c13-3eece03c3473', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': '9a9f6de6-5a5a-70c4-aa68-3bf1b3b84414', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}, {'guestId': 'a469434e-2483-2fa6-ed7b-2e0f15acf1c5', 'attributes': {'active': 0, 'virtWhoType': 'libvirt', 'hypervisorType': 'QEMU'}}]
>2014-06-05 05:22:19,372 [DEBUG]  @virt.py:78 - Virtual machine found: 7.0_Server_x86_64: 17bfd5e4-7545-c240-f1ed-ceb4e3f33160
>

Actions: View

Attachments on bug 1105053: 902472 | 918080 | 918082