Date: Wed, 28 Jul 2010 19:53:47 +0200 From: David Naylor <naylor.b.david@gmail.com> To: "freebsd-current@freebsd.org" <freebsd-current@freebsd.org> Cc: mav@freebsd.org Subject: Interrupt Problems Message-ID: <201007281953.53131.naylor.b.david@gmail.com>
next in thread | raw e-mail | index | archive | help
--nextPart1520521.INfujltebS
Content-Type: multipart/mixed;
boundary="Boundary-01=_s6GUMCWklHy2Vra"
Content-Transfer-Encoding: 7bit
--Boundary-01=_s6GUMCWklHy2Vra
Content-Type: text/plain;
charset="us-ascii"
Content-Transfer-Encoding: quoted-printable
Content-Disposition: inline
Hi,
I have been having interrupt related problems with various subsystems. I=20
suspect this is related to the changes in the event timer infrastructure. =
=20
The subsystems that have experienced interrupt problems:
- hda: this is the easiest to reproduce and what I used to isolate the=20
commits. I get ``pcm0: chn_write(): pcm0:virtual:dsp0.vp0: play interrupt=
=20
timeout, channel dead'' reported and sound no longer plays.
- nfe: this has happened on occasion with no reliable way to reproduce. =20
``watchdog timeouts'' are reported. After this happens all network traffic=
dies=20
and doing `ifconfig nfe0 down; ifconfig nfe0 up' panics the computer.
- dc: same thing as above. =20
- nvidia: has reported interrupt timeouts. This is independent of the=20
locking problem (that is fixed with recently published patch). No reliable=
way=20
to reproduce, appears to happen when under heavy load. X freezes as a resu=
lt. =20
- ata: I had a HDD detach twice. I am not sure if this is related. I hav=
e=20
two HDD, each attached to a different controller. =20
I tested this by using a kernel built from a cvsup date of 2010/06/20 and=20
2010/06/22 (at midnight for both, aka 00:00:00). The former kernel does no=
t=20
exhibit any problems while the latter does. This problem is also present w=
ith=20
a kernel from today. =20
The motherboard is a N650SLI-DS4L with one graphics card. See attached for=
=20
more system information. =20
Is there anything I can do to help diagnose the problem? =20
Regards,
David
--Boundary-01=_s6GUMCWklHy2Vra
Content-Type: text/plain;
charset="iso-8859-1";
name="sysctl.time"
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment;
filename="sysctl.time"
kern.eventtimer.choice: LAPIC(500) HPET(450) HPET1(440) HPET2(440) i8254(100) RTC(0)
kern.eventtimer.et.LAPIC.flags: 15
kern.eventtimer.et.LAPIC.frequency: 133334794
kern.eventtimer.et.LAPIC.quality: 500
kern.eventtimer.et.i8254.flags: 1
kern.eventtimer.et.i8254.frequency: 1193182
kern.eventtimer.et.i8254.quality: 100
kern.eventtimer.et.HPET.flags: 3
kern.eventtimer.et.HPET.frequency: 25000000
kern.eventtimer.et.HPET.quality: 450
kern.eventtimer.et.HPET1.flags: 3
kern.eventtimer.et.HPET1.frequency: 25000000
kern.eventtimer.et.HPET1.quality: 440
kern.eventtimer.et.HPET2.flags: 3
kern.eventtimer.et.HPET2.frequency: 25000000
kern.eventtimer.et.HPET2.quality: 440
kern.eventtimer.et.RTC.flags: 17
kern.eventtimer.et.RTC.frequency: 32768
kern.eventtimer.et.RTC.quality: 0
kern.eventtimer.timer2: HPET
kern.eventtimer.timer1: LAPIC
kern.eventtimer.singlemul: 2
kern.timecounter.tick: 1
kern.timecounter.choice: TSC(-100) HPET(900) i8254(0) ACPI-fast(1000) dummy(-1000000)
kern.timecounter.hardware: ACPI-fast
kern.timecounter.stepwarnings: 0
kern.timecounter.tc.ACPI-fast.mask: 16777215
kern.timecounter.tc.ACPI-fast.counter: 2199550
kern.timecounter.tc.ACPI-fast.frequency: 3579545
kern.timecounter.tc.ACPI-fast.quality: 1000
kern.timecounter.tc.i8254.mask: 65535
kern.timecounter.tc.i8254.counter: 46239
kern.timecounter.tc.i8254.frequency: 1193182
kern.timecounter.tc.i8254.quality: 0
kern.timecounter.tc.HPET.mask: 4294967295
kern.timecounter.tc.HPET.counter: 2739146685
kern.timecounter.tc.HPET.frequency: 25000000
kern.timecounter.tc.HPET.quality: 900
kern.timecounter.tc.TSC.mask: 4294967295
kern.timecounter.tc.TSC.counter: 2718611985
kern.timecounter.tc.TSC.frequency: 2400025995
kern.timecounter.tc.TSC.quality: -100
kern.timecounter.smp_tsc: 0
kern.timecounter.invariant_tsc: 1
--Boundary-01=_s6GUMCWklHy2Vra
Content-Type: text/plain;
charset="iso-8859-1";
name="dmesg.boot"
Content-Transfer-Encoding: 7bit
Content-Disposition: attachment;
filename="dmesg.boot"
Copyright (c) 1992-2010 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 9.0-CURRENT #1: Wed Jul 28 15:47:21 SAST 2010
root@dragon.dg:/tmp/home/freebsd9/src/sys/GENERIC amd64
WARNING: WITNESS option enabled, expect reduced performance.
CPU: Intel(R) Core(TM)2 Quad CPU @ 2.40GHz (2400.03-MHz K8-class CPU)
Origin = "GenuineIntel" Id = 0x6f7 Family = 6 Model = f Stepping = 7
Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
Features2=0xe3bd<SSE3,DTES64,MON,DS_CPL,VMX,EST,TM2,SSSE3,CX16,xTPR,PDCM>
AMD Features=0x20100800<SYSCALL,NX,LM>
AMD Features2=0x1<LAHF>
TSC: P-state invariant
real memory = 6442450944 (6144 MB)
avail memory = 6163714048 (5878 MB)
Event timer "LAPIC" frequency 0 Hz quality 500
ACPI APIC Table: <GBT NVDAACPI>
FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs
FreeBSD/SMP: 1 package(s) x 4 core(s)
cpu0 (BSP): APIC ID: 0
cpu1 (AP): APIC ID: 1
cpu2 (AP): APIC ID: 2
cpu3 (AP): APIC ID: 3
ioapic0: Changing APIC ID to 2
ioapic0 <Version 1.1> irqs 0-23 on motherboard
kbd1 at kbdmux0
acpi0: <GBT NVDAACPI> on motherboard
acpi0: [ITHREAD]
acpi0: Power Button (fixed)
acpi0: reservation of 0, a0000 (3) failed
acpi0: reservation of 100000, cfef0000 (3) failed
Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
acpi_button0: <Power Button> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
pci0: <memory, RAM> at device 0.1 (no driver attached)
pci0: <memory, RAM> at device 0.2 (no driver attached)
pci0: <memory, RAM> at device 0.3 (no driver attached)
pci0: <memory, RAM> at device 0.4 (no driver attached)
pci0: <memory, RAM> at device 0.5 (no driver attached)
pci0: <memory, RAM> at device 0.6 (no driver attached)
pci0: <memory, RAM> at device 0.7 (no driver attached)
pci0: <memory, RAM> at device 1.0 (no driver attached)
pci0: <memory, RAM> at device 1.1 (no driver attached)
pci0: <memory, RAM> at device 1.2 (no driver attached)
pci0: <memory, RAM> at device 1.3 (no driver attached)
pci0: <memory, RAM> at device 1.4 (no driver attached)
pci0: <memory, RAM> at device 1.5 (no driver attached)
pci0: <memory, RAM> at device 1.6 (no driver attached)
pci0: <memory, RAM> at device 2.0 (no driver attached)
pci0: <memory, RAM> at device 2.1 (no driver attached)
pci0: <memory, RAM> at device 2.2 (no driver attached)
pcib1: <ACPI PCI-PCI bridge> at device 3.0 on pci0
pci1: <ACPI PCI bus> on pcib1
vgapci0: <VGA-compatible display> port 0xc000-0xc07f mem 0xe2000000-0xe2ffffff,0xd0000000-0xdfffffff,0xe3000000-0xe3ffffff irq 16 at device 0.0 on pci1
nvidia0: <GeForce 7600 GT> on vgapci0
vgapci0: child nvidia0 requested pci_enable_busmaster
vgapci0: child nvidia0 requested pci_enable_io
vgapci0: child nvidia0 requested pci_enable_io
nvidia0: [ITHREAD]
pci0: <memory, RAM> at device 9.0 (no driver attached)
isab0: <PCI-ISA bridge> at device 10.0 on pci0
isa0: <ISA bus> on isab0
pci0: <serial bus, SMBus> at device 10.1 (no driver attached)
pci0: <memory, RAM> at device 10.2 (no driver attached)
ohci0: <OHCI (generic) USB controller> mem 0xe7006000-0xe7006fff irq 21 at device 11.0 on pci0
ohci0: [ITHREAD]
usbus0: <OHCI (generic) USB controller> on ohci0
ehci0: <EHCI (generic) USB 2.0 controller> mem 0xe7007000-0xe70070ff irq 22 at device 11.1 on pci0
ehci0: [ITHREAD]
usbus1: EHCI version 1.0
usbus1: <EHCI (generic) USB 2.0 controller> on ehci0
atapci0: <nVidia nForce MCP51 UDMA133 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xf000-0xf00f at device 13.0 on pci0
ata0: <ATA channel 0> on atapci0
ata0: [ITHREAD]
ata1: <ATA channel 1> on atapci0
ata1: [ITHREAD]
atapci1: <nVidia nForce MCP51 SATA300 controller> port 0x9f0-0x9f7,0xbf0-0xbf3,0x970-0x977,0xb70-0xb73,0xe500-0xe50f mem 0xe7004000-0xe7004fff irq 23 at device 14.0 on pci0
atapci1: [ITHREAD]
ata2: <ATA channel 0> on atapci1
ata2: [ITHREAD]
ata3: <ATA channel 1> on atapci1
ata3: [ITHREAD]
atapci2: <nVidia nForce MCP51 SATA300 controller> port 0x9e0-0x9e7,0xbe0-0xbe3,0x960-0x967,0xb60-0xb63,0xea00-0xea0f mem 0xe7005000-0xe7005fff irq 20 at device 15.0 on pci0
atapci2: [ITHREAD]
ata4: <ATA channel 0> on atapci2
ata4: [ITHREAD]
ata5: <ATA channel 1> on atapci2
ata5: [ITHREAD]
pcib2: <ACPI PCI-PCI bridge> at device 16.0 on pci0
pci2: <ACPI PCI bus> on pcib2
dc0: <Accton EN2242 MiniPCI 10/100BaseTX> port 0xd000-0xd0ff mem 0xe6000000-0xe60003ff irq 17 at device 7.0 on pci2
miibus0: <MII bus> on dc0
ukphy0: <Generic IEEE 802.3u media interface> PHY 1 on miibus0
ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
dc0: Ethernet address: XX:XX:XX:XX:XX:XX
dc0: [ITHREAD]
hdac0: <NVidia MCP51 High Definition Audio Controller> mem 0xe7000000-0xe7003fff irq 21 at device 16.1 on pci0
hdac0: HDA Driver Revision: 20100226_0142
hdac0: [ITHREAD]
nfe0: <NVIDIA nForce 430 MCP13 Networking Adapter> port 0xec00-0xec07 mem 0xe7008000-0xe7008fff irq 22 at device 20.0 on pci0
miibus1: <MII bus> on nfe0
rgephy0: <RTL8169S/8110S/8211B media interface> PHY 1 on miibus1
rgephy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-FDX, auto
nfe0: Ethernet address: XX:XX:XX:XX:XX:XX
nfe0: [FILTER]
attimer0: <AT timer> port 0x40-0x43 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
attimer0: [FILTER]
Event timer "i8254" frequency 1193182 Hz quality 100
hpet0: <High Precision Event Timer> iomem 0xfeff0000-0xfeff03ff irq 0,8 on acpi0
Timecounter "HPET" frequency 25000000 Hz quality 900
hpet0: [FILTER]
Event timer "HPET" frequency 25000000 Hz quality 450
Event timer "HPET1" frequency 25000000 Hz quality 440
Event timer "HPET2" frequency 25000000 Hz quality 440
atrtc0: <AT realtime clock> port 0x70-0x73 on acpi0
atrtc0: [FILTER]
Event timer "RTC" frequency 32768 Hz quality 0
uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
uart0: [FILTER]
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
atkbd0: [ITHREAD]
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: [GIANT-LOCKED]
psm0: [ITHREAD]
psm0: model IntelliMouse, device ID 3
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
ppc0: cannot reserve I/O port range
acpi_perf0: <ACPI CPU Frequency Control> on cpu0
p4tcc0: <CPU Frequency Thermal Control> on cpu0
est1: <Enhanced SpeedStep Frequency Control> on cpu1
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 925092506000925
device_attach: est1 attach returned 6
p4tcc1: <CPU Frequency Thermal Control> on cpu1
est2: <Enhanced SpeedStep Frequency Control> on cpu2
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 925092506000925
device_attach: est2 attach returned 6
p4tcc2: <CPU Frequency Thermal Control> on cpu2
est3: <Enhanced SpeedStep Frequency Control> on cpu3
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 925092506000925
device_attach: est3 attach returned 6
p4tcc3: <CPU Frequency Thermal Control> on cpu3
Starting kernel event timers: LAPIC @ 1000Hz, HPET @ 127Hz
Timecounters tick every 1.000 msec
usbus0: 12Mbps Full Speed USB v1.0
usbus1: 480Mbps High Speed USB v2.0
acd0: DMA limited to UDMA33, device found non-ATA66 cable
acd0: DVDR <ASUS DRW-1814BL/1.13> at ata0-master UDMA33
ad4: 305244MB <Seagate ST3320620AS 3.AAK> at ata2-master UDMA100 SATA 1.5Gb/s
ugen0.1: <nVidia> at usbus0
uhub0: <nVidia OHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus0
ugen1.1: <nVidia> at usbus1
uhub1: <nVidia EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus1
ad8: 476940MB <Seagate ST3500412AS CC32> at ata4-master UDMA100 SATA 1.5Gb/s
hdac0: HDA Codec #0: Realtek ALC888
pcm0: <HDA Realtek ALC888 PCM #0 Analog> at cad 0 nid 1 on hdac0
pcm1: <HDA Realtek ALC888 PCM #1 Analog> at cad 0 nid 1 on hdac0
pcm2: <HDA Realtek ALC888 PCM #2 Digital> at cad 0 nid 1 on hdac0
SMP: AP CPU #1 Launched!
SMP: AP CPU #2 Launched!
SMP: AP CPU #3 Launched!
WARNING: WITNESS option enabled, expect reduced performance.
GEOM_MIRROR: Device mirror/gm0 launched (2/2).
uhub0: 8 ports with 8 removable, self powered
Root mount waiting for: usbus1
Root mount waiting for: usbus1
uhub1: 8 ports with 8 removable, self powered
Trying to mount root from ufs:/dev/mirror/gm0a
WARNING: / was not properly dismounted
WARNING: TMPFS is considered to be a highly experimental feature in FreeBSD.
lock order reversal:
1st 0xffffff00048a6278 ufs (ufs) @ /home/freebsd9/src/sys/kern/vfs_lookup.c:502
2nd 0xffffff807b5b5f98 bufwait (bufwait) @ /home/freebsd9/src/sys/ufs/ffs/ffs_softdep.c:11291
3rd 0xffffff0004904458 ufs (ufs) @ /home/freebsd9/src/sys/kern/vfs_subr.c:2090
KDB: stack backtrace:
db_trace_self_wrapper() at db_trace_self_wrapper+0x2a
_witness_debugger() at _witness_debugger+0x49
witness_checkorder() at witness_checkorder+0x7ea
__lockmgr_args() at __lockmgr_args+0xd43
ffs_lock() at ffs_lock+0x8c
VOP_LOCK1_APV() at VOP_LOCK1_APV+0x9b
_vn_lock() at _vn_lock+0x50
vget() at vget+0x6e
vfs_hash_get() at vfs_hash_get+0xd1
ffs_vgetf() at ffs_vgetf+0x3d
softdep_sync_metadata() at softdep_sync_metadata+0x5df
ffs_syncvnode() at ffs_syncvnode+0x22d
ffs_truncate() at ffs_truncate+0x211
ufs_direnter() at ufs_direnter+0x775
ufs_makeinode() at ufs_makeinode+0x250
VOP_CREATE_APV() at VOP_CREATE_APV+0x93
vn_open_cred() at vn_open_cred+0x410
kern_openat() at kern_openat+0x163
syscallenter() at syscallenter+0x194
syscall() at syscall+0x41
Xfast_syscall() at Xfast_syscall+0xe2
--- syscall (5, FreeBSD ELF64, open), rip = 0x80072847c, rsp = 0x7fffffffeb48, rbp = 0 ---
bridge0: Ethernet address: XX:XX:XX:XX:XX:XX
nfe0: link state changed to UP
--Boundary-01=_s6GUMCWklHy2Vra--
--nextPart1520521.INfujltebS
Content-Type: application/pgp-signature; name=signature.asc
Content-Description: This is a digitally signed message part.
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v2.0.14 (FreeBSD)
iEYEABECAAYFAkxQbrEACgkQUaaFgP9pFrI+hQCfQWaYnRQYj1IWHDarWnPMuBCS
nDQAn0S/2zJjEmlBblkbYZPMgcpjTH35
=9xz9
-----END PGP SIGNATURE-----
--nextPart1520521.INfujltebS--
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?201007281953.53131.naylor.b.david>