usb/138659: uftdi driver broken in RELENG_8/CURRENT

[Tomas Verbaitis]

The following reply was made to PR usb/138659; it has been noted by GNATS.

From: Tomas Verbaitis <tomasv at megalogika.lt>
To: Hans Petter Selasky <hselasky at c2i.net>
Cc: freebsd-usb at freebsd.org, freebsd-gnats-submit at freebsd.org
Subject: Re: usb/138659: uftdi driver broken in RELENG_8/CURRENT
Date: Thu, 10 Sep 2009 15:52:54 +0300

 On Wed, Sep 09, 2009 at 04:34:00PM +0200, Hans Petter Selasky wrote:
 > On Wednesday 09 September 2009 14:32:22 Tomas Verbaitis wrote:
 > >  - even that device is answering requests slower and slower until it stalls
 > > completely within 1 hour
 > What is printed in dmesg?
 
 Without enabling uftdi debugging, the dmesg only notes device
 connections and removals (btw, the old usb stack would crash the system,
 if attached uftdi deviced was removed and the cuaU* was accessed, so,
 yes, there is an improvement ,))
 
 Sep  9 15:49:46 sklepas kernel: ugen0.2: <Teltonika> at usbus0
 Sep  9 15:49:46 sklepas kernel: uftdi0: <Teltonika ModemUSB/G10> on usbus0
 Sep  9 15:56:08 sklepas kernel: ugen0.2: <Teltonika> at usbus0 (disconnected)
 Sep  9 15:56:08 sklepas kernel: uftdi0: at uhub0, port 1, addr 2 (disconnected)
 Sep  9 15:56:25 sklepas kernel: ugen0.2: <Teltonika> at usbus0
 Sep  9 15:56:26 sklepas kernel: uftdi0: <Teltonika ModemUSB/G10> on usbus0
 Sep  9 15:56:33 sklepas kernel: ugen0.2: <Teltonika> at usbus0 (disconnected)
 Sep  9 15:56:33 sklepas kernel: uftdi0: at uhub0, port 1, addr 2 (disconnected)
 Sep  9 15:56:41 sklepas kernel: ugen0.2: <Teltonika> at usbus0
 Sep  9 15:56:41 sklepas kernel: uftdi0: <Teltonika ModemUSB/G10> on usbus0
 
 > Try enabling uftdi debugging:
 > sysctl hw.usb.uftdi.debug=15
 
 after enabling debug it went like this:
 
 * modem attached
 
 Sep 10 15:38:30 sklepas kernel: ugen0.2: <Teltonika> at usbus0
 Sep 10 15:38:30 sklepas kernel: uftdi0: <Teltonika ModemUSB/G10> on usbus0
 Sep 10 15:38:30 sklepas kernel: uftdi_attach:284:
 
 * kannel started -- it initialized the modem ok and tried to send an sms
 
 Sep 10 15:40:25 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:40:25 sklepas kernel: uftdi_cfg_open:354: uftdi_pre_param:653: 
 Sep 10 15:40:25 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:40:25 sklepas kernel: uftdi_read_callback:459: status change msr=0x90 (0x00) lsr=0x60 (0x00)
 Sep 10 15:40:25 sklepas kernel: uftdi_cfg_get_status:705: msr=0x90 lsr=0x60
 Sep 10 15:40:25 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:40:26 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:40:26 sklepas kernel: uftdi_cfg_get_status:705: msr=0x90 lsr=0x60
 Sep 10 15:40:28 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:40:28 sklepas kernel: uftdi_cfg_open:354: uftdi_pre_param:653: 
 Sep 10 15:40:28 sklepas kernel: uftdi_cfg_get_status:705: msr=0x90 lsr=0x60
 Sep 10 15:40:28 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:40:28 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:40:28 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:40:28 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:40:29 sklepas kernel: uftdi_read_callback:459: status change msr=0x10 (0x90) lsr=0x60 (0x60)
 Sep 10 15:40:29 sklepas kernel: uftdi_cfg_get_status:705: msr=0x10 lsr=0x60
 Sep 10 15:40:31 sklepas kernel: uftdi_read_callback:459: status change msr=0x30 (0x10) lsr=0x60 (0x60)
 Sep 10 15:40:31 sklepas kernel: uftdi_cfg_get_status:705: msr=0x30 lsr=0x60
 Sep 10 15:40:31 sklepas kernel: uftdi_read_callback:459: status change msr=0x10 (0x30) lsr=0x00 (0x60)
 Sep 10 15:40:31 sklepas kernel: uftdi_cfg_get_status:705: msr=0x10 lsr=0x00
 
 * the sms did not get sent, at least the modem did not acknowledge that
 as the communication with it stalled for ca. 4 minutes
 
 * i disconnected the modem and stopped kannel
 
 Sep 10 15:44:06 sklepas kernel: ugen0.2: <Teltonika> at usbus0 (disconnected)
 Sep 10 15:44:06 sklepas kernel: uftdi0: at uhub0, port 2, addr 2 (disconnected)
 
 * kannel stopped only after modem removal, as, apparently it was still
 trying to say at least an ATZ to the modem
 
 * repeated the same again:
 
 Sep 10 15:44:28 sklepas kernel: ugen0.2: <Teltonika> at usbus0
 Sep 10 15:44:28 sklepas kernel: uftdi0: <Teltonika ModemUSB/G10> on usbus0
 Sep 10 15:44:28 sklepas kernel: uftdi_attach:284: 
 Sep 10 15:44:39 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:44:39 sklepas kernel: uftdi_cfg_open:354: uftdi_pre_param:653: 
 Sep 10 15:44:39 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:44:39 sklepas kernel: uftdi_read_callback:459: status change msr=0x90 (0x00) lsr=0x60 (0x00)
 Sep 10 15:44:39 sklepas kernel: uftdi_cfg_get_status:705: msr=0x90 lsr=0x60
 Sep 10 15:44:39 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:44:39 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:44:40 sklepas kernel: uftdi_cfg_get_status:705: msr=0x90 lsr=0x60
 Sep 10 15:44:41 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:44:41 sklepas kernel: uftdi_cfg_open:354: uftdi_pre_param:653: 
 Sep 10 15:44:41 sklepas kernel: uftdi_cfg_get_status:705: msr=0x90 lsr=0x60
 Sep 10 15:44:41 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:44:41 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:44:41 sklepas kernel: uftdi_pre_param:653: 
 Sep 10 15:44:41 sklepas kernel: uftdi_cfg_param:672: 
 Sep 10 15:44:42 sklepas kernel: uftdi_read_callback:459: status change msr=0x10 (0x90) lsr=0x60 (0x60)
 Sep 10 15:44:42 sklepas kernel: uftdi_cfg_get_status:705: msr=0x10 lsr=0x60
 Sep 10 15:44:44 sklepas kernel: uftdi_read_callback:459: status change msr=0x30 (0x10) lsr=0x60 (0x60)
 Sep 10 15:44:44 sklepas kernel: uftdi_cfg_get_status:705: msr=0x30 lsr=0x60
 Sep 10 15:44:44 sklepas kernel: uftdi_read_callback:459: status change msr=0x10 (0x30) lsr=0x00 (0x60)
 Sep 10 15:44:44 sklepas kernel: uftdi_cfg_get_status:705: msr=0x10 lsr=0x00
 Sep 10 15:45:15 sklepas kernel: ugen0.2: <Teltonika> at usbus0 (disconnected)
 Sep 10 15:45:15 sklepas kernel: uftdi0: at uhub0, port 2, addr 2 (disconnected)
 
 
 hope this helps. thank you for quick reaction!
 
 
 -- 
 Tomas "Verbaitis" Verbaitis ** http://megalogika.lt