How to debug acpi boot issue

I installed Fedora 35 recently and tried to polish it. I realized that there is a 5 seconds hang-up during boot. The only thing that eliminate the hang-up is acpi=off kernel paramter. /In that case my latop is useless/. I tried a lot of kernel parameters mentioned in Fedora documentation and google searches. Please help how to debug the root of the problem. Where to start, how to do.

inxi output:

System:
  Kernel: 5.15.4-201.fc35.x86_64 x86_64 bits: 64 compiler: gcc 
  v: 2.37-10.fc35 Desktop: Xfce 4.16.0 tk: Gtk 3.24.30 info: xfce4-panel 
  wm: xfwm 4.16.1 vt: 1 dm: LightDM 1.30.0 
  Distro: Fedora release 35 (Thirty Five) 
Machine:
  Type: Laptop System: LENOVO product: 20RW v: Lenovo ThinkBook 15-IML 
  serial: <filter> Chassis: type: 10 serial: <filter> 
  Mobo: LENOVO model: LNVNB161216 v: SDK0J40697 WIN serial: <filter> 
  UEFI: LENOVO v: CJCN36WW date: 08/06/2021 
Battery:
  ID-1: BAT1 charge: 38.1 Wh (97.4%) condition: 39.1/45.0 Wh (86.9%) 
  volts: 12.6 min: 11.5 model: Celxpert L19C3PF1 type: Li-poly 
  serial: <filter> status: Unknown cycles: 201 
CPU:
  Info: Quad Core model: Intel Core i7-10510U bits: 64 type: MT MCP 
  arch: Kaby Lake note: check rev: C cache: L2: 8 MiB 
  flags: avx avx2 lm nx pae sse sse2 sse3 sse4_1 sse4_2 ssse3 vmx 
  bogomips: 36799 
  Speed: 700 MHz min/max: 400/4900 MHz Core speeds (MHz): 1: 700 2: 2250 
  3: 1654 4: 891 5: 708 6: 700 7: 700 8: 700 
Graphics:
  Device-1: Intel CometLake-U GT2 [UHD Graphics] vendor: Lenovo driver: i915 
  v: kernel bus-ID: 00:02.0 chip-ID: 8086:9b41 class-ID: 0300 
  Device-2: Acer SunplusIT Integrated Camera type: USB driver: uvcvideo 
  bus-ID: 1-6:3 chip-ID: 5986:2113 class-ID: 0e02 
  Display: x11 server: X.Org 1.20.11 compositor: xfwm4 v: 4.16.1 driver: 
  loaded: modesetting unloaded: fbdev,vesa resolution: 1920x1080~60Hz 
  s-dpi: 96 
  OpenGL: renderer: Mesa Intel UHD Graphics (CML GT2) v: 4.6 Mesa 21.2.5 
  direct render: Yes 
Audio:
  Device-1: Intel Comet Lake PCH-LP cAVS vendor: Lenovo 
  driver: snd_hda_intel v: kernel bus-ID: 00:1f.3 chip-ID: 8086:02c8 
  class-ID: 0403 
  Sound Server-1: ALSA v: k5.15.4-201.fc35.x86_64 running: yes 
  Sound Server-2: PipeWire v: 0.3.40 running: yes 
Network:
  Device-1: Realtek RTL8111/8168/8411 PCI Express Gigabit Ethernet 
  vendor: Lenovo driver: r8169 v: kernel port: 3000 bus-ID: 01:00.0 
  chip-ID: 10ec:8168 class-ID: 0200 
  IF: enp1s0 state: down mac: <filter> 
  Device-2: Realtek RTL8822CE 802.11ac PCIe Wireless Network Adapter 
  vendor: Lenovo driver: rtw_8822ce v: N/A port: 2000 bus-ID: 02:00.0 
  chip-ID: 10ec:c822 class-ID: 0280 
  IF: wlp2s0 state: up mac: <filter> 
Bluetooth:
  Device-1: Realtek Bluetooth Radio type: USB driver: btusb v: 0.8 
  bus-ID: 1-10:5 chip-ID: 0bda:c123 class-ID: e001 serial: <filter> 
  Report: bt-adapter ID: hci0 rfk-id: 2 state: up address: <filter> 
Drives:
  Local Storage: total: 476.94 GiB used: 10.8 GiB (2.3%) 
  ID-1: /dev/nvme0n1 vendor: Samsung model: MZVLB512HBJQ-000L2 
  size: 476.94 GiB speed: 31.6 Gb/s lanes: 4 type: SSD serial: <filter> 
  rev: 3L1QEXF7 temp: 38.9 C scheme: GPT 
Partition:
  ID-1: / size: 39.08 GiB used: 10.12 GiB (25.9%) fs: ext4 
  dev: /dev/nvme0n1p6 
  ID-2: /boot/efi size: 256 MiB used: 47.9 MiB (18.7%) fs: vfat 
  dev: /dev/nvme0n1p1 
  ID-3: /home size: 39.07 GiB used: 653.9 MiB (1.6%) fs: ext4 
  dev: /dev/nvme0n1p7 
Swap:
  ID-1: swap-1 type: partition size: 20 GiB used: 0 KiB (0.0%) priority: -2 
  dev: /dev/nvme0n1p5 
  ID-2: swap-2 type: zram size: 8 GiB used: 0 KiB (0.0%) priority: 100 
  dev: /dev/zram0 
Sensors:
  System Temperatures: cpu: 35.0 C mobo: N/A 
  Fan Speeds (RPM): N/A 
Info:
  Processes: 237 Uptime: 14m wakeups: 1 Memory: 15.13 GiB 
  used: 1.97 GiB (13.0%) Init: systemd v: 249 runlevel: 5 
  target: graphical.target Compilers: gcc: 11.2.1 Packages: N/A 
  note: see --pkg Shell: Bash v: 5.1.8 running-in: xfce4-terminal 
  inxi: 3.3.06 

dmesg:

[    1.189570] PM:   Magic number: 13:268:935
[    1.191123] RAS: Correctable Errors collector initialized.
[    1.210112] usb 1-5: New USB device found, idVendor=27c6, idProduct=55a4, bcdDevice= 1.00
[    1.211469] usb 1-5: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    1.212869] usb 1-5: Product: Goodix FingerPrint Device
[    1.214201] usb 1-5: Manufacturer: Generic
[    1.331497] usb 1-6: new high-speed USB device number 3 using xhci_hcd
[    1.471266] usb 1-6: New USB device found, idVendor=5986, idProduct=2113, bcdDevice=54.23
[    1.473120] usb 1-6: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    1.474966] usb 1-6: Product: Integrated Camera
[    1.476761] usb 1-6: Manufacturer: SunplusIT Inc
[    1.592501] usb 1-7: new full-speed USB device number 4 using xhci_hcd
[    1.722743] usb 1-7: New USB device found, idVendor=062a, idProduct=4106, bcdDevice= 1.03
[    1.725147] usb 1-7: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    1.727692] usb 1-7: Product: 2.4G Wireless Mouse
[    1.730231] usb 1-7: Manufacturer: MOSART Semi.
[    1.735683] input: MOSART Semi. 2.4G Wireless Mouse as /devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/0003:062A:4106.0001/input/input4
[    1.738040] input: MOSART Semi. 2.4G Wireless Mouse as /devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/0003:062A:4106.0001/input/input5
[    1.740231] hid-generic 0003:062A:4106.0001: input,hiddev96,hidraw0: USB HID v1.10 Mouse [MOSART Semi. 2.4G Wireless Mouse] on usb-0000:00:14.0-7/input0
[    1.785498] tsc: Refined TSC clocksource calibration: 2304.003 MHz
[    1.787813] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2135fabfc56, max_idle_ns: 440795260950 ns
[    1.790191] clocksource: Switched to clocksource tsc
[    1.855653] usb 1-10: new full-speed USB device number 5 using xhci_hcd
[    1.984957] usb 1-10: New USB device found, idVendor=0bda, idProduct=c123, bcdDevice= 0.00
[    1.987314] usb 1-10: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    1.989950] usb 1-10: Product: Bluetooth Radio 
[    1.990892] usb 1-10: Manufacturer: Realtek 
[    1.991608] usb 1-10: SerialNumber: 00e04c000001
[    8.113437] ACPI: battery: Slot [BAT1] (battery present)
[    8.119813] Freeing unused decrypted memory: 2036K
[    8.122933] Freeing unused kernel image (initmem) memory: 2904K
[    8.123724] Write protecting the kernel read-only data: 30720k
[    8.124996] Freeing unused kernel image (text/rodata gap) memory: 2036K
[    8.126114] Freeing unused kernel image (rodata/data gap) memory: 1760K
[    8.137703] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    8.138406] rodata_test: all tests were successful
[    8.139137] Run /init as init process
[    8.139841]   with arguments:
[    8.139842]     /init
[    8.139843]   with environment:
[    8.139843]     HOME=/
[    8.139844]     TERM=linux
[    8.139844]     BOOT_IMAGE=(hd0,gpt6)/boot/vmlinuz-5.15.4-201.fc35.x86_64
[    8.171628] systemd[1]: systemd v249.7-2.fc35 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT +GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified)
[    8.184464] systemd[1]: Detected architecture x86-64.
[    8.185221] systemd[1]: Running in initial RAM disk.
[    8.188640] systemd[1]: Hostname set to <ZSAZSA-LAPTOP>.
[    8.241935] systemd[1]: Queued start job for default target Initrd Default Target.
[    8.242852] systemd[1]: Reached target Initrd /usr File System.
[    8.244516] systemd[1]: Reached target Local File Systems.
[    8.246074] systemd[1]: Reached target Slice Units.
[    8.247618] systemd[1]: Reached target Swaps.
[    8.249121] systemd[1]: Reached target Timer Units.
[    8.250737] systemd[1]: Listening on D-Bus System Message Bus Socket.
[    8.252345] systemd[1]: Listening on Journal Audit Socket.
[    8.253963] systemd[1]: Listening on Journal Socket (/dev/log).
[    8.255589] systemd[1]: Listening on Journal Socket.
[    8.257250] systemd[1]: Listening on udev Control Socket.
[    8.258932] systemd[1]: Listening on udev Kernel Socket.
[    8.260620] systemd[1]: Reached target Socket Units.
[    8.263280] systemd[1]: Starting Create List of Static Device Nodes...
[    8.264945] systemd[1]: Condition check resulted in Memstrack Anylazing Service being skipped.
[    8.266754] systemd[1]: Starting Journal Service...
[    8.268876] systemd[1]: Starting Load Kernel Modules...
[    8.270518] systemd[1]: Condition check resulted in Create System Users being skipped.
[    8.271755] systemd[1]: Starting Setup Virtual Console...
[    8.273970] systemd[1]: Finished Create List of Static Device Nodes.
[    8.276234] systemd[1]: Starting Create Static Device Nodes in /dev...
[    8.280656] fuse: init (API version 7.34)
[    8.283549] systemd[1]: Finished Load Kernel Modules.

Here is the gap in dmesg:

[    1.990892] usb 1-10: Manufacturer: Realtek 
[    1.991608] usb 1-10: SerialNumber: 00e04c000001
[    8.113437] ACPI: battery: Slot [BAT1] (battery present)
[    8.119813] Freeing unused decrypted memory: 2036K

systemd-analyze time:

Startup finished in 3.904s (firmware) + 4.902s (loader) + 7.981s (kernel) + 1.110s (initrd) + 3.186s (userspace) = 21.086s 
graphical.target reached after 3.162s in userspace

systemd-analyze time with acpi=off kernel parameter:

Startup finished in 1.292s (kernel) + 1.451s (initrd) + 4.064s (userspace) = 6.809s 
graphical.target reached after 4.048s in userspace

Thanks for any suggestion.

Hi,

Firstly I don’t know what causing the problem you have on your system. But if you want to try to change the kernel parameter on acpi things, you could refer on this page on internet.

My suggestion is edit the kernel parameter directly from boot list menu (press keyboard e on boot list menu then add the parameter on the end of same line with options then continue it with ctrl + x). It’s will edit the kernel parameter temporary and will gone each time you reboot again.