tech-kern archive
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index][Old Index]
USB printing panic
Hello,
I am running NetBSD 5.1 sparc64 on a Sun Ultra 5. A Samsung USB printer
is
connected to the system via an NEC-chipset PCI USB host. Printing via
CUPS
using the SPLIX drivers (http://splix.sourceforge.net/) causes a kernel
panic. Printing via CUPS across the network (from hosts with
their own drivers) works without problems.
As far as I can tell, a component of SPLIX (rastertoqpdl)
crashes with SIGBUS, and this sometimes panics the kernel. I don't know
what
the bug in SPLIX is, either.
I'm attaching below a dmesg, and ddb backtraces from two panics; the
second,
occuring when a DEBUG kernel was running, is preceded by kernel
debugging
messages (and I also enabled the debug code in dev/usb/ulpt.c). I also
executed
a few "show" commands in ddb, although I don't entirely understand
them, in the hope
that they might be useful. I don't know how to track this any further.
I do have the core dump from the last crash and would be happy to help
however possible.
Boot messages:
Sun Ultra 5/10 UPA/PCI (UltraSPARC-IIi 270MHz), No Keyboard
OpenBoot 3.11, 256 MB memory installed, Serial #10467420.
Ethernet address 8:0:20:9f:b8:5c, Host ID: 809fb85c.
Initializing Memory |
ok boot debug
Boot device: /pci@1f,0/pci@1,1/ide@3/disk@0,0 File and args: debug
NetBSD IEEE 1275 Bootblock
NetBSD/sparc64 OpenFirmware Boot, Revision 1.13
=0x859bd8
Loading debug: 7579168+367512+483888 [519120+340115]=0x9a2130
Loaded initial symtab at 0x18cfdc8, strtab at 0x194f098, # entries
21604
consinit()
stdin node = f0061840
stdout package = f0061840
buffer @ 0x1c05ca0
console is /pci@1f,0/pci@1,1/ebus@1/se@14,400000:a
Copyright (c) 1996, 1997, 1998, 1999, 2000, 2001, 2002, 2003, 2004,
2005,
2006, 2007, 2008, 2009, 2010
The NetBSD Foundation, Inc. All rights reserved.
Copyright (c) 1982, 1986, 1989, 1991, 1993
The Regents of the University of California. All rights reserved.
NetBSD 5.1 (GENERIC-DEBUG) #4: Thu Feb 3 16:59:01 PST 2011
bill%puddle.supposedly.org@localhost:/home/bill/netbsd-5-1-source/usr/src/sys/arch/sparc64/compile/GENERIC-DEBUG
total memory = 256 MB
avail memory = 238 MB
mainbus0 (root): SUNW,Ultra-5_10 (Sun Ultra 5/10 UPA/PCI): hostid
809fb85c
cpu0 at mainbus0: SUNW,UltraSPARC-IIi @ 270 MHz, UPA id 0
cpu0: 16K instruction (32 b/l), 16K data (32 b/l), 256K external (64
b/l)
psycho0 at mainbus0 addr 0xfffc4000
psycho0: SUNW,sabre: impl 0, version 0: ign 7c0 bus range 0 to 2; PCI
bus 0
extent `psycho mem' (0x0 - 0xffffffff), flags = 0x0
0x0 - 0x807f
extent `psycho io' (0x0 - 0xffffff), flags = 0x0
0x0 - 0x47f
DVMA map: c0000000 to e0000000
IOTSB: 1045a000 to 104da000
memory range: 000001ff 00000000
pci0 at psycho0
ppb0 at pci0 dev 1 function 1: Sun Microsystems Simba PCI bridge (rev.
0x11)
pci1 at ppb0 bus 1
ebus0 at pci1 dev 1 function 0
ebus0: Sun Microsystems PCIO Ebus2, revision 0x01
auxio0 at ebus0 addr 726000-726003, 728000-728003, 72a000-72a003,
72c000-72c003, 72f000-72f003
power at ebus0 addr 724000-724003 ipl 37 not configured
SUNW,pll at ebus0 addr 504000-504002 not configured
sab0 at ebus0 addr 400000-40007f ipl 43: rev 3.2
sabtty0 at sab0 port 0: console i/o
sabtty1 at sab0 port 1
com0 at ebus0 addr 3083f8-3083ff ipl 41: ns16550a, working fifo
kbd0 at com0
com1 at ebus0 addr 3062f8-3062ff ipl 42: ns16550a, working fifo
ms0 at com1
wsmouse0 at ms0 mux 0
lpt0 at ebus0 addr 3043bc-3043cb, 30015c-30015d, 700000-70000f ipl 34
fdthree at ebus0 addr 3023f0-3023f7, 706000-70600f, 720000-720003 ipl
39 not configured
clock0 at ebus0 addr 0-1fff: mk48t59
flashprom at ebus0 addr 0-fffff not configured
audiocs0 at ebus0 addr 200000-2000ff, 702000-70200f, 704000-70400f,
722000-722003 ipl 35 ipl 36: CS4231A
audio0 at audiocs0: full duplex, playback, capture
hme0 at pci1 dev 1 function 1: Sun Happy Meal Ethernet, rev. 1
hme0: interrupting at ivec 3021
hme0: Ethernet address 08:00:20:9f:b8:5c
nsphy0 at hme0 phy 1: DP83840 10/100 media interface, rev. 1
nsphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
machfb0 at pci1 dev 2 function 0: ATI Technologies 3D Rage I/II (rev.
0x9a)
machfb0: 16 MB aperture at 0xe1000000, 4 KB registers at 0x00000000
machfb0: memctl 003210b3
machfb0: 2048 KB SGRAM 62.999 MHz, maximum RAMDAC clock 170 MHz
gen_cntl: 01000210
mach64_get_mode: 1152 5304 5432 1528 900 902 938 937
machfb0: initial resolution 1152x864 at 8 bpp
machfb0: attached to /dev/fb0
machfb0: initializing the DSP
wsdisplay1 at machfb0 kbdmux 1
cmdide0 at pci1 dev 3 function 0
cmdide0: CMD Technology PCI0646 (rev. 0x03)
cmdide0: primary channel configured to native-PCI mode
cmdide0: using ivec 1820 for native-PCI interrupt
atabus0 at cmdide0 channel 0
cmdide0: secondary channel configured to native-PCI mode
atabus1 at cmdide0 channel 1
ppb1 at pci0 dev 1 function 0: Sun Microsystems Simba PCI bridge (rev.
0x11)
pci2 at ppb1 bus 2
ohci0 at pci2 dev 2 function 0: NEC USB Host Controller (rev. 0x43)
ohci0: interrupting at ivec 14
ohci0: OHCI version 1.0
usb0 at ohci0: USB revision 1.0
ohci1 at pci2 dev 2 function 1: NEC USB Host Controller (rev. 0x43)
ohci1: interrupting at ivec 15
ohci1: OHCI version 1.0
usb1 at ohci1: USB revision 1.0
ehci0 at pci2 dev 2 function 2: NEC USB Host Controller (rev. 0x04)
ehci0: interrupting at ivec 16
ehci0: companion controllers, 3 ports each: ohci0 ohci1
usb2 at ehci0: USB revision 2.0
ex0 at pci2 dev 3 function 0: 3Com 3c905C-TX 10/100 Ethernet with mngmt
(rev. 0x74)
ex0: interrupting at ivec 18
ex0: MAC address 00:50:da:66:a0:c6
bmtphy0 at ex0 phy 24: Broadcom 3c905C internal PHY, rev. 6
bmtphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
pcons at mainbus0 not configured
No counter-timer -- using %tick at 270MHz as system clock.
Using %tick -- intr in 2700000 cycles
wskbd0 at kbd0 mux 1
uhub0 at usb0: NEC OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub1 at usb1: NEC OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub2 at usb2: NEC EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
ehci0: handing over full speed device on port 2 to ohci0
ulpt0 at uhub1 port 1 configuration 1 interface 0
ulpt0: Samsung Electronics Co., Ltd. Samsung ML-1520 Series, rev
1.10/1.00, addr 2, iclass 7/1
ulpt0: using bi-directional mode
ulpt_attach: sc=0xb686190 in=3 out=129
kbd0: reset failed
wd0 at atabus0 drive 0: <WDC WD400BB-75JHA0>
wd0: 38146 MB, 77504 cyl, 16 head, 63 sec, 512 bytes/sect x 78125000
sectors
Panic #1:
panic: kernel fault
Stopped in pid 0.5 (system) at netbsd:cpu_Debugger+0x4: nop
db> bt
data_access_fault(b5cbaa0, 30, 1476388, 0, 70, 400) at
netbsd:data_access_fault+
0x13c
?(0, 0, c2d99e0, cf8a000, 2000, 5) at 0x1008708
ulpt_tick(c2d99e0, b30ef80, 0, 0, 14650c0, b30fb70) at
netbsd:ulpt_tick+0x44
callout_softclock(1899ae0, b307f80, 3, 18b9800, b5cbc88, 1899800) at
netbsd:call
out_softclock+0x170
softint_thread(b2ce0c0, b30ef80, 0, 1fff, 18c4800, b30f3b0) at
netbsd:softint_th
read+0x68
lwp_trampoline(f0066f88, fffa9cf8, 110c00, 110340, fffa9df8, 1) at
netbsd:lwp_tr
ampoline+0x8
db> bt
data_access_fault(b5cbaa0, 30, 1476388, 0, 70, 400) at
netbsd:data_access_fault+
0x13c
?(0, 0, c2d99e0, cf8a000, 2000, 5) at 0x1008708
ulpt_tick(c2d99e0, b30ef80, 0, 0, 14650c0, b30fb70) at
netbsd:ulpt_tick+0x44
callout_softclock(1899ae0, b307f80, 3, 18b9800, b5cbc88, 1899800) at
netbsd:call
out_softclock+0x170
softint_thread(b2ce0c0, b30ef80, 0, 1fff, 18c4800, b30f3b0) at
netbsd:softint_th
read+0x68
lwp_trampoline(f0066f88, fffa9cf8, 110c00, 110340, fffa9df8, 1) at
netbsd:lwp_tr
ampoline+0x8
db> bt
data_access_fault(b5cbaa0, 30, 1476388, 0, 70, 400) at
netbsd:data_access_fault+
0x13c
?(0, 0, c2d99e0, cf8a000, 2000, 5) at 0x1008708
ulpt_tick(c2d99e0, b30ef80, 0, 0, 14650c0, b30fb70) at
netbsd:ulpt_tick+0x44
callout_softclock(1899ae0, b307f80, 3, 18b9800, b5cbc88, 1899800) at
netbsd:call
out_softclock+0x170
softint_thread(b2ce0c0, b30ef80, 0, 1fff, 18c4800, b30f3b0) at
netbsd:softint_th
read+0x68
lwp_trampoline(f0066f88, fffa9cf8, 110c00, 110340, fffa9df8, 1) at
netbsd:lwp_tr
ampoline+0x8
db> show all procs
PID LID S CPU FLAGS STRUCT LWP * NAME WAIT
8258 1 3 0 84 c858000 ksh ttyraw
21832 1 3 0 84 c7000c0 less ttyraw
7251 1 3 0 84 c8583e0 cupsd kqueue
6846 1 3 0 84 cf51380 ksh ttyraw
2004 1 3 0 84 c858ba0 ksh ttyraw
6783 1 3 0 84 cf51760 ksh ttyraw
7257 1 3 0 84 c858f80 tail kqueue
12469 1 3 0 84 c439bc0 pickup kqueue
4838 1 3 0 84 c859b20 ksh pause
6301 1 3 0 84 c700880 ksh pause
4638 1 3 0 84 c262460 screen-4.0.3 select
5048 1 3 0 84 c701040 screen-4.0.3 pause
4836 1 3 0 84 c7004a0 ksh pause
4973 1 3 0 84 c700c60 sshd select
4587 1 3 0 84 c859740 sshd netio
19023 1 3 0 84 c701420 ksh ttyraw
25588 1 3 0 84 c701800 sshd select
29603 1 3 0 84 b33b7a0 getty ttyraw
587 1 3 0 84 c438480 smbd select
561 1 3 0 84 c701be0 smbd select
563 1 3 0 84 c4380a0 nmbd select
475 1 3 0 84 c438860 ksh pause
472 1 3 0 84 c438c40 ksh pause
351 1 3 0 84 c263000 sshd select
375 1 3 0 84 b33b3c0 sshd netio
470 1 3 0 84 c439020 cron
nanoslp
464 1 3 0 84 c439400 qmgr kqueue
425 1 3 0 84 c262080 inetd kqueue
423 1 3 0 84 c4397e0 master kqueue
236 1 3 0 84 c262c20 sshd select
269 1 3 0 84 c262840 ntpd pause
250 1 3 0 84 b33ac00 dhcpd select
165 4 3 0 84 c2633e0 named select
3 3 0 84 c2637c0 named
parked
2 3 0 84 c263ba0 named
parked
1 3 0 84 b33a440 named
sigwait
134 1 2 0 4 b33afe0 syslogd
92 1 3 0 84 b33a060 dhclient select
1 1 3 0 84 b320fc0 init wait
0 35 3 0 204 b33a820 physiod
physiod
34 3 0 204 b33bb80 vmem_rehash
vmem_reha
sh
33 3 0 204 b320040 aiodoned
aiodoned
32 3 0 204 b320420 ioflush
syncer
31 3 0 204 b321b60 pgdaemon
pgdaemon
30 3 0 204 b3147e0 cryptoret
crypto_wa
it
28 3 0 204 b314020 usb2
usbevt
27 3 0 204 b314400 usb1
usbevt
26 3 0 204 b320800 usbtask-dr
usbtsk
25 3 0 204 b321780 usbtask-hc
usbtsk
24 3 0 204 b3213a0 usb0
usbevt
23 3 0 204 b320be0 unpgc
unpgc
14 3 0 204 b314bc0 atabus1
atath
13 3 0 204 b314fa0 atabus0
atath
12 3 0 204 b315380 sysmon
smtaskq
11 3 0 204 b315760 pmfevent
pmfevent
10 3 0 204 b315b40 nfssilly
nfssilly
9 3 0 204 b30e000 cachegc
cachegc
8 3 0 204 b30e3e0 vrele
vrele
7 3 0 204 b30e7c0 xcall/0
xcall
6 1 0 204 b30eba0 softser/0
> 5 7 0 204 b30ef80 softclk/0
4 1 0 204 b30f360 softbio/0
3 1 0 204 b30f740 softnet/0
2 1 0 205 b30fb20 idle/0
1 3 0 204 1823ba0 swapper
schedule
db> show event
evcnt type 0: pdpolicy reactanon = 8920
evcnt type 0: pdpolicy reactexec = 4566
evcnt type 0: vmcmd kills = 52817
evcnt type 0: vmcmd calls = 186117
evcnt type 0: softint net/0 = 279242
evcnt type 0: softint bio/0 = 68473
evcnt type 0: softint clk/0 = 127476
evcnt type 0: softint ser/0 = 260
evcnt type 0: callout late/0 = 104
evcnt type 0: crosscall unicast = 3
evcnt type 0: crosscall broadcast = 57
evcnt type 0: namecache entries scanned = 11878
evcnt type 0: namecache entries collected = 27956
evcnt type 0: namecache over scan target = 21
evcnt type 0: namecache under scan target = 7916
evcnt type 0: namecache forced reclaims = 8
evcnt type 1: intr lev7 = 691909
evcnt type 1: intr clock = 792830
evcnt type 1: intr lev15 = 2
evcnt type 0: cpu0 timer = 792830
db> trace /u
data_access_fault(b5cbaa0, 30, 1476388, 0, 70, 400) at
netbsd:data_access_fault+
0x13c
?(0, 0, c2d99e0, cf8a000, 2000, 5) at 0x1008708
ulpt_tick(c2d99e0, b30ef80, 0, 0, 14650c0, b30fb70) at
netbsd:ulpt_tick+0x44
callout_softclock(1899ae0, b307f80, 3, 18b9800, b5cbc88, 1899800) at
netbsd:call
out_softclock+0x170
softint_thread(b2ce0c0, b30ef80, 0, 1fff, 18c4800, b30f3b0) at
netbsd:softint_th
read+0x68
lwp_trampoline(f0066f88, fffa9cf8, 110c00, 110340, fffa9df8, 1) at
netbsd:lwp_tr
ampoline+0x8
?(0, 0, 0, 0, f0066f88, 0) at 0x100030
?(0, 0, 0, 0, 0, 0) at 0
db> show map c2d99e0
MAP 0xc2d99e0: [0x0->0x0]
#ent=12, sz=15, ref=16, version=22, flags=0x0
pmap=0xb7dba80(resident=204315104, wired=207628356)
db> trace /t
data_access_fault(b5cbaa0, 30, 1476388, 0, 70, 400) at
netbsd:data_access_fault+
0x13c
?(0, 0, c2d99e0, cf8a000, 2000, 5) at 0x1008708
ulpt_tick(c2d99e0, b30ef80, 0, 0, 14650c0, b30fb70) at
netbsd:ulpt_tick+0x44
callout_softclock(1899ae0, b307f80, 3, 18b9800, b5cbc88, 1899800) at
netbsd:call
out_softclock+0x170
softint_thread(b2ce0c0, b30ef80, 0, 1fff, 18c4800, b30f3b0) at
netbsd:softint_th
read+0x68
lwp_trampoline(f0066f88, fffa9cf8, 110c00, 110340, fffa9df8, 1) at
netbsd:lwp_tr
ampoline+0x8
db>
Panic #2:
ulptopen: flags=0x0
ulpt_status: status=0x18 err=0
ulpt_open: opening input pipe 129
ulpt_open: start read callout
ulptopen: done, error=0
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
ulpt_tick: sc=0xb686190 err=1
Alignment error: pid=494.1 comm=rastertoqpdl dsfsr=00000000:00800005
dsfar=ffffffff:ffffb40f isfsr=00000000:00000000 pc=103860
ulptwrite
Feb 9 14:ulpt_status: status=0x18 err=0
17:00 pulptwrite
ulpt_tick: sc=0xb686190 err=1
ulpt_status: status=0x18 err=0
udulptclose: stopping read callout
dle /netbsd: pid 494 (rastertoqpulptclose: closed
dl), uid 1: exited on signal 10 (core not dumped, err = 27)
cpu0: data fault: pc=14becc8 addr=0
kernel trap 30: data access exception
Stopped in pid 0.5 (system) at netbsd:usbd_setup_xfer+0x8: ldub
[
%o0 + 0x70], %g3
db> bt
callout_softclock(1899fa8, b307f40, 16ee400, 1899fa8, 16e9000, 16a4800)
at netbs
d:callout_softclock+0x1e4
softint_thread(16e8400, 16e8400, 16e8400, 16e8400, 16e8400, 16e8400) at
netbsd:s
oftint_thread+0xe8
lwp_trampoline(f0066f88, fffa9cf8, 110c00, 110340, fffa9df8, 0) at
netbsd:lwp_tr
ampoline+0x8
Home |
Main Index |
Thread Index |
Old Index