Hi Alan,
Can you provide a comparable usbmon trace from a kernel where the
device works?
Also, to make sure that nothing important has been omitted, please
resend the earlier trace without any "grep" filtering. And do the same
with the new trace.
Now I have a trace from my Ubuntu 10.04 system (running on a Sony Vaio FW):
# uname -a
Linux xxxxxxx 2.6.32-33-generic #72-Ubuntu SMP Fri Jul 29 21:07:13 UTC
2011 x86_64 GNU/Linux
# dmesg
Sep 9 15:30:15 xxxxxxx kernel: [ 502.821293] usb 6-2: new full speed
USB device using uhci_hcd and address 4
Sep 9 15:30:15 xxxxxxx kernel: [ 503.031315] usb 6-2: configuration #1
chosen from 1 choice
Sep 9 15:30:15 xxxxxxx kernel: [ 503.034271] cdc_acm 6-2:1.0: ttyACM0:
USB ACM device
The last line does come up as soon as I modprobe'd "usbserial" and
"cdc_acm". Now there's a /dev/ttyACM0
# cat /sys/kernel/debug/usb/usbmon/3t
ffff8801a1e646c0 1462742760 S Ci:001:00 s a3 00 0000 0001 0004 4 <
ffff8801a1e646c0 1462742779 C Ci:001:00 0 4 = 00010000
ffff8801a1e646c0 1462742785 S Ci:001:00 s a3 00 0000 0002 0004 4 <
ffff8801a1e646c0 1462742792 C Ci:001:00 0 4 = 00010000
ffff8801b68c5cc0 1462742796 S Ii:001:01 -115 2 <
ffff8801b68c5cc0 1465694034 C Ii:001:01 -2 0
# cat /sys/kernel/debug/usb/usbmon/3u
ffff88018f4d0e40 859764005 S Ci:3:001:0 s a3 00 0000 0001 0004 4 <
ffff88018f4d0e40 859764026 C Ci:3:001:0 0 4 = 00010000
ffff88018f4d0e40 859764031 S Ci:3:001:0 s a3 00 0000 0002 0004 4 <
ffff88018f4d0e40 859764039 C Ci:3:001:0 0 4 = 00010000
ffff8801b68c5cc0 859764043 S Ii:3:001:1 -115:128 2 <
ffff8801b68c5cc0 862732760 C Ii:3:001:1 -2:128 0
Now the interesting info - after the board was plugged in once at the
Ubuntu 10.04 system, it also worked on the 12.04 system:
# uname -a
Linux desktop01 3.2.0-29-generic #46-Ubuntu SMP Fri Jul 27 17:03:23 UTC
2012 x86_64 x86_64 x86_64 GNU/Linux
# dmesg
[52550.983426] usb 1-1.2: new full-speed USB device number 11 using ehci_hcd
[52551.079516] cdc_acm 1-1.2:1.0: This device cannot do calls on its
own. It is not a modem.
[52551.079538] cdc_acm 1-1.2:1.0: ttyACM0: USB ACM device
# cat /sys/kernel/debug/usb/usbmon/1u
ffff8803a445e900 456920744 S Ci:1:001:0 s a3 00 0000 0001 0004 4 <
ffff8803a445e900 456920782 C Ci:1:001:0 0 4 = 03050400
ffff8803a445e900 456920785 S Ci:1:001:0 s a3 00 0000 0002 0004 4 <
ffff8803a445e900 456920787 C Ci:1:001:0 0 4 = 00010000
ffff880410e90600 456920789 S Ii:1:001:1 -115:2048 4 <
ffff880401eb9540 456920828 S Ci:1:001:0 s a3 00 0000 0001 0004 4 <
ffff880401eb9540 456920836 C Ci:1:001:0 0 4 = 03050400
ffff880401eb9540 456920838 S Co:1:001:0 s 23 01 0012 0001 0000 0
ffff880401eb9540 456920841 C Co:1:001:0 0 0
ffff880401eb9540 456936749 S Ci:1:001:0 s a3 00 0000 0001 0004 4 <
ffff880401eb9540 456936756 C Ci:1:001:0 0 4 = 03050000
ffff880401eb9540 456936760 S Ci:1:002:0 s 80 00 0000 0000 0002 2 <
ffff880401eb9540 456936927 C Ci:1:002:0 0 2 = 0300
ffff880401eb9540 456936986 S Co:1:002:0 s 00 01 0001 0000 0000 0
ffff880401eb9540 456937035 C Co:1:002:0 0 0
ffff880401eb9540 456937097 S Ci:1:002:0 s a3 00 0000 0001 0004 4 <
ffff880401eb9540 456937161 C Ci:1:002:0 0 4 = 00010000
ffff880401eb9540 456937198 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
ffff880401eb9540 456937286 C Ci:1:002:0 0 4 = 01010100
ffff880401eb9540 456937328 S Co:1:002:0 s 23 01 0010 0002 0000 0
ffff880401eb9540 456937409 C Co:1:002:0 0 0
ffff880401eb9540 456937448 S Ci:1:002:0 s a3 00 0000 0003 0004 4 <
ffff880401eb9540 456937536 C Ci:1:002:0 0 4 = 00010000
ffff880401eb9540 456937574 S Ci:1:002:0 s a3 00 0000 0004 0004 4 <
ffff880401eb9540 456937661 C Ci:1:002:0 0 4 = 00010000
ffff880401eb9540 456937698 S Ci:1:002:0 s a3 00 0000 0005 0004 4 <
ffff880401eb9540 456937786 C Ci:1:002:0 0 4 = 00010000
ffff880401eb9540 456937823 S Ci:1:002:0 s a3 00 0000 0006 0004 4 <
ffff880401eb9540 456937910 C Ci:1:002:0 0 4 = 00010000
ffff880410cec780 457040746 S Ii:1:002:1 -115:2048 1 <
ffff880401eb9300 457040771 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
ffff880401eb9300 457040940 C Ci:1:002:0 0 4 = 01010000
ffff880401eb9300 457040991 S Co:1:002:0 s 23 03 0004 0002 0000 0
ffff880401eb9300 457041036 C Co:1:002:0 0 0
ffff8803a445ed80 457056753 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
ffff8803a445ed80 457056939 C Ci:1:002:0 0 4 = 03011000
ffff880413cb7840 457112753 S Co:1:002:0 s 23 01 0014 0002 0000 0
ffff880413cb7840 457112912 C Co:1:002:0 0 0
ffff880413cb7840 457112965 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
ffff880413cb7840 457113174 C Ci:1:000:0 0 8 = 12010002 02000008
ffff880413cb7840 457113213 S Co:1:002:0 s 23 03 0004 0002 0000 0
ffff880413cb7840 457113285 C Co:1:002:0 0 0
ffff880401eb96c0 457128748 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
ffff880401eb96c0 457128912 C Ci:1:002:0 0 4 = 03011000
ffff880401eb9c00 457184746 S Co:1:002:0 s 23 01 0014 0002 0000 0
ffff880401eb9c00 457184946 C Co:1:002:0 0 0
ffff880401eb9c00 457184965 S Co:1:000:0 s 00 05 000b 0000 0000 0
ffff880401eb9c00 457185160 C Co:1:000:0 0 0
ffff8803a445e180 457204757 S Ci:1:011:0 s 80 06 0100 0000 0012 18 <
ffff8803a445e180 457205062 C Ci:1:011:0 0 18 = 12010002 02000008
d8040a00 01000102 0001
ffff880413cb7840 457205106 S Ci:1:011:0 s 80 06 0600 0000 000a 10 <
ffff880413cb7840 457205313 C Ci:1:011:0 -32 0
ffff880413cb7840 457205354 S Ci:1:011:0 s 80 06 0600 0000 000a 10 <
ffff880413cb7840 457205561 C Ci:1:011:0 -32 0
ffff880401eb9c00 457205605 S Ci:1:011:0 s 80 06 0600 0000 000a 10 <
ffff880401eb9c00 457205910 C Ci:1:011:0 -32 0
ffff880401eb9c00 457206226 S Ci:1:011:0 s 80 06 0200 0000 0009 9 <
ffff880401eb9c00 457206548 C Ci:1:011:0 0 9 = 09024300 020100c0 32
ffff880401eb9c00 457206587 S Ci:1:011:0 s 80 06 0200 0000 0043 67 <
ffff880401eb9c00 457207285 C Ci:1:011:0 0 67 = 09024300 020100c0
32090400 00010202 01000524 00100104 24020205 24060001
ffff880401eb9c00 457207328 S Ci:1:011:0 s 80 06 0300 0000 00ff 255 <
ffff880401eb9c00 457207535 C Ci:1:011:0 0 4 = 04030904
ffff880401eb9c00 457207574 S Ci:1:011:0 s 80 06 0302 0409 00ff 255 <
ffff880401eb9c00 457208159 C Ci:1:011:0 0 52 = 34034300 44004300
20005200 53002d00 32003300 32002000 45006d00 75006c00
ffff880401eb9c00 457208190 S Ci:1:011:0 s 80 06 0301 0409 00ff 255 <
ffff880401eb9c00 457208660 C Ci:1:011:0 0 52 = 34034d00 69006300
72006f00 63006800 69007000 20005400 65006300 68006e00
ffff880401eb9300 457208798 S Co:1:011:0 s 00 09 0001 0000 0000 0
ffff880401eb9300 457209048 C Co:1:011:0 0 0
ffff88031b9f8780 457209198 S Co:1:011:0 s 21 22 0000 0000 0000 0
ffff88031b9f8780 457209284 C Co:1:011:0 0 0
ffff88031b9f8780 457209320 S Co:1:011:0 s 21 20 0000 0000 0007 7 =
80250000 000008
ffff88031b9f8780 457209533 C Co:1:011:0 0 7 >
On the RPi it still doesn't work out, even though usbserial and cdc_acm
are loaded:
# uname -a
Linux raspberrypi 3.2.27+ #102 PREEMPT Sat Sep 1 01:00:50 BST 2012
armv6l GNU/Linux
# dmesg
[91186.375482] usb 1-1.2: new full-speed USB device number 26 using dwc_otg
[91186.455488] usb 1-1.2: device descriptor read/64, error -71
[91186.645392] usb 1-1.2: device descriptor read/64, error -71
[91186.835409] usb 1-1.2: new full-speed USB device number 27 using dwc_otg
[91186.915417] usb 1-1.2: device descriptor read/64, error -71
[91187.105575] usb 1-1.2: device descriptor read/64, error -71
[91187.295486] usb 1-1.2: new full-speed USB device number 28 using dwc_otg
[91187.715255] usb 1-1.2: device not accepting address 28, error -71
[91187.795636] usb 1-1.2: new full-speed USB device number 29 using dwc_otg
[91188.215277] usb 1-1.2: device not accepting address 29, error -71
[91188.215496] hub 1-1:1.0: unable to enumerate USB device on port 2
# cat /sys/kernel/debug/usb/usbmon/0u
ce962b20 1562464093 C Ii:1:002:1 0:2048 1 = 04
ce962b20 1562464119 S Ii:1:002:1 -115:2048 1 <
cd54d5c0 1562464184 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562464300 C Ci:1:002:0 0 4 = 01010100
cd54d5c0 1562464349 S Co:1:002:0 s 23 01 0010 0002 0000 0
cd54d5c0 1562464518 C Co:1:002:0 0 0
cd54d5c0 1562464563 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562464791 C Ci:1:002:0 0 4 = 01010000
cd54d5c0 1562503983 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562504175 C Ci:1:002:0 0 4 = 01010000
cd54d5c0 1562543978 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562544178 C Ci:1:002:0 0 4 = 01010000
cd54d5c0 1562583961 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562584182 C Ci:1:002:0 0 4 = 01010000
cd54d5c0 1562623987 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562624189 C Ci:1:002:0 0 4 = 01010000
cd54d5c0 1562624277 S Co:1:002:0 s 23 03 0004 0002 0000 0
cd54d5c0 1562624409 C Co:1:002:0 0 0
cd54d5c0 1562643968 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562644189 C Ci:1:002:0 0 4 = 03011000
cd54d5c0 1562624277 S Co:1:002:0 s 23 03 0004 0002 0000 0
cd54d5c0 1562624409 C Co:1:002:0 0 0
cd54d5c0 1562643968 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562644189 C Ci:1:002:0 0 4 = 03011000
cd54d5c0 1562703968 S Co:1:002:0 s 23 01 0014 0002 0000 0
cd54d5c0 1562704175 C Co:1:002:0 0 0
cd54d5c0 1562704280 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1562704448 C Ci:1:000:0 -71 0
cd54d5c0 1562704496 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1562704698 C Ci:1:000:0 -71 0
cd54d5c0 1562704747 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1562704946 C Ci:1:000:0 -71 0
cd54d5c0 1562704996 S Co:1:002:0 s 23 03 0004 0002 0000 0
cd54d5c0 1562705168 C Co:1:002:0 0 0
cd54d5c0 1562724002 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562724205 C Ci:1:002:0 0 4 = 03011000
cd54d5c0 1562783974 S Co:1:002:0 s 23 01 0014 0002 0000 0
cd54d5c0 1562784180 C Co:1:002:0 0 0
cd54d5c0 1562893969 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1562894226 C Ci:1:000:0 -71 0
cd54d5c0 1562894278 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1562894468 C Ci:1:000:0 -71 0
cd54d5c0 1562894515 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1562894715 C Ci:1:000:0 -71 0
cd54d5c0 1562894764 S Co:1:002:0 s 23 03 0004 0002 0000 0
cd54d5c0 1562894942 C Co:1:002:0 0 0
cd54d5c0 1562913976 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1562914248 C Ci:1:002:0 0 4 = 03011000
cd54d5c0 1562973974 S Co:1:002:0 s 23 01 0014 0002 0000 0
cd54d5c0 1562974085 C Co:1:002:0 0 0
cd54d5c0 1563083975 S Co:1:002:0 s 23 01 0001 0002 0000 0
cd54d5c0 1563084097 C Co:1:002:0 0 0
cd54d5c0 1563084197 S Co:1:002:0 s 23 03 0004 0002 0000 0
cd54d5c0 1563084337 C Co:1:002:0 0 0
cd54d5c0 1563103978 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1563104113 C Ci:1:002:0 0 4 = 03011000
cd54d5c0 1563163977 S Co:1:002:0 s 23 01 0014 0002 0000 0
cd54d5c0 1563164097 C Co:1:002:0 0 0
cd54d5c0 1563164193 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1563164376 C Ci:1:000:0 -71 0
cd54d5c0 1563164428 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1563164624 C Ci:1:000:0 -71 0
cd54d5c0 1563164674 S Ci:1:000:0 s 80 06 0100 0000 0040 64 <
cd54d5c0 1563164874 C Ci:1:000:0 -71 0
cd54d5c0 1563164926 S Co:1:002:0 s 23 03 0004 0002 0000 0
cd54d5c0 1563165095 C Co:1:002:0 0 0
cd54d5c0 1563183992 S Ci:1:002:0 s a3 00 0000 0002 0004 4 <
cd54d5c0 1563184135 C Ci:1:002:0 0 4 = 03011000
ce962b20 1563232175 C Ii:1:002:1 0:2048 1 = 04
ce962b20 1563232195 S Ii:1:002:1 -115:2048 1 <
cd54d5c0 1563243974 S Co:1:002:0 s 23 01 0014 0002 0000 0
cd54d5c0 1563244105 C Co:1:002:0 0 0
But it now still works when afterwards plugging it into the 12.04 desktop.
Any clue? I'm not that into driver development...
Is this a firmware thing? The device is powered by USB only. Why does it
work on Ubuntu 12.04 after plugging it in once on Ubuntu 10.04?
Thanks!
Florian
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
