Date: Tue, 4 Mar 2003 15:42:43 -0800 (PST) From: Pete Carah <pete@ns.altadena.net> To: current@freebsd.org Subject: Witness problem with sound Message-ID: <200303042342.h24NghHJ034439@ns.altadena.net>
next in thread | raw e-mail | index | archive | help
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<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE> 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: <null device, zero device> Allocating major#252 to "pci" random: <entropy source> mem: <memory & I/O> Pentium Pro MTRR support enabled npx0: <math processor> on motherboard npx0: INT 16 interface acpi0: <SONY C1 > 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: <CPU> port 0x530-0x537 on acpi0 acpi_tz0: <thermal zone> on acpi0 acpi_lid0: <Control Method Lid Switch> on acpi0 acpi_button0: <Power Button> on acpi0 pcib0: <ACPI Host-PCI bridge> 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: <ACPI PCI bus> 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: <Intel 82830M (830M GMCH) SVGA controller> mem 0xe0000000-0xe007ffff,0xe8000000-0xefffffff irq 9 at device 2.0 on pci0 agp0: detected 892k stolen memory agp0: aperture size is 128M pci0: <display> at device 2.1 (no driver attached) uhci0: <Intel 82801CA/CAM (ICH3) USB controller USB-A> port 0x1800-0x181f irq 9 at device 29.0 on pci0 usb0: <Intel 82801CA/CAM (ICH3) USB controller USB-A> 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: <Intel 82801CA/CAM (ICH3) USB controller USB-B> port 0x1820-0x183f irq 9 at device 29.1 on pci0 usb1: <Intel 82801CA/CAM (ICH3) USB controller USB-B> 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: <Intel 82801CA/CAM (ICH3) USB controller USB-C> 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: <Intel 82801CA/CAM (ICH3) USB controller USB-C> 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: <ACPI PCI-PCI bridge> 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: <ACPI PCI bus> 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: <Texas Instruments TSB43AB22/A> 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: <IEEE1394(FireWire) bus> on fwohci0 sbp0: <SBP2/SCSI over firewire> 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: <bridge, PCI-CardBus> at device 5.0 (no driver attached) fxp0: <Intel Pro/100 Ethernet> 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: <i82562ET 10/100 media interface> on miibus0 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp0: bpf attached pci2: <bridge, PCI-CardBus> at device 11.0 (no driver attached) isab0: <PCI-ISA bridge> at device 31.0 on pci0 isa0: <ISA bus> on isab0 atapci0: <Intel ICH3 UDMA100 controller> 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: <serial bus, SMBus> at device 31.3 (no driver attached) pcm0: <Intel 82801CA (ICH3)> port 0x18c0-0x18ff,0x1c00-0x1cff irq 9 at device 31.5 on pci0 pcm0: <Yamaha YMF753 AC97 Codec (id = 0x594d4803)> 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: <simple comms> 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: <Keyboard controller (i8042)> port 0x64,0x60 irq 1 on acpi0 atkbd0: <AT Keyboard> 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: <PS/2 Mouse> 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: <embedded controller> 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: <PLIP network interface> on ppbus0 lp0: bpf attached lpt0: <Printer> on ppbus0 lpt0: Interrupt-driven port ppi0: <Parallel I/O> on ppbus0 fdc0: <Enhanced floppy controller (i82077, NE72065 or clone)> 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: <Control method Battery> on acpi0 acpi_acad0: <AC adapter> 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: <Option ROMs> at iomem 0xdc000-0xdffff,0xd8000-0xdbfff,0xc0000-0xcffff on isa0 pcic0 failed to probe at port 0x3e0 iomem 0xd0000 on isa0 pcic1 failed to probe at port 0x3e2 iomem 0xd4000 irq 11 on isa0 pmtimer0 on isa0 sc0: <System console> at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> sc0: fb0, kbd0, terminal emulator: sc (syscons terminal) spic0: device model type = 2 spic0: <Sony Programmable I/O Controller> at port 0x10a0-0x10a4 on isa0 vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 fb0: vga0, vga, type:VGA (5), flags:0x7007f fb0: port:0x3c0-0x3df, crtc:0x3d4, mem:0xa0000 0x20000 fb0: init mode:24, bios mode:3, current mode:24 fb0: window:0xc00b8000 size:32k gran:32k, buf:0 size:32k VGA parameters upon power-up 50 18 10 00 00 00 03 00 02 67 5f 4f 50 02 55 81 bf 1f 00 4f 0d 0e 00 00 07 80 9c 8e 8f 28 1f 96 b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff VGA parameters in BIOS for mode 24 50 18 10 00 10 00 03 00 02 67 5f 4f 50 82 55 81 bf 1f 00 4f 0d 0e 00 00 00 00 9c 8e 8f 28 1f 96 b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff EGA/VGA parameters to be used for mode 24 50 18 10 00 00 00 03 00 02 67 5f 4f 50 02 55 81 bf 1f 00 4f 0d 0e 00 00 07 80 9c 8e 8f 28 1f 96 b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff vt0 failed to probe on isa0 isa_probe_children: probing PnP devices Device configuration finished. procfs registered Timecounters tick every 10.000 msec lo0: bpf attached acpi_cpu0: set speed to 100.0% acpi_cpu: throttling enabled, 8 steps (100% to 12.5%), currently 100.0% acpi_cmbat0: battery initialization start acpi_cmbat0: battery initialization done, tried 1 times acpi_acad0: acline initialization start acpi_acad0: On Line acpi_acad0: acline initialization done, tried 1 times ad0: success setting UDMA100 on Intel ICH3 chip GEOM: new disk ad0 ar: FreeBSD check1 failed ad0: <TOSHIBA MK4018GAS/Q1.02 C> ATA-5 disk at ata0-master ad0: 38154MB (78140160 sectors), 77520 C, 16 H, 63 S, 512 B ad0: 16 secs/int, 1 depth queue, UDMA100 ad0: piomode=12 dmamode=34 udmamode=69 cblid=1 pcm0: measured ac97 link rate at 96060 Hz [0] f:00 typ:7 s(CHS):0/1/1 e(CHS):206/254/255 s:63 l:15663312 [1] f:80 typ:165 s(CHS):207/0/193 e(CHS):255/254/255 s:15663375 l:8385930 [2] f:00 typ:165 s(CHS):255/255/255 e(CHS):255/254/255 s:24049305 l:8385930 [3] f:00 typ:165 s(CHS):255/255/255 e(CHS):255/254/255 s:32435235 l:45704925 GEOM: Configure ad0s1, start 32256 length 8019615744 end 8019647999 GEOM: Configure ad0s2, start 8019648000 length 4293596160 end 12313244159 GEOM: Configure ad0s3, start 12313244160 length 4293596160 end 16606840319 GEOM: Configure ad0s4, start 16606840320 length 23400921600 end 40007761919 GEOM: Add ad0s2 hot[0] start 512 length 276 end 787 GEOM: Configure ad0s2a, start 0 length 268435456 end 268435455 GEOM: Configure ad0s2b, start 536870912 length 536870912 end 1073741823 GEOM: Configure ad0s2c, start 0 length 4293596160 end 4293596159 GEOM: Configure ad0s2e, start 268435456 length 268435456 end 536870911 GEOM: Configure ad0s2f, start 1073741824 length 3219854336 end 4293596159 firewire0: New S400 device ID:08004603011d4b48 GEOM: Add ad0s3 hot[0] start 512 length 276 end 787 GEOM: Configure ad0s3a, start 0 length 268435456 end 268435455 GEOM: Configure ad0s3b, start 536870912 length 536870912 end 1073741823 GEOM: Configure ad0s3c, start 0 length 4293596160 end 4293596159 GEOM: Configure ad0s3e, start 268435456 length 268435456 end 536870911 GEOM: Configure ad0s3f, start 1073741824 length 3219854336 end 4293596159 firewire0: Device SBP-II sbp_post_explore (sbp_cold=2) sbp_post_explore: EUI:08004603011d4b48 spec=1 key=1. target 0 lun 0 found sbp0:0:0 ordered:0 type:5 EUI:08004603011d4b48 node:0 speed:2 maxrec:10 new! sbp0:0:0 'Sony' 'PCGA-DSM5' 'ad1830' GEOM: Add ad0s4 hot[0] start 512 length 276 end 787 GEOM: Configure ad0s4a, start 0 length 23400921600 end 23400921599 GEOM: Configure ad0s4c, start 0 length 23400921600 end 23400921599 GEOM: Add ad0s2a hot[0] start 512 length 276 end 787 GEOM: Add ad0s2c hot[0] start 512 length 276 end 787 GEOM: Add ad0s3a hot[0] start 512 length 276 end 787 GEOM: Add ad0s3c hot[0] start 512 length 276 end 787 GEOM: Add ad0s4a hot[0] start 512 length 276 end 787 GEOM: Add ad0s4c hot[0] start 512 length 276 end 787 sbp0:0:0 LOGIN fwohci0: maxdesc: 3 sbp0:0:0 login: len 12, ID 0, cmd 0000fffff0010100, recon_hold 0 sbp0:0:0 sbp_busy_timeout sbp0:0:0 sbp_agent_reset sbp0:0:0 sbp_do_attach (probe2:sbp0:0:1:0): error 22 (probe2:sbp0:0:1:0): Unretryable Error (probe3:sbp0:0:2:0): error 22 (probe3:sbp0:0:2:0): Unretryable Error (probe4:sbp0:0:3:0): error 22 (probe4:sbp0:0:3:0): Unretryable Error (probe5:sbp0:0:4:0): error 22 (probe5:sbp0:0:4:0): Unretryable Error (probe6:sbp0:0:5:0): error 22 (probe6:sbp0:0:5:0): Unretryable Error (probe7:sbp0:0:6:0): error 22 (probe7:sbp0:0:6:0): Unretryable Error sbp0:0:0 XPT_SCSI_IO: cmd: 12 01 80 00 ff 00 ad de de c0, flags: 0x40, 6b cmd/255b data/18b sense sbp0:0:0 SCSI status 2 sfmt 0 valid 0 key 5 code 24 qlfr 0 len 7 (probe1:sbp0:0:0:0): error 22 (probe1:sbp0:0:0:0): Unretryable Error sbp0:0:0 XPT_SCSI_IO: cmd: 00 00 00 00 00 00 ad de de c0, flags: 0xc0, 6b cmd/0b data/32b sense sbp0:0:0 SCSI status 2 sfmt 0 valid 0 key 6 code 29 qlfr 0 len 7 (probe1:sbp0:0:0:1): error 22 (probe1:sbp0:0:0:1): Unretryable Error (probe1:sbp0:0:0:2): error 22 (probe1:sbp0:0:0:2): Unretryable Error (probe1:sbp0:0:0:3): error 22 (probe1:sbp0:0:0:3): Unretryable Error (probe1:sbp0:0:0:4): error 22 (probe1:sbp0:0:0:4): Unretryable Error (probe1:sbp0:0:0:5): error 22 (probe1:sbp0:0:0:5): Unretryable Error (probe1:sbp0:0:0:6): error 22 (probe1:sbp0:0:0:6): Unretryable Error (probe1:sbp0:0:0:7): error 22 (probe1:sbp0:0:0:7): Unretryable Error pass0 at umass-sim0 bus 0 target 0 lun 0 pass0: <Sony MSC-U03 1.00> Removable Direct Access SCSI-0 device pass0: Serial Number 3 pass0: 1.000MB/s transfers pass1 at sbp0 bus 0 target 0 lun 0 pass1: <MATSHITA UJDA730 DVD/CDRW 1.00> Removable CD-ROM SCSI-0 device pass1: 50.000MB/s transfers sbp0:0:0 XPT_SCSI_IO: cmd: 25 00 00 00 00 00 00 00 00 00, flags: 0x40, 10b cmd/8b data/32b sense sbp0:0:0 SCSI status 2 sfmt 0 valid 0 key 2 code 3a qlfr 0 len 7 (cd0:sbp0:0:0:0): error 6 (cd0:sbp0:0:0:0): Unretryable Error cd0 at sbp0 bus 0 target 0 lun 0 cd0: <MATSHITA UJDA730 DVD/CDRW 1.00> Removable CD-ROM SCSI-0 device cd0: 50.000MB/s transfers cd0: Attempt to query device size failed: NOT READY, Medium not present GEOM: new disk da0 da0 at umass-sim0 bus 0 target 0 lun 0 da0: <Sony MSC-U03 1.00> Removable Direct Access SCSI-0 device da0: Serial Number 3 da0: 1.000MB/s transfers da0: 3MB (7904 512 byte sectors: 64H 32S/T 3C) [0] f:80 typ:1 s(CHS):0/1/12 e(CHS):245/1/16 s:27 l:7845 [1] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0 [2] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0 [3] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0 GEOM: Configure da0s1, start 13824 length 4016640 end 4030463 Mounting root from ufs:/dev/ad0s2a start_init: trying /sbin/init GEOM: Add ad0s3a hot[0] start 512 length 276 end 787 GEOM: Add ad0s4a hot[0] start 512 length 276 end 787 --------------------------------------------------- There are other problems (mostly with pcmcia, which is left out of this kernel; it causes hangs on init), but this one is obvious and does leave the system running. A remaining one that bothers multi-type usb card readers is that CAM/XPT only scans LUN 0 for any device it finds. All my card readers show as only CF because of this, and I have to give 4 camcontrol commands to get the system to see the rest (at least it does work with manual intervention!!). -- Pete To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-current" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?200303042342.h24NghHJ034439>