Hello Jacob,
[email protected] (Jacob Meuser), 2010.11.24 (Wed) 22:07 (CET):
> On Tue, Nov 23, 2010 at 10:28:17AM +0100, MERIGHI Marcus wrote:
> > Jacob Meuser <[email protected]>, 2010-11-22 23:06:23:
>
> > > > uvm_fault(0xd0a1a040, 0x0, 0, 1) -> e
> > > > kernel: page fault trap, code=0
> > > > Stopped at usbd_do_request_flags_pipe+0x18: movl
> > > > 0x258(%eax),%ec
> > > > x
> > > > ddb>
> > > > ddb> trace
> > > > usbd_do_request_flags_pipe(d1f3ac00,2,dc16aef8,0,0) at
> > > > usbd_do_request_flags_pi
> > > > pe+0x18
> > > > usbd_do_request_flags(d1f3ac00,dc16aef8,0,0,0) at
> > > > usbd_do_request_flags+0x3c
> > > > usbd_do_request(d1f3ac00,dc16aef8,0,d079ab1d,d0a0f200) at
> > > > usbd_do_request+0x37
> > > > usbd_reset_port(d1f3ac00,1,d1f3a980,d03e1d87,40) at usbd_reset_port+0x42
> > > > uhub_explore(d1f3ac00,d1f3accc,dc16af8c,d07978b6,d1f3ac80) at
> > > > uhub_explore+0x16
> > > > f
> > > > usb_explore(d1f3ac80,20,d097e6b6,0,d6d7f768) at usb_explore+0x3f
> > > > usb_task_thread(d6d7f768) at usb_task_thread+0x76
> > >
> > > does the device work? does the kernel see devices attached to the USB?
> >
> > yes. below dmesg with pcmcia card attached as well as usb stick via
> > pcmcia card. watch out for "pcmcia card inserted" and "usb stick
> > inserted".
>
> ok then it's not the initial uhub_explore() just hanging out
> forever ... apparently the device generates a hub interrupt
> when it's removed.
>
> I've just sent a patch to tech@ which I think will fix
> the crash. the subject is 'more usb detach love'. can you
> see if that makes a difference?
I have already seen your follow up message but since I already patched
with your lengthy diff and running on that kernel I thought I'd get you
the output anyways (look for "# inserting pcmcia uhub"):
>> OpenBSD/i386 BOOT 3.02
boot>
booting hd0a:/bsd: 8190524+1091240 [61+369760+355662]=0x98b470
entry point at 0x200120
[ using 725900 bytes of bsd ELF symbol table ]
Copyright (c) 1982, 1986, 1989, 1991, 1993
The Regents of the University of California. All rights reserved.
Copyright (c) 1995-2010 OpenBSD. All rights reserved. http://www.OpenBSD.org
OpenBSD 4.8-current (GENERIC) #2: Thu Nov 25 13:47:43 CET 2010
[email protected]:/mnt/openbsd/src/sys/arch/i386/compile/GENERIC
cpu0: Mobile Intel(R) Pentium(R) 4 - M CPU 2.00GHz ("GenuineIntel" 686-class) 2
GHz
cpu0: FPU,V86,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,
DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,SBF,CNXT-ID,xTPR
real mem = 1072721920 (1023MB)
avail mem = 1045118976 (996MB)
mainbus0 at root
bios0 at mainbus0: AT/286+ BIOS, date 06/12/03, BIOS32 rev. 0 @ 0xfd7e0, SMBIOS
rev. 2.31 @ 0xe0010 (48 entries)
bios0: vendor IBM version "1IET66WW (2.05 )" date 06/12/2003
bios0: IBM 2366EG9
acpi0 at bios0: rev 2
acpi0: sleep states S0 S3 S4 S5
acpi0: tables DSDT FACP SSDT ECDT TCPA BOOT
acpi0: wakeup devices LID_(S3) SLPB(S3) UART(S3) PCI0(S4) PCI1(S4) DOCK(S4) USB0
(S3) USB1(S3) USB2(S3) AC97(S4)
acpitimer0 at acpi0: 3579545 Hz, 24 bits
acpiec0 at acpi0
acpiprt0 at acpi0: bus 0 (PCI0)
acpiprt1 at acpi0: bus 1 (AGP_)
acpiprt2 at acpi0: bus 2 (PCI1)
acpicpu0 at acpi0: C3, C2, FVS, 2000, 1200 MHz
acpipwrres0 at acpi0: PUBS
acpitz0 at acpi0: critical temperature 94 degC
acpibtn0 at acpi0: LID_
acpibtn1 at acpi0: SLPB
acpibat0 at acpi0: BAT0 model "IBM-COMPATIBLE" serial 20884 type LION oem "GW"
acpibat1 at acpi0: BAT1 not present
acpiac0 at acpi0: AC unit online
acpithinkpad0 at acpi0
acpidock0 at acpi0: DOCK not docked (0)
bios0: ROM list: 0xc0000/0x10000 0xdc000/0x4000! 0xe0000/0x10000
cpu0 at mainbus0: (uniprocessor)
pci0 at mainbus0 bus 0: configuration mode 1 (bios)
pchb0 at pci0 dev 0 function 0 "Intel 82845 Host" rev 0x04
intelagp0 at pchb0
agp0 at intelagp0: aperture at 0xe0000000, size 0x4000000
ppb0 at pci0 dev 1 function 0 "Intel 82845 AGP" rev 0x04
pci1 at ppb0 bus 1
vga1 at pci1 dev 0 function 0 "ATI Radeon Mobility M7" rev 0x00
wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation)
wsdisplay0: screen 1-5 added (80x25, vt100 emulation)
radeondrm0 at vga1: irq 11
drm0 at radeondrm0
uhci0 at pci0 dev 29 function 0 "Intel 82801CA/CAM USB" rev 0x02: irq 11
uhci1 at pci0 dev 29 function 1 "Intel 82801CA/CAM USB" rev 0x02: irq 11
uhci2 at pci0 dev 29 function 2 "Intel 82801CA/CAM USB" rev 0x02: irq 11
ppb1 at pci0 dev 30 function 0 "Intel 82801BAM Hub-to-PCI" rev 0x42
pci2 at ppb1 bus 2
mem address conflict 0x50000000/0x1000
mem address conflict 0x51000000/0x1000
cbb0 at pci2 dev 0 function 0 "TI PCI1520 CardBus" rev 0x01: irq 11
cbb1 at pci2 dev 0 function 1 "TI PCI1520 CardBus" rev 0x01: irq 11
fxp0 at pci2 dev 8 function 0 "Intel PRO/100 VE" rev 0x42, i82562: irq 11, addre
ss 00:09:6b:3f:67:a8
inphy0 at fxp0 phy 1: i82562ET 10/100 PHY, rev. 0
cardslot0 at cbb0 slot 0 flags 0
cardbus0 at cardslot0: bus 3 device 0 cacheline 0x8, lattimer 0xb0
pcmcia0 at cardslot0
cardslot1 at cbb1 slot 1 flags 0
cardbus1 at cardslot1: bus 6 device 0 cacheline 0x8, lattimer 0xb0
pcmcia1 at cardslot1
ichpcib0 at pci0 dev 31 function 0 "Intel 82801CAM LPC" rev 0x02
pciide0 at pci0 dev 31 function 1 "Intel 82801CAM IDE" rev 0x02: DMA, channel 0
configured to compatibility, channel 1 configured to compatibility
wd0 at pciide0 channel 0 drive 0: <WDC WD3200BEVE-00A0HT0>
wd0: 16-sector PIO, LBA48, 305245MB, 625142448 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 5
wd1 at pciide0 channel 1 drive 0: <WDC WD1600BEVE-00WZT0>
wd1: 16-sector PIO, LBA48, 152627MB, 312581808 sectors
wd1(pciide0:1:0): using PIO mode 4, Ultra-DMA mode 5
ichiic0 at pci0 dev 31 function 3 "Intel 82801CA/CAM SMBus" rev 0x02: irq 11
iic0 at ichiic0
auich0 at pci0 dev 31 function 5 "Intel 82801CA/CAM AC97" rev 0x02: irq 11, ICH3
AC97
ac97: codec id 0x41445348 (Analog Devices AD1881A)
ac97: codec features headphone, Analog Devices Phat Stereo
audio0 at auich0
usb0 at uhci0: USB revision 1.0
uhub0 at usb0 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb1 at uhci1: USB revision 1.0
uhub1 at usb1 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb2 at uhci2: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at ichpcib0
isadma0 at isa0
com0 at isa0 port 0x3f8/8 irq 4: ns16550a, 16 byte fifo
com0: console
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
pms0 at pckbc0 (aux slot)
pckbc0: using irq 12 for aux slot
wsmouse0 at pms0 mux 0
pcppi0 at isa0 port 0x61
spkr0 at pcppi0
npx0 at isa0 port 0xf0/16: reported by CPUID; using exception 16
biomask eded netmask eded ttymask ffff
mtrr: Pentium Pro MTRR support
com3 at pcmcia1 function 1 "Sierra Wireless, AC850, 3G Network Adapter" port 0x3
3f8/8: ns16550a, 16 byte fifo
umass0 at uhub1 port 2 configuration 1 interface 0 "Generic AutoRUN/Partition" r
ev 2.00/1.00 addr 2
umass0: using SCSI over Bulk-Only
scsibus0 at umass0: 2 targets, initiator 0
sd0 at scsibus0 targ 1 lun 0: <Mass, Storage Device, \001 \001> SCSI0 0/direct r
emovable
sd0: 3781MB, 512 bytes/sec, 7744511 sec total
vscsi0 at root
scsibus1 at vscsi0: 256 targets
softraid0 at root
root on wd0a swap on wd0b dump on wd0b
Automatic boot in progress: starting file system checks.
/dev/wd0a (10a8ab1121377141.a): file system is clean; not checking
/dev/wd0j (10a8ab1121377141.j): file system is clean; not checking
/dev/wd0e (10a8ab1121377141.e): file system is clean; not checking
/dev/wd0f (10a8ab1121377141.f): file system is clean; not checking
/dev/wd0g (10a8ab1121377141.g): file system is clean; not checking
/dev/wd0h (10a8ab1121377141.h): file system is clean; not checking
/dev/wd0k (10a8ab1121377141.k): file system is clean; not checking
setting tty flags
kbd: keyboard mapping set to de
keyboard.encoding -> de
pf enabled
ddb.console: 0 -> 1
machdep.allowaperture: 0 -> 2
machdep.kbdreset: 0 -> 1
machdep.lidsuspend: 0 -> 0
starting network
starting system logger
starting initial daemons: portmap amd ntpd.
savecore: no core dump
checking quotas: done.
building ps databases: kvm dev.
clearing /tmp
starting pre-securelevel daemons:.
setting kernel security level: kern.securelevel: 0 -> 1
turning on accounting
creating runtime link editor directory cache.
preserving editor files.
starting network daemons: sshd ifstated lpd ldapd smtpd inetd.
starting local daemons:mount_ffs: 1b7ba332f009b306.a on /mnt/asfer: No such file
or directory
smartd freedt squid.
standard daemons: apmd sensorsd hotplugd cron.
Fri Nov 26 10:25:51 CET 2010
starting xdm...
scsibus2 at softraid0: 1 targets
sd1 at scsibus2 targ 0 lun 0: <OPENBSD, SR CRYPTO, 004> SCSI2 0/direct fixed
sd1: 256006MB, 512 bytes/sec, 524300593 sec total
scsibus3 at softraid0: 1 targets
sd2 at scsibus3 targ 0 lun 0: <OPENBSD, SR CRYPTO, 004> SCSI2 0/direct fixed
sd2: 111916MB, 512 bytes/sec, 229204498 sec total
scsibus4 at softraid0: 1 targets
sd3 at scsibus4 targ 0 lun 0: <OPENBSD, SR CRYPTO, 004> SCSI2 0/direct fixed
sd3: 3600MB, 512 bytes/sec, 7373233 sec total
sd2 detached
scsibus3 detached
cbb1: bad Vcc request. sock_ctrl 0x400, sock_status 0x3000035e
cbb1: bad Vcc request. sock_ctrl 0x400, sock_status 0x30000316
com3 detached
sd3 detached
scsibus4 detached
# inserting pcmcia uhub
uhci3 at cardbus0 dev 0 function 0 "VIA VT83C572 USB" rev 0x62: irq 11
usb3 at uhci3: USB revision 1.0
uhub3 at usb3 "VIA UHCI root hub" rev 1.00/1.00 addr 1
uhci4 at cardbus0 dev 0 function 1 "VIA VT83C572 USB" rev 0x62: irq 11
usb4 at uhci4: USB revision 1.0
uhub4 at usb4 "VIA UHCI root hub" rev 1.00/1.00 addr 1
ehci0 at cardbus0 dev 0 function 2 "VIA VT6202 USB" rev 0x65: irq 11
usb5 at ehci0: USB revision 2.0
uhub5 at usb5 "VIA EHCI root hub" rev 2.00/1.00 addr 1
# unplug of usb stick from normal notebook usb
sd0 detached
scsibus0 detached
umass0 detached
# plug usb stick to pcmcia uhub
umass0 at uhub5 port 1 configuration 1 interface 0 "Generic AutoRUN/Partition" r
ev 2.00/1.00 addr 2
umass0: using SCSI over Bulk-Only
scsibus0 at umass0: 2 targets, initiator 0
sd0 at scsibus0 targ 1 lun 0: <Mass, Storage Device, \001 \001> SCSI0 0/direct r
emovable
sd0: 3781MB, 512 bytes/sec, 7744511 sec total
# hotplugd automagic
scsibus3 at softraid0: 1 targets
sd2 at scsibus3 targ 0 lun 0: <OPENBSD, SR CRYPTO, 004> SCSI2 0/direct fixed
sd2: 111916MB, 512 bytes/sec, 229204498 sec total
scsibus4 at softraid0: 1 targets
sd3 at scsibus4 targ 0 lun 0: <OPENBSD, SR CRYPTO, 004> SCSI2 0/direct fixed
sd3: 3600MB, 512 bytes/sec, 7373233 sec total
sd2 detached
scsibus3 detached
# unplug usb stick
sd0 detached
scsibus0 detached
umass0 detached
# unplug pcmcia uhub
uhci3: host system error
uhci3: host controller process error
uhci3: host controller halted
uhci4: host system error
uhci4: host controller process error
uhci4: host controller halted
ehci0: unrecoverable error, controller halted
ehci0: blocking intrs 0x10
uhub3 detached
usb3 detached
uhci3 detached
uhub4 detached
usb4 detached
uhci4 detached
uhub5 detached
uvm_fault(0xd09f9080, 0xeffff000, 0, 1) -> d
kernel: page fault trap, code=0
Stopped at usbd_do_request_flags_pipe+0x18: movl 0x258(%eax),%ec
x
ddb> trace
usbd_do_request_flags_pipe(d1f86980,efff0065,dc16bef8,0,0) at usbd_do_request_f
lags_pipe+0x18
usbd_do_request_flags(d1f86980,dc16bef8,0,0,0) at usbd_do_request_flags+0x3c
usbd_do_request(d1f86980,dc16bef8,0,d079ae0d,d0a10200) at usbd_do_request+0x37
usbd_reset_port(d1f86980,1,d1fc0400,d03e20f7,40) at usbd_reset_port+0x42
uhub_explore(d1f86980,d1ed17cc,dc16bf8c,d0797b47,d1ed1780) at uhub_explore+0x17
1
usb_explore(d1ed1780,20,d097edb6,0,d6d7f768) at usb_explore+0x3f
usb_task_thread(d6d7f768) at usb_task_thread+0x77
Bad frame pointer: 0xd0b8de48
ddb> ps
PID PPID PGRP UID S FLAGS WAIT COMMAND
10326 12292 26893 0 3 0x4080 nanosleep sleep
30847 16259 26893 0 3 0x4080 nanosleep sleep
27968 23928 26893 0 3 0x4080 nanosleep sleep
20510 7390 26893 0 3 0x4080 nanosleep sleep
15721 3593 26893 0 3 0x4080 nanosleep sleep
3178 30390 26893 0 3 0x4080 nanosleep sleep
30341 7907 26893 0 3 0x4080 nanosleep sleep
12972 1 26893 0 3 0x4080 piperd logger
16259 1 26893 0 3 0x80 pause ksh
28232 1 26893 0 3 0x4080 piperd logger
23928 1 26893 0 3 0x80 pause ksh
7507 1 26893 0 3 0x4080 piperd logger
12292 1 26893 0 3 0x80 pause ksh
29817 1 26893 0 3 0x4080 piperd logger
7390 1 26893 0 3 0x80 pause ksh
2153 1 26893 0 3 0x4080 piperd logger
3593 1 26893 0 3 0x80 pause ksh
30098 1 26893 0 3 0x4080 piperd logger
30390 1 26893 0 3 0x80 pause ksh
13228 1 26893 0 3 0x4080 piperd logger
7907 1 26893 0 3 0x80 pause ksh
30563 0 0 0 3 0x100200 bored srdis
11937 2296 11937 0 3 0x80 poll xdm
3686 4852 4852 0 3 0x40180 netio Xorg
4852 2296 4852 35 3 0x44180 select Xorg
22591 1 22591 1000 3 0x40180 select ssh-agent
5697 0 0 0 3 0x100200 bored srdis
13501 1 13501 0 3 0x4080 ttyin getty
5865 1 5865 0 3 0x4080 ttyin getty
24092 1 24092 0 3 0x4080 ttyin getty
8422 1 8422 0 3 0x4080 ttyin getty
16468 1 16468 0 3 0x4080 ttyin ksh
2296 1 2296 0 3 0x80 pause xdm
25074 3227 11491 515 3 0x4080 piperd unlinkd
2288 3227 11491 515 3 0x4080 poll ncsa_auth
25516 3227 11491 515 3 0x4080 poll ncsa_auth
7346 1 7346 0 3 0x80 select cron
26893 1 26893 0 3 0x80 htplev hotplugd
12790 1 12790 0 3 0x80080 nanosleep sensorsd
20846 1 20846 0 3 0x80 kqread apmd
3227 11491 11491 515 3 0x4180 poll squid
11491 1 11491 0 3 0x80 poll squid
27369 1 6756 0 3 0x80 nanosleep smartd
27060 2915 27060 510 3 0x4080 piperd logger
2915 32313 32313 0 3 0x4080 select supervise
29563 9854 29563 510 3 0x4180 poll pdnsd
9854 32313 32313 0 3 0x4080 select supervise
32313 1 32313 0 3 0x4080 nanosleep svscan
15103 1 15103 99 3 0x180 poll aucat
7354 1 7354 0 3 0x180 select inetd
25160 22439 22439 95 3 0x180 kqread smtpd
26395 22439 22439 95 3 0x180 kqread smtpd
13957 22439 22439 95 3 0x180 kqread smtpd
7545 22439 22439 95 3 0x180 kqread smtpd
10423 22439 22439 95 3 0x180 kqread smtpd
12701 22439 22439 95 3 0x180 kqread smtpd
19357 22439 22439 95 3 0x180 kqread smtpd
17673 22439 22439 95 3 0x180 kqread smtpd
22439 1 22439 0 3 0x80 kqread smtpd
7684 3643 3643 100 3 0x180 kqread ldapd
3643 1 3643 0 3 0x80 kqread ldapd
14069 1 14069 0 3 0x40180 select lpd
15385 1 15385 0 3 0x80 kqread ifstated
21469 1 21469 0 3 0x80 select sshd
11206 0 0 0 3 0x100200 acct acct
7300 7118 24640 83 3 0x180 poll ntpd
7118 24640 24640 83 3 0x180 poll ntpd
24640 1 24640 0 3 0x80 poll ntpd
27125 0 0 0 3 0x100280 nfsidl nfsio
14902 0 0 0 3 0x100280 nfsidl nfsio
28052 0 0 0 3 0x100280 nfsidl nfsio
28162 0 0 0 3 0x100280 nfsidl nfsio
13449 1 19454 0 3 0x80 select amd
18287 1 18287 28 3 0x180 poll portmap
19619 23156 23156 74 3 0x180 bpf pflogd
23156 1 23156 0 3 0x80 netio pflogd
7461 7774 7774 73 2 0x180 syslogd
7774 1 7774 0 3 0x88 netio syslogd
14 0 0 0 3 0x100200 aiodoned aiodoned
13 0 0 0 3 0x100200 syncer update
12 0 0 0 3 0x100200 cleaner cleaner
11 0 0 0 3 0x100200 reaper reaper
10 0 0 0 3 0x100200 pgdaemon pagedaemon
9 0 0 0 3 0x100200 bored crypto
8 0 0 0 3 0x100200 pftm pfpurge
* 7 0 0 0 7 0x100200 usbtask
6 0 0 0 3 0x100200 usbatsk usbatsk
5 0 0 0 3 0x100200 acpi0 acpi0
4 0 0 0 3 0x100200 endtask syswq
3 0 0 0 3 0x40100200 idle0
2 0 0 0 3 0x100200 kmalloc kmthread
1 0 1 0 3 0x4080 wait init
0 -1 0 0 3 0x80200 scheduler swapper
ddb> boot sync
syncing disks... done
WARNING: not updating battery clock
softraid0: 0x400 i/o error on block 16 while reading metadata 6
softraid0: could not write metadata to sd0a
sd3 detached
scsibus4 detached
sd1 detached
scsibus2 detached
cbb1: bad Vcc request. sock_ctrl 0x400, sock_status 0x30000316
rebooting...
Now going for your next diff...
Bye,
Marcus
