2034601 – RHSM DBus API is not available via lorax

RHEL Engineering is moving the tracking of its product development work on RHEL 6 through RHEL 9 to Red Hat Jira (issues.redhat.com). If you're a Red Hat customer, please continue to file support cases via the Red Hat customer portal. If you're not, please head to the "RHEL project" in Red Hat Jira and file new tickets here. Individual Bugzilla bugs in the statuses "NEW", "ASSIGNED", and "POST" are being migrated throughout September 2023. Bugs of Red Hat partners with an assigned Engineering Partner Manager (EPM) are migrated in late September as per pre-agreed dates. Bugs against components "kernel", "kernel-rt", and "kpatch" are only migrated if still in "NEW" or "ASSIGNED". If you cannot log in to RH Jira, please consult article #7032570. That failing, please send an e-mail to the RH Jira admins at rh-issues@redhat.com to troubleshoot your issue as a user management inquiry. The email creates a ServiceNow ticket with Red Hat. Individual Bugzilla bugs that are migrated will be moved to status "CLOSED", resolution "MIGRATED", and set with "MigratedToJIRA" in "Keywords". The link to the successor Jira issue will be found under "Links", have a little "two-footprint" icon next to it, and direct you to the "RHEL project" in Red Hat Jira (issue links are of type "https://issues.redhat.com/browse/RHEL-XXXX", where "X" is a digit). This same link will be available in a blue banner at the top of the page informing you that that bug has been migrated.

Bug 2034601 - RHSM DBus API is not available via lorax

Summary: RHSM DBus API is not available via lorax

Keywords:
Status:	CLOSED WONTFIX
Alias:	None
Product:	Red Hat Enterprise Linux 8
Classification:	Red Hat
Component:	anaconda
Sub Component:
Version:	8.5
Hardware:	Unspecified
OS:	Unspecified
Priority:	unspecified
Severity:	unspecified
Target Milestone:	rc
Target Release:	---
Assignee:	Anaconda Maintenance Team
QA Contact:	Release Test Team
Docs Contact:
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+	depends on / blocked

Reported:	2021-12-21 13:22 UTC by Lukas Zapletal
Modified:	2023-06-21 07:28 UTC (History)
CC List:	2 users (show)
Fixed In Version:
Doc Type:	If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed:	2023-06-21 07:28:16 UTC
Type:	Bug
Target Upstream Version:
Embargoed:
Dependent Products:
Flags:	pm-rhel: mirror+

Attachments	(Terms of Use)

Links
System	ID	Private	Priority	Status	Summary	Last Updated
Red Hat Issue Tracker	RHELPLAN-106345	0	None	None	None	2021-12-21 13:25:56 UTC

Description Lukas Zapletal 2021-12-21 13:22:31 UTC

Hello,

I am working on upgrading our Satellite Discovery LiveCD image from EL7 to EL8. For Satellite we use RHEL, upstream we use CentOS to build upstream images. My first goal is to bring the image to build upstream, then I can move to downstream, therefore apologies for reporting this on CentOS 8 (8.5) rather than RHEL, I can reproduce on RHEL 8 if needed.

The symptoms are the same as in: https://bugzilla.redhat.com/show_bug.cgi?id=1957063 (this BZ was filed against RHEL9).

Fresh CentOS 8.5 installation, installed lorax, anaconda and started build:

# livemedia-creator --ks fdi-image.ks --make-iso --no-virt --nomacboot --extra-boot-args 'nomodeset nokaslr' --project FDI --dracut-arg=--xz --dracut-arg=--no-hostonly --dracut-arg=--debug --dracut-arg=--no-early-microcode '--dracut-arg=--omit plymouth' '--dracut-arg=--add livenet dmsquash-live convertfs pollcdrom qemu qemu-net mptbase mptscsih mptspi hv_storvsc hid_hyperv hv_netvsc hv_vmbus'

2021-12-21 14:17:50,318: livemedia-creator v28.14.62-1
2021-12-21 14:17:50,319: selinux is enabled and in Permissive mode
2021-12-21 14:17:50,461: disk_img = /var/tmp/lmc-disk-9izy4g15.img
2021-12-21 14:17:50,461: Using disk size of 3002MiB
2021-12-21 14:17:51,002: Running anaconda.
2021-12-21 14:17:56,055: Starting installer, one moment...
2021-12-21 14:17:56,056: terminal size detection failed, using default width
2021-12-21 14:17:56,056: anaconda 33.16.5.6-1.el8 for FDI 8 (pre-release) started.
2021-12-21 14:17:56,056: 14:17:56 Running pre-installation scripts
2021-12-21 14:17:56,531: Processing logs from ('127.0.0.1', 35846)
2021-12-21 14:17:56,597: 14:17:56 Not asking for VNC because of an automated install
2021-12-21 14:18:11,800: Starting automated install..........Unable to init server: Could not connect: Connection refused
2021-12-21 14:18:11,827: Unable to init server: Could not connect: Connection refused
2021-12-21 14:18:11,828: Unable to init server: Could not connect: Connection refused
2021-12-21 14:18:12,720: Unable to init server: Could not connect: Connection refused
2021-12-21 14:21:13,861:
2021-12-21 14:21:13,861: ================================================================================
2021-12-21 14:21:13,861: ================================================================================
2021-12-21 14:21:13,861: Installation
2021-12-21 14:21:13,861:
2021-12-21 14:21:13,861: 1) [x] Language settings                 2) [x] Time settings
2021-12-21 14:21:13,862: (English (United States))                (Etc/UTC timezone)
2021-12-21 14:21:13,862: 3) [x] Installation source               4) [x] Software selection
2021-12-21 14:21:13,862: (http://mirrorlist.centos.org/?r         (Custom software selected)
2021-12-21 14:21:13,862: elease=8&arch=$basearch&repo=bas
2021-12-21 14:21:13,862: eos)
2021-12-21 14:21:13,862: 5) [ ] User creation
2021-12-21 14:21:13,862: (No user will be created)
2021-12-21 14:21:13,862:
2021-12-21 14:21:13,862: ================================================================================
2021-12-21 14:21:13,862: ================================================================================
2021-12-21 14:21:13,863: Progress
2021-12-21 14:21:13,863:
2021-12-21 14:21:13,863:
2021-12-21 14:21:13,863: Running in cmdline mode, no interactive debugging allowed.
2021-12-21 14:21:13,863: The exact error message is:
2021-12-21 14:21:13,863:
2021-12-21 14:21:13,863: The RHSM DBus API is not available..
2021-12-21 14:21:13,863:
2021-12-21 14:21:13,863: The installer will now terminate.
2021-12-21 14:21:13,864: Error in atexit._run_exitfuncs:
2021-12-21 14:21:13,864: Traceback (most recent call last):
2021-12-21 14:21:13,864: File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 477, in _get_method_reply
2021-12-21 14:21:13,864: return self._handle_method_error(error)
2021-12-21 14:21:13,864: File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 497, in _handle_method_error
2021-12-21 14:21:13,865: raise exception from None
2021-12-21 14:21:13,865: dasbus.error.DBusError: umount of /run/user/0 failed (32)
2021-12-21 14:21:13,994: Running anaconda failed: process '['anaconda', '--kickstart', '/root/fdi-image.ks', '--cmdline', '--loglevel', 'debug', '--dirinstall', '--remotelog', '127.0.0.1:49421']' exited with status 1
2021-12-21 14:21:13,995: Shutting down log processing
2021-12-21 14:21:14,253: Install failed: novirt_install failed
2021-12-21 14:21:14,254: Removing bad disk image
2021-12-21 14:21:14,254: ERROR: Image creation failed: novirt_install failed
2021-12-21 14:21:14,254: Image creation failed: novirt_install failed

Logs:

==> /tmp/anaconda.log <==
14:18:01,249 INF lifecycle: Module initialized: LangSpoke
14:18:01,254 INF lifecycle: Module initialized: TimeSpoke
14:18:01,255 INF threading: Running Thread: AnaSourceWatcher (140377239578368)
14:18:01,255 INF threading: Running Thread: AnaSoftwareWatcher (140377247971072)
14:18:01,261 WRN ui.tui.hubs: Spoke StorageSpoke initialization failure!
14:18:01,264 INF lifecycle: Module initialized: PasswordSpoke
14:18:01,267 WRN ui.tui.hubs: Spoke PasswordSpoke initialization failure!
14:18:01,272 INF lifecycle: Module initialized: UserSpoke
14:18:01,275 INF lifecycle: Initialization of all modules (6) has been started.

==> /tmp/packaging.log <==
14:18:01,924 DBG dnf: anaconda: using metadata from Fri 10 Dec 2021 02:03:32 PM CET.
14:18:01,924 DBG dnf: repo: using cache for: AppStream
14:18:03,865 DBG dnf: AppStream: using metadata from Fri 10 Dec 2021 02:03:48 PM CET.
14:18:03,865 DBG dnf: repo: using cache for: epel8
14:18:07,391 DBG dnf: epel8: using metadata from Tue 21 Dec 2021 02:28:09 AM CET.
14:18:07,391 DBG dnf: repo: using cache for: foreman-el8
14:18:07,842 DBG dnf: foreman-el8: using metadata from Mon 20 Dec 2021 10:50:53 PM CET.
14:18:07,842 DBG dnf: repo: using cache for: foreman-plugins-el8
14:18:08,517 DBG dnf: foreman-plugins-el8: using metadata from Mon 20 Dec 2021 10:52:03 PM CET.
14:18:08,517 INF dnf: Last metadata expiration check: 0:00:04 ago on Tue 21 Dec 2021 02:18:01 PM CET.
14:18:08,520 DBG dnf: User-Agent: constructed: 'libdnf (CentOS Linux 8; generic; Linux.x86_64)'
14:18:09,634 DDEBUG dnf: timer: sack setup: 8419 ms
14:18:09,635 DDEBUG dnf: Getting group metadata
14:18:09,635 DDEBUG dnf: Adding group file from repository: anaconda
14:18:09,646 DDEBUG dnf: Adding group file from repository: AppStream
14:18:09,667 DDEBUG dnf: Adding group file from repository: epel8
14:18:09,678 DDEBUG dnf: Adding group file from repository: foreman-el8
14:18:09,686 DDEBUG dnf: Adding group file from repository: foreman-plugins-el8
14:18:09,698 DDEBUG dnf: timer: loading comps: 63 ms
14:18:09,699 INF packaging: Refreshing environment_addons
14:18:09,901 INF packaging: Failed to parse proxy for test if repo available : No host url
14:18:09,901 INF packaging: Failed to parse proxy for test if repo available : No host url
14:18:09,901 INF packaging: Failed to parse proxy for test if repo available : No host url
14:18:09,902 INF packaging: Failed to parse proxy for test if repo available : No host url
14:18:10,264 INF packaging: Failed to parse proxy for test if repo available : No host url

==> /tmp/anaconda.log <==
14:18:10,753 DBG payload.manager: Updating payload thread state: FINISHED
14:18:10,753 DBG ui.tui.spokes.software_selection: Payload restarted, set new info and clear the old one.
14:18:10,753 INF threading: Thread Done: AnaPayloadThread (140377333655296)
14:18:10,753 DBG ui.tui.spokes.software_selection: Apply called old env None, new env None and addons set()
14:18:10,754 INF lifecycle: Module initialized: SoftwareSpoke
14:18:10,754 INF threading: Thread Done: AnaSoftwareWatcher (140377247971072)
14:18:10,758 INF lifecycle: Module initialized: SourceSpoke
14:18:10,758 INF lifecycle: All modules have been initialized.
14:18:10,758 INF threading: Thread Done: AnaSourceWatcher (140377239578368)
14:18:11,638 DBG simpleline: Scheduling screen SummaryHub
14:18:11,638 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
14:18:11,639 DBG simpleline: Scheduling screen ProgressSpoke
14:18:11,639 DBG simpleline: Starting main loop
14:18:11,640 DBG simpleline: Processing screen ScreenData(SummaryHub,None,False)
14:18:11,698 DBG simpleline: Input is required by ScreenData(SummaryHub,None,False) screen
14:18:11,715 DBG simpleline: New signal CloseScreenSignal enqueued with source SummaryHub
14:18:11,715 DBG simpleline: Closing screen ScreenData(SummaryHub,None,False) from SummaryHub
14:18:11,715 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
14:18:11,716 DBG simpleline: Processing screen ScreenData(ProgressSpoke,None,False)
14:18:11,717 INF threading: Running Thread: AnaInstallThread (140377239578368)

==> /tmp/storage.log <==
DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Task/1.
DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Task/2.
DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Task/3.
DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Task/4.

==> /tmp/anaconda.log <==
14:18:11,768 INF threading: Thread Failed: AnaInstallThread (140377239578368)
14:18:11,768 DBG exception: running handleException
14:18:11,769 CRT exception: Traceback (most recent call last):

  File "/usr/lib64/python3.6/site-packages/pyanaconda/threading.py", line 280, in run
    threading.Thread.run(self)

  File "/usr/lib64/python3.6/threading.py", line 867, in run
    self._target(*self._args, **self._kwargs)

  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation.py", line 385, in run_installation
    queue.append(_prepare_configuration(payload, ksdata))

  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation.py", line 88, in _prepare_configuration
    subscription_dbus_tasks = subscription_proxy.InstallWithTasks()

  File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 447, in _call_method
    **kwargs,

  File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 477, in _get_method_reply
    return self._handle_method_error(error)

  File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 497, in _handle_method_error
    raise exception from None

dasbus.error.DBusError: The RHSM DBus API is not available.

14:18:11,828 DBG exception: Gtk cannot be initialized
14:18:11,828 DBG exception: In a non-main thread, sending a message with exception data
14:18:11,828 DBG simpleline: New signal ExceptionSignal enqueued with source ScreenScheduler
14:18:11,828 INF threading: Thread Done: AnaInstallThread (140377239578368)
14:18:12,719 DBG simpleline: Executing inner loop
14:18:12,719 DBG simpleline: New signal ExceptionSignal enqueued with source ScreenScheduler
14:18:12,719 ERR ui.tui:
======= Screen stack =======
----------- TOP ------------
ScreenData(ProgressSpoke,None,False)
============================

14:18:12,719 DBG exception: running handleException
14:18:12,720 CRT exception: Traceback (most recent call last):

  File "/usr/lib64/python3.6/site-packages/pyanaconda/threading.py", line 280, in run
    threading.Thread.run(self)

  File "/usr/lib64/python3.6/threading.py", line 867, in run
    self._target(*self._args, **self._kwargs)

  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation.py", line 385, in run_installation
    queue.append(_prepare_configuration(payload, ksdata))

  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation.py", line 88, in _prepare_configuration
    subscription_dbus_tasks = subscription_proxy.InstallWithTasks()

  File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 447, in _call_method
    **kwargs,

  File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 477, in _get_method_reply
    return self._handle_method_error(error)

  File "/usr/lib/python3.6/site-packages/dasbus/client/handler.py", line 497, in _handle_method_error
    raise exception from None

dasbus.error.DBusError: The RHSM DBus API is not available.

14:18:12,720 DBG exception: Gtk cannot be initialized
14:18:12,720 DBG exception: In the main thread, running exception handler
14:18:12,721 INF core.util: Running kickstart %%onerror script(s)
14:18:12,721 INF core.util: All kickstart %%onerror script(s) have been run
14:18:12,721 INF kickstart.script: Running kickstart %%traceback script(s)
14:18:12,721 INF kickstart.script: All kickstart %%traceback script(s) have been run

==> /tmp/packaging.log <==
14:21:12,821 DBG dnf: User-Agent: constructed: 'libdnf (CentOS Linux 8; generic; Linux.x86_64)'
14:21:12,824 INF packaging: setting DNF platform id to: platform:el8
14:21:12,824 DBG packaging: getting release version from tree at None (8)
14:21:12,824 DBG packaging: using default release version of 8
14:21:12,833 DDEBUG dnf: Getting group metadata
14:21:12,833 DDEBUG dnf: timer: loading comps: 0 ms

==> /tmp/dnf.librepo.log <==
14:21:12,833 INF librepo: Librepo version: 1.14.0 with CURL_GLOBAL_ACK_EINTR support (libcurl/7.61.1 OpenSSL/1.1.1k zlib/1.2.11 brotli/1.0.6 libidn2/2.2.0 libpsl/0.20.2 (+libidn2/2.2.0) libssh/0.9.4/openssl/zlib nghttp2/1.33.0)

==> /tmp/packaging.log <==
14:21:12,835 DBG packaging: Dnf configuration:
[main]
allow_vendor_change = 1
assumeno = 0
assumeyes = 0
autocheck_running_kernel = 1
bandwidth = 0
best = 0
bugtracker_url = https://bugzilla.redhat.com/enter_bug.cgi?product=Fedora&component=dnf
cachedir = /tmp/dnf.cache
cacheonly = 0
check_config_file_age = 1
clean_requirements_on_remove = 1
color = auto
color_list_available_downgrade = magenta
color_list_available_install = bold,cyan
color_list_available_reinstall = bold,underline,green
color_list_available_upgrade = bold,blue
color_list_installed_extra = bold,red
color_list_installed_newer = bold,yellow
color_list_installed_older = yellow
color_list_installed_reinstall = cyan
color_search_match = bold,magenta
color_update_installed = red
color_update_local = green
color_update_remote = bold,green
config_file_path = /etc/dnf/dnf.conf
countme = 0
debug_solver = 0
debuglevel = 2
defaultyes = 0
deltarpm = 1
deltarpm_percentage = 75
disable_excludes =
diskspacecheck = 1
enabled = 1
enablegroups = 1
errorlevel = 3
exclude =
excludepkgs =
exit_on_lock = 0
fastestmirror = 0
gpgcheck = 0
gpgkey_dns_verification = 0
group_package_types = mandatory, default, conditional
history_list_view = commands
history_record = 1
history_record_packages = dnf, rpm
ignorearch = 0
includepkgs =
install_weak_deps = 1
installonly_limit = 3
installonlypkgs = kernel, kernel-PAE, installonlypkg(kernel), installonlypkg(kernel-module), installonlypkg(vm), multiversion(kernel)
installroot = /mnt/sysroot
ip_resolve = whatever
keepcache = 0
localpkg_gpgcheck = 0
log_compress = 0
log_rotate = 4
log_size = 1048576
logdir = /tmp/
logfilelevel = 9
max_parallel_downloads = 3
metadata_expire = 172800
metadata_timer_sync = 10800
minrate = 1000
module_obsoletes = 0
module_platform_id = platform:el8
module_stream_switch = 0
multilib_policy = best
obsoletes = 1
password =
persistdir = /mnt/sysroot/var/lib/dnf
pluginconfpath = /tmp/dnf.pluginconf
pluginpath = /usr/lib/python3.6/site-packages/dnf-plugins
plugins = 1
protect_running_kernel = 1
protected_packages = dnf, dnf, setup, systemd, systemd-udev, sudo, yum, dnf, setup, systemd, systemd-udev, sudo, yum
proxy =
proxy_auth_method = any
proxy_sslcacert =
proxy_sslclientcert =
proxy_sslclientkey =
proxy_sslverify = 1
recent = 7
repo_gpgcheck = 0
reposdir = /etc/yum.repos.d, /etc/anaconda.repos.d, /tmp/updates/anaconda.repos.d, /tmp/product/anaconda.repos.d
reset_nice = 1
retries = 10
rpmverbosity = info
showdupesfromrepos = 0
skip_broken = 0
skip_if_unavailable = 0
sslcacert =
sslclientcert =
sslclientkey =
sslverify = 1
sslverifystatus = 0
strict = 1
system_cachedir = /var/cache/dnf
throttle = 0
timeout = 30
transformdb = 1
tsflags =
upgrade_group_objects_upgrade = 1
user_agent = libdnf (CentOS Linux 8; generic; Linux.x86_64)
username =
varsdir = /etc/yum/vars, /etc/dnf/vars
zchunk = 1


==> /tmp/storage.log <==
DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Task/5.
DEBUG:dasbus.connection:Publishing an object at /org/fedoraproject/Anaconda/Modules/Storage/Task/6.
INFO:anaconda.threading:Running Thread: AnaTaskThread-UnmountFilesystemsTask-1 (140339052799744)
DEBUG:blivet:               BindFS.supported: supported: False ;
DEBUG:blivet:get_format('bind') returning BindFS instance with object id 4
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 6
DEBUG:blivet:                  DirectoryDevice._set_format: /dev ; type: bind ; current: None ;
DEBUG:blivet:updated /dev size to 3.5 KiB (3.5 KiB)
DEBUG:blivet:                   TmpFS.supported: supported: True ;
DEBUG:blivet:get_format('tmpfs') returning TmpFS instance with object id 8
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 10
DEBUG:blivet:                  NoDevice._set_format: tmpfs ; type: tmpfs ; current: None ;
DEBUG:blivet:                 DevPtsFS.supported: supported: False ;
DEBUG:blivet:get_format('devpts') returning DevPtsFS instance with object id 12
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 14
DEBUG:blivet:                  NoDevice._set_format: devpts ; type: devpts ; current: None ;
DEBUG:blivet:                 SysFS.supported: supported: False ;
DEBUG:blivet:get_format('sysfs') returning SysFS instance with object id 16
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 18
DEBUG:blivet:                  NoDevice._set_format: sysfs ; type: sysfs ; current: None ;
DEBUG:blivet:                 ProcFS.supported: supported: False ;
DEBUG:blivet:get_format('proc') returning ProcFS instance with object id 20
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 22
DEBUG:blivet:                  NoDevice._set_format: proc ; type: proc ; current: None ;
DEBUG:blivet:                 USBFS.supported: supported: False ;
DEBUG:blivet:get_format('usbfs') returning USBFS instance with object id 24
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 26
DEBUG:blivet:                  NoDevice._set_format: usbfs ; type: usbfs ; current: None ;
DEBUG:blivet:                 SELinuxFS.supported: supported: False ;
DEBUG:blivet:get_format('selinuxfs') returning SELinuxFS instance with object id 28
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 30
DEBUG:blivet:                  NoDevice._set_format: selinuxfs ; type: selinuxfs ; current: None ;
DEBUG:blivet:               BindFS.supported: supported: False ;
DEBUG:blivet:get_format('bind') returning BindFS instance with object id 32
DEBUG:blivet:get_format('None') returning DeviceFormat instance with object id 34
DEBUG:blivet:                  DirectoryDevice._set_format: /run ; type: bind ; current: None ;
DEBUG:blivet:updated /run size to 1.21 KiB (1.21 KiB)
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
DEBUG:blivet:           SELinuxFS.teardown: device: selinuxfs ; type: selinuxfs ; status: False ;
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
DEBUG:blivet:           SysFS.teardown: device: sysfs ; type: sysfs ; status: False ;
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
DEBUG:blivet:           BindFS.teardown: device: /run ; type: bind ; status: False ;
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
DEBUG:blivet:           ProcFS.teardown: device: proc ; type: proc ; status: False ;
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
DEBUG:testdata:sysfs attr /sys/class/block/sdb/device/model: 436f6d7061637420466c6173682020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdc/device/model: 534d2f78442d506963747572652020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdd/device/model: 53442f4d4d43202020202020202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sde/device/model: 4d532f4d532d50726f2f4847202020200a
DEBUG:testdata:sysfs attr /sys/class/block/sdf/device/model: 53442f4d4d432f4d532f4d5350524f200a
DEBUG:testdata:sysfs attr /sys/class/block/sda/device/model: 486974616368692048445337323130350a
DEBUG:testdata:sysfs attr /sys/class/block/sr0/device/model: 4344445644572054532d48363533544e0a
DEBUG:blivet:           TmpFS.teardown: device: tmpfs ; type: tmpfs ; status: True ;
INFO:program:Running... udevadm settle --timeout=300
DEBUG:program:Return code: 0
INFO:program:Running... umount /run/user/0
INFO:program:stderr:
INFO:program:b'umount: /run/user/0: target is busy.'
DEBUG:program:Return code: 32
INFO:program:Running... lsof /run/user/0
DEBUG:program:Return code: 1
INFO:anaconda.threading:Thread Failed: AnaTaskThread-UnmountFilesystemsTask-1 (140339052799744)
ERROR:anaconda.modules.common.task.task:Thread AnaTaskThread-UnmountFilesystemsTask-1 has failed: Traceback (most recent call last):
  File "/usr/lib64/python3.6/site-packages/pyanaconda/threading.py", line 280, in run
    threading.Thread.run(self)
  File "/usr/lib64/python3.6/threading.py", line 867, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/common/task/task.py", line 97, in _task_run_callback
    self._set_result(self.run())
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/storage/teardown.py", line 43, in run
    self._storage.umount_filesystems(swapoff=False)
  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
    return m(*args, **kwargs)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/storage/devicetree/model.py", line 441, in umount_filesystems
    self.fsset.umount_filesystems(swapoff=swapoff)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/storage/devicetree/fsset.py", line 579, in umount_filesystems
    device.format.teardown()
  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
    return m(*args, **kwargs)
  File "/usr/lib/python3.6/site-packages/blivet/formats/__init__.py", line 653, in teardown
    self._teardown(**kwargs)
  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
    return m(*args, **kwargs)
  File "/usr/lib/python3.6/site-packages/blivet/formats/fs.py", line 629, in _teardown
    raise FSError("umount of %s failed (%d)" % (mountpoint, rc))
blivet.errors.FSError: umount of /run/user/0 failed (32)

INFO:anaconda.threading:Thread Done: AnaTaskThread-UnmountFilesystemsTask-1 (140339052799744)
WARNING:dasbus.server.handler:The call org.fedoraproject.Anaconda.Task.Finish has failed with an exception:
Traceback (most recent call last):
  File "/usr/lib/python3.6/site-packages/dasbus/server/handler.py", line 421, in _method_callback
    *unwrap_variant(parameters)
  File "/usr/lib/python3.6/site-packages/dasbus/server/handler.py", line 234, in _handle_call
    return handler(*parameters)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/common/task/task_interface.py", line 114, in Finish
    self.implementation.finish()
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/common/task/task.py", line 161, in finish
    threadMgr.raise_if_error(self._thread_name)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/threading.py", line 171, in raise_if_error
    raise exc_info[0](exc_info[1]).with_traceback(exc_info[2])
  File "/usr/lib64/python3.6/site-packages/pyanaconda/threading.py", line 280, in run
    threading.Thread.run(self)
  File "/usr/lib64/python3.6/threading.py", line 867, in run
    self._target(*self._args, **self._kwargs)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/common/task/task.py", line 97, in _task_run_callback
    self._set_result(self.run())
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/storage/teardown.py", line 43, in run
    self._storage.umount_filesystems(swapoff=False)
  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
    return m(*args, **kwargs)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/storage/devicetree/model.py", line 441, in umount_filesystems
    self.fsset.umount_filesystems(swapoff=swapoff)
  File "/usr/lib64/python3.6/site-packages/pyanaconda/modules/storage/devicetree/fsset.py", line 579, in umount_filesystems
    device.format.teardown()
  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
    return m(*args, **kwargs)
  File "/usr/lib/python3.6/site-packages/blivet/formats/__init__.py", line 653, in teardown
    self._teardown(**kwargs)
  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
    return m(*args, **kwargs)
  File "/usr/lib/python3.6/site-packages/blivet/formats/fs.py", line 629, in _teardown
    raise FSError("umount of %s failed (%d)" % (mountpoint, rc))
blivet.errors.FSError: umount of /run/user/0 failed (32)

Comment 4 Jan Stodola 2021-12-21 16:42:22 UTC

Lukasi, try running livemedia-creator with --anaconda-arg="--product CentOS Linux"

Comment 5 Jan Stodola 2022-01-03 15:09:06 UTC

Created attachment 1848703 [details]
livemedia.log

anaconda is not using the right product when livemedia-creator is executed on CentOS:
# livemedia-creator --make-iso --no-virt --ks rhel-livemedia.ks

From anaconda.log:
16:01:15,178 INF core.configuration.product: Loading information about products from /etc/anaconda/product.d.
16:01:15,179 INF core.configuration.product: Found CentOS Stream at /etc/anaconda/product.d/centos-stream.conf.
16:01:15,179 INF core.configuration.product: Found CentOS Linux at /etc/anaconda/product.d/centos.conf.
16:01:15,180 INF core.configuration.product: Found Fedora AtomicHost at /etc/anaconda/product.d/fedora-atomic-host.conf.
16:01:15,180 INF core.configuration.product: Found Fedora Server at /etc/anaconda/product.d/fedora-server.conf.
16:01:15,180 INF core.configuration.product: Found Fedora Silverblue at /etc/anaconda/product.d/fedora-silverblue.conf.
16:01:15,180 INF core.configuration.product: Found Fedora Workstation Live at /etc/anaconda/product.d/fedora-workstation-live.conf.
16:01:15,181 INF core.configuration.product: Found Fedora Workstation at /etc/anaconda/product.d/fedora-workstation.conf.
16:01:15,181 INF core.configuration.product: Found Fedora at /etc/anaconda/product.d/fedora.conf.
16:01:15,181 INF core.configuration.product: Found oVirt Node Next at /etc/anaconda/product.d/ovirt.conf.
16:01:15,181 INF core.configuration.product: Found Red Hat Enterprise Linux at /etc/anaconda/product.d/rhel.conf.
16:01:15,182 INF core.configuration.product: Found Red Hat Virtualization at /etc/anaconda/product.d/rhev.conf.
16:01:15,182 INF core.configuration.product: Found Scientific Linux at /etc/anaconda/product.d/scientific-linux.conf.
16:01:15,182 WRN core.configuration.product: No support for the product Linux.
16:01:15,182 WRN core.configuration.product: No support for the product Linux.
16:01:15,182 INF core.configuration.product: The product Red Hat Enterprise Linux is supported.
16:01:15,186 INF main: /usr/sbin/anaconda 33.16.5.6-1.el8

Comment 8 RHEL Program Management 2023-06-21 07:28:16 UTC

After evaluating this issue, there are no plans to address it further or fix it in an upcoming release.  Therefore, it is being closed.  If plans change such that this issue will be fixed in an upcoming release, then the bug can be reopened.

Note You need to log in before you can comment on or make changes to this bug.