Bug 244845 - ue0 realtek interface stops working after some time connection stalls problem down->up helps unitek Y-3083B
Summary: ue0 realtek interface stops working after some time connection stalls problem...
Status: New
Alias: None
Product: Base System
Classification: Unclassified
Component: usb (show other bugs)
Version: 12.1-RELEASE
Hardware: amd64 Any
: --- Affects Some People
Assignee: freebsd-usb (Nobody)
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2020-03-16 11:49 UTC by Tomasz "CeDeROM" CEDRO
Modified: 2020-03-18 23:32 UTC (History)
1 user (show)

See Also:


Attachments
usbdump + txt 7zipped (4.11 KB, application/x-7z-compressed)
2020-03-18 23:32 UTC, Tomasz "CeDeROM" CEDRO
no flags Details

Note You need to log in before you can comment on or make changes to this bug.
Description Tomasz "CeDeROM" CEDRO 2020-03-16 11:49:42 UTC
Hello world :-)

I have this nice USB 3.0/C UNITEK Y-3083B USB HUB + GigaBit Ethernet device that expands my laptop or smartphone cards and provides ue0 Ethernet connectivity. However always after some time network stops and I have to put that ue0 interface down and up. That never happens on built-in Ethernet card em0 (Intel(R) PRO/1000 Network Connection).

Any hints welcome :-)
Tomek


 # uname -a
FreeBSD 0xCFMX4 12.1-RELEASE-p2 FreeBSD 12.1-RELEASE-p2 GENERIC  amd64

# usbconfig
ugen0.1: <0x8086 XHCI root HUB> at usbus0, cfg=0 md=HOST spd=SUPER (5.0Gbps) pwr=SAVE (0mA)
ugen1.1: <Intel EHCI root HUB> at usbus1, cfg=0 md=HOST spd=HIGH (480Mbps) pwr=SAVE (0mA)
ugen0.2: <Generic 4-Port USB 2.0 Hub> at usbus0, cfg=0 md=HOST spd=HIGH (480Mbps) pwr=SAVE (0mA)
ugen1.2: <vendor 0x8087 product 0x8001> at usbus1, cfg=0 md=HOST spd=HIGH (480Mbps) pwr=SAVE (0mA)
ugen0.3: <Creative Technology SB Live 24-bit External> at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=ON (308mA)
ugen0.4: <Kionix Inc Kionix Sensor Hub F:0006 SI:0001 R2> at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=ON (100mA)
ugen0.5: <Generic USB HD Webcam> at usbus0, cfg=0 md=HOST spd=HIGH (480Mbps) pwr=ON (500mA)
ugen0.6: <Sierra Wireless, Incorporated EM7305> at usbus0, cfg=0 md=HOST spd=HIGH (480Mbps) pwr=ON (500mA)
ugen0.7: <Sharp Corp. 12.5EA0003> at usbus0, cfg=0 md=HOST spd=FULL (12Mbps) pwr=ON (100mA)
ugen0.8: <Generic 4-Port USB 3.0 Hub> at usbus0, cfg=0 md=HOST spd=SUPER (5.0Gbps) pwr=SAVE (0mA)
ugen0.9: <Realtek USB 10/100/1000 LAN> at usbus0, cfg=0 md=HOST spd=SUPER (5.0Gbps) pwr=ON (72mA)


# usbconfig -d 0.9 dump_device_desc
ugen0.9: <Realtek USB 10/100/1000 LAN> at usbus0, cfg=0 md=HOST spd=SUPER (5.0Gbps) pwr=ON (72mA)

  bLength = 0x0012
  bDescriptorType = 0x0001
  bcdUSB = 0x0300
  bDeviceClass = 0x0000  <Probed by interface class>
  bDeviceSubClass = 0x0000
  bDeviceProtocol = 0x0000
  bMaxPacketSize0 = 0x0009
  idVendor = 0x0bda
  idProduct = 0x8153
  bcdDevice = 0x3100
  iManufacturer = 0x0001  <Realtek>
  iProduct = 0x0002  <USB 10/100/1000 LAN>
  iSerialNumber = 0x0006  <001000001>
  bNumConfigurations = 0x0002
Comment 1 Hans Petter Selasky freebsd_committer 2020-03-16 12:24:33 UTC
Any errors in dmesg?

Did you try enabling the sysctl debug knob for this driver?

--HPS
Comment 2 Hans Petter Selasky freebsd_committer 2020-03-16 12:25:53 UTC
It might also be you need to use:

usbdump -i usbusX -f Y -s 65536

To figure out if there is a USB error causing this.

--HPS
Comment 3 Tomasz "CeDeROM" CEDRO 2020-03-16 12:44:36 UTC
Thank you HPS for the hints, will try to pinpoint the issue :-)

* hw.usb.ure.debug=1.
* usbdump (I also have hardware USB sniffer).
* driver watchdog.

I was hoping maybe there is some sort of quirk that is known to work :-)
Comment 4 Tomasz "CeDeROM" CEDRO 2020-03-16 19:37:01 UTC
The problem happened around 3 times so far.

I did set hw.usb.ure.debug=1 but that does not provide any additional information in dmesg.

The only information in dmesg that may be related (please confirm) is:
sonewconn: pcb 0xfffff80114d1c300: Listen queue overflow: 1 already in queue awaiting acceptance (1 occurrences)
sonewconn: pcb 0xfffff8000ade7400: Listen queue overflow: 1 already in queue awaiting acceptance (2 occurrences)
sonewconn: pcb 0xfffff80023277900: Listen queue overflow: 1 already in queue awaiting acceptance (1 occurrences)
sonewconn: pcb 0xfffff80154033700: Listen queue overflow: 1 already in queue awaiting acceptance (1 occurrences)

I did capture data with usbdump and the only suspicious messages with ERR != 0 are like this:

14:28:12.803849 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:12.804363 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=0,IVAL=0,ERR=0
14:28:12.804868 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:13.089056 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
14:28:13.139294 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
14:28:13.802305 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:13.802812 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0

...

14:28:22.803938 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:22.804447 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:22.804957 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=0,IVAL=0,ERR=0
14:28:22.805462 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:22.917306 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
14:28:22.967541 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
14:28:23.801519 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0

...

14:28:31.820373 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=0,IVAL=0,ERR=0
14:28:31.820882 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:32.735598 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
14:28:32.785295 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
14:28:32.854292 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:32.854797 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0

...

14:28:41.871020 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=0,IVAL=0,ERR=0
14:28:41.871527 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
14:28:42.552908 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
14:28:42.603553 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
14:28:42.867550 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0

I did use -w to dump data into a file just in case.

Btw. is it possible to open those usbdump files with Wireshark? It creashes on open..
Comment 5 Tomasz "CeDeROM" CEDRO 2020-03-16 19:57:34 UTC
sonewconn does not seem to be related because now I lost the connection and that message is not in dmesg.

I did catch something that may be related:

20:51:58.160826 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
20:51:58.161334 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
20:51:58.161838 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=0,IVAL=0,ERR=0
20:51:58.162347 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
20:51:58.471157 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
20:51:58.520570 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
20:51:59.159352 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
20:51:59.159856 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
20:51:59.160365 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=0,IVAL=0,ERR=0
20:51:59.160873 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
2

ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ue0: link state changed to UP
Comment 6 Hans Petter Selasky freebsd_committer 2020-03-16 21:49:53 UTC
https://github.com/jerrywossion/usbdump-wireshark
Comment 7 Hans Petter Selasky freebsd_committer 2020-03-16 21:50:58 UTC
You could check the timeout value used in the driver.

Have you enabled pauseframes rx/tx for this device?

See ifconfig -m ue0

--HPS
Comment 8 Tomasz "CeDeROM" CEDRO 2020-03-16 22:23:17 UTC
Below goes the ifconfig -m output. I did not change anything for the driver nor anything in ifconfig all runs on generic defaults :-)

# ifconfig -m ue0
ue0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> metric 0 mtu 1500
        options=80000<LINKSTATE>
        capabilities=80000<LINKSTATE>
        ether 00:e0:4c:33:f1:db
        inet 192.168.0.107 netmask 0xffffff00 broadcast 192.168.0.255
        media: Ethernet autoselect (1000baseT <full-duplex>)
        status: active
        supported media:
                media autoselect
                media 1000baseT mediaopt full-duplex,master
                media 1000baseT mediaopt full-duplex
                media 100baseTX mediaopt full-duplex
                media 100baseTX
                media 10baseT/UTP mediaopt full-duplex
                media 10baseT/UTP
                media none
        nd6 options=29<PERFORMNUD,IFDISABLED,AUTO_LINKLOCAL>

There are some hardcoded timeouts in usb_config ure_config[URE_N_TRANSFER]. All other timeouts relate to URE_TIMEOUT define:

https://svnweb.freebsd.org/base/head/sys/dev/usb/net/if_ure.c?revision=357972&view=markup#l132

ps/2: usbdump-wireshark url returns 404 but I now have idea what to search, tank u! :-)
Comment 9 Tomasz "CeDeROM" CEDRO 2020-03-17 01:25:55 UTC
Also this:

ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
Comment 10 Tomasz "CeDeROM" CEDRO 2020-03-17 01:27:59 UTC
Also this:

ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
Comment 11 Hans Petter Selasky freebsd_committer 2020-03-17 08:34:36 UTC
Could you do a usbdump with -v option to see if there may be a USB transfer length mismatch causing the IOERROR?

--HPS
Comment 12 Tomasz "CeDeROM" CEDRO 2020-03-18 22:58:40 UTC
Today the link was lost - ifconfig showed no media and the ifconfig down/up did not help the card driver got into some sort of locked state - but the cable was all the time connected to the card and the leds were blinking.

Dmesg showed:

ue0: link state changed to DOWN
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ue0: link state changed to UP
ure_bulk_read_callback: bulk read error, USB_ERR_IOERROR
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED
ue0: link state changed to DOWN
ure_bulk_read_callback: bulk read error, USB_ERR_CANCELLED


I did not catch that IOERROR / CANCELLED on usbdump sorry. Will provide more info when have one. This IOERROR is also related with link loss / media detect failure.

Below is the grep from usbdump related with TIMEOUT error that leads to connectivity loss that can be fixed with ifconfid down/up:

% usbdump -v  -r freeebsd-ue-ure-usbdump-20200316-3.pcap|grep -A 6 -B 5 -n -w "ERR=[A-Z]*"

5252760- frame[1] READ 4 bytes
5252761-20:50:59.099903 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5252762- frame[0] WRITE 8 bytes
5252763- frame[1] READ 4 bytes
5252764- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5252765:20:50:59.557650 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5252766-20:50:59.607357 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5252767- frame[0] WRITE 8 bytes
5252768- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5252769-20:50:59.607850 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5252770- frame[0] WRITE 8 bytes
5252771-20:50:59.607852 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=1444,IVAL=0
--
5253579- frame[1] READ 4 bytes
5253580-20:51:09.108675 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5253581- frame[0] WRITE 8 bytes
5253582- frame[1] READ 4 bytes
5253583- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5253584:20:51:09.379367 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5253585-20:51:09.429616 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5253586- frame[0] WRITE 8 bytes
5253587- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5253588-20:51:09.430104 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5253589- frame[0] WRITE 8 bytes
5253590-20:51:09.430106 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=76,IVAL=0
--
5254312- frame[1] READ 4 bytes
5254313-20:51:19.118915 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5254314- frame[0] WRITE 8 bytes
5254315- frame[1] READ 4 bytes
5254316- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5254317:20:51:19.197339 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5254318-20:51:19.247365 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5254319- frame[0] WRITE 8 bytes
5254320- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5254321-20:51:19.247857 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5254322- frame[0] WRITE 8 bytes
5254323-20:51:19.247858 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=76,IVAL=0
--
5254973- frame[1] READ 4 bytes
5254974-20:51:28.128696 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5254975- frame[0] WRITE 8 bytes
5254976- frame[1] READ 4 bytes
5254977- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5254978:20:51:29.015878 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5254979-20:51:29.065282 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5254980- frame[0] WRITE 8 bytes
5254981- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5254982-20:51:29.065632 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5254983- frame[0] WRITE 8 bytes
5254984-20:51:29.065648 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=1444,IVAL=0
--
5255792- frame[1] READ 4 bytes
5255793-20:51:38.139942 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5255794- frame[0] WRITE 8 bytes
5255795- frame[1] READ 4 bytes
5255796- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5255797:20:51:38.833663 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5255798-20:51:38.883373 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5255799- frame[0] WRITE 8 bytes
5255800- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5255801-20:51:38.883862 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5255802- frame[0] WRITE 8 bytes
5255803-20:51:38.883863 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=76,IVAL=0
--
5256525- frame[1] READ 4 bytes
5256526-20:51:48.151193 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5256527- frame[0] WRITE 8 bytes
5256528- frame[1] READ 4 bytes
5256529- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5256530:20:51:48.651917 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5256531-20:51:48.701623 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5256532- frame[0] WRITE 8 bytes
5256533- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5256534-20:51:48.702115 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5256535- frame[0] WRITE 8 bytes
5256536-20:51:48.702117 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=108,IVAL=0
--
5257260- frame[1] READ 4 bytes
5257261-20:51:58.162347 usbus0.9 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=4,IVAL=0,ERR=0
5257262- frame[0] WRITE 8 bytes
5257263- frame[1] READ 4 bytes
5257264- 0000  00 38 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |.8..            |
5257265:20:51:58.471157 usbus0.9 DONE-BULK-EP=00000002,SPD=SUPER,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
5257266-20:51:58.520289 usbus0.9 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=8,IVAL=50
5257267- frame[0] WRITE 8 bytes
5257268- 0000  02 01 00 00 02 00 00 00  -- -- -- -- -- -- -- --  |........        |
5257269-20:51:58.520570 usbus0.9 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=50,ERR=0
5257270- frame[0] WRITE 8 bytes
5257271-20:51:58.520574 usbus0.9 SUBM-BULK-EP=00000002,SPD=SUPER,NFR=1,SLEN=108,IVAL=0

I hope that helps anyhow..
Comment 13 Tomasz "CeDeROM" CEDRO 2020-03-18 23:32:20 UTC
Created attachment 212516 [details]
usbdump + txt 7zipped
Comment 14 Tomasz "CeDeROM" CEDRO 2020-03-18 23:32:52 UTC
In fact the interface stays in locked state. I did manage to catch a usbdump. There are only IOERROR over there.

When polling the media status if busts a single series of IOERROR. When ifconfig ue0 up it repeats the IOERROR until ifconfig ue0 down. Re-plugging the ethernet cable does not change anything. Interface needs to be re-plugged or reset via usbconfig.

At the moment I am using onboard Intel em0 to send this message.

# usbdump -r freeebsd-ue-ure-20200319-1.usbdump -v > freeebsd-ue-ure-20200319-1.txt

00:06:30.727923 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 08 E9 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:30.732238 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:30.795507 usbus0.10 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=12,IVAL=0
 frame[0] WRITE 8 bytes
 0000  40 05 6C E8 33 01 04 00  -- -- -- -- -- -- -- --  |@.l.3...        |
 frame[1] WRITE 4 bytes
 0000  00 A0 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |....            |
00:06:30.799982 usbus0.10 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:30.864238 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 00 B4 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:30.868736 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:30.931733 usbus0.10 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=12,IVAL=0
 frame[0] WRITE 8 bytes
 0000  40 05 6C E8 33 01 04 00  -- -- -- -- -- -- -- --  |@.l.3...        |
 frame[1] WRITE 4 bytes
 0000  00 A0 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |....            |
00:06:30.936226 usbus0.10 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:31.000761 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 00 B4 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:31.005224 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:31.067517 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 08 E9 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:31.071977 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:32.135519 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 08 E9 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:32.139950 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:32.203044 usbus0.10 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=12,IVAL=0
 frame[0] WRITE 8 bytes
 0000  40 05 6C E8 33 01 04 00  -- -- -- -- -- -- -- --  |@.l.3...        |
 frame[1] WRITE 4 bytes
 0000  00 A0 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |....            |
00:06:32.207449 usbus0.10 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:32.272224 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 00 B4 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:32.276695 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:32.339683 usbus0.10 SUBM-CTRL-EP=00000000,SPD=SUPER,NFR=2,SLEN=12,IVAL=0
 frame[0] WRITE 8 bytes
 0000  40 05 6C E8 33 01 04 00  -- -- -- -- -- -- -- --  |@.l.3...        |
 frame[1] WRITE 4 bytes
 0000  00 A0 00 00 -- -- -- --  -- -- -- -- -- -- -- --  |....            |
00:06:32.344205 usbus0.10 DONE-CTRL-EP=00000000,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:32.410429 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 00 B4 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:32.414944 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:32.477695 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 08 E9 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:32.482190 usbus0.10 DONE-CTRL-EP=00000080,SPD=SUPER,NFR=1,SLEN=0,IVAL=0,ERR=IOERROR
 frame[0] WRITE 0 bytes
00:06:33.547332 usbus0.10 SUBM-CTRL-EP=00000080,SPD=SUPER,NFR=2,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  C0 05 08 E9 00 01 04 00  -- -- -- -- -- -- -- --  |........        |
 frame[1] READ 4 bytes
00:06:33.551664 usbus0.10 DONE-CTRL-
...

I am attaching compressed usbdump :-)