ulpt can't attach Lexmark E120

George Mitchell george+freebsd at m5p.com
Sat Aug 24 00:44:32 UTC 2013 

On 08/23/13 07:11, George Mitchell wrote:
> On 08/23/13 02:18, Hans Petter Selasky wrote:
>> On 08/23/13 02:29, George Mitchell wrote:
>>> On 08/22/13 07:34, Hans Petter Selasky wrote:
>>
>>> Here's the result:
>>> [...]
>>> (at which point if I type control-c to stop usbdump, the system gets a
>>> fatal kernel mode translation fault, but that's another story.)  Hope
>>> this helps.                                              -- George
>>
>> I would expect to see some messages ERR != 0 when you plug the device.
>> Can you show both usbdump output and dmesg output which belongs together?
>>
>> --HPS
>
> Not sure exactly how I would get the usbdump output and log output
> interspersed in the correct order, and the fact that the pi panics
> when I type control-C at usbdump doesn't help.  Subjectively, the
> "ulpt0 attach returned 12" seemed to occur a fraction of a second
> later than the others.  But I'll see what I can come up with this
> evening.                                                  -- George

Well, what I ended up doing is turning on ulpt debugging and then piping
usbdump into logger, yielding the attachment.  But I'm not 100% sure
that the output is in the proper sequence.

Give that the printer works fine with the same code on my amd64
machines, does this suggest we have a byte-ordering problem in the
driver?                                                   -- George
-------------- next part --------------
Aug 24 00:10:24 pi kernel: ugen0.5: <Lexmark International> at usbus0
Aug 24 00:10:24 pi kernel: ulpt_probe: 
Aug 24 00:10:24 pi kernel: ulpt_probe: 
Aug 24 00:10:24 pi kernel: ulpt_attach: sc=0xc2d46a00
Aug 24 00:10:24 pi kernel: ulpt0: <Lexmark International Lexmark E120n, class 0/0, rev 2.00/1.00, addr 5> on usbus0
Aug 24 00:10:24 pi kernel: ulpt_attach: setting alternate config number: 0
Aug 24 00:10:24 pi kernel: ulpt_attach: error=USB_ERR_INVAL
Aug 24 00:10:24 pi kernel: ulpt_detach: sc=0xc2d46a00
Aug 24 00:10:24 pi kernel: device_attach: ulpt0 attach returned 12
Aug 24 00:10:24 pi george: 00:08:02.619534 usbus0.5 SUBM-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.620189 usbus0.5 DONE-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.620282 usbus0.5 SUBM-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.621186 usbus0.5 DONE-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.638617 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.640299 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.640802 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.643668 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=20,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.643831 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.646289 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.646389 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.648294 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.648404 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.650283 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.650380 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.658667 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=16,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.658783 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.661289 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.661386 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.664291 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=44,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.664404 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.666289 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.666387 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.668663 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=28,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.668850 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.671284 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=12,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.671411 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.678038 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=32,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.678144 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.680296 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:08:02.680394 usbus0.5 SUBM-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:08:02.681663 usbus0.5 DONE-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.899835 usbus0.5 SUBM-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.900725 usbus0.5 DONE-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.900822 usbus0.5 SUBM-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.901733 usbus0.5 DONE-CTRL-EP=00000000,SPD=FULL,NFR=1,SLEN=0,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.918759 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.920837 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.921351 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.924208 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=20,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.924372 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.926830 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.926932 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.928822 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.928932 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.930819 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.930916 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.937950 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=16,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.938104 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0
Aug 24 00:10:24 pi george: 00:10:22.939826 usbus0.5 DONE-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=4,IVAL=0,ERR=0
Aug 24 00:10:24 pi george: 00:10:22.939926 usbus0.5 SUBM-CTRL-EP=00000080,SPD=FULL,NFR=2,SLEN=8,IVAL=0

More information about the freebsd-current mailing list