From owner-freebsd-current Tue Mar 4 15:43: 5 2003 Delivered-To: freebsd-current@freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id A5A3E37B401 for ; Tue, 4 Mar 2003 15:42:45 -0800 (PST) Received: from ns.altadena.net (ns.altadena.net [207.151.161.2]) by mx1.FreeBSD.org (Postfix) with ESMTP id 35ED243F85 for ; Tue, 4 Mar 2003 15:42:44 -0800 (PST) (envelope-from pete@ns.altadena.net) Received: from ns.altadena.net (localhost [127.0.0.1]) by ns.altadena.net (8.12.6/8.12.3) with ESMTP id h24Nghpa034440 for ; Tue, 4 Mar 2003 15:42:43 -0800 (PST) (envelope-from pete@ns.altadena.net) Received: (from pete@localhost) by ns.altadena.net (8.12.6/8.12.3/Submit) id h24NghHJ034439 for current@freebsd.org; Tue, 4 Mar 2003 15:42:43 -0800 (PST) (envelope-from pete) From: Pete Carah Message-Id: <200303042342.h24NghHJ034439@ns.altadena.net> Subject: Witness problem with sound To: current@freebsd.org Date: Tue, 4 Mar 2003 15:42:43 -0800 (PST) X-Mailer: ELM [version 2.4ME+ PL68 (25)] MIME-Version: 1.0 Content-Type: text/plain; charset=iso8859-1 Content-Transfer-Encoding: 7bit Sender: owner-freebsd-current@FreeBSD.ORG Precedence: bulk List-ID: List-Archive: (Web Archive) List-Help: (List Instructions) List-Subscribe: List-Unsubscribe: X-Loop: FreeBSD.ORG I don't know how system-specific this problem is, but: Sony VAIO R505ES Sound is Intel ICH3 + Yamaha. This or something closely related has been happening for weeks. Several times earlier this week and last week sound panic'd, and also sometimes there was a panic (several different kinds) on boot. Late last week X wouldn't start due to not being able to see the VESA modes. All those except the sound problems currently appear fixed... This may or may not be related to the fact that acpi puts nearly all device interrupts on irq 9 (which causes other problems). Problem: ...... Mar 4 14:56:27 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:748 Mar 4 14:56:27 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:748 Mar 4 14:56:27 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:748 Mar 4 14:56:27 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:696 Mar 4 14:56:27 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:696 Mar 4 14:56:27 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:696 Mar 4 14:56:28 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:696 Mar 4 14:56:28 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:696 Mar 4 14:56:28 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:696 Mar 4 14:56:28 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:673 Mar 4 14:56:28 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:673 Mar 4 14:56:28 port2 kernel: /usr/src/sys/vm/uma_core.c:1330: could sleep with "pcm0:play:0" locked from /usr/src/sys/dev/sound/pcm/dsp.c:673 ..... (repeated by the thousands, at various lines, the above plus sound.c:191 . Sound comes out but is chopped up, as if interrupt service was not reliable. Dmesg: Copyright (c) 1992-2003 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 5.0-CURRENT #34: Tue Mar 4 11:36:51 PST 2003 pete@port2.altadena.net:/d/obj-c/usr/src/sys/PORT2 Preloaded elf kernel "/boot/kernel/kernel" at 0xc053f000. Preloaded elf module "/boot/kernel/acpi.ko" at 0xc053f0a8. Calibrating clock(s) ... i8254 clock: 1193201 Hz CLK_USE_I8254_CALIBRATION not specified - using default frequency Timecounter "i8254" frequency 1193182 Hz Calibrating TSC clock ... TSC clock: 1193108506 Hz Timecounter "TSC" frequency 1193108506 Hz CPU: Intel(R) Pentium(R) III Mobile CPU 1200MHz (1193.11-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x6b1 Stepping = 1 Features=0x383f9ff real memory = 535298048 (510 MB) Physical memory chunk(s): 0x00001000 - 0x0009dfff, 643072 bytes (157 pages) 0x00566000 - 0x1fceffff, 527998976 bytes (128906 pages) 0x1fd00000 - 0x1fe77fff, 1540096 bytes (376 pages) avail memory = 514080768 (490 MB) bios32: Found BIOS32 Service Directory header at 0xc00f6bb0 bios32: Entry = 0xfd871 (c00fd871) Rev = 0 Len = 1 pcibios: PCI BIOS entry at 0xfd870+0x13a pnpbios: Found PnP BIOS data at 0xc00f6be0 pnpbios: Entry = f0000:8816 Rev = 1.0 Other BIOS signatures found: Allocating major#253 to "net" wlan: <802.11 Link Layer> null: Allocating major#252 to "pci" random: mem: Pentium Pro MTRR support enabled npx0: on motherboard npx0: INT 16 interface acpi0: on motherboard ACPI-0625: *** Info: GPE Block0 defined as GPE0 to GPE15 ACPI-0625: *** Info: GPE Block1 defined as GPE16 to GPE31 pci_open(1): mode 1 addr port (0x0cf8) is 0x8000f904 pci_open(1a): mode1res=0x80000000 (0x80000000) pci_cfgcheck: device 0 [class=060000] [hdr=00] is there (id=35758086) pcibios: BIOS version 2.10 Using $PIR table, 9 entries at 0xc00fdf30 PCI-Only Interrupts: none Location Bus Device Pin Link IRQs embedded 2 5 A 0x69 3 embedded 2 8 A 0x68 9 embedded 0 29 A 0x60 9 embedded 0 29 B 0x63 9 embedded 0 2 A 0x60 9 embedded 0 1 A 0x60 9 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 ACPI timer looks GOOD min = 2, max = 3, width = 2 Timecounter "ACPI-fast" frequency 3579545 Hz acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) acpi_cpu0: port 0x530-0x537 on acpi0 acpi_tz0: on acpi0 acpi_lid0: on acpi0 acpi_button0: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 ---- initial configuration ------------------------ \\_SB_.LNKA irq 9: [ 9] low,level,sharable 0.1.0 \\_SB_.LNKB irq 0: [ 9] low,level,sharable 0.1.1 \\_SB_.LNKC irq 0: [ 9] low,level,sharable 0.1.2 \\_SB_.LNKD irq 9: [ 9] low,level,sharable 0.1.3 \\_SB_.LNKA irq 9: [ 9] low,level,sharable 0.2.0 \\_SB_.LNKA irq 9: [ 9] low,level,sharable 0.29.0 \\_SB_.LNKD irq 9: [ 9] low,level,sharable 0.29.1 \\_SB_.LNKC irq 0: [ 9] low,level,sharable 0.29.2 \\_SB_.LNKH irq 0: [ 9] low,level,sharable 0.29.3 \\_SB_.LNKB irq 0: [ 9] low,level,sharable 0.31.1 ---- before setting priority for links ------------ \\_SB_.LNKB: interrupts: 9 penalty: 1050 references: 2 priority: 0 \\_SB_.LNKC: interrupts: 9 penalty: 1050 references: 2 priority: 0 \\_SB_.LNKH: interrupts: 9 penalty: 1050 references: 1 priority: 0 ---- before fixup boot-disabled links ------------- \\_SB_.LNKB: interrupts: 9 penalty: 1050 references: 2 priority: 2100 \\_SB_.LNKC: interrupts: 9 penalty: 1050 references: 2 priority: 2100 \\_SB_.LNKH: interrupts: 9 penalty: 1050 references: 1 priority: 1050 ---- after fixup boot-disabled links -------------- \\_SB_.LNKB: interrupts: 9 penalty: 1050 references: 2 priority: 2100 \\_SB_.LNKC: interrupts: 9 penalty: 1050 references: 2 priority: 2100 \\_SB_.LNKH: interrupts: 9 penalty: 1050 references: 1 priority: 1050 ---- arbitrated configuration --------------------- \\_SB_.LNKA irq 9: [ 9] low,level,sharable 0.1.0 \\_SB_.LNKB irq 0: [ 9] low,level,sharable 0.1.1 \\_SB_.LNKC irq 0: [ 9] low,level,sharable 0.1.2 \\_SB_.LNKD irq 9: [ 9] low,level,sharable 0.1.3 \\_SB_.LNKA irq 9: [ 9] low,level,sharable 0.2.0 \\_SB_.LNKA irq 9: [ 9] low,level,sharable 0.29.0 \\_SB_.LNKD irq 9: [ 9] low,level,sharable 0.29.1 \\_SB_.LNKC irq 0: [ 9] low,level,sharable 0.29.2 \\_SB_.LNKH irq 0: [ 9] low,level,sharable 0.29.3 \\_SB_.LNKB irq 0: [ 9] low,level,sharable 0.31.1 pci0: on pcib0 pci0: physical bus=0 map[10]: type 3, range 32, base 00000000, size 0, enabled found-> vendor=0x8086, dev=0x3575, revid=0x04 bus=0, slot=0, func=0 class=06-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0106, statreg=0x2010, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) map[10]: type 3, range 32, base e8000000, size 27, enabled map[14]: type 1, range 32, base e0000000, size 19, enabled found-> vendor=0x8086, dev=0x3577, revid=0x04 bus=0, slot=2, func=0 class=03-00-00, hdrtype=0x00, mfdev=1 cmdreg=0x0007, statreg=0x0090, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=a, irq=9 powerspec 1 supports D0 D1 D3 current D0 map[10]: type 3, range 32, base f0000000, size 27, enabled map[14]: type 1, range 32, base e0080000, size 19, enabled found-> vendor=0x8086, dev=0x3577, revid=0x00 bus=0, slot=2, func=1 class=03-80-00, hdrtype=0x00, mfdev=1 cmdreg=0x0007, statreg=0x0090, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x09 (2250 ns) powerspec 1 supports D0 D1 D3 current D0 map[20]: type 4, range 32, base 00001800, size 5, enabled found-> vendor=0x8086, dev=0x2482, revid=0x02 bus=0, slot=29, func=0 class=0c-03-00, hdrtype=0x00, mfdev=1 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=a, irq=9 map[20]: type 4, range 32, base 00001820, size 5, enabled found-> vendor=0x8086, dev=0x2484, revid=0x02 bus=0, slot=29, func=1 class=0c-03-00, hdrtype=0x00, mfdev=0 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=b, irq=9 map[20]: type 4, range 32, base 00001840, size 5, enabled found-> vendor=0x8086, dev=0x2487, revid=0x02 bus=0, slot=29, func=2 class=0c-03-00, hdrtype=0x00, mfdev=0 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=c, irq=255 found-> vendor=0x8086, dev=0x2448, revid=0x42 bus=0, slot=30, func=0 class=06-04-00, hdrtype=0x01, mfdev=0 cmdreg=0x0007, statreg=0x0080, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x04 (1000 ns), maxlat=0x00 (0 ns) found-> vendor=0x8086, dev=0x248c, revid=0x02 bus=0, slot=31, func=0 class=06-01-00, hdrtype=0x00, mfdev=1 cmdreg=0x000f, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) map[10]: type 4, range 32, base 000001f0, size 3, enabled map[14]: type 4, range 32, base 000003f4, size 2, enabled map[18]: type 4, range 32, base 00000170, size 3, enabled map[1c]: type 4, range 32, base 00000374, size 2, enabled map[20]: type 4, range 32, base 00001860, size 4, enabled map[24]: type 1, range 32, base e0100000, size 10, memory disabled found-> vendor=0x8086, dev=0x248a, revid=0x02 bus=0, slot=31, func=1 class=01-01-8a, hdrtype=0x00, mfdev=0 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=a, irq=255 map[20]: type 4, range 32, base 00001880, size 5, enabled found-> vendor=0x8086, dev=0x2483, revid=0x02 bus=0, slot=31, func=3 class=0c-05-00, hdrtype=0x00, mfdev=0 cmdreg=0x0001, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=b, irq=255 map[10]: type 4, range 32, base 00001c00, size 8, port disabled map[14]: type 4, range 32, base 000018c0, size 6, enabled found-> vendor=0x8086, dev=0x2485, revid=0x02 bus=0, slot=31, func=5 class=04-01-00, hdrtype=0x00, mfdev=0 cmdreg=0x0000, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=b, irq=9 map[10]: type 4, range 32, base 00002400, size 8, port disabled map[14]: type 4, range 32, base 00002000, size 7, enabled found-> vendor=0x8086, dev=0x2486, revid=0x02 bus=0, slot=31, func=6 class=07-03-00, hdrtype=0x00, mfdev=0 cmdreg=0x0000, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=b, irq=255 agp0: mem 0xe0000000-0xe007ffff,0xe8000000-0xefffffff irq 9 at device 2.0 on pci0 agp0: detected 892k stolen memory agp0: aperture size is 128M pci0: at device 2.1 (no driver attached) uhci0: port 0x1800-0x181f irq 9 at device 29.0 on pci0 usb0: on uhci0 usb0: USB revision 1.0 uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub0: 2 ports with 2 removable, self powered uhci1: port 0x1820-0x183f irq 9 at device 29.1 on pci0 usb1: on uhci1 usb1: USB revision 1.0 uhub1: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub1: 2 ports with 2 removable, self powered uhci2: port 0x1840-0x185f at device 29.2 on pci0 pcib0: matched entry for 0.29.INTC (source \\_SB_.LNKC) pcib0: possible interrupts: 9 pcib0: slot 29 INTC routed to irq 9 via \\_SB_.LNKC usb2: on uhci2 usb2: USB revision 1.0 uhub2: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1 uhub2: 2 ports with 2 removable, self powered umass0: Sony USB Memory Stick Slot, rev 1.10/1.09, addr 2 umass0:0:0:-1: Attached to scbus0 as device 0 pcib1: at device 30.0 on pci0 pcib1: secondary bus 2 pcib1: subordinate bus 2 pcib1: I/O decode 0x3000-0x3fff pcib1: memory decode 0xe0200000-0xe02fffff pcib1: prefetched decode 0xfff00000-0xfffff ---- initial configuration ------------------------ \\_SB_.LNKC irq 0: [ 9] low,level,sharable 2.2.0 \\_SB_.LNKF irq 0: [ 9] low,level,sharable 2.5.0 \\_SB_.LNKG irq 0: [ 9] low,level,sharable 2.5.1 \\_SB_.LNKE irq 9: [ 9] low,level,sharable 2.8.0 \\_SB_.LNKD irq 9: [ 9] low,level,sharable 2.11.0 \\_SB_.LNKA irq 9: [ 9] low,level,sharable 2.11.1 ---- before setting priority for links ------------ \\_SB_.LNKB: interrupts: 9 penalty: 1680 references: 2 priority: 2100 \\_SB_.LNKC: interrupts: 9 penalty: 1680 references: 3 priority: 2100 \\_SB_.LNKH: interrupts: 9 penalty: 1680 references: 1 priority: 1050 \\_SB_.LNKF: interrupts: 9 penalty: 1680 references: 1 priority: 0 \\_SB_.LNKG: interrupts: 9 penalty: 1680 references: 1 priority: 0 ---- before fixup boot-disabled links ------------- \\_SB_.LNKC: interrupts: 9 penalty: 1680 references: 3 priority: 5040 \\_SB_.LNKB: interrupts: 9 penalty: 1680 references: 2 priority: 3360 \\_SB_.LNKH: interrupts: 9 penalty: 1680 references: 1 priority: 1680 \\_SB_.LNKF: interrupts: 9 penalty: 1680 references: 1 priority: 1680 \\_SB_.LNKG: interrupts: 9 penalty: 1680 references: 1 priority: 1680 ---- after fixup boot-disabled links -------------- \\_SB_.LNKC: interrupts: 9 penalty: 1680 references: 3 priority: 5040 \\_SB_.LNKB: interrupts: 9 penalty: 1680 references: 2 priority: 3360 \\_SB_.LNKH: interrupts: 9 penalty: 1680 references: 1 priority: 1680 \\_SB_.LNKF: interrupts: 9 penalty: 1680 references: 1 priority: 1680 \\_SB_.LNKG: interrupts: 9 penalty: 1680 references: 1 priority: 1680 ---- arbitrated configuration --------------------- \\_SB_.LNKC irq 0: [ 9] low,level,sharable 2.2.0 \\_SB_.LNKF irq 0: [ 9] low,level,sharable 2.5.0 \\_SB_.LNKG irq 0: [ 9] low,level,sharable 2.5.1 \\_SB_.LNKE irq 9: [ 9] low,level,sharable 2.8.0 \\_SB_.LNKD irq 9: [ 9] low,level,sharable 2.11.0 \\_SB_.LNKA irq 9: [ 9] low,level,sharable 2.11.1 pci2: on pcib1 pci2: physical bus=2 map[10]: type 1, range 32, base e0205000, size 11, enabled map[14]: type 1, range 32, base e0200000, size 14, enabled found-> vendor=0x104c, dev=0x8023, revid=0x00 bus=2, slot=2, func=0 class=0c-00-10, hdrtype=0x00, mfdev=0 cmdreg=0x0006, statreg=0x0210, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x03 (750 ns), maxlat=0x04 (1000 ns) intpin=a, irq=255 powerspec 2 supports D0 D1 D2 D3 current D0 found-> vendor=0x1180, dev=0x0475, revid=0x80 bus=2, slot=5, func=0 class=06-07-00, hdrtype=0x02, mfdev=0 cmdreg=0x0007, statreg=0x0210, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=a, irq=3 powerspec 2 supports D0 D1 D2 D3 current D0 map[10]: type 1, range 32, base e0204000, size 12, enabled map[14]: type 4, range 32, base 00003000, size 6, enabled found-> vendor=0x8086, dev=0x1031, revid=0x42 bus=2, slot=8, func=0 class=02-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0007, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x42 (1980 ns), mingnt=0x08 (2000 ns), maxlat=0x38 (14000 ns) intpin=a, irq=9 powerspec 2 supports D0 D1 D2 D3 current D0 found-> vendor=0x104c, dev=0xac50, revid=0x01 bus=2, slot=11, func=0 class=06-07-00, hdrtype=0x02, mfdev=0 cmdreg=0x0000, statreg=0x0210, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x40 (16000 ns), maxlat=0x03 (750 ns) intpin=a, irq=255 powerspec 1 supports D0 D1 D2 D3 current D0 fwohci0: mem 0xe0200000-0xe0203fff,0xe0205000-0xe02057ff at device 2.0 on pci2 fwohci0: PCI bus latency was changing to 250. fwohci0: cache size 8. pcib1: device fwohci0 requested decoded memory range 0xe0205000-0xe02057ff pcib1: matched entry for 2.2.INTA (source \\_SB_.LNKC) pcib1: slot 2 INTA is routed to irq 9 fwohci0: OHCI version 1.10 (ROM=1) fwohci0: No. of Isochronous channel is 4. fwohci0: EUI64 08:00:46:03:01:0e:aa:53 fwohci0: resetting OHCI...done (loop=0) fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: Phy 1394a available S400, 2 ports. fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: Enable 1394a Enhancements fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: Link S400, max_rec 2048 bytes. fwohci0: BUS_OPT 0xa002 -> 0xf800a002 fwohci0: fwohci_set_intr: 1 firewire0: on fwohci0 sbp0: on firewire0 sbp_attach (cold=1) fwohci0: Initiate bus reset fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: fwphy_rddata: loop=0, retry=0 fwohci0: BUS reset fwohci0: node_id = 0xc000ffc1, CYCLEMASTER mode firewire0: 2 nodes, maxhop <= 1, cable IRM = 1 (me) fwohci0: fw_set_bus_manager: 1->1 (loop=0) fwohci0: maxdesc: 2 fwohci0: start AT DMA status=0 pci2: at device 5.0 (no driver attached) fxp0: port 0x3000-0x303f mem 0xe0204000-0xe0204fff irq 9 at device 8.0 on pci2 pcib1: device fxp0 requested decoded memory range 0xe0204000-0xe0204fff fxp0: using memory space register mapping fxp0: Ethernet address 08:00:46:4e:96:17 fxp0: PCI IDs: 8086 1031 104d 8100 0042 fxp0: Dynamic Standby mode is disabled inphy0: on miibus0 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp0: bpf attached pci2: at device 11.0 (no driver attached) isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1860-0x186f,0x374-0x377,0x170-0x177,0x3f4-0x3f7,0x1f0-0x1f7 mem 0xe0100000-0xe01003ff at device 31.1 on pci0 ata0: iobase=0x01f0 altiobase=0x03f6 bmaddr=0x1860 ata0: pre reset mask=03 ostat0=50 ostat2=00 ata0-master: ATAPI 00 00 ata0-slave: ATAPI 00 00 ata0: after reset mask=03 stat0=50 stat1=00 ata0-master: ATA 01 a5 ata0: devices=01 ata0: at 0x1f0 irq 14 on atapci0 ata1: iobase=0x0170 altiobase=0x0376 bmaddr=0x1868 ata1: pre reset mask=03 ostat0=00 ostat2=00 ata1-master: ATAPI 00 00 ata1-slave: ATAPI 00 00 ata1: after reset mask=03 stat0=00 stat1=00 ata1: devices=00 ata1: at 0x170 irq 15 on atapci0 pci0: at device 31.3 (no driver attached) pcm0: port 0x18c0-0x18ff,0x1c00-0x1cff irq 9 at device 31.5 on pci0 pcm0: pcm0: Codec features 18 bit DAC, 5 bit master volume, no 3D Stereo Enhancement pcm0: Primary codec extended features reserved 1, AMAP, reserved 4 pcm0: sndbuf_setmap 86d000, 4000; 0xe06f8000 -> 86d000 pcm0: sndbuf_setmap 871000, 4000; 0xe06fc000 -> 871000 pci0: at device 31.6 (no driver attached) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) atkbdc0: port 0x64,0x60 irq 1 on acpi0 atkbd0: flags 0x1 irq 1 on atkbdc0 atkbd: the current kbd controller command byte 0047 atkbd: keyboard ID 0x41ab (2) kbd0 at atkbd0 kbd0: atkbd0, AT 101/102 (2), config:0x1, flags:0x3d0000 psm0: unable to allocate IRQ psmcpnp0 irq 12 on acpi0 psm0: current command byte:0047 psm0: irq 12 on atkbdc0 psm0: model GlidePoint, device ID 0-00, 2 buttons psm0: config:00000000, flags:00000000, packet size:3 psm0: syncmask:c0, syncbits:00 acpi_ec0: port 0x66,0x62 on acpi0 sio0: irq maps: 0x201 0x211 0x201 0x201 sio0 port 0x3f8-0x3ff irq 4 on acpi0 sio0: type 16550A unknown: not probed (disabled) unknown: not probed (disabled) ppc0: using extended I/O port range ppc0: ECP SPP ECP+EPP SPP ppc0 port 0x778-0x77f,0x378-0x37f irq 7 drq 3 on acpi0 ppc0: SMC-like chipset (ECP/EPP/PS2/NIBBLE) in COMPATIBLE mode ppc0: FIFO with 16/16/15 bytes threshold plip0: on ppbus0 lp0: bpf attached lpt0: on ppbus0 lpt0: Interrupt-driven port ppi0: on ppbus0 fdc0: port 0x3f7,0x3f0-0x3f5 irq 6 drq 2 on acpi0 fdc0: FIFO enabled, 8 bytes threshold fd0: <1440-KB 3.5" drive> on fdc0 drive 0 mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) acpi_cmbat0: on acpi0 acpi_acad0: on acpi0 mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_probe: no address given, try 0x530 mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) unknown: not probed (disabled) unknown: not probed (disabled) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) mss_detect, busy still set (0xff) ata: ata0 already exists; skipping it ata: ata1 already exists; skipping it atkbdc: atkbdc0 already exists; skipping it fdc: fdc0 already exists; skipping it ppc: ppc0 already exists; skipping it sio: sio0 already exists; skipping it Trying Read_Port at 203 Trying Read_Port at 243 Trying Read_Port at 283 Trying Read_Port at 2c3 Trying Read_Port at 303 Trying Read_Port at 343 Trying Read_Port at 383 Trying Read_Port at 3c3 sc: sc0 already exists; skipping it vga: vga0 already exists; skipping it isa_probe_children: disabling PnP devices isa_probe_children: probing non-PnP devices orm0: