Disabling irq #9

rochus · 2024-04-02 09:01:13

One of my systems shows "Disabling IRQ #9" during boot. I don't know when this started, but I believe the onset to be with kernel 6.8. That is, I was running a 6.7 kernel for a bit longer (sha-1 patched/reverted, thanks to loqs) before moving to 6.8.1 (thanks again, loqs!), so I'm not entirely sure. The log indicates running the system with the irqpoll. When doing so, IRQ 9 is not disabled, but iwlwifi/iwd stops working, and it doesn't help me understand what's wrong. I couldn't find anything yet about this problem, any hints about how to troubleshoot it appreciated.

journalctl for a boot without irqpoll (disabling irq 9): https://0x0.st/XzwG.log
journalctl for a boot with irqpoll (iwlwifi isisue): https://0x0.st/XzwD.log

$ cat /proc/interrupts 
            CPU0       CPU1       CPU2       CPU3       CPU4       CPU5       CPU6       CPU7       CPU8       CPU9       CPU10      CPU11      CPU12      CPU13      CPU14      CPU15      
   0:         45          0          0          0          0          0          0          0          0          0          0          0          0          0          0          0  IR-IO-APIC    2-edge      timer
   1:       4578          0          0          0          0          0          0          0          0          0          0          0          0          0          0          0  IR-IO-APIC    1-edge      i8042
   8:          0          0          0          0          0          0          0          0          0          0          0          0          0          0          0          0  IR-IO-APIC    8-edge      rtc0
   9:          0     100157          0          0          0          0          0          0          0          0          0          0          0          0          0          0  IR-IO-APIC    9-fasteoi   acpi, pinctrl_amd
   ... more lines here, but irq 9 is the incriminating one.

seth · 2024-04-02 12:57:40

Apr 02 10:40:52 pulsar kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
…
Apr 02 10:40:52 pulsar kernel: irq 9: nobody cared (try booting with the "irqpoll" option)
Apr 02 10:40:52 pulsar kernel: CPU: 1 PID: 65 Comm: cpuhp/1 Not tainted 6.8.1-arch1-1.1 #1 33b0b47234150a9695925ee89ef2bad6b994d5b6
Apr 02 10:40:52 pulsar kernel: Hardware name: LENOVO 20UJS00K00/20UJS00K00, BIOS R1CET77W(1.46 ) 10/26/2023
Apr 02 10:40:52 pulsar kernel: Call Trace:
Apr 02 10:40:52 pulsar kernel:  <IRQ>
Apr 02 10:40:52 pulsar kernel:  dump_stack_lvl+0x47/0x60
Apr 02 10:40:52 pulsar kernel:  __report_bad_irq+0x2b/0xc0
Apr 02 10:40:52 pulsar kernel:  note_interrupt+0x2a6/0x2f0
Apr 02 10:40:52 pulsar kernel:  handle_irq_event+0x75/0x80
Apr 02 10:40:52 pulsar kernel:  handle_fasteoi_irq+0x8e/0x240
Apr 02 10:40:52 pulsar kernel:  __common_interrupt+0x42/0xb0
Apr 02 10:40:52 pulsar kernel:  common_interrupt+0x81/0xa0
Apr 02 10:40:52 pulsar kernel:  </IRQ>
Apr 02 10:40:52 pulsar kernel:  <TASK>
Apr 02 10:40:52 pulsar kernel:  asm_common_interrupt+0x26/0x40
Apr 02 10:40:52 pulsar kernel: RIP: 0010:finish_task_switch.isra.0+0x9a/0x2f0
Apr 02 10:40:52 pulsar kernel: Code: 00 00 0f 1f 44 00 00 49 8b 9f d8 0a 00 00 48 85 db 0f 85 c9 00 00 00 0f 1f 44 00 00 4c 89 ff e8 0c 99 cc 00 fb 0f 1f 44 00 00 <65> 48 8b 04 25 80 3f 03 00 66 90 4d 85 ed 74 21 65 48 8b 04 25 80
Apr 02 10:40:52 pulsar kernel: RSP: 0018:ffffafcb003a3bf8 EFLAGS: 00000282
Apr 02 10:40:52 pulsar kernel: RAX: ffff9c29c0bee900 RBX: 0000000000000000 RCX: 0000000000000002
Apr 02 10:40:52 pulsar kernel: RDX: 0000000000000000 RSI: 0000000000000001 RDI: ffff9c30af8747c0
Apr 02 10:40:52 pulsar kernel: RBP: ffffafcb003a3c20 R08: 0000000000000000 R09: 0000000000000000
Apr 02 10:40:52 pulsar kernel: R10: 0000000000000001 R11: 0000000000000110 R12: ffff9c29c0bee900
Apr 02 10:40:52 pulsar kernel: R13: 0000000000000000 R14: 0000000000000001 R15: ffff9c30af8747c0
Apr 02 10:40:52 pulsar kernel:  ? finish_task_switch.isra.0+0x94/0x2f0
Apr 02 10:40:52 pulsar kernel:  __schedule+0x3ee/0x1520
Apr 02 10:40:52 pulsar kernel:  preempt_schedule_irq+0x43/0x60
Apr 02 10:40:52 pulsar kernel:  asm_common_interrupt+0x26/0x40
Apr 02 10:40:52 pulsar kernel: RIP: 0010:device_create_groups_vargs+0x55/0xf0
Apr 02 10:40:52 pulsar kernel: Code: 87 a6 00 00 00 48 8b 3d b9 ee d8 00 49 89 f6 41 89 d7 49 89 cc ba f0 02 00 00 be c0 0d 00 00 4d 89 c5 e8 be d5 a4 ff 48 89 c3 <48> 85 c0 0f 84 81 00 00 00 48 89 c7 e8 7a a2 ff ff 4c 89 73 40 48
Apr 02 10:40:52 pulsar kernel: RSP: 0018:ffffafcb003a3da0 EFLAGS: 00000246
Apr 02 10:40:52 pulsar kernel: RAX: ffff9c30ac616c00 RBX: ffff9c30ac616c00 RCX: 0000000000000000
Apr 02 10:40:52 pulsar kernel: RDX: 0000000000000400 RSI: ffffffff88347ef2 RDI: ffff9c30ac616c00
Apr 02 10:40:52 pulsar kernel: RBP: ffffffff88a191e0 R08: 0000000000000400 R09: 0000000000000000
Apr 02 10:40:52 pulsar kernel: R10: ffffafcb003a3da0 R11: ffff9c30ac616c00 R12: 0000000000000000
Apr 02 10:40:52 pulsar kernel: R13: 0000000000000000 R14: 0000000000000000 R15: 000000000ca00001
Apr 02 10:40:52 pulsar kernel:  ? device_create_groups_vargs+0x52/0xf0
Apr 02 10:40:52 pulsar kernel:  ? __pfx_msr_device_create+0x10/0x10
Apr 02 10:40:52 pulsar kernel:  device_create+0x55/0x70
Apr 02 10:40:52 pulsar kernel:  ? device_create+0x4/0x70
Apr 02 10:40:52 pulsar kernel:  msr_device_create+0x2b/0x40
Apr 02 10:40:52 pulsar kernel:  cpuhp_invoke_callback+0xf8/0x460
Apr 02 10:40:52 pulsar kernel:  ? srso_return_thunk+0x5/0x5f
Apr 02 10:40:52 pulsar kernel:  ? __pfx_smpboot_thread_fn+0x10/0x10
Apr 02 10:40:52 pulsar kernel:  cpuhp_thread_fun+0xec/0x190
Apr 02 10:40:52 pulsar kernel:  smpboot_thread_fn+0xdc/0x1d0
Apr 02 10:40:52 pulsar kernel:  kthread+0xe8/0x120
Apr 02 10:40:52 pulsar kernel:  ? __pfx_kthread+0x10/0x10
Apr 02 10:40:52 pulsar kernel:  ret_from_fork+0x34/0x50
Apr 02 10:40:52 pulsar kernel:  ? __pfx_kthread+0x10/0x10
Apr 02 10:40:52 pulsar kernel:  ret_from_fork_asm+0x1b/0x30
Apr 02 10:40:52 pulsar kernel:  </TASK>
Apr 02 10:40:52 pulsar kernel: handlers:
Apr 02 10:40:52 pulsar kernel: [<00000000a95cdc9c>] irq_default_primary_handler threaded [<00000000070fbbcd>] acpi_irq
Apr 02 10:40:52 pulsar kernel: Disabling IRQ #9

https://bugzilla.kernel.org/show_bug.cgi?id=207749#c54
Probably UEFI bug, are there detremental outcomes that you attribute to the irq9 situation? (don't use irqpoll)

rochus · 2024-04-02 13:30:18

I did not notice any detrimental effects yet. That is, the system is running stable, which is why I ignored this issue so far. I was troubleshooting another system today already, so I decided I might just have a look at this as well.

In any case, thanks for the link! I read through the comments over there. It looks like the same issue, but I don't appear to have the same symptoms. For instance, my Fn keys work afaik, and I'm not missing any acpi capability. At least none that I was aware of so far. dmesg actually produces some errors of the form

[13185.199397] ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PCI0.LPC0.EC0.HKEY.MSCB], AE_NOT_FOUND (20230628/psargs-330)
[13185.199423] ACPI Error: Aborting method \_SB.PEP._DSM due to previous error (AE_NOT_FOUND) (20230628/psparse-529)

which fits the description in one of the comments (https://bugzilla.kernel.org/show_bug.cgi?id=207749#c60).

seth · 2024-04-02 14:23:35

"ACPI BIOS Error (bug): Could not resolve symbol" are super-common and yours doesn't match anything in the reports.
https://wiki.archlinux.org/title/DSDT - but unless there're immediate problems from that and you've a solid plan to address them this way, I'd just look the other side and move on.

Edit: what you can test though is whether toggling the wifi makes the IRQ error go away.

Last edited by seth (2024-04-02 14:24:17)

Arch Linux

#1 2024-04-02 09:01:13

Disabling irq #9

#2 2024-04-02 12:57:40

Re: Disabling irq #9

#3 2024-04-02 13:30:18

Re: Disabling irq #9

#4 2024-04-02 14:23:35

Re: Disabling irq #9

Board footer