Bug 1916540
| Summary: | Negative proxy tests occasionally encounter the wrong exception handling | ||
|---|---|---|---|
| Product: | Red Hat Enterprise Linux 8 | Reporter: | John Sefler <jsefler> |
| Component: | subscription-manager | Assignee: | candlepin-bugs |
| Status: | CLOSED ERRATA | QA Contact: | Red Hat subscription-manager QE Team <rhsm-qe> |
| Severity: | low | Docs Contact: | |
| Priority: | unspecified | ||
| Version: | 8.4 | CC: | arpandey, redakkan |
| Target Milestone: | rc | Keywords: | EasyFix, Triaged |
| Target Release: | 8.5 | Flags: | pm-rhel:
mirror+
|
| Hardware: | Unspecified | ||
| OS: | Unspecified | ||
| Whiteboard: | |||
| Fixed In Version: | subscription-manager-1.28.16-1.el8 | Doc Type: | If docs needed, set a value |
| Doc Text: | Story Points: | --- | |
| Clone Of: | Environment: | ||
| Last Closed: | 2021-11-09 19:37:35 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: | |||
Pre-verifying on subscription-manager-1.28.15-1.el8.x86_64
verification steps:
[root@hpe-dl380pgen8-02-vm-3 ~]# subscription-manager version
server type: Red Hat Subscription Management
subscription management server: Unknown
subscription management rules: Unknown
subscription-manager: 1.28.15-1.el8
[root@hpe-dl380pgen8-02-vm-3 ~]#
[root@hpe-dl380pgen8-02-vm-3 ~]# rpm -qa --changelog subscription-manager | grep 1916540
[root@hpe-dl380pgen8-02-vm-3 ~]# <<<<<<< rpm changelog not present for fix
[root@hpe-dl380pgen8-02-vm-3 ~]# subscription-manager register --username archana-486 --password redhat
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
The system has been registered with ID: 88a65fd8-809e-4d84-9260-a8026167da39
The registered system name is: hpe-dl380pgen8-02-vm-3.hpe2.lab.eng.bos.redhat.com
[root@hpe-dl380pgen8-02-vm-3 ~]#
[root@hpe-dl380pgen8-02-vm-3 ~]#
[root@hpe-dl380pgen8-02-vm-3 ~]#
[root@hpe-dl380pgen8-02-vm-3 ~]# subscription-manager config --server.proxy_hostname=bad-proxy --server.proxy_port=3129
[root@hpe-dl380pgen8-02-vm-3 ~]# subscription-manager list --available
Proxy error, unable to connect to proxy server.
[root@hpe-dl380pgen8-02-vm-3 ~]# echo '{"foo":"bar"}' > /etc/rhsm/facts/custom.facts
[root@hpe-dl380pgen8-02-vm-3 ~]# subscription-manager list --available
Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details. <<<< exception message not fixed
Additional info: rhsm.log
2021-04-22 10:06:26,043 [ERROR] subscription-manager:106305:MainThread @cache.py:184 - Error updating system data on the server
2021-04-22 10:06:26,043 [ERROR] subscription-manager:106305:MainThread @cache.py:185 - Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 728, in _request
conn.request(request_type, handler, body=body, headers=final_headers)
File "/usr/lib64/python3.6/http/client.py", line 1269, in request
self._send_request(method, url, body, headers, encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1315, in _send_request
self.endheaders(body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1264, in endheaders
self._send_output(message_body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1040, in _send_output
self.send(msg)
File "/usr/lib64/python3.6/http/client.py", line 978, in send
self.connect()
File "/usr/lib64/python3.6/http/client.py", line 1429, in connect
super().connect()
File "/usr/lib64/python3.6/http/client.py", line 950, in connect
(self.host,self.port), self.timeout, self.source_address)
File "/usr/lib64/python3.6/socket.py", line 704, in create_connection
for res in getaddrinfo(host, port, 0, SOCK_STREAM):
File "/usr/lib64/python3.6/socket.py", line 745, in getaddrinfo
for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -2] Name or service not known
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 176, in update_check
self._sync_with_server(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/facts.py", line 88, in _sync_with_server
uep.updateConsumer(consumer_uuid, facts=self.get_facts())
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 1224, in updateConsumer
ret = self.conn.request_put(method, params)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 915, in request_put
return self._request("PUT", method, params, headers=headers)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 932, in _request
info=info, headers=headers, cert_key_pairs=cert_key_pairs)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 758, in _request
err))
rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
2021-04-22 10:06:26,045 [ERROR] subscription-manager:106305:MainThread @managercli.py:218 - exception caught in subscription-manager
2021-04-22 10:06:26,045 [ERROR] subscription-manager:106305:MainThread @managercli.py:219 - Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details.
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 728, in _request
conn.request(request_type, handler, body=body, headers=final_headers)
File "/usr/lib64/python3.6/http/client.py", line 1269, in request
self._send_request(method, url, body, headers, encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1315, in _send_request
self.endheaders(body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1264, in endheaders
self._send_output(message_body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1040, in _send_output
self.send(msg)
File "/usr/lib64/python3.6/http/client.py", line 978, in send
self.connect()
File "/usr/lib64/python3.6/http/client.py", line 1429, in connect
super().connect()
File "/usr/lib64/python3.6/http/client.py", line 950, in connect
(self.host,self.port), self.timeout, self.source_address)
File "/usr/lib64/python3.6/socket.py", line 704, in create_connection
for res in getaddrinfo(host, port, 0, SOCK_STREAM):
File "/usr/lib64/python3.6/socket.py", line 745, in getaddrinfo
for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -2] Name or service not known
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 176, in update_check
self._sync_with_server(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/facts.py", line 88, in _sync_with_server
uep.updateConsumer(consumer_uuid, facts=self.get_facts())
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 1224, in updateConsumer
ret = self.conn.request_put(method, params)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 915, in request_put
return self._request("PUT", method, params, headers=headers)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 932, in _request
info=info, headers=headers, cert_key_pairs=cert_key_pairs)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 758, in _request
err))
rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 546, in main
return_code = self._do_command()
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 2953, in _do_command
after_date=after_date,
File "/usr/lib64/python3.6/site-packages/rhsmlib/services/entitlement.py", line 394, in get_available_pools
items_per_page=_items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 344, in get_available_entitlements
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 563, in get_filtered_pools_list
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 279, in list_pools
require(FACTS).update_check(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 186, in update_check
raise Exception(_("Error updating system data on the server, see /var/log/rhsm/rhsm.log "
Exception: Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details.
[root@hpe-dl380pgen8-02-vm-3 ~]#
based on above observations, issue is not fixed in subscription-manager-1.28.15-1.el8.x86_64
setting verified: FailedQA
PR https://github.com/candlepin/subscription-manager/pull/2602 is for subscription-manager-1.28 Verifying bug on : subscription-manager-1.28.16-1.el8.x86_64
Steps for verification:
[root@hpe-dl380pgen8-02-vm-8 ~]# subscription-manager version
server type: This system is currently not registered.
subscription management server: 3.2.16-1
subscription management rules: 5.41
subscription-manager: 1.28.16-1.el8
[root@hpe-dl380pgen8-02-vm-8 ~]#
[root@hpe-dl380pgen8-02-vm-8 ~]# rpm -qa --changelog subscription-manager | grep 1916540
- 1916540: Negative proxy tests occasionally encounter the wrong exception
[root@hpe-dl380pgen8-02-vm-8 ~]# subscription-manager register --username ****** --password *********
Registering to: subscription.rhsm.stage.redhat.com:443/subscription
The system has been registered with ID: 99aa9fe7-b94e-4734-9df5-d9d37bf9c9ee
The registered system name is: hpe-dl380pgen8-02-vm-8.hpe2.lab.eng.bos.redhat.com
[root@hpe-dl380pgen8-02-vm-8 ~]#
[root@hpe-dl380pgen8-02-vm-8 ~]# subscription-manager config --server.proxy_hostname=bad-proxy --server.proxy_port=3129
[root@hpe-dl380pgen8-02-vm-8 ~]#
[root@hpe-dl380pgen8-02-vm-8 ~]# subscription-manager list --available
Proxy error, unable to connect to proxy server.
[root@hpe-dl380pgen8-02-vm-8 ~]#
[root@hpe-dl380pgen8-02-vm-8 ~]# echo '{"foo":"bar"}' > /etc/rhsm/facts/custom.facts
[root@hpe-dl380pgen8-02-vm-8 ~]# subscription-manager list --available
Proxy error, unable to connect to proxy server. <<< Expected exception message appeared
snippet from rhsm.log :
[root@hpe-dl380pgen8-02-vm-8 ~]# tail -110 /var/log/rhsm/rhsm.log
2021-04-28 04:27:37,497 [ERROR] subscription-manager:52017:MainThread @managercli.py:218 - exception caught in subscription-manager
2021-04-28 04:27:37,497 [ERROR] subscription-manager:52017:MainThread @managercli.py:219 - Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 728, in _request
conn.request(request_type, handler, body=body, headers=final_headers)
File "/usr/lib64/python3.6/http/client.py", line 1269, in request
self._send_request(method, url, body, headers, encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1315, in _send_request
self.endheaders(body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1264, in endheaders
self._send_output(message_body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1040, in _send_output
self.send(msg)
File "/usr/lib64/python3.6/http/client.py", line 978, in send
self.connect()
File "/usr/lib64/python3.6/http/client.py", line 1429, in connect
super().connect()
File "/usr/lib64/python3.6/http/client.py", line 950, in connect
(self.host,self.port), self.timeout, self.source_address)
File "/usr/lib64/python3.6/socket.py", line 704, in create_connection
for res in getaddrinfo(host, port, 0, SOCK_STREAM):
File "/usr/lib64/python3.6/socket.py", line 745, in getaddrinfo
for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -2] Name or service not known
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 564, in main
return_code = self._do_command()
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 3001, in _do_command
after_date=after_date,
File "/usr/lib64/python3.6/site-packages/rhsmlib/services/entitlement.py", line 403, in get_available_pools
iso_dates=iso_dates
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 345, in get_available_entitlements
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 569, in get_filtered_pools_list
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 282, in list_pools
profile_mgr.update_check(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 472, in update_check
supported_resources = get_supported_resources()
File "/usr/lib64/python3.6/site-packages/subscription_manager/utils.py", line 250, in get_supported_resources
return uep.get_supported_resources()
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 990, in get_supported_resources
self._load_supported_resources()
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 978, in _load_supported_resources
resources_list = self.conn.request_get("/")
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 906, in request_get
return self._request("GET", method, headers=headers, cert_key_pairs=cert_key_pairs)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 932, in _request
info=info, headers=headers, cert_key_pairs=cert_key_pairs)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 758, in _request
err))
rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
2021-04-28 04:27:52,583 [ERROR] subscription-manager:52070:MainThread @managercli.py:218 - exception caught in subscription-manager
2021-04-28 04:27:52,583 [ERROR] subscription-manager:52070:MainThread @managercli.py:219 - Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 728, in _request
conn.request(request_type, handler, body=body, headers=final_headers)
File "/usr/lib64/python3.6/http/client.py", line 1269, in request
self._send_request(method, url, body, headers, encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1315, in _send_request
self.endheaders(body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1264, in endheaders
self._send_output(message_body, encode_chunked=encode_chunked)
File "/usr/lib64/python3.6/http/client.py", line 1040, in _send_output
self.send(msg)
File "/usr/lib64/python3.6/http/client.py", line 978, in send
self.connect()
File "/usr/lib64/python3.6/http/client.py", line 1429, in connect
super().connect()
File "/usr/lib64/python3.6/http/client.py", line 950, in connect
(self.host,self.port), self.timeout, self.source_address)
File "/usr/lib64/python3.6/socket.py", line 704, in create_connection
for res in getaddrinfo(host, port, 0, SOCK_STREAM):
File "/usr/lib64/python3.6/socket.py", line 745, in getaddrinfo
for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
socket.gaierror: [Errno -2] Name or service not known
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 564, in main
return_code = self._do_command()
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 3001, in _do_command
after_date=after_date,
File "/usr/lib64/python3.6/site-packages/rhsmlib/services/entitlement.py", line 403, in get_available_pools
iso_dates=iso_dates
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 345, in get_available_entitlements
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 569, in get_filtered_pools_list
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 279, in list_pools
require(FACTS).update_check(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 184, in update_check
raise pe
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 176, in update_check
self._sync_with_server(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/facts.py", line 88, in _sync_with_server
uep.updateConsumer(consumer_uuid, facts=self.get_facts())
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 1224, in updateConsumer
ret = self.conn.request_put(method, params)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 915, in request_put
return self._request("PUT", method, params, headers=headers)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 932, in _request
info=info, headers=headers, cert_key_pairs=cert_key_pairs)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 758, in _request
err))
rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
[root@hpe-dl380pgen8-02-vm-8 ~]#
Verified : Consistent exception "Proxy error, unable to connect to proxy server." is being raised for negative proxy tests
Verifying on :
# subscription-manager version
server type: Red Hat Subscription Management
subscription management server: 3.2.18-1
subscription management rules: 5.41
subscription-manager: 1.28.16-1.el8
# rpm -qa --changelog subscription-manager | grep 1916540
- 1916540: Negative proxy tests occasionally encounter the wrong exception
# subscription-manager identity
system identity: *********
name: ****************
org name: *****
org ID: *****
# subscription-manager config --server.proxy_hostname=bad-proxy --server.proxy_port=3129
# subscription-manager list --available
Proxy error, unable to connect to proxy server.
# echo '{"foo":"bar"}' > /etc/rhsm/facts/custom.facts
# subscription-manager list --available
Proxy error, unable to connect to proxy server.
^^ As per the request made in the bug , the Proxy error message is now appearing on the cli
Based on the observation , Moving the bug to Verified!!
Additional info : rhsm.log
==========================
# tail -f /var/log/rhsm/rhsm.log -n 30
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 564, in main
return_code = self._do_command()
File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 3001, in _do_command
after_date=after_date,
File "/usr/lib64/python3.6/site-packages/rhsmlib/services/entitlement.py", line 403, in get_available_pools
iso_dates=iso_dates
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 345, in get_available_entitlements
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 569, in get_filtered_pools_list
items_per_page=items_per_page
File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 279, in list_pools
require(FACTS).update_check(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 184, in update_check
raise pe
File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 176, in update_check
self._sync_with_server(uep, consumer_uuid)
File "/usr/lib64/python3.6/site-packages/subscription_manager/facts.py", line 88, in _sync_with_server
uep.updateConsumer(consumer_uuid, facts=self.get_facts())
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 1224, in updateConsumer
ret = self.conn.request_put(method, params)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 915, in request_put
return self._request("PUT", method, params, headers=headers)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 932, in _request
info=info, headers=headers, cert_key_pairs=cert_key_pairs)
File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 758, in _request
err))
rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known
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:4390 |
Description of problem: We have a series of automated negative proxy tests that are trying to assert that "Proxy error, unable to connect to proxy server." is presented to the user, but instead, "Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details." is presented. Reviewing the rhsm.log reveals a stack of four nested exceptions that are caught and raised. This seems excessive and reports a slightly misleading exception. Here is a simple two-line fix that can be added to subscription_manager/cache.py @@ -180,6 +180,8 @@ class CacheManager(object): return 1 except connection.RestlibException as re: raise re + except connection.ProxyException as pe: + raise pe except Exception as e: log.error("Error updating system data on the server") log.exception(e) Version-Release number of selected component (if applicable): [root@kvm-08-guest18 ~]# rpm -q subscription-manager subscription-manager-1.28.9-1.el8.x86_64 How reproducible: Steps to Reproduce: [root@kvm-08-guest18 ~]# subscription-manager register --username=stage_auto_testuser --serverurl=subscription.rhsm.stage.redhat.com:443/subscription Password: Registering to: subscription.rhsm.stage.redhat.com:443/subscription The system has been registered with ID: 1ea30b80-ea53-4949-8a02-429a9f983c1b The registered system name is: kvm-08-guest18.hv2.lab.eng.bos.redhat.com [root@kvm-08-guest18 ~]# [root@kvm-08-guest18 ~]# subscription-manager config --server.proxy_hostname=bad-proxy --server.proxy_port=3129 [root@kvm-08-guest18 ~]# [root@kvm-08-guest18 ~]# subscription-manager list --available Proxy error, unable to connect to proxy server. [root@kvm-08-guest18 ~]# [root@kvm-08-guest18 ~]# echo '{"foo":"bar"}' > /etc/rhsm/facts/custom.facts [root@kvm-08-guest18 ~]# [root@kvm-08-guest18 ~]# subscription-manager list --available Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details. [root@kvm-08-guest18 ~]# [root@kvm-08-guest18 ~]# tail -109 /var/log/rhsm/rhsm.log 2021-01-14 20:40:37,189 [DEBUG] subscription-manager:409955:MainThread @cache.py:172 - Checking current system info against cache: /var/lib/rhsm/facts/facts.json 2021-01-14 20:40:37,216 [DEBUG] subscription-manager:409955:MainThread @dmiinfo.py:76 - Using dmidecode dump file: /dev/mem 2021-01-14 20:40:37,267 [DEBUG] subscription-manager:409955:MainThread @custom.py:87 - Loading custom facts from: /etc/rhsm/facts/custom.facts 2021-01-14 20:40:37,268 [DEBUG] subscription-manager:409955:MainThread @cache.py:174 - System data has changed, updating server. 2021-01-14 20:40:37,268 [DEBUG] subscription-manager:409955:MainThread @facts.py:87 - Updating facts on server 2021-01-14 20:40:37,268 [DEBUG] subscription-manager:409955:MainThread @connection.py:700 - Making request: PUT /subscription/consumers/1ea30b80-ea53-4949-8a02-429a9f983c1b 2021-01-14 20:40:37,270 [DEBUG] subscription-manager:409955:MainThread @connection.py:558 - Loaded CA certificates from /etc/rhsm/ca/: redhat-entitlement-authority.pem, redhat-uep.pem 2021-01-14 20:40:37,270 [DEBUG] subscription-manager:409955:MainThread @connection.py:587 - Using proxy: bad-proxy:3129 2021-01-14 20:40:37,292 [ERROR] subscription-manager:409955:MainThread @cache.py:184 - Error updating system data on the server 2021-01-14 20:40:37,292 [ERROR] subscription-manager:409955:MainThread @cache.py:185 - Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known Traceback (most recent call last): File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 719, in _request conn.request(request_type, handler, body=body, headers=final_headers) File "/usr/lib64/python3.6/http/client.py", line 1269, in request self._send_request(method, url, body, headers, encode_chunked) File "/usr/lib64/python3.6/http/client.py", line 1315, in _send_request self.endheaders(body, encode_chunked=encode_chunked) File "/usr/lib64/python3.6/http/client.py", line 1264, in endheaders self._send_output(message_body, encode_chunked=encode_chunked) File "/usr/lib64/python3.6/http/client.py", line 1040, in _send_output self.send(msg) File "/usr/lib64/python3.6/http/client.py", line 978, in send self.connect() File "/usr/lib64/python3.6/http/client.py", line 1429, in connect super().connect() File "/usr/lib64/python3.6/http/client.py", line 950, in connect (self.host,self.port), self.timeout, self.source_address) File "/usr/lib64/python3.6/socket.py", line 704, in create_connection for res in getaddrinfo(host, port, 0, SOCK_STREAM): File "/usr/lib64/python3.6/socket.py", line 745, in getaddrinfo for res in _socket.getaddrinfo(host, port, family, type, proto, flags): socket.gaierror: [Errno -2] Name or service not known During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 176, in update_check self._sync_with_server(uep, consumer_uuid) File "/usr/lib64/python3.6/site-packages/subscription_manager/facts.py", line 88, in _sync_with_server uep.updateConsumer(consumer_uuid, facts=self.get_facts()) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 1182, in updateConsumer ret = self.conn.request_put(method, params) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 906, in request_put return self._request("PUT", method, params, headers=headers) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 923, in _request info=info, headers=headers, cert_key_pairs=cert_key_pairs) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 749, in _request err)) rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known 2021-01-14 20:40:37,293 [ERROR] subscription-manager:409955:MainThread @managercli.py:218 - exception caught in subscription-manager 2021-01-14 20:40:37,293 [ERROR] subscription-manager:409955:MainThread @managercli.py:219 - Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details. Traceback (most recent call last): File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 719, in _request conn.request(request_type, handler, body=body, headers=final_headers) File "/usr/lib64/python3.6/http/client.py", line 1269, in request self._send_request(method, url, body, headers, encode_chunked) File "/usr/lib64/python3.6/http/client.py", line 1315, in _send_request self.endheaders(body, encode_chunked=encode_chunked) File "/usr/lib64/python3.6/http/client.py", line 1264, in endheaders self._send_output(message_body, encode_chunked=encode_chunked) File "/usr/lib64/python3.6/http/client.py", line 1040, in _send_output self.send(msg) File "/usr/lib64/python3.6/http/client.py", line 978, in send self.connect() File "/usr/lib64/python3.6/http/client.py", line 1429, in connect super().connect() File "/usr/lib64/python3.6/http/client.py", line 950, in connect (self.host,self.port), self.timeout, self.source_address) File "/usr/lib64/python3.6/socket.py", line 704, in create_connection for res in getaddrinfo(host, port, 0, SOCK_STREAM): File "/usr/lib64/python3.6/socket.py", line 745, in getaddrinfo for res in _socket.getaddrinfo(host, port, family, type, proto, flags): socket.gaierror: [Errno -2] Name or service not known During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 176, in update_check self._sync_with_server(uep, consumer_uuid) File "/usr/lib64/python3.6/site-packages/subscription_manager/facts.py", line 88, in _sync_with_server uep.updateConsumer(consumer_uuid, facts=self.get_facts()) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 1182, in updateConsumer ret = self.conn.request_put(method, params) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 906, in request_put return self._request("PUT", method, params, headers=headers) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 923, in _request info=info, headers=headers, cert_key_pairs=cert_key_pairs) File "/usr/lib64/python3.6/site-packages/rhsm/connection.py", line 749, in _request err)) rhsm.connection.ProxyException: Unable to connect to: bad-proxy:3129 [Errno -2] Name or service not known During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 546, in main return_code = self._do_command() File "/usr/lib64/python3.6/site-packages/subscription_manager/managercli.py", line 2953, in _do_command after_date=after_date, File "/usr/lib64/python3.6/site-packages/rhsmlib/services/entitlement.py", line 394, in get_available_pools items_per_page=_items_per_page File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 344, in get_available_entitlements items_per_page=items_per_page File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 563, in get_filtered_pools_list items_per_page=items_per_page File "/usr/lib64/python3.6/site-packages/subscription_manager/managerlib.py", line 279, in list_pools require(FACTS).update_check(uep, consumer_uuid) File "/usr/lib64/python3.6/site-packages/subscription_manager/cache.py", line 186, in update_check raise Exception(_("Error updating system data on the server, see /var/log/rhsm/rhsm.log " Exception: Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details. [root@kvm-08-guest18 ~]# Actual results: Error updating system data on the server, see /var/log/rhsm/rhsm.log for more details. Expected results: Proxy error, unable to connect to proxy server. Additional info: