usb/140883: [axe] USB gigabit ethernet hangs after short period
of traffic
Jason Edwards
sub.mesa at gmail.com
Tue Dec 1 14:10:02 UTC 2009
The following reply was made to PR usb/140883; it has been noted by GNATS.
From: Jason Edwards <sub.mesa at gmail.com>
To: bug-followup at FreeBSD.org, Pyun YongHyeon <pyunyh at gmail.com>
Cc:
Subject: Re: usb/140883: [axe] USB gigabit ethernet hangs after short period
of traffic
Date: Tue, 1 Dec 2009 14:36:44 +0100
--000325558d665019be0479aad903
Content-Type: text/plain; charset=ISO-8859-1
Hello list and Pyon YongHyeon,
I tried your patch, which would let axe use amphy instead of ukphy, but it
doesn't seem to work; it still uses the ukphy and it still crashes. I
managed to set hw.usb.axe.debug to 15 and record /var/log/messages during
heavy traffic (~50 megabits). Output is below.
First the dmesg after applying patch and rebuilding kernel (axe is built in
the kernel) though it doesnt seem to have changed since before the patch:
-------
ugen4.2: <vendor 0x050d> at usbus4
axe0: <vendor 0x050d product 0x5055, rev 2.00/0.01, addr 2> on usbus4
axe0: PHYADDR 0xe0:0x01
(..)
miibus1: <MII bus> on axe0
ukphy0: <Generic IEEE 802.3u media interface> PHY 1 on miibus1
ukphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT,
1000baseT-FDX, auto
ue0: <USB Ethernet> on axe0
ue0: Ethernet address: <removed>
-------
debug output during heavy traffic:
---
Dec 1 14:10:52 mesa kernel: axe_bulk_write_callback:870: transfer complete
Dec 1 14:11:23 mesa last message repeated 493 times
Dec 1 14:12:57 mesa last message repeated 2755 times
(..)
Dec 1 14:12:57 mesa kernel: axe_bulk_write_callback:870: transfer complete
Dec 1 14:13:28 mesa last message repeated 1721 times
Dec 1 14:15:29 mesa last message repeated 35874 times
Dec 1 14:23:11 mesa last message repeated 557689 times
Dec 1 14:23:11 mesa kernel: axe_bulk_write_callback:870:
transferite_callback:870: transfer complete
Dec 1 14:23:11 mesa kernel: axe_bulk_write_callback:870: transfer complete
Dec 1 14:23:42 mesa last message repeated 46012 times
Dec 1 14:25:43 mesa last message repeated 174082 times
Dec 1 14:26:35 mesa last message repeated 76977 times
Dec 1 14:26:45 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:26:46 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:26:46 mesa last message repeated 6 times
Dec 1 14:26:55 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:27:14 mesa last message repeated 2 times
Dec 1 14:27:16 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:27:16 mesa last message repeated 6 times
Dec 1 14:27:24 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:27:44 mesa last message repeated 2 times
Dec 1 14:27:46 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:27:46 mesa last message repeated 6 times
Dec 1 14:27:53 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:28:13 mesa last message repeated 2 times
Dec 1 14:28:16 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:28:16 mesa last message repeated 6 times
Dec 1 14:28:23 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:28:43 mesa last message repeated 2 times
Dec 1 14:28:46 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:28:46 mesa last message repeated 6 times
Dec 1 14:28:52 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:29:12 mesa last message repeated 2 times
Dec 1 14:29:16 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:29:16 mesa last message repeated 7 times
Dec 1 14:29:22 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:30:01 mesa last message repeated 4 times
Dec 1 14:30:11 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:30:16 mesa miniupnpd[968]: sendto(udp_notify=7, 10.0.1.1): No
buffer space available
Dec 1 14:30:16 mesa last message repeated 6 times
Dec 1 14:30:21 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:30:31 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
Dec 1 14:30:40 mesa kernel: ue0: link state changed to DOWN
Dec 1 14:30:40 mesa kernel: axe_bulk_write_callback:941: transfer error,
USB_ERR_TIMEOUT
---
Regards,
sub
--000325558d665019be0479aad903
Content-Type: text/html; charset=ISO-8859-1
Content-Transfer-Encoding: quoted-printable
Hello list and Pyon YongHyeon,<br><br>I tried your patch, which would let a=
xe use amphy instead of ukphy, but it doesn't seem to work; it still us=
es the ukphy and it still crashes. I managed to set hw.usb.axe.debug to 15 =
and record /var/log/messages during heavy traffic (~50 megabits). Output is=
below.<br>
<br>First the dmesg after applying patch and rebuilding kernel (axe is buil=
t in the kernel) though it doesnt seem to have changed since before the pat=
ch:<br>-------<br>ugen4.2: <vendor 0x050d> at usbus4<br>axe0: <ven=
dor 0x050d product 0x5055, rev 2.00/0.01, addr 2> on usbus4<br>
axe0: PHYADDR 0xe0:0x01<br>(..)<br>miibus1: <MII bus> on axe0<br>ukph=
y0: <Generic IEEE 802.3u media interface> PHY 1 on miibus1<br>ukphy0:=
=A0 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-FD=
X, auto<br>
ue0: <USB Ethernet> on axe0<br>ue0: Ethernet address: <removed>=
<br>-------<br><br><br>debug output during heavy traffic:<br>---<br>Dec=A0 =
1 14:10:52 mesa kernel: axe_bulk_write_callback:870: transfer complete<br>
Dec=A0 1 14:11:23 mesa last message repeated 493 times<br>Dec=A0 1 14:12:57=
mesa last message repeated 2755 times<br>(..)<br>Dec=A0 1 14:12:57 mesa ke=
rnel: axe_bulk_write_callback:870: transfer complete<br>Dec=A0 1 14:13:28 m=
esa last message repeated 1721 times<br>
Dec=A0 1 14:15:29 mesa last message repeated 35874 times<br>Dec=A0 1 14:23:=
11 mesa last message repeated 557689 times<br>Dec=A0 1 14:23:11 mesa kernel=
: axe_bulk_write_callback:870: transferite_callback:870: transfer complete<=
br>
Dec=A0 1 14:23:11 mesa kernel: axe_bulk_write_callback:870: transfer comple=
te<br>Dec=A0 1 14:23:42 mesa last message repeated 46012 times<br>Dec=A0 1 =
14:25:43 mesa last message repeated 174082 times<br>Dec=A0 1 14:26:35 mesa =
last message repeated 76977 times<br>
Dec=A0 1 14:26:45 mesa kernel: axe_bulk_write_callback:941: transfer error,=
USB_ERR_TIMEOUT<br>Dec=A0 1 14:26:46 mesa miniupnpd[968]: sendto(udp_notif=
y=3D7, 10.0.1.1): No buffer space available<br>Dec=A0 1 14:26:46 mesa last =
message repeated 6 times<br>
Dec=A0 1 14:26:55 mesa kernel: axe_bulk_write_callback:941: transfer error,=
USB_ERR_TIMEOUT<br>Dec=A0 1 14:27:14 mesa last message repeated 2 times<br=
>Dec=A0 1 14:27:16 mesa miniupnpd[968]: sendto(udp_notify=3D7, 10.0.1.1): N=
o buffer space available<br>
Dec=A0 1 14:27:16 mesa last message repeated 6 times<br>Dec=A0 1 14:27:24 m=
esa kernel: axe_bulk_write_callback:941: transfer error, USB_ERR_TIMEOUT<br=
>Dec=A0 1 14:27:44 mesa last message repeated 2 times<br>Dec=A0 1 14:27:46 =
mesa miniupnpd[968]: sendto(udp_notify=3D7, 10.0.1.1): No buffer space avai=
lable<br>
Dec=A0 1 14:27:46 mesa last message repeated 6 times<br>Dec=A0 1 14:27:53 m=
esa kernel: axe_bulk_write_callback:941: transfer error, USB_ERR_TIMEOUT<br=
>Dec=A0 1 14:28:13 mesa last message repeated 2 times<br>Dec=A0 1 14:28:16 =
mesa miniupnpd[968]: sendto(udp_notify=3D7, 10.0.1.1): No buffer space avai=
lable<br>
Dec=A0 1 14:28:16 mesa last message repeated 6 times<br>Dec=A0 1 14:28:23 m=
esa kernel: axe_bulk_write_callback:941: transfer error, USB_ERR_TIMEOUT<br=
>Dec=A0 1 14:28:43 mesa last message repeated 2 times<br>Dec=A0 1 14:28:46 =
mesa miniupnpd[968]: sendto(udp_notify=3D7, 10.0.1.1): No buffer space avai=
lable<br>
Dec=A0 1 14:28:46 mesa last message repeated 6 times<br>Dec=A0 1 14:28:52 m=
esa kernel: axe_bulk_write_callback:941: transfer error, USB_ERR_TIMEOUT<br=
>Dec=A0 1 14:29:12 mesa last message repeated 2 times<br>Dec=A0 1 14:29:16 =
mesa miniupnpd[968]: sendto(udp_notify=3D7, 10.0.1.1): No buffer space avai=
lable<br>
Dec=A0 1 14:29:16 mesa last message repeated 7 times<br>Dec=A0 1 14:29:22 m=
esa kernel: axe_bulk_write_callback:941: transfer error, USB_ERR_TIMEOUT<br=
>Dec=A0 1 14:30:01 mesa last message repeated 4 times<br>Dec=A0 1 14:30:11 =
mesa kernel: axe_bulk_write_callback:941: transfer error, USB_ERR_TIMEOUT<b=
r>
Dec=A0 1 14:30:16 mesa miniupnpd[968]: sendto(udp_notify=3D7, 10.0.1.1): No=
buffer space available<br>Dec=A0 1 14:30:16 mesa last message repeated 6 t=
imes<br>Dec=A0 1 14:30:21 mesa kernel: axe_bulk_write_callback:941: transfe=
r error, USB_ERR_TIMEOUT<br>
Dec=A0 1 14:30:31 mesa kernel: axe_bulk_write_callback:941: transfer error,=
USB_ERR_TIMEOUT<br>Dec=A0 1 14:30:40 mesa kernel: ue0: link state changed =
to DOWN<br>Dec=A0 1 14:30:40 mesa kernel: axe_bulk_write_callback:941: tran=
sfer error, USB_ERR_TIMEOUT<br>
---<br><br>Regards,<br>sub<br>
--000325558d665019be0479aad903--
More information about the freebsd-usb
mailing list