From owner-freebsd-stable@FreeBSD.ORG Fri Jul 16 23:30:48 2010 Return-Path: Delivered-To: freebsd-stable@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 10B9B106566C for ; Fri, 16 Jul 2010 23:30:48 +0000 (UTC) (envelope-from christof.schulze@gmx.com) Received: from mailout-eu.gmx.com (mailout-eu.gmx.com [213.165.64.42]) by mx1.freebsd.org (Postfix) with SMTP id 5B1208FC12 for ; Fri, 16 Jul 2010 23:30:47 +0000 (UTC) Received: (qmail invoked by alias); 16 Jul 2010 23:30:45 -0000 Received: from e180219233.adsl.alicedsl.de (EHLO klausdieter0815.dyndns.org) [85.180.219.233] by mail.gmx.com (mp-eu005) with SMTP; 17 Jul 2010 01:30:45 +0200 X-Authenticated: #56306756 X-Provags-ID: V01U2FsdGVkX1+IneJgiO+IzRH2PhAmoDbVI1BnVn1gSe6lG4DsD/ /C8STLn6SvmihY Received: by myhost.mydomain.de (Postfix, from userid 1001) id 0AA7491C3; Sat, 17 Jul 2010 01:30:44 +0200 (CEST) From: Christof Schulze To: freebsd-stable@freebsd.org Date: Sat, 17 Jul 2010 01:30:25 +0200 User-Agent: KMail/1.13.5 (FreeBSD/8.1-RC1; KDE/4.4.5; amd64; ; ) MIME-Version: 1.0 Content-Type: multipart/signed; boundary="nextPart6127825.jy1zcbCnie"; protocol="application/pgp-signature"; micalg=pgp-sha1 Content-Transfer-Encoding: 7bit Message-Id: <201007170130.44701.christof.schulze@gmx.com> X-Y-GMX-Trusted: 0 Subject: interrupt issues 8_RELENG from two days ago X-BeenThere: freebsd-stable@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Production branch of FreeBSD source code List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Fri, 16 Jul 2010 23:30:48 -0000 --nextPart6127825.jy1zcbCnie Content-Type: Text/Plain; charset="us-ascii" Content-Transfer-Encoding: quoted-printable Hello everyone, having upgraded my laptop to a recent 8_RELENG from an earlier 8_RELENG fro= m =20 the time of the 8.0 release, I find it behaves very strangely. When booting devd hangs often until cancelled with ctrl+c. Sometimes it seems that pending work is waiting for disk activity until it = is=20 kicked off. I noticed this when setting up the keycodes for zsh and the=20 duration for reading each key differed significantly depending whether ther= e=20 was disk activity or not. This happens as well in X as in console. I tried disabling powerd, setting kern.hz to 100 and using the timers ACPI- =46AST (default), HPET, i8254 and TSC - no change so far. I am not sure if it is because an ancient configuration setting I had in pl= ace=20 earlier and that I am missing now or whether this is due to a code change. However, I am at a loss and would appreciate further input on the matter. D= ue=20 to the upcoming release I am posting to -stable just to get this tracked in= =20 case this is the symptom of some obscure bug. Thank you in advance & Regards Christof This is vmstat -i: % vmstat -i = =20 ~ interrupt total rate irq1: atkbd0 28 0 irq9: acpi0 173 0 irq12: psm0 17 0 irq14: ata0 3009 8 irq16: wpi0 uhci3+ 5516 15 irq18: uhci2 14 0 irq21: fwohci0 2 0 irq22: bfe0 sdhci0 608 1 irq23: uhci0 ehci0 2 0 cpu0: timer 18165 51 irq256: hdac0 17 0 cpu1: timer 17986 50 Total 45537 127 this is dmesg: % dmesg = =20 ~ 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. =46reeBSD is a registered trademark of The FreeBSD Foundation. =46reeBSD 8.1-PRERELEASE #0: Thu Jul 15 14:29:16 UTC 2010 root@:/usr/obj/usr/src/sys/GENERIC amd64 Timecounter "i8254" frequency 1193182 Hz quality 0 CPU: Intel(R) Core(TM)2 CPU T5500 @ 1.66GHz (1662.52-MHz K8-class= =20 CPU) Origin =3D "GenuineIntel" Id =3D 0x6f6 Family =3D 6 Model =3D f Stepp= ing =3D 6 Features=3D0xbfebfbff Features2=3D0xe39d AMD Features=3D0x20100800 AMD Features2=3D0x1 TSC: P-state invariant real memory =3D 2684354560 (2560 MB) avail memory =3D 2562097152 (2443 MB) ACPI APIC Table: =46reeBSD/SMP: Multiprocessor System Detected: 2 CPUs =46reeBSD/SMP: 1 package(s) x 2 core(s) cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 1 ioapic0: Changing APIC ID to 1 ioapic0 irqs 0-23 on motherboard kbd1 at kbdmux0 acpi0: on motherboard acpi0: [ITHREAD] acpi0: Power Button (fixed) Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 cpu0: on acpi0 cpu1: on acpi0 acpi_ec0: port 0x62,0x66 on acpi0 acpi_hpet0: iomem 0xfed00000-0xfed003ff on acp= i0 Timecounter "HPET" frequency 14318180 Hz quality 900 acpi_acad0: on acpi0 battery0: on acpi0 acpi_lid0: on acpi0 acpi_button0: on acpi0 acpi_button1: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 vgapci0: port 0x1800-0x1807 mem=20 0xd8100000-0xd817ffff,0xc0000000-0xcfffffff,0xd8200000-0xd823ffff irq 16 at= =20 device 2.0 on pci0 agp0: on vgapci0 agp0: detected 7932k stolen memory agp0: aperture size is 256M vgapci1: mem 0xd8180000-0xd81fffff at device 2.1 o= n=20 pci0 hdac0: mem=20 0xd8240000-0xd8243fff irq 22 at device 27.0 on pci0 hdac0: HDA Driver Revision: 20100226_0142 hdac0: [ITHREAD] pcib1: irq 17 at device 28.0 on pci0 pci2: on pcib1 wpi0: mem 0xd4000000-0xd4000fff irq 16 at=20 device 0.0 on pci2 wpi0: Driver Revision 20071127 wpi0: Hardware Revision (0x1) adding chan 1 (2412MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 2 adding chan 2 (2417MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 4 adding chan 3 (2422MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 6 adding chan 4 (2427MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 8 adding chan 5 (2432MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 10 adding chan 6 (2437MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 12 adding chan 7 (2442MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 14 adding chan 8 (2447MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 16 adding chan 9 (2452MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 18 adding chan 10 (2457MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 20 adding chan 11 (2462MHz) flags=3D0x2b maxpwr=3D15 passive=3D0, offset 22 adding chan 12 (2467MHz) flags=3D0x21 maxpwr=3D15 passive=3D1, offset 24 adding chan 13 (2472MHz) flags=3D0x21 maxpwr=3D15 passive=3D1, offset 26 adding chan 34 (5170MHz) flags=3D0x21 maxpwr=3D15 passive=3D1, offset 27 adding chan 36 (5180MHz) flags=3D0xab maxpwr=3D15 passive=3D0, offset 28 adding chan 38 (5190MHz) flags=3D0x21 maxpwr=3D15 passive=3D1, offset 29 adding chan 40 (5200MHz) flags=3D0xab maxpwr=3D15 passive=3D0, offset 30 adding chan 42 (5210MHz) flags=3D0x21 maxpwr=3D15 passive=3D1, offset 31 adding chan 44 (5220MHz) flags=3D0xab maxpwr=3D15 passive=3D0, offset 32 adding chan 46 (5230MHz) flags=3D0x21 maxpwr=3D15 passive=3D1, offset 33 adding chan 48 (5240MHz) flags=3D0xab maxpwr=3D15 passive=3D0, offset 34 adding chan 52 (5260MHz) flags=3D0xb1 maxpwr=3D15 passive=3D1, offset 35 adding chan 56 (5280MHz) flags=3D0xb1 maxpwr=3D15 passive=3D1, offset 36 adding chan 60 (5300MHz) flags=3D0xb1 maxpwr=3D15 passive=3D1, offset 37 adding chan 64 (5320MHz) flags=3D0xb1 maxpwr=3D15 passive=3D1, offset 38 adding chan 100 (5500MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 39 adding chan 104 (5520MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 40 adding chan 108 (5540MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 41 adding chan 112 (5560MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 42 adding chan 116 (5580MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 43 adding chan 120 (5600MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 44 adding chan 124 (5620MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 45 adding chan 128 (5640MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 46 adding chan 132 (5660MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 47 adding chan 136 (5680MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 48 adding chan 140 (5700MHz) flags=3D0xb1 maxpwr=3D16 passive=3D1, offset 49 power group 0: chan=3D1 maxpwr=3D45 temp=3D-176 sample 0: index=3D13 power=3D42 sample 1: index=3D29 power=3D30 sample 2: index=3D47 power=3D11 sample 3: index=3D58 power=3D0 sample 4: index=3D77 power=3D-18 power group 1: chan=3D44 maxpwr=3D50 temp=3D-180 sample 0: index=3D12 power=3D42 sample 1: index=3D19 power=3D35 sample 2: index=3D32 power=3D22 sample 3: index=3D43 power=3D11 sample 4: index=3D77 power=3D-21 power group 2: chan=3D64 maxpwr=3D48 temp=3D-179 sample 0: index=3D12 power=3D41 sample 1: index=3D20 power=3D34 sample 2: index=3D33 power=3D21 sample 3: index=3D44 power=3D11 sample 4: index=3D77 power=3D-19 power group 3: chan=3D116 maxpwr=3D47 temp=3D-178 sample 0: index=3D12 power=3D36 sample 1: index=3D20 power=3D28 sample 2: index=3D36 power=3D11 sample 3: index=3D48 power=3D1 sample 4: index=3D77 power=3D-26 power group 4: chan=3D153 maxpwr=3D47 temp=3D-176 sample 0: index=3D10 power=3D35 sample 1: index=3D20 power=3D23 sample 2: index=3D32 power=3D11 sample 3: index=3D42 power=3D3 sample 4: index=3D77 power=3D-28 wpi0: Regulatory Domain: MoW2 wpi0: Hardware Type: B wpi0: Hardware Revision: ? wpi0: SKU does support 802.11a wpi0: [ITHREAD] pcib2: irq 16 at device 28.1 on pci0 pci3: on pcib2 uhci0: port 0x1820-0x183f irq 23= at=20 device 29.0 on pci0 uhci0: [ITHREAD] usbus0: on uhci0 uhci1: port 0x1840-0x185f irq 19= at=20 device 29.1 on pci0 uhci1: [ITHREAD] usbus1: on uhci1 uhci2: port 0x1860-0x187f irq 18= at=20 device 29.2 on pci0 uhci2: [ITHREAD] usbus2: on uhci2 uhci3: port 0x1880-0x189f irq 16= at=20 device 29.3 on pci0 uhci3: [ITHREAD] usbus3: on uhci3 ehci0: mem 0xd8444000-0xd84443f= f=20 irq 23 at device 29.7 on pci0 ehci0: [ITHREAD] usbus4: EHCI version 1.0 usbus4: on ehci0 pcib3: at device 30.0 on pci0 pci5: on pcib3 bfe0: mem 0xd8000000-0xd8001fff irq 22 = at=20 device 5.0 on pci5 miibus0: on bfe0 bmtphy0: PHY 1 on miibus0 bmtphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto bfe0: Ethernet address: 00:13:77:27:90:3a bfe0: [ITHREAD] cbb0: at device 9.0 on pci5 cardbus0: on cbb0 pccard0: <16-bit PCCard bus> on cbb0 cbb0: [FILTER] fwohci0: mem 0xd8002000-0xd80027ff at device 9.1 on pci5 fwohci0: [ITHREAD] fwohci0: OHCI version 1.0 (ROM=3D1) fwohci0: No. of Isochronous channels is 4. fwohci0: EUI64 00:00:f0:41:01:03:a6:22 fwohci0: Phy 1394a available S400, 2 ports. fwohci0: Link S400, max_rec 2048 bytes. firewire0: on fwohci0 fwe0: on firewire0 if_fwe0: Fake Ethernet address: 02:00:f0:03:a6:22 fwe0: Ethernet address: 02:00:f0:03:a6:22 fwip0: on firewire0 fwip0: Firewire address: 00:00:f0:41:01:03:a6:22 @ 0xfffe00000000, S400,=20 maxrec 2048 dcons_crom0: on firewire0 dcons_crom0: bus_addr 0x9ab44000 fwohci0: Initiate bus reset fwohci0: fwohci_intr_core: BUS reset fwohci0: fwohci_intr_core: node_id=3D0x00000000, SelfID Count=3D1, CYCLEMAS= TER=20 mode sdhci0: mem 0xd8002800-0xd80028ff at device 9.2 on pci5 sdhci0: 1 slot(s) allocated sdhci0: [ITHREAD] pci5: at device 9.3 (no driver attached) pci5: at device 9.4 (no driver attached) pci5: at device 9.5 (no driver attached) isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port=20 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x1810-0x181f at device 31.1 on pci0 ata0: on atapci0 ata0: [ITHREAD] pci0: at device 31.3 (no driver attached) acpi_tz0: on acpi0 acpi_tz1: on acpi0 atrtc0: port 0x70-0x77 irq 8 on acpi0 atrtc0: Warning: Couldn't map I/O. atkbdc0: port 0x60,0x64 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] atkbd0: [ITHREAD] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: [ITHREAD] psm0: model IntelliMouse, device ID 3 orm0: at iomem 0xdc000-0xdffff on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=3D0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 ppc0: cannot reserve I/O port range coretemp0: on cpu0 est0: on cpu0 p4tcc0: on cpu0 coretemp1: on cpu1 est1: on cpu1 p4tcc1: on cpu1 firewire0: 1 nodes, maxhop <=3D 0 cable IRM irm(0) (me)=20 firewire0: bus manager 0=20 ZFS NOTICE: Prefetch is disabled by default if less than 4GB of RAM is=20 present; to enable, add "vfs.zfs.prefetch_disable=3D0" to /boot/loader.c= onf. ZFS filesystem version 3 ZFS storage pool version 14 Timecounters tick every 10.000 msec vboxdrv: fAsync=3D0 offMin=3D0x122 offMax=3D0x398 usbus0: 12Mbps Full Speed USB v1.0 usbus1: 12Mbps Full Speed USB v1.0 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 12Mbps Full Speed USB v1.0 usbus4: 480Mbps High Speed USB v2.0 cbb0: Unsupported card type detected ad0: 95396MB at ata0-master UDMA100=20 ugen0.1: at usbus0 uhub0: on usbus0 ugen1.1: at usbus1 uhub1: on usbus1 ugen2.1: at usbus2 uhub2: on usbus2 ugen3.1: at usbus3 uhub3: on usbus3 ugen4.1: at usbus4 uhub4: on usbus4 hdac0: HDA Codec #0: Analog Devices AD1986A hdac0: HDA Codec #1: Lucent/Agere Systems (Unknown) hdac0: hdac_widget_connection_parse: nid=3D18 WARNING: zero cnid entnum=3D4= j=3D2=20 index=3D0 entries=3D8 found=3D2 res=3D0x21002211 pcm0: at cad 0 nid 1 on hdac0 pcm1: at cad 0 nid 1 on hdac0 SMP: AP CPU #1 Launched! uhub1: 2 ports with 2 removable, self powered uhub0: 2 ports with 2 removable, self powered uhub2: 2 ports with 2 removable, self powered uhub3: 2 ports with 2 removable, self powered Root mount waiting for: usbus4 Root mount waiting for: usbus4 Root mount waiting for: usbus4 uhub4: 8 ports with 8 removable, self powered Trying to mount root from zfs:zroot/root ugen2.2: at usbus2 vboxnet0: Ethernet address: 0a:00:27:00:00:00 wlan0: Ethernet address: 00:18:de:24:c6:7c wpi0: timeout resetting Tx ring 1 wpi0: timeout resetting Tx ring 3 wpi0: timeout resetting Tx ring 4 microcode alive notification version 10e02 alive 1 microcode alive notification version 10e02 alive 1 wpi_newstate: INIT -> SCAN flags 0x0 wpi_newstate: SCAN -> AUTH flags 0x0 config chan 3 flags 8005 cck f ofdm 15 wpi_newstate: AUTH -> ASSOC flags 0x0 wpi_newstate: ASSOC -> RUN flags 0x0 config chan 3 flags 8015 wpi0: need multicast update callback wpi0: need multicast update callback wpi0: need multicast update callback WARNING: attempt to domain_add(bluetooth) after domainfinalize() drm0: on vgapci0 vgapci0: child drm0 requested pci_enable_busmaster info: [drm] AGP at 0xc0000000 256MB info: [drm] Initialized i915 1.6.0 20080730 drm0: [ITHREAD] =2D-=20 () ascii ribbon campaign - against html e-mail=20 /\ www.asciiribbon.org - against proprietary attachments --nextPart6127825.jy1zcbCnie Content-Type: application/pgp-signature; name=signature.asc Content-Description: This is a digitally signed message part. -----BEGIN PGP SIGNATURE----- Version: GnuPG v2.0.15 (FreeBSD) iEYEABECAAYFAkxA66QACgkQpZfyPAmdZJmL6ACgmHQy6o7A9QV/2zert8aQwOdI c5kAn1n5lq+3RbvVxipvluBwV4X9y2i1 =ulTX -----END PGP SIGNATURE----- --nextPart6127825.jy1zcbCnie--