Hi all
I've seen the same problem on mailing archives but I couldn't track any
solution.
Description:
After some time (from seconds to hours) connection hangs. Everything looks ok
but I can't ping even my peer or browse the web.
My configuration:
system - Mandrake 9.1
modem - thomson speedtouch 330 (btw mine is silver :)
driver - speedtouch 1.2 beta2
firmware - mgmt.o (shipped with my modem)
$ lspci | grep USB
00:07.2 USB Controller: Intel Corp. 82371AB/EB/MB PIIX4 USB (rev 01)
My syslog:
Nov 6 19:44:20 localhost modem_run[2377]: modem_run version 1.2-beta2 started
by konrad uid 0
Nov 6 19:44:20 localhost modem_run[2377]: Found ALCATEL SpeedTouch USB modem
Nov 6 19:44:20 localhost modem_run[2377]: Best offset 6463 with probability
100%
Nov 6 19:44:20 localhost modem_run[2377]: Best offset 526179 with probability
100%
Nov 6 19:44:21 localhost modem_run[2377]: Firmware information
(CRC:0x94a45435, Size:526187, 1.3.3 - GNU/Linux - Win32)
Nov 6 19:44:23 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:44:23 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x85
len 512 ret -110
Nov 6 19:44:23 localhost modem_run[2377]: BLOCK1 : 883 bytes uploaded :
OK
Nov 6 19:44:23 localhost modem_run[2377]: BLOCK2 : 511 bytes downloaded :
OK
Nov 6 19:44:25 localhost modem_run[2377]: BLOCK3 : 526187 bytes uploaded :
OK
Nov 6 19:44:25 localhost modem_run[2377]: BLOCK4 : 511 bytes downloaded :
OK
Nov 6 19:44:26 localhost modem_run[2377]: Modem reference : 35717710......
Nov 6 19:44:46 localhost automount[2406]: running expiration on path
/autofs/disks/linux2
Nov 6 19:44:46 localhost automount[2406]: expired /autofs/disks/linux2
Nov 6 19:44:46 localhost automount[2408]: running expiration on path
/autofs/disks/mobile
Nov 6 19:44:46 localhost automount[2408]: expired /autofs/disks/mobile
Nov 6 19:44:54 localhost modem_run[2383]: Sending a signal to notify the adsl
up state
Nov 6 19:44:54 localhost modem_run[2377]: ADSL synchronization has been
obtained
Nov 6 19:44:54 localhost modem_run[2377]: ADSL line is up (640 kbit/s down |
160 kbit/s up)
Nov 6 19:44:59 localhost pppd[2426]: pppd 2.4.1 started by root, uid 0
Nov 6 19:44:59 localhost pppoa3[2427]: pppoa3 version 1.2-beta2 started by
root (uid 0)
Nov 6 19:44:59 localhost pppoa3[2427]: Control thread ready
Nov 6 19:44:59 localhost pppd[2426]: using channel 1
Nov 6 19:44:59 localhost pppd[2426]: Using interface ppp0
Nov 6 19:44:59 localhost pppd[2426]: Connect: ppp0 <--> /dev/pts/2
Nov 6 19:44:59 localhost kernel: HDLC line discipline: version $Revision: 3.3
$, maxframe=4096
Nov 6 19:44:59 localhost kernel: N_HDLC line discipline registered.
Nov 6 19:44:59 localhost pppoa3[2427]: Modem found!
Nov 6 19:44:59 localhost pppoa3[2437]: host --> pppoa3 --> modem stream
ready
Nov 6 19:44:59 localhost pppoa3[2438]: modem --> pppoa3 --> host stream
ready
Nov 6 19:44:59 localhost /etc/hotplug/net.agent: assuming ppp0 is already up
Nov 6 19:45:00 localhost pppd[2426]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<magic 0x9a573646>]
Nov 6 19:45:02 localhost pppd[2426]: rcvd [LCP ConfReq id=0x94 <mru 9178>
<auth chap MD5> <magic 0x2da86cf5>]
Nov 6 19:45:02 localhost pppd[2426]: sent [LCP ConfAck id=0x94 <mru 9178>
<auth chap MD5> <magic 0x2da86cf5>]
Nov 6 19:45:03 localhost pppd[2426]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<magic 0x9a573646>]
Nov 6 19:45:03 localhost pppd[2426]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0>
<magic 0x9a573646>]
Nov 6 19:45:03 localhost pppd[2426]: rcvd [CHAP Challenge id=0x47
<c9d2ee168fa0afd0ba8c078b8427ccac>, name = "war_ru1"]
Nov 6 19:45:03 localhost pppd[2426]: sent [CHAP Response id=0x47
<3074da9de90d6e81f84efd44e9d8e965>, name = "[EMAIL PROTECTED]"]
Nov 6 19:45:04 localhost pppd[2426]: rcvd [CHAP Success id=0x47 ""]
Nov 6 19:45:04 localhost pppd[2426]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0>
<ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Nov 6 19:45:04 localhost pppd[2426]: rcvd [IPCP ConfReq id=0x7b <addr
213.25.2.29>]
Nov 6 19:45:04 localhost pppd[2426]: sent [IPCP ConfAck id=0x7b <addr
213.25.2.29>]
Nov 6 19:45:04 localhost pppd[2426]: rcvd [IPCP ConfNak id=0x1 <addr
80.54.18.65> <ms-dns1 194.204.152.34> <ms-dns3 217.98.63.164>]
Nov 6 19:45:04 localhost pppd[2426]: sent [IPCP ConfReq id=0x2 <addr
80.54.18.65> <ms-dns1 194.204.152.34> <ms-dns3 217.98.63.164>]
Nov 6 19:45:04 localhost pppd[2426]: rcvd [IPCP ConfAck id=0x2 <addr
80.54.18.65> <ms-dns1 194.204.152.34> <ms-dns3 217.98.63.164>]
Nov 6 19:45:04 localhost pppd[2426]: local IP address 80.54.18.65
Nov 6 19:45:04 localhost pppd[2426]: remote IP address 213.25.2.29
Nov 6 19:45:04 localhost pppd[2426]: primary DNS address 194.204.152.34
Nov 6 19:45:04 localhost pppd[2426]: secondary DNS address 217.98.63.164
Nov 6 19:45:04 localhost pppd[2426]: Script /etc/ppp/ip-up started (pid 2449)
Nov 6 19:45:04 localhost kernel: ip_tables: (C) 2000-2002 Netfilter core team
Nov 6 19:45:04 localhost kernel: ip_conntrack version 2.1 (2559 buckets,
20472 max) - 320 bytes per conntrack
Nov 6 19:45:04 localhost pppd[2426]: Script /etc/ppp/ip-up finished (pid
2449), status = 0x0
Nov 6 19:45:06 localhost kernel: IN=ppp0 OUT= MAC= SRC=80.28.198.210
DST=80.54.18.65 LEN=60 TOS=0x00 PREC=0x00 TTL=50 ID=58582 DF PROTO=TCP
SPT=50045 DPT=4662 WINDOW=65535 RES=0x00 SYN URGP=0
Nov 6 19:45:08 localhost kernel: IN=ppp0 OUT= MAC= SRC=80.54.42.251
DST=80.54.18.65 LEN=48 TOS=0x00 PREC=0x00
TTL=121 ID=25679 DF PROTO=TCP SPT=4783 DPT=4662 WINDOW=16384 RES=0x00 SYN
URGP=0
Nov 6 19:45:10 localhost kernel: IN=ppp0 OUT= MAC= SRC=80.201.53.167
DST=80.54.18.65 LEN=48 TOS=0x00 PREC=0x00 TTL=113 ID=30174 DF PROTO=TCP
SPT=4328 DPT=1024 WINDOW=16384 RES=0x00 SYN URGP=0
Nov 6 19:45:20 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:20 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:21 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:21 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:22 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:22 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:23 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:23 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:24 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:24 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:25 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:25 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:26 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:26 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:27 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:27 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:28 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:28 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:45:29 localhost kernel: usb_control/bulk_msg: timeout
Nov 6 19:45:29 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Second thing:
I'm not able to reconnect after connection hangs and I have to reboot.
Here's what I try:
Disconnect usb cable
$ killall pppd
$ killall modem_run
Reconnect usb cable
restart starting script
after that my syslog looks like this:
Nov 6 19:46:19 localhost pppoa3[2438]: Error reading usb urb
Nov 6 19:46:19 localhost pppoa3[2438]: Cleaning Write to usb data
Nov 6 19:46:19 localhost pppoa3[2427]: Woken by a sem_post event -> Exiting
Nov 6 19:46:19 localhost pppoa3[2427]: Read from usb Canceled
Nov 6 19:46:19 localhost kernel: usb-uhci.c: interrupt, status 2, frame# 1478
Nov 6 19:46:19 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:46:19 localhost pppoa3[2437]: Cleaning Read from usb data
Nov 6 19:46:19 localhost pppoa3[2427]: Exiting
Nov 6 19:46:19 localhost pppd[2426]: Script /usr/local/sbin/pppoa3 -v 1 -m 1
-c -vpi 0 -vci 35 finished (pid 2Nov 6 19:46:19 localhost pppd[2426]: Modem
hangup
Nov 6 19:46:19 localhost pppd[2426]: Script /etc/ppp/ip-down started (pid
2576)
Nov 6 19:46:19 localhost pppd[2426]: Connection terminated.
Nov 6 19:46:19 localhost pppd[2426]: Connect time 1.4 minutes.
Nov 6 19:46:19 localhost pppd[2426]: Sent 58146 bytes, received 302 bytes.
Nov 6 19:50:10 localhost kernel: usbdevfs: USBDEVFS_BULK failed dev 2 ep 0x7
len 106 ret -110
Nov 6 19:50:10 localhost kernel: usb.c: USB disconnect on device 00:07.2-1
address 2
Nov 6 19:58:13 localhost kernel: hub.c: new USB device 00:07.2-1, assigned
address 3
Nov 6 19:58:13 localhost kernel: usb.c: USB device 3 (vend/prod 0x6b9/0x4061)
is not claimed by any active driNov 6 19:58:32 localhost pppd[3676]: pppd
2.4.1 started by root, uid 0
Nov 6 19:58:32 localhost pppd[3676]: using channel 2
Nov 6 19:58:32 localhost pppd[3676]: Using interface ppp0
Nov 6 19:58:32 localhost pppd[3676]: Connect: ppp0 <--> /dev/pts/3
Nov 6 19:58:32 localhost pppoa3[3677]: pppoa3 version 1.2-beta2 started by
root (uid 0)
Nov 6 19:58:32 localhost /etc/hotplug/net.agent: assuming ppp0 is already up
Nov 6 19:58:32 localhost pppoa3[3677]: A previous instance seems to be
running
Nov 6 19:58:32 localhost pppoa3[3677]: Sending the kill signal to 2582 and
waiting...
Nov 6 19:58:33 localhost pppd[3676]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<magic 0x46e6195>]
Nov 6 19:59:00 localhost last message repeated 9 times
Nov 6 19:59:03 localhost pppd[3676]: LCP: timeout sending Config-Requests
Nov 6 19:59:03 localhost pppd[3676]: Connection terminated.
Anyone has any idea what's wrong or how to reset the damn thing?
konrad
--
Konrad Klimaszewski [EMAIL PROTECTED] www.if.pw.edu.pl/~klimasz
Registered Linux User #300246 : http://counter.li.org
========================================================================
Please remain calm, it's no use both of us being hysterical at the same time.
Liste de diffusion modem ALCATEL SpeedTouch USB
Pour se d�sinscrire : mailto:[EMAIL PROTECTED]
