From owner-freebsd-current@FreeBSD.ORG Mon Nov 24 10:03:19 2003 Return-Path: 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 4B5C116A4CE for ; Mon, 24 Nov 2003 10:03:19 -0800 (PST) Received: from blake.polstra.com (dsl081-189-066.sea1.dsl.speakeasy.net [64.81.189.66]) by mx1.FreeBSD.org (Postfix) with ESMTP id 2507E43F85 for ; Mon, 24 Nov 2003 10:03:15 -0800 (PST) (envelope-from jdp@polstra.com) Received: from strings.polstra.com (dsl081-189-067.sea1.dsl.speakeasy.net [64.81.189.67]) by blake.polstra.com (8.12.9p2/8.12.9) with ESMTP id hAOI3E8b023424; Mon, 24 Nov 2003 10:03:14 -0800 (PST) (envelope-from jdp@polstra.com) Message-ID: X-Mailer: XFMail 1.5.4 on FreeBSD X-Priority: 3 (Normal) MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="_=XFMail.1.5.4.FreeBSD:20031124100314:244=_" In-Reply-To: <20031123172209.M84982@root.org> Date: Mon, 24 Nov 2003 10:03:14 -0800 (PST) From: John Polstra To: Nate Lawson X-Bogosity: No, tests=bogofilter, spamicity=0.009541, version=0.14.5 cc: current@freebsd.org Subject: Re: PII SMP system hangs during boot with ACPI enabled X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.1 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Mon, 24 Nov 2003 18:03:19 -0000 This message is in MIME format --_=XFMail.1.5.4.FreeBSD:20031124100314:244=_ Content-Type: text/plain; charset=us-ascii On 24-Nov-2003 Nate Lawson wrote: > Please add debug.acpi.disable="cpu" to loader.conf or type that in at the > loader prompt. If it boots ok, we'll have to debug the acpi_cpu_startup > path. Thanks. It still hangs even with debug.acpi.disable="cpu". I have attached the verbose boot messages. They are essentially the same as the previous messages, except that the acpi_cpu messages are gone now as expected. If there's anything else I should try, just let me know. John --_=XFMail.1.5.4.FreeBSD:20031124100314:244=_ Content-Disposition: attachment; filename="s1836dluan-boot2.txt" Content-Transfer-Encoding: 7bit Content-Type: text/plain; charset=us-ascii; name=s1836dluan-boot2.txt; SizeOnDisk=19703 SMAP type=01 base=0000000000000000 len=000000000009fc00 SMAP type=02 base=000000000009fc00 len=0000000000000400 SMAP type=02 base=00000000000e0000 len=0000000000020000 SMAP type=01 base=0000000000100000 len=000000000fee0000 SMAP type=03 base=000000000ffe0000 len=0000000000018000 SMAP type=04 base=000000000fff8000 len=0000000000008000 SMAP type=02 base=00000000fec00000 len=0000000000001000 SMAP type=02 base=00000000fee00000 len=0000000000001000 SMAP type=02 base=00000000fffc0000 len=0000000000040000 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.2-BETA #1: Sun Nov 23 13:32:22 PST 2003 jdp@vashon.polstra.com:/usr/src/sys/i386/compile/VASHON Preloaded elf kernel "/boot/kernel/kernel" at 0xc07bc000. ACPI APIC Table: Calibrating clock(s) ... i8254 clock: 1193039 Hz CLK_USE_I8254_CALIBRATION not specified - using default frequency Timecounter "i8254" frequency 1193182 Hz quality 0 Calibrating TSC clock ... TSC clock: 400911753 Hz CPU: Pentium II/Pentium II Xeon/Celeron (400.91-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x652 Stepping = 2 Features=0x183fbff real memory = 268304384 (255 MB) Physical memory chunk(s): 0x0000000000001000 - 0x000000000009efff, 647168 bytes (158 pages) 0x0000000000100000 - 0x00000000003fffff, 3145728 bytes (768 pages) 0x0000000000829000 - 0x000000000fb39fff, 254873600 bytes (62225 pages) avail memory = 255262720 (243 MB) APIC ID: physical 0, logical 0:0 APIC ID: physical 1, logical 0:1 FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 1 bios32: Found BIOS32 Service Directory header at 0xc00fdb40 bios32: Entry = 0xfdb50 (c00fdb50) Rev = 0 Len = 1 pcibios: PCI BIOS entry at 0xf0000+0xdb71 pnpbios: Found PnP BIOS data at 0xc00f72c0 pnpbios: Entry = f0000:6964 Rev = 1.0 Other BIOS signatures found: APIC: CPU 0 has ACPI ID 1 APIC: CPU 1 has ACPI ID 2 MADT: Found IO APIC ID 2, Vector 0 at 0xfec00000 ioapic0: intpin 0 -> ExtINT (edge, activehi) ioapic0: intpin 1 -> irq 1 (edge, activehi) ioapic0: intpin 2 -> irq 2 (edge, activehi) ioapic0: intpin 3 -> irq 3 (edge, activehi) ioapic0: intpin 4 -> irq 4 (edge, activehi) ioapic0: intpin 5 -> irq 5 (edge, activehi) ioapic0: intpin 6 -> irq 6 (edge, activehi) ioapic0: intpin 7 -> irq 7 (edge, activehi) ioapic0: intpin 8 -> irq 8 (edge, activehi) ioapic0: intpin 9 -> irq 9 (edge, activehi) ioapic0: intpin 10 -> irq 10 (edge, activehi) ioapic0: intpin 11 -> irq 11 (edge, activehi) ioapic0: intpin 12 -> irq 12 (edge, activehi) ioapic0: intpin 13 -> irq 13 (edge, activehi) ioapic0: intpin 14 -> irq 14 (edge, activehi) ioapic0: intpin 15 -> irq 15 (edge, activehi) ioapic0: intpin 16 -> irq 16 (level, activelo) ioapic0: intpin 17 -> irq 17 (level, activelo) ioapic0: intpin 18 -> irq 18 (level, activelo) ioapic0: intpin 19 -> irq 19 (level, activelo) ioapic0: intpin 20 -> irq 20 (level, activelo) ioapic0: intpin 21 -> irq 21 (level, activelo) ioapic0: intpin 22 -> irq 22 (level, activelo) ioapic0: intpin 23 -> irq 23 (level, activelo) MADT: intr override: source 0, irq 2 ioapic0: Routing IRQ 0 -> intpin 2 ioapic0: intpin 2 trigger: edge ioapic0: intpin 2 polarity: active-hi MADT: intr override: source 9, irq 20 ioapic0: intpin 9 disabled ioapic0: intpin 20 trigger: level ioapic0: intpin 20 polarity: active-hi ioapic0 irqs 0-23 on motherboard cpu0 BSP: ID: 0x00000000 VER: 0x00040011 LDR: 0x01000000 DFR: 0x0fffffff lint0: 0x00010700 lint1: 0x00000400 TPR: 0x00000000 SVR: 0x000001ff null: random: mem: Pentium Pro MTRR support enabled acpi0: on motherboard acpi0: Overriding SCI Interrupt from IRQ 9 to IRQ 20 pci_open(1): mode 1 addr port (0x0cf8) is 0x8000005c pci_open(1a): mode1res=0x80000000 (0x80000000) pci_cfgcheck: device 0 [class=060000] [hdr=00] is there (id=71908086) pcibios: BIOS version 2.10 AcpiOsDerivePciId: bus 0 dev 7 func 0 acpi0: Power Button (fixed) ACPI timer looks BAD min = 2, max = 5, width = 3 ACPI timer looks BAD min = 2, max = 5, width = 3 ACPI timer looks BAD min = 2, max = 5, width = 3 ACPI timer looks BAD min = 2, max = 6, width = 4 ACPI timer looks BAD min = 2, max = 6, width = 4 ACPI timer looks BAD min = 2, max = 5, width = 3 ACPI timer looks BAD min = 2, max = 6, width = 4 ACPI timer looks BAD min = 2, max = 6, width = 4 ACPI timer looks BAD min = 2, max = 5, width = 3 ACPI timer looks BAD min = 2, max = 5, width = 3 Timecounter "ACPI-safe" frequency 3579545 Hz quality 1000 AcpiOsDerivePciId: bus 0 dev 0 func 0 AcpiOsDerivePciId: bus 0 dev 0 func 0 AcpiOsDerivePciId: bus 0 dev 7 func 0 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0 pcib0: port 0xcf8-0xcff on acpi0 ---- initial configuration ------------------------ ---- before setting priority for links ------------ ---- before fixup boot-disabled links ------------- ---- after fixup boot-disabled links -------------- ---- arbitrated configuration --------------------- pci0: on pcib0 pci0: physical bus=0 map[10]: type 3, range 32, base f8000000, size 26, enabled found-> vendor=0x8086, dev=0x7190, revid=0x02 bus=0, slot=0, func=0 class=06-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0006, statreg=0x2210, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) found-> vendor=0x8086, dev=0x7191, revid=0x02 bus=0, slot=1, func=0 class=06-04-00, hdrtype=0x01, mfdev=0 cmdreg=0x001f, statreg=0x0220, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x88 (34000 ns), maxlat=0x00 (0 ns) found-> vendor=0x8086, dev=0x7110, revid=0x02 bus=0, slot=7, 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[20]: type 4, range 32, base 0000ffa0, size 4, enabled found-> vendor=0x8086, dev=0x7111, revid=0x01 bus=0, slot=7, func=1 class=01-01-80, hdrtype=0x00, mfdev=0 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) map[20]: type 4, range 32, base 0000ef80, size 5, enabled pcib0: matched entry for 0.7.INTD (source ) pcib0: device is hardwired to IRQ 19 found-> vendor=0x8086, dev=0x7112, revid=0x01 bus=0, slot=7, func=2 class=0c-03-00, hdrtype=0x00, mfdev=0 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=d, irq=19 map[90]: type 4, range 32, base 00000440, size 4, enabled found-> vendor=0x8086, dev=0x7113, revid=0x02 bus=0, slot=7, func=3 class=06-80-00, hdrtype=0x00, mfdev=0 cmdreg=0x0001, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) found-> vendor=0x1011, dev=0x0024, revid=0x03 bus=0, slot=16, func=0 class=06-04-00, hdrtype=0x01, mfdev=0 cmdreg=0x0107, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x03 (750 ns), maxlat=0x00 (0 ns) map[10]: type 3, range 32, base fd0ff000, size 12, enabled map[14]: type 4, range 32, base 0000ef40, size 5, enabled map[18]: type 1, range 32, base fea00000, size 20, enabled pcib0: matched entry for 0.17.INTA (source ) pcib0: device is hardwired to IRQ 19 found-> vendor=0x8086, dev=0x1229, revid=0x05 bus=0, slot=17, func=0 class=02-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0117, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x08 (2000 ns), maxlat=0x38 (14000 ns) intpin=a, irq=19 powerspec 1 supports D0 D1 D2 D3 current D0 map[10]: type 4, range 32, base 0000e400, size 8, enabled map[14]: type 1, range 32, base febfe000, size 12, enabled pcib0: matched entry for 0.18.INTA (source ) pcib0: device is hardwired to IRQ 16 found-> vendor=0x9004, dev=0x7895, revid=0x04 bus=0, slot=18, func=0 class=01-00-00, hdrtype=0x00, mfdev=1 cmdreg=0x0117, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x08 (2000 ns), maxlat=0x08 (2000 ns) intpin=a, irq=16 powerspec 1 supports D0 D3 current D0 map[10]: type 4, range 32, base 0000e800, size 8, enabled map[14]: type 1, range 32, base febff000, size 12, enabled pcib0: matched entry for 0.18.INTB (source ) pcib0: device is hardwired to IRQ 16 found-> vendor=0x9004, dev=0x7895, revid=0x04 bus=0, slot=18, func=1 class=01-00-00, hdrtype=0x00, mfdev=1 cmdreg=0x0117, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x08 (2000 ns), maxlat=0x08 (2000 ns) intpin=b, irq=16 powerspec 1 supports D0 D3 current D0 map[10]: type 3, range 32, base fd0fe000, size 12, enabled map[14]: type 4, range 32, base 0000ef20, size 5, enabled map[18]: type 1, range 32, base fe800000, size 20, enabled pcib0: matched entry for 0.20.INTA (source ) pcib0: device is hardwired to IRQ 17 found-> vendor=0x8086, dev=0x1229, revid=0x04 bus=0, slot=20, func=0 class=02-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0117, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x08 (2000 ns), maxlat=0x38 (14000 ns) intpin=a, irq=17 powerspec 1 supports D0 D1 D2 D3 current D0 agp0: mem 0xf8000000-0xfbffffff at d evice 0.0 on pci0 agp0: allocating GATT for aperture of size 64M pcib1: at device 1.0 on pci0 pcib1: secondary bus 1 pcib1: subordinate bus 1 pcib1: I/O decode 0xc000-0xcfff pcib1: memory decode 0xfd100000-0xfe1fffff pcib1: prefetched decode 0xf2e00000-0xf4efffff pci1: on pcib1 pci1: physical bus=1 map[10]: type 3, range 32, base f3000000, size 24, enabled map[14]: type 1, range 32, base fe1fc000, size 14, enabled map[18]: type 1, range 32, base fd800000, size 23, enabled pcib0: matched entry for 0.1.INTA (source ) pcib0: device is hardwired to IRQ 16 pcib1: slot 0 INTA is routed to irq 16 found-> vendor=0x102b, dev=0x051f, revid=0x00 bus=1, slot=0, func=0 class=03-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0007, statreg=0x02b0, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=a, irq=16 pci1: at device 0.0 (no driver attached) isab0: at device 7.0 on pci0 isa0: on isab0 atapci0: port 0xffa0-0xffaf at device 7.1 on pci 0 ata0: reset tp1 mask=03 ostat0=50 ostat1=00 ata0-master: stat=0x00 err=0x01 lsb=0x14 msb=0xeb ata0-slave: stat=0x00 err=0x01 lsb=0x7f msb=0x7f ata0: reset tp2 mask=03 stat0=00 stat1=00 devices=0x4 ata0: at 0x1f0 irq 14 on atapci0 ata0: [MPSAFE] ata1: reset tp1 mask=03 ostat0=15 ostat1=15 ata1-master: stat=0x1e err=0x1e lsb=0x1e msb=0x1e ata1-slave: stat=0x0a err=0x0a lsb=0x0a msb=0x0a ata1-master: stat=0x24 err=0x24 lsb=0x24 msb=0x24 ata1-slave: stat=0x10 err=0x10 lsb=0x10 msb=0x10 ata1-master: stat=0x2a err=0x2a lsb=0x2a msb=0x2a ata1-master: stat=0x15 err=0x15 lsb=0x15 msb=0x15 ata1-master: stat=0x01 err=0x01 lsb=0x01 msb=0x01 ata1: reset tp2 mask=03 stat0=01 stat1=10 devices=0x0 ata1: at 0x170 irq 15 on atapci0 ata1: [MPSAFE] uhci0: port 0xef80-0xef9f irq 19 at de vice 7.2 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 pci0: at device 7.3 (no driver attached) pcib2: at device 16.0 on pci0 pcib2: secondary bus 2 pcib2: subordinate bus 2 pcib2: I/O decode 0xd000-0xdfff pcib2: memory decode 0xfe200000-0xfe2fffff pcib2: prefetched decode 0xf4f00000-0xf4ffffff pci2: on pcib2 pci2: physical bus=2 fxp0: port 0xef40-0xef5f mem 0xfea00000-0xfeaffff f,0xfd0ff000-0xfd0fffff irq 19 at device 17.0 on pci0 fxp0: using memory space register mapping fxp0: Ethernet address 00:e0:81:10:09:c2 fxp0: PCI IDs: 8086 1229 8086 0008 0005 fxp0: Dynamic Standby mode is disabled miibus0: on fxp0 inphy0: on miibus0 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp0: bpf attached ahc0: port 0xe400-0xe4ff mem 0xfebfe000-0xf ebfefff irq 16 at device 18.0 on pci0 ahc0: Defaulting to MEMIO off ahc0: Reading SEEPROM...done. ahc0: internal 50 cable not present, internal 68 cable not present ahc0: external cable not present ahc0: BIOS eeprom is present ahc0: High byte termination Enabled ahc0: Low byte termination Enabled ahc0: Downloading Sequencer Program... 412 instructions downloaded ahc0: Features 0x16235, Bugs 0x15, Flags 0x20485540 aic7895C: Ultra Wide Channel A, SCSI Id=7, 32/253 SCBs ahc1: port 0xe800-0xe8ff mem 0xfebff000-0xf ebfffff irq 16 at device 18.1 on pci0 ahc1: Defaulting to MEMIO off ahc1: Reading SEEPROM...done. ahc1: internal 50 cable not present, internal 68 cable not present ahc1: external cable not present ahc1: BIOS eeprom is present ahc1: High byte termination Enabled ahc1: Low byte termination Enabled ahc1: Downloading Sequencer Program... 412 instructions downloaded ahc1: Features 0x16235, Bugs 0x15, Flags 0x20485540 aic7895C: Ultra Wide Channel B, SCSI Id=7, 32/253 SCBs fxp1: port 0xef20-0xef3f mem 0xfe800000-0xfe8ffff f,0xfd0fe000-0xfd0fefff irq 17 at device 20.0 on pci0 fxp1: using memory space register mapping fxp1: Ethernet address 00:a0:c9:b0:13:df fxp1: PCI IDs: 8086 1229 8086 0009 0004 fxp1: Dynamic Standby mode is disabled miibus1: on fxp1 inphy1: on miibus1 inphy1: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp1: bpf attached acpi_button0: on acpi0 unknown: not probed (disabled) atkbdc0: port 0x64,0x60 irq 1 on acpi0 kbdc: DIAGNOSE status:0055 kbdc: TEST_KBD_PORT status:0000 kbdc: DIAGNOSE status:0055 kbdc: TEST_KBD_PORT status:0000 psm0: unable to allocate IRQ fdc0: output ready timeout fdc0: cmd 3 failed at out byte 1 of 3 sio0: irq maps: 0x4201 0x4211 0x4201 0x4201 sio0 port 0x3f8-0x3ff irq 4 on acpi0 sio0: type 16550A, console sio1: irq maps: 0x4201 0x4209 0x4201 0x4201 sio1 port 0x2f8-0x2ff irq 3 on acpi0 sio1: type 16550A unknown: not probed (disabled) unknown: not probed (disabled) unknown: not probed (disabled) fdc0: output ready timeout fdc0: cmd 3 failed at out byte 1 of 3 unknown: not probed (disabled) unknown: not probed (disabled) npx0: [FAST] npx0: on motherboard npx0: INT 16 interface ata: ata0 already exists; skipping it ata: ata1 already exists; skipping it atkbdc: atkbdc0 already exists; skipping it sio: sio0 already exists; skipping it sio: sio1 already exists; skipping it Trying Read_Port at 203 CTL0043: start dependent (0) CTL0043: adding irq mask 0x20 CTL0043: adding dma mask 0x2 CTL0043: adding dma mask 0x8 CTL0043: adding io range 0x220-0x22f, size=0x10, align=0x1 CTL0043: adding io range 0x330-0x331, size=0x2, align=0x1 CTL0043: adding io range 0x388-0x38b, size=0x4, align=0x1 CTL0043: start dependent (1) CTL0043: adding irq mask 0x6a0 CTL0043: adding dma mask 0xb CTL0043: adding dma mask 0xb CTL0043: adding io range 0x220-0x28f, size=0x10, align=0x20 CTL0043: adding io range 0x300-0x331, size=0x2, align=0x30 CTL0043: adding io range 0x388-0x38b, size=0x4, align=0x1 CTL0043: start dependent (1) CTL0043: adding irq mask 0x6a0 CTL0043: adding dma mask 0xb CTL0043: adding dma mask 0xb CTL0043: adding io range 0x220-0x28f, size=0x10, align=0x20 CTL0043: adding io range 0x300-0x331, size=0x2, align=0x30 CTL0043: start dependent (1) CTL0043: adding irq mask 0x6a0 CTL0043: adding dma mask 0xb CTL0043: adding dma mask 0xb CTL0043: adding io range 0x220-0x28f, size=0x10, align=0x20 CTL0043: start dependent (2) CTL0043: adding irq mask 0x6a0 CTL0043: adding dma mask 0xb CTL0043: adding io range 0x220-0x28f, size=0x10, align=0x20 CTL0043: adding io range 0x300-0x331, size=0x2, align=0x10 CTL0043: adding io range 0x388-0x397, size=0x4, align=0x4 CTL0043: start dependent (2) CTL0043: adding irq mask 0x6a0 CTL0043: adding dma mask 0xb CTL0043: adding io range 0x220-0x28f, size=0x10, align=0x20 CTL0043: end dependent CTL7005: start dependent (0) CTL7005: adding io range 0x201-0x201, size=0x1, align=0x1 CTL7005: start dependent (1) CTL7005: adding io range 0x200-0x20f, size=0x1, align=0x1 CTL7005: end dependent 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: