kern/80381: 5.4 RC3 can't allocate ps/2 irq, no psm, no mouse. Same box works fine on 5.3

Harry Coin harrycoin at quietfountain.com
Tue Apr 26 16:30:08 PDT 2005


>Number:         80381
>Category:       kern
>Synopsis:       5.4 RC3 can't allocate ps/2 irq, no psm, no mouse.  Same box works fine on 5.3
>Confidential:   no
>Severity:       critical
>Priority:       high
>Responsible:    freebsd-bugs
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          sw-bug
>Submitter-Id:   current-users
>Arrival-Date:   Tue Apr 26 23:30:07 GMT 2005
>Closed-Date:
>Last-Modified:
>Originator:     Harry Coin
>Release:        5.4 RC3 #6
>Organization:
>Environment:
FreeBSD server1.quietfountain.com 5.4-RC3 FreeBSD 5.4-RC3 #6: Mon Apr 25 14:26:53 CDT 2005     root at server1.quietfountain.com:/usr/obj/usr/src/sys/SERVER1  i386

>Description:
Here's a boot -v dmesg showing that a working ps/2 mouse under 5.3 is ignored on the latest 5.4 as of today.

Attached mouse is a MS 2 button wheel ps/2 mouse.

Seems it can't allocate an interrupt.  So, no mouse driver loads under 5.4.  Go back to 5.3, and the mouse works (but atapicam generates an interrupt storm hang (not panic) on boot under 5.3.  The atapicam issue is fixed in 5.4.

Here are the few relevant lines, then the whole dmesg

atkbdc0: <Keyboard controller (i8042)> port 0x64,0x60 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
atkbd: the current kbd controller command byte 0065
atkbd: keyboard ID 0x41ab (2)
kbd0 at atkbd0
kbd0: atkbd0, AT 101/102 (2), config:0x0, flags:0x3d0000
atkbd0: [GIANT-LOCKED]
psm0: unable to allocate IRQ
psmcpnp0: <PS/2 mouse port> irq 12 on acpi0
psm0: current command byte:0065
psm0: failed to reset the aux device.

Here's the whole dmesg -v


pcib0: matched entry for 0.1.INTA
pcib0: slot 1 INTA hardwired to IRQ 16
pcib1: slot 0 INTA is routed to irq 16
found->	vendor=0x10de, dev=0x0181, revid=0xa2
	bus=1, slot=0, func=0
	class=03-00-00, hdrtype=0x00, mfdev=0
	cmdreg=0x0007, statreg=0x02b0, cachelnsz=0 (dwords)
	lattimer=0xc0 (5760 ns), mingnt=0x05 (1250 ns), maxlat=0x01 (250 ns)
	intpin=a, irq=16
	powerspec 2  supports D0 D3  current D0
nvidia0: <GeForce4 MX 440 with AGP8X> mem 0xe8000000-0xefffffff,0xfd000000-0xfdffffff irq 16 at device 0.0 on pci1
nvidia0: Reserved 0x1000000 bytes for rid 0x10 type 3 at 0xfd000000
nvidia0: Reserved 0x8000000 bytes for rid 0x14 type 3 at 0xe8000000
nvidia0: [GIANT-LOCKED]
pcib2: <ACPI PCI-PCI bridge> at device 3.0 on pci0
pcib2:   secondary bus     2
pcib2:   subordinate bus   2
pcib2:   I/O decode        0xc000-0xcfff
pcib2:   memory decode     0xfe900000-0xfe9fffff
pcib2:   prefetched decode 0xfff00000-0xfffff
ACPI PCI link initial configuration:
pci2: <ACPI PCI bus> on pcib2
pci2: physical bus=2
	map[10]: type 1, range 32, base fe9e0000, size 17, enabled
pcib2: device (null) requested decoded memory range 0xfe9e0000-0xfe9fffff
	map[18]: type 4, range 32, base 0000cf80, size  5, enabled
pcib2: device (null) requested decoded I/O range 0xcf80-0xcf9f
pcib2: matched entry for 2.1.INTA
pcib2: slot 1 INTA hardwired to IRQ 18
found->	vendor=0x8086, dev=0x1019, revid=0x00
	bus=2, slot=1, func=0
	class=02-00-00, hdrtype=0x00, mfdev=0
	cmdreg=0x0007, statreg=0x0238, cachelnsz=4 (dwords)
	lattimer=0x00 (0 ns), mingnt=0xff (63750 ns), maxlat=0x00 (0 ns)
	intpin=a, irq=18
	powerspec 2  supports D0 D3  current D0
em0: <Intel(R) PRO/1000 Network Connection, Version - 1.7.35> port 0xcf80-0xcf9f mem 0xfe9e0000-0xfe9fffff irq 18 at device 1.0 on pci2
em0: Reserved 0x20000 bytes for rid 0x10 type 3 at 0xfe9e0000
em0: Reserved 0x20 bytes for rid 0x18 type 4 at 0xcf80
em0: [MPSAFE]
em0: bpf attached
em0: Ethernet address: 00:0c:6e:79:7a:bb
em0:  Speed:N/A  Duplex:N/A
uhci0: <Intel 82801EB (ICH5) USB controller USB-A> port 0xeec0-0xeedf irq 16 at device 29.0 on pci0
uhci0: Reserved 0x20 bytes for rid 0x20 type 4 at 0xeec0
uhci0: [GIANT-LOCKED]
usb0: <Intel 82801EB (ICH5) 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 82801EB (ICH5) USB controller USB-B> port 0xef00-0xef1f irq 19 at device 29.1 on pci0
uhci1: Reserved 0x20 bytes for rid 0x20 type 4 at 0xef00
uhci1: [GIANT-LOCKED]
usb1: <Intel 82801EB (ICH5) 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 82801EB (ICH5) USB controller USB-C> port 0xef20-0xef3f irq 18 at device 29.2 on pci0
uhci2: Reserved 0x20 bytes for rid 0x20 type 4 at 0xef20
uhci2: [GIANT-LOCKED]
usb2: <Intel 82801EB (ICH5) 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
uhci3: <Intel 82801EB (ICH5) USB controller USB-D> port 0xef40-0xef5f irq 16 at device 29.3 on pci0
uhci3: Reserved 0x20 bytes for rid 0x20 type 4 at 0xef40
uhci3: [GIANT-LOCKED]
usb3: <Intel 82801EB (ICH5) USB controller USB-D> on uhci3
usb3: USB revision 1.0
uhub3: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub3: 2 ports with 2 removable, self powered
pci0: <serial bus, USB> at device 29.7 (no driver attached)
pcib3: <ACPI PCI-PCI bridge> at device 30.0 on pci0
pcib3:   secondary bus     3
pcib3:   subordinate bus   3
pcib3:   I/O decode        0xd000-0xdfff
pcib3:   memory decode     0xfea00000-0xfeafffff
pcib3:   prefetched decode 0xfff00000-0xfffff
pcib3:   Subtractively decoded bridge.
ACPI PCI link initial configuration:
pci3: <ACPI PCI bus> on pcib3
pci3: physical bus=3
	map[10]: type 1, range 32, base feaff800, size 11, enabled
pcib3: device (null) requested decoded memory range 0xfeaff800-0xfeafffff
	map[14]: type 4, range 32, base 0000dc00, size  7, enabled
pcib3: device (null) requested decoded I/O range 0xdc00-0xdc7f
pcib3: matched entry for 3.3.INTA
pcib3: slot 3 INTA hardwired to IRQ 20
found->	vendor=0x1106, dev=0x3044, revid=0x80
	bus=3, slot=3, func=0
	class=0c-00-10, hdrtype=0x00, mfdev=0
	cmdreg=0x0117, statreg=0x0210, cachelnsz=4 (dwords)
	lattimer=0xc0 (5760 ns), mingnt=0x00 (0 ns), maxlat=0x20 (8000 ns)
	intpin=a, irq=20
	powerspec 2  supports D0 D2 D3  current D0
fwohci0: <VIA Fire II (VT6306)> port 0xdc00-0xdc7f mem 0xfeaff800-0xfeafffff irq 20 at device 3.0 on pci3
fwohci0: Reserved 0x800 bytes for rid 0x10 type 3 at 0xfeaff800
fwohci0: [MPSAFE]
fwohci0: OHCI version 1.0 (ROM=1)
fwohci0: No. of Isochronous channels is 4.
fwohci0: EUI64 00:e0:18:00:00:28:47:f6
fwohci0: Phy 1394a available S400, 2 ports.
fwohci0: Link S400, max_rec 2048 bytes.
firewire0: <IEEE1394(FireWire) bus> on fwohci0
fwohci0: Initiate bus reset
fwohci0: node_id=0xc800ffc0, gen=1, CYCLEMASTER mode
firewire0: 1 nodes, maxhop <= 0, cable IRM = 0 (me)
firewire0: bus manager 0 (me)
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel ICH5 UDMA100 controller> port 0xef90-0xef9f,0xefa8-0xefab,0xefa0-0xefa7,0xefac-0xefaf,0xefe0-0xefe7 irq 18 at device 31.1 on pci0
atapci0: Reserved 0x10 bytes for rid 0x20 type 4 at 0xef90
atapci0: [MPSAFE]
ata2: channel #0 on atapci0
atapci0: Reserved 0x8 bytes for rid 0x10 type 4 at 0xefe0
atapci0: Reserved 0x4 bytes for rid 0x14 type 4 at 0xefac
ata2: reset tp1 mask=03 ostat0=50 ostat1=50
ata2-master: stat=0x50 err=0x01 lsb=0x00 msb=0x00
ata2-slave:  stat=0x50 err=0x01 lsb=0x00 msb=0x00
ata2: reset tp2 stat0=50 stat1=50 devices=0x3<ATA_SLAVE,ATA_MASTER>
ata2: [MPSAFE]
ata3: channel #1 on atapci0
atapci0: Reserved 0x8 bytes for rid 0x18 type 4 at 0xefa0
atapci0: Reserved 0x4 bytes for rid 0x1c type 4 at 0xefa8
ata3: reset tp1 mask=03 ostat0=00 ostat1=00
ata3-master: stat=0x6f err=0x6f lsb=0x6f msb=0x6f
<many of these same snipped>
ata3-master: stat=0x6f err=0x6f lsb=0x6f msb=0x6f
ata3-master: stat=0x6f err=0x6f lsb=0x6f msb=0x6f
ata3-master: stat=0x6f err=0x6f lsb=0x6f msb=0x6f
ata3: reset tp2 stat0=ef stat1=80 devices=0x0
ata3: [MPSAFE]
pci0: <serial bus, SMBus> at device 31.3 (no driver attached)
pcm0: <Intel ICH5 (82801EB)> port 0xee80-0xeebf,0xe800-0xe8ff mem 0xfebff000-0xfebff0ff,0xfebff400-0xfebff5ff irq 17 at device 31.5 on pci0
pcm0: Reserved 0x200 bytes for rid 0x18 type 3 at 0xfebff400
pcm0: Reserved 0x100 bytes for rid 0x1c type 3 at 0xfebff000
pcm0: [GIANT-LOCKED]
pcm0: <Analog Devices AD1985 AC97 Codec (id = 0x41445375)>
pcm0: Codec features headphone, 20 bit DAC, 5 bit master volume, no 3D Stereo Enhancement
pcm0: Primary codec extended features variable rate PCM, double rate PCM, reserved 1, center DAC, surround DAC, LFE DAC, AMAP
pcm0: sndbuf_setmap 7d608000, 4000; 0xeac79000 -> 7d608000
pcm0: sndbuf_setmap 7d5ff000, 4000; 0xeac7d000 -> 7d5ff000
acpi_button0: <Power Button> on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x64,0x60 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
atkbd: the current kbd controller command byte 0065
atkbd: keyboard ID 0x41ab (2)
kbd0 at atkbd0
kbd0: atkbd0, AT 101/102 (2), config:0x0, flags:0x3d0000
atkbd0: [GIANT-LOCKED]
psm0: unable to allocate IRQ
psmcpnp0: <PS/2 mouse port> irq 12 on acpi0
psm0: current command byte:0065
psm0: failed to reset the aux device.
sio0: irq maps: 0x801 0x811 0x801 0x801
sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
sio0: type 16550A
sio1: irq maps: 0x801 0x809 0x801 0x801
sio1: <16550A-compatible COM port> port 0x2f8-0x2ff irq 3 on acpi0
sio1: type 16550A
fdc0: <floppy drive controller (FDE)> port 0x3f7,0x3f0-0x3f5 irq 6 drq 2 on acpi0
fdc0: ic_type 90 part_id 80
fdc0: [MPSAFE]
fdc0: [FAST]
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
ppc0: using extended I/O port range
ppc0: ECP SPP ECP+EPP SPP
ppc0: <ECP parallel printer port> port 0x778-0x77b,0x378-0x37f irq 7 drq 3 on acpi0
ppc0: SMC-like chipset (ECP/EPP/PS2/NIBBLE) in COMPATIBLE mode
ppc0: FIFO with 16/16/9 bytes threshold
ppbus0: <Parallel port bus> on ppc0
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
ppi0: <Parallel I/O> on ppbus0
atkbdc: atkbdc0 already exists; skipping it
fdc: fdc0 already exists; skipping it
ppc: ppc0 already exists; skipping it
sio: sio0 already exists; skipping it
sio: sio1 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: <ISA Option ROM> at iomem 0xc0000-0xce7ff on isa0
pmtimer0 on isa0
adv0: not probed (disabled)
aha0: not probed (disabled)
aic0: not probed (disabled)
ata0 at port 0x3f6,0x1f0-0x1f7 irq 14 on isa0
ata0: reset tp1 mask=00 ostat0=ff ostat1=ff
ata0: [MPSAFE]
ata1 at port 0x376,0x170-0x177 irq 15 on isa0
ata1: reset tp1 mask=00 ostat0=ff ostat1=ff
ata1: [MPSAFE]
bt0: not probed (disabled)
cs0: not probed (disabled)
ed0: not probed (disabled)
fe0: not probed (disabled)
ie0: not probed (disabled)
lnc0: not probed (disabled)
pcic0 failed to probe at port 0x3e0 iomem 0xd0000 on isa0
pcic1: not probed (disabled)
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
sc0: fb0, kbd0, terminal emulator: sc (syscons terminal)
sio2: not probed (disabled)
sio3: not probed (disabled)
sn0: not probed (disabled)
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 82 54 80 
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 54 80 
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 10 00 03 00 02 67 5f 4f 50 82 54 80 
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 
vt0: not probed (disabled)
isa_probe_children: probing PnP devices
Device configuration finished.
Reducing kern.maxvnodes 134066 -> 100000
procfs registered
Timecounter "TSC" frequency 2806372688 Hz quality -100
Timecounters tick every 10.000 msec
Linux ELF exec handler installed
lo0: bpf attached
em0: Link is up 1000 Mbps Full Duplex
ata2-slave: pio=0x0c wdma=0x22 udma=0x45 cable=80pin
ata2-master: pio=0x0c wdma=0x22 udma=0x45 cable=80pin
ata2-master: setting PIO4 on Intel ICH5 chip
ata2-master: setting UDMA100 on Intel ICH5 chip
ata2-slave: setting PIO4 on Intel ICH5 chip
ata2-slave: setting UDMA100 on Intel ICH5 chip
ad4: <WDC WD2500JB-00EVA0/15.05R15> ATA-6 disk at ata2-master
ad4: 238475MB (488397168 sectors), 484521 C, 16 H, 63 S, 512 B
ad4: 16 secs/int, 1 depth queue, UDMA100
ar: FreeBSD check1 failed
ad5: <WDC WD2500JB-00EVA0/15.05R15> ATA-6 disk at ata2-slave
ad5: 238475MB (488397168 sectors), 484521 C, 16 H, 63 S, 512 B
ad5: 16 secs/int, 1 depth queue, UDMA100
ar: FreeBSD check1 failed
pcm0: measured ac97 link rate at 48004 Hz, will use 48000 Hz
SMP: AP CPU #1 Launched!
cpu1 AP:
     ID: 0x01000000   VER: 0x00050014 LDR: 0x02000000 DFR: 0x0fffffff
  lint0: 0x00010700 lint1: 0x00010400 TPR: 0x00000000 SVR: 0x000001ff
ioapic0: routing intpin 1 (ISA IRQ 1) to cluster 0
ioapic0: routing intpin 3 (ISA IRQ 3) to cluster 0
ioapic0: routing intpin 4 (ISA IRQ 4) to cluster 0
ioapic0: routing intpin 6 (ISA IRQ 6) to cluster 0
ioapic0: routing intpin 7 (ISA IRQ 7) to cluster 0
ioapic0: routing intpin 8 (ISA IRQ 8) to cluster 0
ioapic0: routing intpin 9 (ISA IRQ 9) to cluster 0
ioapic0: routing intpin 13 (ISA IRQ 13) to cluster 0
ioapic0: routing intpin 14 (ISA IRQ 14) to cluster 0
ioapic0: routing intpin 15 (ISA IRQ 15) to cluster 0
ioapic0: routing intpin 16 (PCI IRQ 16) to cluster 0
ioapic0: routing intpin 17 (PCI IRQ 17) to cluster 0
ioapic0: routing intpin 18 (PCI IRQ 18) to cluster 0
ioapic0: routing intpin 19 (PCI IRQ 19) to cluster 0
ioapic0: routing intpin 20 (PCI IRQ 20) to cluster 0
GEOM: new disk ad4
GEOM: new disk ad5
[0] f:80 typ:165 s(CHS):0/1/1 e(CHS):168/15/63 s:63 l:488397105
[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 ad4s1, start 32256 length 250059317760 end 250059350015
[0] f:80 typ:165 s(CHS):0/1/1 e(CHS):168/15/63 s:63 l:488397105
[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 ad5s1, start 32256 length 250059317760 end 250059350015
[0] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
[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:80 typ:165 s(CHS):0/0/1 e(CHS):1023/254/63 s:0 l:50000
GEOM: Configure ad4s1a, start 0 length 1073741824 end 1073741823
GEOM: Configure ad4s1b, start 1073741824 length 2147483648 end 3221225471
GEOM: Configure ad4s1c, start 0 length 250059317760 end 250059317759
GEOM: Configure ad4s1d, start 3221225472 length 1073741824 end 4294967295
GEOM: Configure ad4s1e, start 4294967296 length 4294967296 end 8589934591
GEOM: Configure ad4s1f, start 8589934592 length 241469383168 end 250059317759
GEOM: Configure ad5s1b, start 0 length 2147483648 end 2147483647
GEOM: Configure ad5s1c, start 0 length 250059317760 end 250059317759
GEOM: Configure ad5s1f, start 2147483648 length 247911834112 end 250059317759
[0] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
[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:80 typ:165 s(CHS):0/0/1 e(CHS):1023/254/63 s:0 l:50000
[0] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
[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:80 typ:165 s(CHS):0/0/1 e(CHS):1023/254/63 s:0 l:50000
Mounting root from ufs:/dev/ad4s1a
start_init: trying /sbin/init
splash: image decoder found: green_saver
em0: Link is up 1000 Mbps Full Duplex

>How-To-Repeat:
      Boot.  Happens every time.
>Fix:
      Wish I knew.

>Release-Note:
>Audit-Trail:
>Unformatted:


More information about the freebsd-bugs mailing list