Bug 1978109

Summary: Slower boot because dracut-initqueue fail notify DBus
Product: [Fedora] Fedora Reporter: Lorenzo Prosseda <lprosseda>
Component: dracutAssignee: dracut-maint-list
Status: CLOSED DUPLICATE QA Contact: Fedora Extras Quality Assurance <extras-qa>
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: 34CC: dracut-maint-list, hdegoede, jonathan, zbyszek
Target Milestone: ---   
Target Release: ---   
Hardware: x86_64   
OS: Linux   
Whiteboard:
Fixed In Version: Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2021-07-01 11:02:34 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:

Description Lorenzo Prosseda 2021-07-01 07:07:58 UTC 
Description of problem:
By updating only the dracut package to the version 55-2, I experienced a slowdown of more than a minute during the boot process; from the "systemd-analize blame" command, I found that the dracut-initqueue was taking more than a minute to run.
Then, from the journal of the unit (which I got using "journalctl -xeu dracut-initqueue.service -b") I could see that a warning is popping out with the 55.

I am sure that this was absent in dracut version 53-4, because by running "dnf downgrade dracut" I was prompted to install exactly the package "dracut-053-4.fc34.x86_64", and after regenerating the initrd and rebooting, it now takes 10 seconds to the unit to finish. 


How reproducible:
install the package "dracut-055-2.fc34.x86_64"

Here are the journal extracts for both versions of dracut

Dracut version "dracut-053-4.fc34.x86_64", baseline:

lug 01 08:41:45 thinker systemd[1]: Starting dracut initqueue hook...
░░ Subject: A start job for unit dracut-initqueue.service has begun execution
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ A start job for unit dracut-initqueue.service has begun execution.
░░ 
░░ The job identifier is 50.
lug 01 08:41:45 thinker dracut-initqueue[572]: Scanning devices sda3  for LVM logical volumes fedora-vg/root fedora-vg/swap
lug 01 08:41:45 thinker dracut-initqueue[597]: inactive '/dev/fedora-vg/root' [80.00 GiB] inherit
lug 01 08:41:45 thinker dracut-initqueue[597]: inactive '/dev/fedora-vg/home' [<149.00 GiB] inherit
lug 01 08:41:45 thinker dracut-initqueue[597]: inactive '/dev/fedora-vg/swap' [<7.78 GiB] inherit
lug 01 08:41:58 thinker systemd[1]: Finished dracut initqueue hook.
░░ Subject: A start job for unit dracut-initqueue.service has finished successfully
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ A start job for unit dracut-initqueue.service has finished successfully.
░░ 
░░ The job identifier is 50.
lug 01 08:41:59 thinker systemd[1]: dracut-initqueue.service: Deactivated successfully.
░░ Subject: Unit succeeded
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ The unit dracut-initqueue.service has successfully entered the 'dead' state.
lug 01 08:41:59 thinker systemd[1]: Stopped dracut initqueue hook.
░░ Subject: A stop job for unit dracut-initqueue.service has finished
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ A stop job for unit dracut-initqueue.service has finished.
░░ 
░░ The job identifier is 162 and the job result is done.


Dracut version "dracut-055-2.fc34.x86_64", slower boot (+90s) due to DBus notification timeout

lug 01 07:55:27 thinker systemd[1]: Starting dracut initqueue hook...
░░ Subject: A start job for unit dracut-initqueue.service has begun execution
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ A start job for unit dracut-initqueue.service has begun execution.
░░ 
░░ The job identifier is 53.
lug 01 07:55:27 thinker dracut-initqueue[609]: Scanning devices sda3  for LVM logical volumes fedora-vg/root
lug 01 07:55:27 thinker dracut-initqueue[609]: fedora-vg/swap
lug 01 07:55:27 thinker dracut-initqueue[630]: inactive          '/dev/fedora-vg/root' [80.00 GiB] inherit
lug 01 07:55:27 thinker dracut-initqueue[630]: inactive          '/dev/fedora-vg/home' [<149.00 GiB] inherit
lug 01 07:55:27 thinker dracut-initqueue[630]: inactive          '/dev/fedora-vg/swap' [<7.78 GiB] inherit
lug 01 07:56:57 thinker dracut-initqueue[632]: WARNING: D-Bus notification failed: Transport endpoint is not connected
lug 01 07:57:00 thinker systemd[1]: Finished dracut initqueue hook.
░░ Subject: A start job for unit dracut-initqueue.service has finished successfully
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ A start job for unit dracut-initqueue.service has finished successfully.
░░ 
░░ The job identifier is 53.
lug 01 07:57:00 thinker systemd[1]: dracut-initqueue.service: Deactivated successfully.
░░ Subject: Unit succeeded
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ The unit dracut-initqueue.service has successfully entered the 'dead' state.
lug 01 07:57:00 thinker systemd[1]: Stopped dracut initqueue hook.
░░ Subject: A stop job for unit dracut-initqueue.service has finished
░░ Defined-By: systemd
░░ Support: https://lists.freedesktop.org/mailman/listinfo/systemd-devel
░░ 
░░ A stop job for unit dracut-initqueue.service has finished.
░░ 
░░ The job identifier is 168 and the job result is done.
Comment 1 Hans de Goede 2021-07-01 11:02:34 UTC 

*** This bug has been marked as a duplicate of bug 1976653 ***