Bug 702546 - Upon wakeup from pm-hibernate (suspend to disk): "Disabling IRQ #18" kernel message, USB keyboard unresponsive
Summary: Upon wakeup from pm-hibernate (suspend to disk): "Disabling IRQ #18" kernel m...
Status: RESOLVED WONTFIX
Alias: None
Product: openSUSE 11.4
Classification: openSUSE
Component: Kernel (show other bugs)
Version: Final
Hardware: x86-64 openSUSE 11.4
: P5 - None : Major with 5 votes (vote)
Target Milestone: ---
Assignee: E-mail List
QA Contact: E-mail List
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2011-06-28 07:01 UTC by Ned 64
Modified: 2012-08-02 15:59 UTC (History)
3 users (show)

See Also:
Found By: ---
Services Priority:
Business Priority:
Blocker: ---
Marketing QA Status: ---
IT Deployment: ---


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Ned 64 2011-06-28 07:01:59 UTC
User-Agent:       Mozilla/5.0 (X11; Linux x86_64; rv:2.0.1) Gecko/20100101 Firefox/4.0.1

When I suspend my PC to disk (using gnome's menu) and wake up again, there is a message on all terminals,

Message from syslogd@localhost at Jun 28 08:33:30 ...
 kernel:[17402.585626] Disabling IRQ #18

and the USB keyboard / mouse become unresponsive.  About 10% of keypresses go unnoticed, which is very annoying.  When I type faster up to 50% are lost.

This happens regularly when hibernating, although I have not tried often enough to say for sure whether it happens every time.  It did in my case.


Reproducible: Always

Steps to Reproduce:
1. Boot system in Gnome, start some programs
2. Suspend to disk using the SuSE Gnome menu item Computer->Shutdown
3. After suspend and power gone, boot up again.  No keypress or mouse movement during boot process (after selecting the correct option in grub) are necessary to cause the problem.

Actual Results:  
Message from syslogd@localhost at Jun 28 08:33:30 ...
 kernel:[17402.585626] Disabling IRQ #18

message, USB keyboard and/or mouse unresponsive.  When I suspend the system again another message appears and another USB device is affected.  Sometimes it helps to re-plug the USB device in a different port, but not in the same.

Expected Results:  
System unsuspends without affecting USB device functionality.

System info:
 - AMD Phenom II X4 955 with 12 GB RAM on a Gigabyte GMA-UD2H board
 - Enough Swap etc. to suspend OK

-> rpm -qf /usr/sbin/pm-hibernate 
pm-utils-1.4.1-5.9.1.x86_64

-> uname -a
Linux localhost 2.6.37.6-0.5-desktop #1 SMP PREEMPT 2011-04-25 21:48:33 +0200 x86_64 x86_64 x86_64 GNU/Linux

-> cat /proc/interrupts
           CPU0       CPU1       CPU2       CPU3       
  0:    2344127       2077    4278089      48015   IO-APIC-edge      timer
  1:          4          0          2          0   IO-APIC-edge      i8042
  4:          0          0          2          0   IO-APIC-edge    
  7:          1          0          0          0   IO-APIC-edge    
  8:          0          0         25          0   IO-APIC-edge      rtc0
  9:          0          0          0          0   IO-APIC-fasteoi   acpi
 16:        774          0        750          0   IO-APIC-fasteoi   hda_intel
 17:    1462916          1       4467         20   IO-APIC-fasteoi   ehci_hcd:usb1, ehci_hcd:usb2, ehci_hcd:usb3, pata_jmicron
 18:     899729          0        384          7   IO-APIC-fasteoi   ohci_hcd:usb4, ohci_hcd:usb5, ohci_hcd:usb6, ohci_hcd:usb7, nvidia
 22:          0        267         22          0   IO-APIC-fasteoi   firewire_ohci
 40:     565325          0      13597        181   PCI-MSI-edge      ahci
 41:          1          0      37336         41   PCI-MSI-edge      xhci_hcd
 42:          0          0          0          0   PCI-MSI-edge      xhci_hcd
 43:          0          0          0          0   PCI-MSI-edge      xhci_hcd
 44:          0          0          0          0   PCI-MSI-edge      xhci_hcd
 45:          0          0          0          0   PCI-MSI-edge      xhci_hcd
 46:    1799244          0         51          0   PCI-MSI-edge      eth0
NMI:         19         16         16         10   Non-maskable interrupts
LOC:    3628905    3937634    2127599    2262765   Local timer interrupts
SPU:          0          0          0          0   Spurious interrupts
PMI:         19         16         16         10   Performance monitoring interrupts
IWI:          0          0          0          0   IRQ work interrupts
RES:    5451244    5831414    5065915    3663893   Rescheduling interrupts
CAL:      30344      46914      46315      44465   Function call interrupts
TLB:      33106      28468      21604      17243   TLB shootdowns
TRM:          0          0          0          0   Thermal event interrupts
THR:          0          0          0          0   Threshold APIC interrupts
MCE:          0          0          0          0   Machine check exceptions
MCP:         63         62         62         62   Machine check polls
ERR:          1
MIS:          0

from dmesg:

(...)
[17401.397045] usb 1-2: reset high speed USB device using ehci_hcd and address 2
[17401.784047] usb 5-3: reset low speed USB device using ohci_hcd and address 2
[17402.092092] PM: restore of devices complete after 1350.860 msecs
[17402.123738] snapshot_ioctl: ioctl '4004330c' is deprecated and will be removed soon, update your suspend-to-disk utilities
[17402.123740] Restarting tasks ... 
[17402.123825] usb 1-1: USB disconnect, address 3
[17402.125881] done.
[17402.158630] PM: Basic memory bitmaps freed
[17402.585311] irq 18: nobody cared (try booting with the "irqpoll" option)
[17402.585318] Pid: 0, comm: swapper Tainted: P            2.6.37.6-0.5-desktop #1
[17402.585322] Call Trace:
[17402.585333]  [<ffffffff810059b9>] dump_trace+0x79/0x340
[17402.585339]  [<ffffffff81521752>] dump_stack+0x69/0x6f
[17402.585345]  [<ffffffff810cb38e>] __report_bad_irq+0x1e/0x90
[17402.585349]  [<ffffffff810cb5a9>] note_interrupt+0x1a9/0x200
[17402.585354]  [<ffffffff810cc545>] handle_fasteoi_irq+0x105/0x140
[17402.585359]  [<ffffffff810058b5>] handle_irq+0x15/0x20
[17402.585362]  [<ffffffff810054fe>] do_IRQ+0x5e/0xe0
[17402.585367]  [<ffffffff81524fd3>] ret_from_intr+0x0/0xa
[17402.585372]  [<ffffffff8100b794>] default_idle+0x44/0x230
[17402.585376]  [<ffffffff8100b9d2>] c1e_idle+0x52/0x100
[17402.585381]  [<ffffffff8100125c>] cpu_idle+0x4c/0xa0
[17402.585386]  [<ffffffff81b3ebf8>] start_kernel+0x39a/0x3a5
[17402.585390]  [<ffffffff81b3e414>] x86_64_start_kernel+0xf9/0xff
[17402.585393] handlers:
[17402.585395] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[17402.585399] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[17402.585402] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[17402.585405] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[17402.585408] [<ffffffffa08093f0>] (nv_kern_isr+0x0/0x80 [nvidia])
[17402.585626] Disabling IRQ #18
Comment 1 Ned 64 2011-07-06 05:42:02 UTC
Is there a way to re-enable IRQ 18 via proc or similar?

Can I do anything to provide more detailed data for analysis?

Anybody looking at this case?

Regards, Ned

PS: Today's dmesg attached.  Is the first line relevant here?


[52048.807322] snapshot_ioctl: ioctl '4004330c' is deprecated and will be removed soon, update your suspend-to-disk utilities
[52048.807324] Restarting tasks ... done.
[52048.841988] PM: Basic memory bitmaps freed
[52049.786470] irq 18: nobody cared (try booting with the "irqpoll" option)
[52049.786476] Pid: 0, comm: swapper Tainted: P            2.6.37.6-0.5-desktop #1
[52049.786480] Call Trace:
[52049.786491]  [<ffffffff810059b9>] dump_trace+0x79/0x340
[52049.786497]  [<ffffffff81521752>] dump_stack+0x69/0x6f
[52049.786503]  [<ffffffff810cb38e>] __report_bad_irq+0x1e/0x90
[52049.786507]  [<ffffffff810cb5a9>] note_interrupt+0x1a9/0x200
[52049.786512]  [<ffffffff810cc545>] handle_fasteoi_irq+0x105/0x140
[52049.786517]  [<ffffffff810058b5>] handle_irq+0x15/0x20
[52049.786521]  [<ffffffff810054fe>] do_IRQ+0x5e/0xe0
[52049.786525]  [<ffffffff81524fd3>] ret_from_intr+0x0/0xa
[52049.786531]  [<ffffffff8100b794>] default_idle+0x44/0x230
[52049.786535]  [<ffffffff8100b9d2>] c1e_idle+0x52/0x100
[52049.786540]  [<ffffffff8100125c>] cpu_idle+0x4c/0xa0
[52049.786545]  [<ffffffff81b3ebf8>] start_kernel+0x39a/0x3a5
[52049.786549]  [<ffffffff81b3e414>] x86_64_start_kernel+0xf9/0xff
[52049.786552] handlers:
[52049.786554] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[52049.786558] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[52049.786561] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[52049.786564] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[52049.786567] [<ffffffffa082f3f0>] (nv_kern_isr+0x0/0x80 [nvidia])
[52049.786784] Disabling IRQ #18
Comment 2 Nikola S 2011-07-07 08:20:05 UTC
I'm having the same problem. Sometimes after system returns from hibernation, mouse and keyboard becomes unresponsive.

System:
AMD Phenom(tm) II X4 B45 on Asrock 890GX Extreme3, 4GB RAM
Opensuse 11.4 / KDE , 10GB swap


uname -a:
Linux des1 2.6.37.6-0.5-desktop #1 SMP PREEMPT 2011-04-25 21:48:33 +0200 x86_64 x86_64 x86_64 GNU/Linux


/proc/interrupts:
           CPU0       CPU1       CPU2       CPU3       
  0:        127          0          0          1   IO-APIC-edge      timer
  1:          4          0          0          2   IO-APIC-edge      i8042
  7:          1          0          0          0   IO-APIC-edge    
  8:          1          0          2         60   IO-APIC-edge      rtc0
  9:          0          0          0          0   IO-APIC-fasteoi   acpi
 14:          0          0          0          0   IO-APIC-edge      pata_atiixp
 15:          0          0          0          0   IO-APIC-edge      pata_atiixp
 16:       2623          0          2        698   IO-APIC-fasteoi   hda_intel, firewire_ohci
 17:         94          0          0         38   IO-APIC-fasteoi   ehci_hcd:usb1, ehci_hcd:usb2, ehci_hcd:usb3
 18:     198649          0       1318         74   IO-APIC-fasteoi   ohci_hcd:usb4, ohci_hcd:usb5, ohci_hcd:usb6, ohci_hcd:usb7, nouveau
 19:          0         48          0        125   IO-APIC-fasteoi   hda_intel
 40:      10353         14         31       7984   PCI-MSI-edge      ahci
 41:      26477          0          0         22   PCI-MSI-edge      eth0
NMI:          0          0          0          0   Non-maskable interrupts
LOC:     249480     213460     193540     171865   Local timer interrupts
SPU:          0          0          0          0   Spurious interrupts
PMI:          0          0          0          0   Performance monitoring interrupts
IWI:          0          0          0          0   IRQ work interrupts
RES:     199293     185544     164228     121385   Rescheduling interrupts
CAL:       1045       1068        836       1430   Function call interrupts
TLB:       4489       6568       4943       3460   TLB shootdowns
TRM:          0          0          0          0   Thermal event interrupts
THR:          0          0          0          0   Threshold APIC interrupts
MCE:          0          0          0          0   Machine check exceptions
MCP:          5          5          5          5   Machine check polls
ERR:          1


dmesg:
[  437.170080] usb 5-1: reset low speed USB device using ohci_hcd and address 2
[  437.642779] irq 18: nobody cared (try booting with the "irqpoll" option)
[  437.642781] Pid: 0, comm: swapper Not tainted 2.6.37.6-0.5-desktop #1
[  437.642783] Call Trace:
[  437.642794]  [<ffffffff810059b9>] dump_trace+0x79/0x340
[  437.642799]  [<ffffffff81521752>] dump_stack+0x69/0x6f
[  437.642803]  [<ffffffff810cb38e>] __report_bad_irq+0x1e/0x90
[  437.642806]  [<ffffffff810cb5a9>] note_interrupt+0x1a9/0x200
[  437.642810]  [<ffffffff810cc545>] handle_fasteoi_irq+0x105/0x140
[  437.642813]  [<ffffffff810058b5>] handle_irq+0x15/0x20
[  437.642816]  [<ffffffff810054fe>] do_IRQ+0x5e/0xe0
[  437.642819]  [<ffffffff81524fd3>] ret_from_intr+0x0/0xa
[  437.642823]  [<ffffffff8100b794>] default_idle+0x44/0x230
[  437.642827]  [<ffffffff8100125c>] cpu_idle+0x4c/0xa0
[  437.642830]  [<ffffffff81b3ebf8>] start_kernel+0x39a/0x3a5
[  437.642833]  [<ffffffff81b3e414>] x86_64_start_kernel+0xf9/0xff
[  437.642835] handlers:
[  437.642836] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[  437.642838] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[  437.642840] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[  437.642842] [<ffffffff81385410>] (usb_hcd_irq+0x0/0x70)
[  437.642843] [<ffffffffa02605c0>] (nouveau_irq_handler+0x0/0x1b0 [nouveau])
[  437.642863] Disabling IRQ #18
[  437.736090] usb 7-2: reset low speed USB device using ohci_hcd and address 2
Comment 3 Ned 64 2011-07-11 07:40:50 UTC
I have installaed kernel 2.6.37.6-40-desktop from the repository http://download.opensuse.org/repositories/Kernel:/openSUSE-11.4/openSUSE_11.4/ and have booted three times without problems.  This may be an indication that the problem is resolved in newer kernels.

In this case I would like to ask Novell to incorporate the relevant patch into 11.4 Updates as soon as possible.

Nikola, do you have the possibility of trying the new kernel?

Regards, Ned.
Comment 4 Ned 64 2011-07-12 06:50:47 UTC
Too bad, no use - IRQ 18 disabled with new kernel :-(

Any maintainer reading this?


[20543.311187] irq 18: nobody cared (try booting with the "irqpoll" option)
[20543.311189] Pid: 0, comm: swapper Tainted: P            2.6.37.6-40-desktop #1
[20543.311191] Call Trace:
[20543.311201]  [<ffffffff810059b9>] dump_trace+0x79/0x340
[20543.311205]  [<ffffffff815225d2>] dump_stack+0x69/0x6f
[20543.311209]  [<ffffffff810cc3be>] __report_bad_irq+0x1e/0x90
[20543.311212]  [<ffffffff810cc5d9>] note_interrupt+0x1a9/0x200
[20543.311215]  [<ffffffff810cd575>] handle_fasteoi_irq+0x105/0x140
[20543.311218]  [<ffffffff810058b5>] handle_irq+0x15/0x20
[20543.311221]  [<ffffffff810054fe>] do_IRQ+0x5e/0xe0
[20543.311224]  [<ffffffff81525e53>] ret_from_intr+0x0/0xa
[20543.311228]  [<ffffffff8100b794>] default_idle+0x44/0x230
[20543.311231]  [<ffffffff8100b9d2>] c1e_idle+0x52/0x100
[20543.311234]  [<ffffffff8100125c>] cpu_idle+0x4c/0xa0
[20543.311237]  [<ffffffff81b3ebf8>] start_kernel+0x39a/0x3a5
[20543.311240]  [<ffffffff81b3e414>] x86_64_start_kernel+0xf9/0xff
[20543.311242] handlers:
[20543.311243] [<ffffffff81386250>] (usb_hcd_irq+0x0/0x70)
[20543.311245] [<ffffffff81386250>] (usb_hcd_irq+0x0/0x70)
[20543.311247] [<ffffffff81386250>] (usb_hcd_irq+0x0/0x70)
[20543.311248] [<ffffffff81386250>] (usb_hcd_irq+0x0/0x70)
[20543.311250] [<ffffffffa0968c90>] (nv_kern_isr+0x0/0x80 [nvidia])
[20543.311443] Disabling IRQ #18
[20544.811225] PM: restore of devices complete after 2941.495 msecs
[20544.842761] snapshot_ioctl: ioctl '4004330c' is deprecated and will be removed soon, update your suspend-to-disk utilities
[20544.842763] Restarting tasks ... done.
[20544.876890] PM: Basic memory bitmaps freed
Comment 5 Jeff Mahoney 2012-08-02 15:59:05 UTC
With the coming release of openSUSE 12.2, openSUSE kernel developers are focusing their efforts there. Reports against openSUSE 11.4 and prior will not get the attention needed to resolve them before openSUSE 12.2 is release and openSUSE 11.4 becomes unmaintained.

Please re-test with openSUSE 12.1 or openSUSE RC2+ and re-open with an updated Product if you still encounter your issue.

We apologize for this issue not getting the attention it deserves but we are focusing our resources in the area where they will have the most impact for our users.  We're working hard to make openSUSE 12.2 the best openSUSE release yet!