kern/42843: High interrupt load

To: kern-bug-people%netbsd.org@localhost,gnats-admin%netbsd.org@localhost,netbsd-bugs%netbsd.org@localhost
Subject: kern/42843: High interrupt load
From: peter%kerwien.homeip.net@localhost
Date: Thu, 18 Feb 2010 20:05:00 +0000 (UTC)
>Number:         42843
>Category:       kern
>Synopsis:       High interrupt load
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    kern-bug-people
>State:          open
>Class:          sw-bug
>Submitter-Id:   net
>Arrival-Date:   Thu Feb 18 20:05:00 +0000 2010
>Originator:     Peter Kerwien
>Release:        NetBSD-5.0.2 amd64
>Organization:
N/A
>Environment:
NetBSD pc1 5.0.2 NetBSD 5.0.2 (GENERIC) #0: Sat Feb  6 13:44:19 UTC 2010  
builds%b8.netbsd.org@localhost:/home/builds/ab/netbsd-5-0-2-RELEASE/amd64/201002061851Z-obj/home/builds/ab/netbsd-5-0-2-RELEASE/src/sys/arch/amd64/compile/GENERIC
 amd64

>Description:
After installation of NetBSD-5.0.2, I see unexpected high interrupt load:

load averages:  0.02,  0.07,  0.03;               up 0+00:04:23        20:22:39
16 processes: 14 sleeping, 2 on CPU
CPU0 states:  0.0% user,  0.0% nice,  0.0% system, 60.4% interrupt, 39.6% idle
CPU1 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt,  100% idle
CPU2 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt,  100% idle
CPU3 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt,  100% idle
Memory: 15M Act, 1676K Inact, 936K Wired, 5824K Exec, 5876K File, 3392M Free
Swap: 4096M Total, 4096M Free

  PID USERNAME PRI NICE   SIZE   RES STATE      TIME   WCPU    CPU COMMAND
    0 root       0    0     0K   22M CPU/3      0:04  0.00%  0.00% [system]
  399 root      43    0  7612K 1164K CPU/0      0:00  0.00%  0.00% top
  369 root      85    0    29M 3004K wait/0     0:00  0.00%  0.00% login
...

My system is a Gigabyte GA-MA785GT-UD3H motherboard with F4 BIOS. AMD Phenom II 
x4 965 and 2x2GB RAM. I have attached a USB mouse and keyboard.

# vmstat -i
interrupt                                     total     rate
global TLB IPI                                32841      129
ioapic0 pin 18                                   29        0
ioapic0 pin 22                                75462      298
ioapic0 pin 16                             46963399   185626
ioapic0 pin 17                                    2        0
ioapic0 pin 15                                    6        0
Total                                      47071739   186054

=> A lot of activity on pin 16

# dmesg | grep ioapic
ioapic0 at mainbus0 apid 2: pa 0xfec00000, version 21, 24 pins
azalia0: interrupting at ioapic0 pin 19
re0: interrupting at ioapic0 pin 18
ahcisata0: interrupting at ioapic0 pin 22
ohci0: interrupting at ioapic0 pin 16
ohci1: interrupting at ioapic0 pin 16
ehci0: interrupting at ioapic0 pin 17
ohci2: interrupting at ioapic0 pin 18
ohci3: interrupting at ioapic0 pin 18
ehci1: interrupting at ioapic0 pin 19
ixpide0: primary channel interrupting at ioapic0 pin 14
ixpide0: secondary channel interrupting at ioapic0 pin 15
azalia1: interrupting at ioapic0 pin 16
ohci4: interrupting at ioapic0 pin 18

I recompiled a GENERIC kernel without azalia => still high interrupt load. Then 
I recompiled GENERIC without ohci => stuck during boot.

I have similar boot problems when I try a untouched GENERIC kernel and tries to 
disable audio and USB support in BIOS. Since I have seen reports with problems 
that disappeared when disabling SMP. My problem does not disappear when booting 
with boot -1.

Please let me know what other information you might need and what more I can 
test.

=====

# dmesg
Copyright (c) 1996, 1997, 1998, 1999, 2000, 2001, 2002, 2003, 2004, 2005,
    2006, 2007, 2008, 2009
    The NetBSD Foundation, Inc.  All rights reserved.
Copyright (c) 1982, 1986, 1989, 1991, 1993
    The Regents of the University of California.  All rights reserved.

NetBSD 5.0.2 (GENERIC) #0: Sat Feb  6 13:44:19 UTC 2010
        
builds%b8.netbsd.org@localhost:/home/builds/ab/netbsd-5-0-2-RELEASE/amd64/201002061851Z-obj/home/builds/ab/netbsd-5-0-2-RELEASE/src/sys/arch/amd64/compile/GENERIC
total memory = 3581 MB
avail memory = 3456 MB
timecounter: Timecounters tick every 10.000 msec
timecounter: Timecounter "i8254" frequency 1193182 Hz quality 100
SMBIOS rev. 2.4 @ 0xf0100 (59 entries)
Gigabyte Technology Co., Ltd. GA-MA785GT-UD3H ( )
mainbus0 (root)
cpu0 at mainbus0 apid 0: AMD 686-class, 3415MHz, id 0x100f43
cpu1 at mainbus0 apid 1: AMD 686-class, 3415MHz, id 0x100f43
cpu2 at mainbus0 apid 2: AMD 686-class, 3415MHz, id 0x100f43
cpu3 at mainbus0 apid 3: AMD 686-class, 3415MHz, id 0x100f43
ioapic0 at mainbus0 apid 2: pa 0xfec00000, version 21, 24 pins
acpi0 at mainbus0: Intel ACPICA 20080321
acpi0: X/RSDT: OemId <GBT   ,GBTUACPI,42302e31>, AslId <GBTU,01010101>
acpi0: SCI interrupting at int 9
acpi0: fixed-feature power button present
timecounter: Timecounter "ACPI-Fast" frequency 3579545 Hz quality 1000
ACPI-Fast 32-bit timer
acpibut0 at acpi0 (PWRB, PNP0C0C): ACPI Power Button
attimer1 at acpi0 (TMR, PNP0100): AT Timer
attimer1: io 0x40-0x43
hpet0 at acpi0 (HPET, PNP0103)
hpet0: mem 0xfed00000-0xfed003ff irq 0,8
timecounter: Timecounter "hpet0" frequency 14318180 Hz quality 2000
pcppi1 at acpi0 (SPKR, PNP0800)
pcppi1: io 0x61
midi0 at pcppi1: PC speaker (CPU-intensive output)
sysbeep0 at pcppi1
attimer1: attached to pcppi1
pci0 at mainbus0 bus 0: configuration mode 1
pci0: i/o space, memory space enabled, rd/line, rd/mult, wr/inv ok
pchb0 at pci0 dev 0 function 0
pchb0: vendor 0x1022 product 0x9601 (rev. 0x00)
ppb0 at pci0 dev 1 function 0: vendor 0x1022 product 0x9602 (rev. 0x00)
pci1 at ppb0 bus 1
pci1: i/o space, memory space enabled
vga0 at pci1 dev 5 function 0: vendor 0x1002 product 0x9710 (rev. 0x00)
wsdisplay0 at vga0 kbdmux 1: console (80x25, vt100 emulation)
wsmux1: connecting to wsdisplay0
drm at vga0 not configured
azalia0 at pci1 dev 5 function 1: Generic High Definition Audio Controller
azalia0: interrupting at ioapic0 pin 19
azalia0: host: 0x1002/0x970f (rev. 0), HDA rev. 1.0
ppb1 at pci0 dev 10 function 0: vendor 0x1022 product 0x9609 (rev. 0x00)
ppb1: unsupported PCI Express version
pci2 at ppb1 bus 2
pci2: i/o space, memory space enabled, rd/line, wr/inv ok
re0 at pci2 dev 0 function 0: RealTek 8168B/8111B PCIe Gigabit Ethernet (rev. 
0x02)
re0: interrupting at ioapic0 pin 18
re0: Ethernet address 6c:f0:49:01:04:61
re0: using 256 tx descriptors
rgephy0 at re0 phy 7: RTL8169S/8110S/8211 1000BASE-T media interface, rev. 2
rgephy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 
1000baseT-FDX, auto
ahcisata0 at pci0 dev 17 function 0: vendor 0x1002 product 0x4391
ahcisata0: interrupting at ioapic0 pin 22
ahcisata0: AHCI revision 1.1, 4 ports, 32 command slots, features 0xf722e080
atabus0 at ahcisata0 channel 0
atabus1 at ahcisata0 channel 1
atabus2 at ahcisata0 channel 2
atabus3 at ahcisata0 channel 3
ohci0 at pci0 dev 18 function 0: vendor 0x1002 product 0x4397 (rev. 0x00)
ohci0: interrupting at ioapic0 pin 16
ohci0: OHCI version 1.0, legacy support
usb0 at ohci0: USB revision 1.0
ohci1 at pci0 dev 18 function 1: vendor 0x1002 product 0x4398 (rev. 0x00)
ohci1: interrupting at ioapic0 pin 16
ohci1: OHCI version 1.0, legacy support
usb1 at ohci1: USB revision 1.0
ehci0 at pci0 dev 18 function 2: vendor 0x1002 product 0x4396 (rev. 0x00)
ehci0: interrupting at ioapic0 pin 17
ehci0: dropped intr workaround enabled
ehci0: EHCI version 1.0
ehci0: companion controllers, 3 ports each: ohci0 ohci1
usb2 at ehci0: USB revision 2.0
ohci2 at pci0 dev 19 function 0: vendor 0x1002 product 0x4397 (rev. 0x00)
ohci2: interrupting at ioapic0 pin 18
ohci2: OHCI version 1.0, legacy support
usb3 at ohci2: USB revision 1.0
ohci3 at pci0 dev 19 function 1: vendor 0x1002 product 0x4398 (rev. 0x00)
ohci3: interrupting at ioapic0 pin 18
ohci3: OHCI version 1.0, legacy support
usb4 at ohci3: USB revision 1.0
ehci1 at pci0 dev 19 function 2: vendor 0x1002 product 0x4396 (rev. 0x00)
ehci1: interrupting at ioapic0 pin 19
ehci1: dropped intr workaround enabled
ehci1: EHCI version 1.0
ehci1: companion controllers, 3 ports each: ohci2 ohci3
usb5 at ehci1: USB revision 2.0
piixpm0 at pci0 dev 20 function 0
piixpm0: vendor 0x1002 product 0x4385 (rev. 0x3c)
piixpm0: interrupting at SMIpiixpm0: polling
iic0 at piixpm0: I2C bus
ixpide0 at pci0 dev 20 function 1
ixpide0: ATI Technologies IXP IDE Controller (rev. 0x00)
ixpide0: bus-master DMA support present
ixpide0: primary channel configured to compatibility mode
ixpide0: primary channel interrupting at ioapic0 pin 14
atabus4 at ixpide0 channel 0
ixpide0: secondary channel configured to compatibility mode
ixpide0: secondary channel interrupting at ioapic0 pin 15
atabus5 at ixpide0 channel 1
azalia1 at pci0 dev 20 function 2: Generic High Definition Audio Controller
azalia1: interrupting at ioapic0 pin 16
azalia1: host: 0x1002/0x4383 (rev. 0), HDA rev. 1.0
pcib0 at pci0 dev 20 function 3
pcib0: vendor 0x1002 product 0x439d (rev. 0x00)
ppb2 at pci0 dev 20 function 4: vendor 0x1002 product 0x4384 (rev. 0x00)
pci3 at ppb2 bus 3
pci3: i/o space, memory space enabled
ohci4 at pci0 dev 20 function 5: vendor 0x1002 product 0x4399 (rev. 0x00)
ohci4: interrupting at ioapic0 pin 18
ohci4: OHCI version 1.0, legacy support
usb6 at ohci4: USB revision 1.0
pchb1 at pci0 dev 24 function 0
pchb1: vendor 0x1022 product 0x1200 (rev. 0x00)
pchb2 at pci0 dev 24 function 1
pchb2: vendor 0x1022 product 0x1201 (rev. 0x00)
pchb3 at pci0 dev 24 function 2
pchb3: vendor 0x1022 product 0x1202 (rev. 0x00)
amdtemp0 at pci0 dev 24 function 3
amdtemp0: AMD CPU Temperature Sensors (Family10h / Family11h)
pchb4 at pci0 dev 24 function 4
pchb4: vendor 0x1022 product 0x1204 (rev. 0x00)
isa0 at pcib0
pckbc0 at isa0 port 0x60-0x64
pckbc: cmd word write error
timecounter: Timecounter "clockinterrupt" frequency 100 Hz quality 0
timecounter: Timecounter "TSC" frequency 3415571260 Hz quality 3000
azalia0: codec[0]: ATI RS690/780 HDMI (rev. 0.0), HDA rev. 1.0
audio0 at azalia0: full duplex, independent
azalia1: codec[0]: Realtek ALC885 (rev. 1.1), HDA rev. 1.0
audio1 at azalia1: full duplex, independent
uhub0 at usb0: vendor 0x1002 OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 3 ports with 3 removable, self powered
uhub1 at usb1: vendor 0x1002 OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub1: 3 ports with 3 removable, self powered
uhub2 at usb2: vendor 0x1002 EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
uhub2: 6 ports with 6 removable, self powered
uhub3 at usb3: vendor 0x1002 OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub3: 3 ports with 3 removable, self powered
uhub4 at usb4: vendor 0x1002 OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub4: 3 ports with 3 removable, self powered
uhub5 at usb5: vendor 0x1002 EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
uhub5: 6 ports with 6 removable, self powered
uhub6 at usb6: vendor 0x1002 OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub6: 2 ports with 2 removable, self powered
ahcisata0 port 2: device present, speed: 1.5Gb/s
wd0 at atabus2 drive 0: <WDC WD740ADFD-00NLR1>
wd0: drive supports 16-sector PIO transfers, LBA48 addressing
wd0: 70910 MB, 144071 cyl, 16 head, 63 sec, 512 bytes/sect x 145223999 sectors
wd0: drive supports PIO mode 4, DMA mode 2, Ultra-DMA mode 6 (Ultra/133)
wd0(ahcisata0:2:0): using PIO mode 4, DMA mode 2, Ultra-DMA mode 6 (Ultra/133) 
(using DMA)
atapibus0 at atabus5: 2 targets
cd0 at atapibus0 drive 0: <TSSTcorp CDDVDW SH-S223F, , SB03> cdrom removable
cd0: 32-bit data port
cd0: drive supports PIO mode 4, DMA mode 2, Ultra-DMA mode 5 (Ultra/100)
cd0(ixpide0:1:0): using PIO mode 4, Ultra-DMA mode 5 (Ultra/100) (using DMA)
Kernelized RAIDframe activated
pad0: outputs: 44100Hz, 16-bit, stereo
audio2 at pad0: half duplex
boot device: wd0
root on wd0a dumps on wd0b
root file system type: ffs
uhidev0 at uhub0 port 1 configuration 1 interface 0
uhidev0: Logitech USB-PS/2 Optical Mouse, rev 2.00/21.00, addr 2, iclass 3/1
ums0 at uhidev0: 8 buttons and Z dir.
wsmouse0 at ums0 mux 0
uhidev1 at uhub1 port 2 configuration 1 interface 0
uhidev1: Logitech HID compliant keyboard, rev 1.10/1.80, addr 2, iclass 3/1
ukbd0 at uhidev1
wskbd0 at ukbd0 mux 1
wskbd0: connecting to wsdisplay0
uhidev2 at uhub1 port 2 configuration 1 interface 1
uhidev2: Logitech HID compliant keyboard, rev 1.10/1.80, addr 2, iclass 3/0
uhidev2: 2 report ids
uhid0 at uhidev2 reportid 1: input=2, output=0, feature=0
uhid1 at uhidev2 reportid 2: input=1, output=0, feature=0
wsdisplay0: screen 1 added (80x25, vt100 emulation)
wsdisplay0: screen 2 added (80x25, vt100 emulation)
wsdisplay0: screen 3 added (80x25, vt100 emulation)
wsdisplay0: screen 4 added (80x25, vt100 emulation)

>How-To-Repeat:

>Fix:
Follow-Ups:
- Re: kern/42843: High interrupt load
  - From: Andreas Wrede
Prev by Date: NetBSD Nightly Trouble Ticket Report
Next by Date: Re: kern/42799: LVM logical volumes fail to attach if 'pseudo-device dm' is compiled in th kernel
Previous by Thread: lib/42842: atomic_ops(3) cannot be used from C++
Next by Thread: Re: kern/42843: High interrupt load
Indexes:
Home | Main Index | Thread Index | Old Index