cockpituous
commented
2 years ago rhel-8-7 Ooops, it happened again
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:10194/devtools/browser/5644da82-2e17-46dc-809f-69fa99ef9dd9
[0405/101455.159179:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/101455.161025:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/101455.165778:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/101455.167606:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/101455.170721:ERROR:gpu_init.cc(523)] Passthrough is not supported, GL is disabled, ANGLE is
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-o22gNbMRLd,guid=165598801472d6a0a6292917642d4a28
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> debug: Current organization: {"created": "2023-03-19T23:02:06+0000", "updated": "2023-03-19T23:02:35+0000", "id": "8ad8808986fc1ba30186fc1bd0850002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> log:
> debug: requesting update
audit: type=1400 audit(1680689878.882:6): avc: denied { create } for pid=24481 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1680689878.897:7): avc: denied { write } for pid=24481 comm="semanage" name="modules" dev="vda3" ino=17813222 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1680689928.957:8): avc: denied { read } for pid=24862 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15789 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680689928.957:9): avc: denied { open } for pid=24862 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15789 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680689928.979:10): avc: denied { ioctl } for pid=24862 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15789 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680689928.980:11): avc: denied { read } for pid=24862 comm="luksmeta" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680689928.980:12): avc: denied { open } for pid=24862 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680689962.777:15): avc: denied { write } for pid=25298 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26209 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
audit: type=1400 audit(1680689996.690:16): avc: denied { read } for pid=25434 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680689996.691:17): avc: denied { create } for pid=25434 comm="gluster" name="cli.log" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_log_t:s0 tclass=file permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2502-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680689878.882:6): avc: denied { create } for pid=24481 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2502-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680689878.882:6): avc: denied { create } for pid=24481 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [407s on 2-ci-srv-03]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-05T10:20:32.354056 | revision 9d909af52a6a84a3f89d9d2df920e07a58d4a3a1 Times recorded: 1 Latest occurrences:
- 2023-04-05T10:20:32.354056 | revision 9d909af52a6a84a3f89d9d2df920e07a58d4a3a1
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:10110/devtools/browser/f74dca3a-21ac-478e-a779-8b8eae5746e6
[0405/103435.345289:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/103435.347070:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/103435.351364:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/103435.352975:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/103435.355811:ERROR:gpu_init.cc(523)] Passthrough is not supported, GL is disabled, ANGLE is
> warning: failed to poll tuned
> debug: Reading configuration file
> debug: Trying to get current organization...
> debug: loaded client config
> debug: Current organization: {}
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-VaHW2oXr9v,guid=488356dea92a632bfedc91fc642d4ec4
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> debug: Current organization: {"created": "2023-03-19T23:02:06+0000", "updated": "2023-03-19T23:02:35+0000", "id": "8ad8808986fc1ba30186fc1bd0850002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> log:
> debug: requesting update
audit: type=1400 audit(1680691058.700:6): avc: denied { read } for pid=24471 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680691058.701:7): avc: denied { create } for pid=24471 comm="gluster" name="cli.log" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_log_t:s0 tclass=file permissive=1
audit: type=1400 audit(1680691060.285:8): avc: denied { read } for pid=24585 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15794 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680691060.285:9): avc: denied { open } for pid=24585 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15794 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680691060.305:10): avc: denied { ioctl } for pid=24585 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15794 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680691060.314:11): avc: denied { open } for pid=24585 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680691087.192:14): avc: denied { create } for pid=24865 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1680691087.215:15): avc: denied { write } for pid=24865 comm="semanage" name="modules" dev="vda3" ino=17813222 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1680691090.292:16): avc: denied { write } for pid=24883 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26195 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2502-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680691058.700:6): avc: denied { read } for pid=24471 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2502-FAIL.log.gz
[0405/104011.059485:ERROR:broker_posix.cc(40)] Recvmsg error: Connection reset by peer (104)
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680691058.700:6): avc: denied { read } for pid=24471 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [406s on 2-ci-srv-01]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-05T10:40:12.072385 | revision 3b2862a66bf7ecb4e4d19f3d6692ad61d3806232 Times recorded: 1 Latest occurrences:
- 2023-04-05T10:40:12.072385 | revision 3b2862a66bf7ecb4e4d19f3d6692ad61d3806232
# ----------------------------------------------------------------------
# testInsights (__main__.TestSubscriptions.testInsights)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:9279/devtools/browser/7c8ed7c9-a90e-47e1-9604-f8ad2cab0d87
[0405/230654.602530:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/230654.604738:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/230654.609092:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/230654.610683:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/230654.613452:ERROR:gpu_init.cc(523)] Passthrough is not supported, GL is disabled, ANGLE is
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-E5i5meLQ7N,guid=20b89d13498075722c6e40a5642dff17
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> debug: Current organization: {"created": "2023-03-19T23:02:06+0000", "updated": "2023-03-19T23:02:35+0000", "id": "8ad8808986fc1ba30186fc1bd0850002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> log:
audit: type=1400 audit(1680736128.570:4): avc: denied { write } for pid=23831 comm="platform-python" name="cache" dev="vda3" ino=233135 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir permissive=0
Wrote JS log to TestSubscriptions-testInsights-rhel-8-7-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestSubscriptions-testInsights-rhel-8-7-127.0.0.2-2301-FAIL.log.gz
Journal extracted to TestSubscriptions-testInsights-services-127.0.0.2-2302-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680736128.570:4): avc: denied { write } for pid=23831 comm="platform-python" name="cache" dev="vda3" ino=233135 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir permissive=0
Wrote screenshot to TestSubscriptions-testInsights-rhel-8-7-127.0.0.2-2301-FAIL.png
Wrote HTML dump to TestSubscriptions-testInsights-rhel-8-7-127.0.0.2-2301-FAIL.html
Wrote JS log to TestSubscriptions-testInsights-rhel-8-7-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestSubscriptions-testInsights-rhel-8-7-127.0.0.2-2301-FAIL.log.gz
Journal extracted to TestSubscriptions-testInsights-services-127.0.0.2-2302-FAIL.log.gz
[0405/230903.337551:ERROR:broker_posix.cc(40)] Recvmsg error: Connection reset by peer (104)
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680736128.570:4): avc: denied { write } for pid=23831 comm="platform-python" name="cache" dev="vda3" ino=233135 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir permissive=0
# Result testInsights (__main__.TestSubscriptions.testInsights) failed
# 1 TEST FAILED [204s on 4-cockpit-10]
not ok 1 integration-tests/check-subscriptions TestSubscriptions.testInsights $1.5First occurrence: 2023-04-05T23:09:04.138657 | revision 0918835a03c320774cda512bd838141ef0996ce0 Times recorded: 1 Latest occurrences:
- 2023-04-05T23:09:04.138657 | revision 0918835a03c320774cda512bd838141ef0996ce0
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:9544/devtools/browser/23adad7f-c50f-40fc-817d-95f3bd75eb80
[0405/230709.309293:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/230709.317274:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/230709.332383:ERROR:gpu_init.cc(523)] Passthrough is not supported, GL is disabled, ANGLE is
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-aPQBs9mp6k,guid=6ee927b6d8faf71e40ec5803642dff26
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: Current organization: {"created": "2023-03-19T23:02:06+0000", "updated": "2023-03-19T23:02:35+0000", "id": "8ad8808986fc1ba30186fc1bd0850002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> log:
> debug: requesting update
audit: type=1400 audit(1680736161.046:6): avc: denied { map } for pid=24040 comm="subscription-ma" path="/dev/mem" dev="devtmpfs" ino=9419 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:memory_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680736171.122:7): avc: denied { read } for pid=24366 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15783 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680736171.122:8): avc: denied { open } for pid=24366 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15783 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680736171.144:9): avc: denied { ioctl } for pid=24366 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15783 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680736171.155:10): avc: denied { read } for pid=24366 comm="luksmeta" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680736171.155:11): avc: denied { open } for pid=24366 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680736184.830:14): avc: denied { create } for pid=24579 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1680736184.849:15): avc: denied { write } for pid=24579 comm="semanage" name="modules" dev="vda3" ino=9264152 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1680736186.233:16): avc: denied { write } for pid=24588 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26299 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
audit: type=1400 audit(1680736248.045:17): avc: denied { read } for pid=25138 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680736248.080:18): avc: denied { create } for pid=25138 comm="gluster" name="cli.log" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_log_t:s0 tclass=file permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2502-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680736161.046:6): avc: denied { map } for pid=24040 comm="subscription-ma" path="/dev/mem" dev="devtmpfs" ino=9419 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:memory_device_t:s0 tclass=chr_file permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2501-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2502-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680736161.046:6): avc: denied { map } for pid=24040 comm="subscription-ma" path="/dev/mem" dev="devtmpfs" ino=9419 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:memory_device_t:s0 tclass=chr_file permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [387s on rhos-01-16]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-05T23:11:19.855388 | revision 0918835a03c320774cda512bd838141ef0996ce0 Times recorded: 1 Latest occurrences:
- 2023-04-05T23:11:19.855388 | revision 0918835a03c320774cda512bd838141ef0996ce0
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:9798/devtools/browser/6814a47c-e38e-41fb-a46c-c9a26eb132b8
[0405/231017.732639:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/231017.734772:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/231017.743084:ERROR:egl_util.cc(44)] Failed to load GLES library: /usr/lib64/chromium-browser/libGLESv2.so: /usr/lib64/chromium-browser/libGLESv2.so: cannot open shared object file: No such file or directory
[0405/231017.745622:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[0405/231017.750172:ERROR:gpu_init.cc(523)] Passthrough is not supported, GL is disabled, ANGLE is
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-37G1bJ4i85,guid=312fd71b6495c645b58d3da8642dffe3
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> debug: Current organization: {"created": "2023-03-19T23:02:06+0000", "updated": "2023-03-19T23:02:35+0000", "id": "8ad8808986fc1ba30186fc1bd0850002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> log:
> debug: requesting update
audit: type=1400 audit(1680736402.540:6): avc: denied { read } for pid=24454 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15805 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680736402.540:7): avc: denied { open } for pid=24454 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15805 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680736402.558:8): avc: denied { ioctl } for pid=24454 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15805 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1680736402.565:9): avc: denied { read } for pid=24454 comm="luksmeta" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680736402.565:10): avc: denied { open } for pid=24454 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1680736495.815:11): avc: denied { create } for pid=25187 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1680736495.839:12): avc: denied { write } for pid=25187 comm="semanage" name="modules" dev="vda3" ino=9264152 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1680736501.015:15): avc: denied { write } for pid=25251 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26222 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2201-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2201-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2202-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680736402.540:6): avc: denied { read } for pid=24454 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15805 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2201-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2201-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2201-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2201-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2202-FAIL.log.gz
[0405/231603.567969:ERROR:broker_posix.cc(40)] Recvmsg error: Connection reset by peer (104)
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1680736402.540:6): avc: denied { read } for pid=24454 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15805 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [423s on 4-cockpit-10]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-05T23:16:04.703855 | revision 0918835a03c320774cda512bd838141ef0996ce0 Times recorded: 1 Latest occurrences:
- 2023-04-05T23:16:04.703855 | revision 0918835a03c320774cda512bd838141ef0996ce0
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
> https://cockpit-images.eu-central-1.linodeobjects.com/ (authenticated)
> https://cockpit-images.us-east-1.linodeobjects.com/ (authenticated)
x http://10.0.190.233/images/
=> https://cockpit-images.us-east-1.linodeobjects.com/services-02be8481bcd0173870b75b1b4edc084452f490d826ecda6b03582aa6003c2cdd.qcow2
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:9732/devtools/browser/b44cabbb-ad97-488f-b95c-b743d2e7cab7
[0413/230735.810568:WARNING:sandbox_linux.cc(393)] InitializeSandbox() called with multiple threads in process gpu-process.
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-iG4PCR3ipi,guid=6c051cc74fc8a717acc5898b64388b3f
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: Current organization: {"created": "2023-04-06T09:10:36+0000", "updated": "2023-04-06T09:10:50+0000", "id": "8a8181bd8755d4f1018755d503180002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> log:
> debug: requesting update
audit: type=1400 audit(1681427385.414:6): avc: denied { map } for pid=24080 comm="subscription-ma" path="/dev/mem" dev="devtmpfs" ino=9419 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:memory_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681427402.231:7): avc: denied { create } for pid=24443 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1681427402.308:8): avc: denied { write } for pid=24443 comm="semanage" name="modules" dev="vda3" ino=9263947 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1681427408.319:9): avc: denied { read } for pid=24535 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15765 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681427408.319:10): avc: denied { open } for pid=24535 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15765 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681427408.343:11): avc: denied { ioctl } for pid=24535 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15765 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681427408.355:12): avc: denied { read } for pid=24535 comm="luksmeta" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681427408.355:13): avc: denied { open } for pid=24535 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681427469.820:16): avc: denied { write } for pid=25043 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26310 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
audit: type=1400 audit(1681427472.913:17): avc: denied { read } for pid=25229 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681427472.913:18): avc: denied { create } for pid=25229 comm="gluster" name="cli.log" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_log_t:s0 tclass=file permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2401-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2402-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1681427385.414:6): avc: denied { map } for pid=24080 comm="subscription-ma" path="/dev/mem" dev="devtmpfs" ino=9419 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:memory_device_t:s0 tclass=chr_file permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2401-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2401-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2401-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2402-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1681427385.414:6): avc: denied { map } for pid=24080 comm="subscription-ma" path="/dev/mem" dev="devtmpfs" ino=9419 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:memory_device_t:s0 tclass=chr_file permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [394s on rhos-01-8]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-13T23:11:36.765742 | revision 0336f152363506427c9ba7faf0999faf9e8bf66b Times recorded: 1 Latest occurrences:
- 2023-04-13T23:11:36.765742 | revision 0336f152363506427c9ba7faf0999faf9e8bf66b
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:9806/devtools/browser/9293faec-f4a9-4cce-8ab2-c6dd3c8dadc1
[0413/230800.749086:WARNING:sandbox_linux.cc(393)] InitializeSandbox() called with multiple threads in process gpu-process.
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-ri89rkwOSD,guid=66a50aa853de3610a45766e164388b5b
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> debug: Current organization: {"created": "2023-04-06T09:10:36+0000", "updated": "2023-04-06T09:10:50+0000", "id": "8a8181bd8755d4f1018755d503180002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> log:
> debug: requesting update
audit: type=1400 audit(1681427468.062:6): avc: denied { read } for pid=24450 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681427468.062:7): avc: denied { create } for pid=24450 comm="gluster" name="cli.log" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_log_t:s0 tclass=file permissive=1
audit: type=1400 audit(1681427492.542:8): avc: denied { read } for pid=24641 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15795 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681427492.542:9): avc: denied { open } for pid=24641 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15795 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681427492.563:10): avc: denied { ioctl } for pid=24641 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15795 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681427492.572:11): avc: denied { open } for pid=24641 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681427509.053:12): avc: denied { write } for pid=24830 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26209 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
audit: type=1400 audit(1681427571.571:13): avc: denied { create } for pid=25208 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1681427571.649:14): avc: denied { write } for pid=25208 comm="semanage" name="modules" dev="vda3" ino=9263947 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2301-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2302-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1681427468.062:6): avc: denied { read } for pid=24450 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2301-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2301-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2301-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2302-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1681427468.062:6): avc: denied { read } for pid=24450 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [421s on 2-cockpit-7]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-13T23:13:38.713148 | revision 0336f152363506427c9ba7faf0999faf9e8bf66b Times recorded: 1 Latest occurrences:
- 2023-04-13T23:13:38.713148 | revision 0336f152363506427c9ba7faf0999faf9e8bf66b
# ----------------------------------------------------------------------
# testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail)
Waiting 5 seconds for https://10.111.112.100:8443/candlepin
Waiting for https://10.111.112.100:8443/candlepin
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
/usr/lib/python3.6/site-packages/urllib3/connectionpool.py:847: InsecureRequestWarning: Unverified HTTPS request is being made. Adding certificate verification is strongly advised. See: https://urllib3.readthedocs.io/en/latest/advanced-usage.html#ssl-warnings
InsecureRequestWarning)
DevTools listening on ws://127.0.0.1:9547/devtools/browser/e43413d4-23dd-4228-895e-2110e7a2e171
[0414/074628.684704:WARNING:sandbox_linux.cc(393)] InitializeSandbox() called with multiple threads in process gpu-process.
> warning: failed to poll tuned
> debug: Trying to get current organization...
> debug: Reading configuration file
> debug: Current organization: {}
> debug: loaded client config
> debug: Other state: unknown
> debug: connection_options:
> debug: Opening private bus interface at unix:abstract=/run/dbus-L26FY3NDl7,guid=0e294a4089f89de7e0884dd8643904de
> debug: registering using username and password
> log: registration_options:
> debug: Result of registration:
> debug: stopping registration server
> debug: saving: server.hostname
> debug: saving: server.port
> debug: saving: server.prefix
> debug: requesting update of subscription status
> debug: requesting update of syspurpose status
> debug: Current organization: {"created": "2023-04-06T09:10:36+0000", "updated": "2023-04-06T09:10:50+0000", "id": "8a8181bd8755d4f1018755d503180002", "displayName": "Admin Owner", "key": "admin", "contentPrefix": null, "defaultServiceLevel": null, "logLevel": null, "contentAccessMode": "entitlement", "contentAccessModeList": "entitlement", "autobindHypervisorDisabled": false, "autobindDisabled": false, "lastRefreshed": null, "parentOwner": null, "upstreamConsumer": null}
> log:
> debug: requesting update
audit: type=1400 audit(1681458537.966:6): avc: denied { create } for pid=24499 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
audit: type=1400 audit(1681458537.982:7): avc: denied { write } for pid=24499 comm="semanage" name="modules" dev="vda3" ino=9263947 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1681458537.982:8): avc: denied { write } for pid=24499 comm="semanage" name="modules" dev="vda3" ino=9263947 scontext=system_u:system_r:insights_client_t:s0 tcontext=unconfined_u:object_r:semanage_store_t:s0 tclass=dir permissive=1
audit: type=1400 audit(1681458540.961:11): avc: denied { write } for pid=24579 comm="vdo" name="_etc_vdoconf.yml.lock" dev="tmpfs" ino=26415 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:var_lock_t:s0 tclass=file permissive=1
audit: type=1400 audit(1681458543.356:12): avc: denied { read } for pid=24677 comm="gluster" name="random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
audit: type=1400 audit(1681458547.862:13): avc: denied { read } for pid=24856 comm="luksmeta" name="sr0" dev="devtmpfs" ino=15801 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681458547.862:14): avc: denied { open } for pid=24856 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15801 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681458547.892:15): avc: denied { ioctl } for pid=24856 comm="luksmeta" path="/dev/sr0" dev="devtmpfs" ino=15801 ioctlcmd=0x1268 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:removable_device_t:s0 tclass=blk_file permissive=1
audit: type=1400 audit(1681458547.907:16): avc: denied { open } for pid=24856 comm="luksmeta" path="/dev/random" dev="devtmpfs" ino=9424 scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:object_r:random_device_t:s0 tclass=chr_file permissive=1
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2601-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2601-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2602-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1681458537.966:6): avc: denied { create } for pid=24499 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
Wrote screenshot to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2601-FAIL.png
Wrote HTML dump to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2601-FAIL.html
Wrote JS log to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2601-FAIL.js.log
Journal extracted to TestSubscriptions-testSubAndInAndFail-rhel-8-7-127.0.0.2-2601-FAIL.log.gz
Journal extracted to TestSubscriptions-testSubAndInAndFail-services-127.0.0.2-2602-FAIL.log.gz
Traceback (most recent call last):
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1561, in tearDown
self.check_journal_messages()
File "/work/bots/make-checkout-workdir/integration-tests/common/testlib.py", line 1772, in check_journal_messages
raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1681458537.966:6): avc: denied { create } for pid=24499 comm="semanage" scontext=system_u:system_r:insights_client_t:s0 tcontext=system_u:system_r:insights_client_t:s0 tclass=netlink_audit_socket permissive=1
# Result testSubAndInAndFail (__main__.TestSubscriptions.testSubAndInAndFail) failed
# 1 TEST FAILED [406s on rhos-01-2]
not ok 5 integration-tests/check-subscriptions TestSubscriptions.testSubAndInAndFail $1.5First occurrence: 2023-04-14T07:50:42.873807 | revision f6508f1909fc15c0752265b1d482888056bc428c Times recorded: 1 Latest occurrences:
- 2023-04-14T07:50:42.873807 | revision f6508f1909fc15c0752265b1d482888056bc428c
mvollmer
Downstream reports
RHEL 8.7: https://bugzilla.redhat.com/show_bug.cgi?id=2124550 RHEL 9.1: https://bugzilla.redhat.com/show_bug.cgi?id=2124549