Modemsite's Forum56 - The Modem Board
Main | profile | register | search | help | Ad-free Login
Forums | USR (Public) | Disconnect reason is Unable to Retrain?    Watch  
Author Topic
error
Tl Posts:
8

USA
Posted - 6/21/2004 8:56:51 PM  Show Profile  Email Poster  Edit Message
I have a USR 56K external modem 5603 flashed to v.92 using the latest firmware 5.4.62 found on www.usr.com just today. My problem is that I can only stay connected 10-12 minutes before I'm disconnected. I have already tried disabling 56k entirely, and using S10=60, and I get the following. I have no idea why the modem might be unable to retrain. How do I fix this one? I've also included the diagnostic from a "typical" 56k connection (usually 45333-52000) below this one.

ati6
U.S. Robotics 56K FAX EXT Link Diagnostics...

Chars sent 41278 Chars Received 299955
Chars lost 0
Octets sent 23701 Octets Received 239691
Blocks sent 1207 Blocks Received 1996
Blocks resent 0

Retrains Requested 0 Retrains Granted 0
Line Reversals 0 Blers 0
Link Timeouts 0 Link Naks 0

Data Compression V42BIS 2048/32
Equalization Long
Fallback Enabled
Protocol LAPM
Speed 28800/31200
Last Call 00:11:22

Disconnect Reason is Unable to Retrain

OK
ati11
U.S. Robotics 56K FAX EXT Link Diagnostics...


Modulation V.34
Carrier Freq (Hz) 1959/1959
Symbol Rate 3429/3429
Trellis Code 64S-4D/64S-4D
Nonlinear Encoding ON/ON
Precoding OFF/ON
Shaping OFF/ON
Preemphasis Index 3/8
Recv/Xmit Level (-dBm) 31/12
Near Echo Loss (dB) 28
Far Echo Loss (dB) 55
Carrier Offset (Hz) 168
Round Trip Delay (msec) 6
Timing Offset (ppm) 1472
SNR (dB) 34
Speed Shifts Up/Down/Null 0/0/0
Status :

OK
aty11

Freq Level (dB)

150 25
300 24
450 24
600 24
750 25
900 25
1050 26
1200 26
1350 27
1500 27
1650 28
1800 28
1950 29
2100 29
2250 30
2400 31
2550 31
2700 32
2850 32
3000 32
3150 33
3300 33
3450 35
3600 38
3750 42
OK

"Typical" results:

ati6
U.S. Robotics 56K FAX EXT Link Diagnostics...

Chars sent 35295 Chars Received 204455
Chars lost 0
Octets sent 18902 Octets Received 87809
Blocks sent 915 Blocks Received 783
Blocks resent 0

Retrains Requested 0 Retrains Granted 0
Line Reversals 0 Blers 15
Link Timeouts 0 Link Naks 0

Data Compression V42BIS 2048/32
Equalization Long
Fallback Enabled
Protocol LAPM
Speed 50666/21600
V.90 Peak Speed 50666
Last Call 00:08:24

Disconnect Reason is Unable to Retrain

OK
ati11
U.S. Robotics 56K FAX EXT Link Diagnostics...


Modulation V.90/V.34
Carrier Freq (Hz) None/1920
Symbol Rate 8000/3200
Trellis Code None/64S-4D
Nonlinear Encoding None/ON
Precoding OFF/ON
Shaping OFF/ON
Preemphasis Index 5/8
Recv/Xmit Level (-dBm) 22.7/8.6
Near Echo Loss (dB) 37.4
Far Echo Loss (dB) 0
Carrier Offset (Hz) 0
Round Trip Delay (msec) 7
Timing Offset (ppm) 1999
SNR (dB) 49.4
Speed Shifts Up/Down/Null 0/0/2
Status : uu,5,12N,12.2,-15,0N,000,48.2,-65.7,0
OK
aty11

Freq Level (dB)

150 26
300 24
450 24
600 24
750 25
900 25
1050 26
1200 26
1350 27
1500 27
1650 28
1800 28
1950 29
2100 29
2250 30
2400 31
2550 31
2700 32
2850 32
3000 32
3150 33
3300 33
3450 35
3600 38
3750 42
OK

v.Richard
Tl Posts:
6222

USA
Posted - 6/22/2004 8:15:53 AM  Show Profile  Email Poster  Edit Message  v.Richards Homepage
Could be the phone line, the ISP modem you are calling, or your modem.
Suggest - enable your modem speaker on all the time to hear what's going on - add
m2
to extra settings
www.modemsite.com/56k/initmagic.asp

This page has some audio of what modem should sound like, retrains, etc.
www.modemsite.com/56k/trouble3.asp

Aloha! Richard.

charles
Tl Posts:
5879

USA
Posted - 6/22/2004 9:06:23 AM  Show Profile  Email Poster  Edit Message
Might also try removing everything from the phone lines except the modem,try connection again.
error
Tl Posts:
8

USA
Posted - 6/22/2004 9:38:38 AM  Show Profile  Email Poster  Edit Message
Thanks for the suggestions. I have already tried 3 dialup access numbers and get the same on each of them. In addition I turned on the speaker but I don't seem to hear anything out of the ordinary during the connection. When it disconnects, it just suddenly gives me a single long tone for a few seconds, before the modem finally gives up. I also don't have anything on the phone line other than the modem, and all the I/W is new.
charles
Tl Posts:
5879

USA
Posted - 6/22/2004 9:41:57 AM  Show Profile  Email Poster  Edit Message
Could you post a modem log and might try S10=200S25=100
Have you tried other jack? remove everything from there jacks in the house,might also connect right to the telco box out side.What OS? Check what is running the background when this happens like any auto updates.
If you have a network card on this pc and not using it disable it in the device manager.

http://www.modemhelp.net/linenoise/usr/ati11.shtml

Edited by - charles on 6/22/2004 9:57:58 AM

error
Tl Posts:
8

USA
Posted - 6/22/2004 2:53:17 PM  Show Profile  Email Poster  Edit Message
I'm using Linux 2.6.7 and pppd 2.4.2. There is no difference using your suggested init string, and the logs really give me nothing useful to go on.

Jun 22 16:14:06 roam pppd[18212]: pppd 2.4.2 started by root, uid 0
Jun 22 16:14:06 roam pppd[18212]: Using interface ppp0
Jun 22 16:14:06 roam pppd[18212]: Starting link
Jun 22 16:14:07 roam chat[18221]: abort on (BUSY)
Jun 22 16:14:07 roam chat[18221]: abort on (ERROR)
Jun 22 16:14:07 roam chat[18221]: abort on (NO ANSWER)
Jun 22 16:14:07 roam chat[18221]: abort on (NO CARRIER)
Jun 22 16:14:07 roam chat[18221]: abort on (NO DIALTONE)
Jun 22 16:14:07 roam chat[18221]: abort on (Invalid Login)
Jun 22 16:14:07 roam chat[18221]: abort on (Login incorrect)
Jun 22 16:14:07 roam chat[18221]: send (ATZ^M)
Jun 22 16:14:07 roam chat[18221]: expect (OK)
Jun 22 16:14:07 roam chat[18221]: TZ^M^M
Jun 22 16:14:07 roam chat[18221]: OK
Jun 22 16:14:07 roam chat[18221]: -- got it
Jun 22 16:14:07 roam chat[18221]: send (ATS10=200S25=100^M)
Jun 22 16:14:07 roam chat[18221]: expect (OK)
Jun 22 16:14:07 roam chat[18221]: ^M
Jun 22 16:14:07 roam chat[18221]: ATS10=200S25=100^M^M
Jun 22 16:14:07 roam chat[18221]: OK
Jun 22 16:14:07 roam chat[18221]: -- got it
Jun 22 16:14:07 roam chat[18221]: send (ATDT3418715^M)
Jun 22 16:14:07 roam chat[18221]: expect (CONNECT)
Jun 22 16:14:07 roam chat[18221]: ^M
Jun 22 16:14:27 roam chat[18221]: ATDT3418715^M^M
Jun 22 16:14:27 roam chat[18221]: CONNECT
Jun 22 16:14:27 roam chat[18221]: -- got it
Jun 22 16:14:27 roam chat[18221]: send (^M)
Jun 22 16:14:27 roam chat[18221]: expect (sername)
Jun 22 16:14:27 roam chat[18221]: 45333/ARQ/V92/LAPM/V42BIS^M
Jun 22 16:14:27 roam chat[18221]: C^M
Jun 22 16:14:27 roam chat[18221]: UQKT2^M
Jun 22 16:14:27 roam chat[18221]: ^M
Jun 22 16:14:27 roam chat[18221]: ^M
Jun 22 16:14:27 roam chat[18221]: User Access Verification^M
Jun 22 16:14:27 roam chat[18221]: ^M
Jun 22 16:14:27 roam chat[18221]: Username
Jun 22 16:14:27 roam chat[18221]: -- got it
Jun 22 16:14:27 roam chat[18221]: send (user@isp.com^M">user@isp.com^M)
Jun 22 16:14:27 roam chat[18221]: expect (assword)
Jun 22 16:14:27 roam chat[18221]: : ^M
Jun 22 16:14:27 roam chat[18221]: Username: user@isp.com^M">user@isp.com^M
Jun 22 16:14:27 roam chat[18221]: Password
Jun 22 16:14:27 roam chat[18221]: -- got it
Jun 22 16:14:27 roam chat[18221]: send (password^M)
Jun 22 16:14:28 roam pppd[18212]: Serial connection established.
Jun 22 16:14:28 roam pppd[18212]: using channel 44
Jun 22 16:14:28 roam pppd[18212]: Connect: ppp0 <--> /dev/modem
Jun 22 16:14:29 roam pppd[18212]: sent [LCP ConfReq id=0x1 <mru 1476> <asyncmap 0x0> <magic 0x3f0deee3> <pcomp> <accomp>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [LCP ConfReq id=0x33 <asyncmap 0xa0000> <magic 0x96678b2b> <pcomp> <accomp>]
Jun 22 16:14:29 roam pppd[18212]: sent [LCP ConfAck id=0x33 <asyncmap 0xa0000> <magic 0x96678b2b> <pcomp> <accomp>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [LCP ConfNak id=0x1 <mru 1500>]
Jun 22 16:14:29 roam pppd[18212]: sent [LCP ConfReq id=0x2 <asyncmap 0x0> <magic 0x3f0deee3> <pcomp> <accomp>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [LCP ConfAck id=0x2 <asyncmap 0x0> <magic 0x3f0deee3> <pcomp> <accomp>]
Jun 22 16:14:29 roam pppd[18212]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Jun 22 16:14:29 roam pppd[18212]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [IPCP ConfReq id=0x5f <addr 67.1.96.3>]
Jun 22 16:14:29 roam pppd[18212]: sent [IPCP ConfAck id=0x5f <addr 67.1.96.3>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [LCP ProtRej id=0x34 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Jun 22 16:14:29 roam pppd[18212]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Jun 22 16:14:29 roam pppd[18212]: sent [IPCP ConfReq id=0x2 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [IPCP ConfNak id=0x2 <addr 67.1.98.76> <ms-dns1 205.171.3.65> <ms-dns3 205.171.2.65>]
Jun 22 16:14:29 roam pppd[18212]: sent [IPCP ConfReq id=0x3 <addr 67.1.98.76> <ms-dns1 205.171.3.65> <ms-dns3 205.171.2.65>]
Jun 22 16:14:29 roam pppd[18212]: rcvd [IPCP ConfAck id=0x3 <addr 67.1.98.76> <ms-dns1 205.171.3.65> <ms-dns3 205.171.2.65>]
Jun 22 16:14:29 roam pppd[18212]: Local IP address changed to 67.1.98.76
Jun 22 16:14:29 roam pppd[18212]: Remote IP address changed to 67.1.96.3
Jun 22 16:14:29 roam pppd[18212]: sent [IP data] 45 00 00 54 00 00 40 00 ...
Jun 22 16:14:29 roam pppd[18212]: Script /etc/ppp/ip-up started (pid 18228)
Jun 22 16:14:29 roam pppd[18212]: Script /etc/ppp/ip-up finished (pid 18228), status = 0x0
Jun 22 16:30:25 roam pppd[18212]: Script /etc/ppp/ip-down started (pid 18333)
Jun 22 16:30:25 roam pppd[18212]: Script /etc/ppp/ip-down finished (pid 18333), status = 0x1
Jun 22 16:30:25 roam pppd[18212]: Connection terminated.
Jun 22 16:30:25 roam pppd[18212]: Connect time 16.0 minutes.
Jun 22 16:30:25 roam pppd[18212]: Sent 101316 bytes, received 995949 bytes.


ati6
U.S. Robotics 56K FAX EXT Link Diagnostics...

Chars sent 106519 Chars Received 1007937
Chars lost 0
Octets sent 62017 Octets Received 948827
Blocks sent 3905 Blocks Received 7756
Blocks resent 4

Retrains Requested 0 Retrains Granted 0
Line Reversals 0 Blers 213
Link Timeouts 0 Link Naks 1

Data Compression V42BIS 2048/32
Equalization Long
Fallback Enabled
Protocol LAPM
Speed 49333/21600
V.90 Peak Speed 49333
Last Call 00:13:13

Disconnect Reason is Unable to Retrain

OK
ati11
U.S. Robotics 56K FAX EXT Link Diagnostics...


Modulation V.90/V.34
Carrier Freq (Hz) None/1920
Symbol Rate 8000/3200
Trellis Code None/64S-4D
Nonlinear Encoding None/ON
Precoding OFF/ON
Shaping OFF/ON
Preemphasis Index 5/8
Recv/Xmit Level (-dBm) 22.7/8.7
Near Echo Loss (dB) 37.5
Far Echo Loss (dB) 0
Carrier Offset (Hz) 0
Round Trip Delay (msec) 7
Timing Offset (ppm) 2120
SNR (dB) 44.2
Speed Shifts Up/Down/Null 2/2/2
Status : uu,5,12N,12.1,-15,0N,000,47.8,-66.8,0
OK
aty11

Freq Level (dB)

150 20
300 18
450 18
600 18
750 19
900 19
1050 20
1200 20
1350 21
1500 21
1650 22
1800 23
1950 23
2100 24
2250 24
2400 25
2550 25
2700 26
2850 26
3000 26
3150 27
3300 27
3450 29
3600 32
3750 36
OK

mainbuss
Tl Posts:
145

USA
Posted - 6/22/2004 4:06:49 PM  Show Profile  Email Poster  Edit Message

Edited by - mainbuss on 7/10/2004 10:12:47 PM
error
Tl Posts:
8

USA
Posted - 6/22/2004 4:09:15 PM  Show Profile  Email Poster  Edit Message
No, I just posted the wrong number, sorry. It is a 5686-03 (00568603).
mainbuss
Tl Posts:
145

USA
Posted - 6/22/2004 4:28:21 PM  Show Profile  Email Poster  Edit Message

Edited by - mainbuss on 7/10/2004 10:13:05 PM
error
Tl Posts:
8

USA
Posted - 6/22/2004 4:57:07 PM  Show Profile  Email Poster  Edit Message
I don't know why you couldn't find it. I can go to the site and get it every time; just select 005686-03 from the drop down list and I wind up here: http://www.usr.com/v92/v-upgrade.asp?patch=5686 and there at the bottom is the firmware. Anyway, that's been done already.

Besides, the firmware is not my problem; the disconnects are my problem.
Edited by - error on 6/22/2004 4:59:16 PM

error
Tl Posts:
8

USA
Posted - 6/22/2004 5:31:34 PM  Show Profile  Email Poster  Edit Message
The plot thickens...

I just got done reviewing my system logs for the last day, and I discovered that a connection I made around 5am this morning lasted well in excess of four hours! (I had to leave for work at 6am and I have a weather icon that updates every 10 minutes.)

Jun 22 05:21:42 roam pppd[16579]: Starting link
Jun 22 05:22:04 roam pppd[16579]: Serial connection established.
Jun 22 05:22:04 roam pppd[16579]: Connect: ppp0 <--> /dev/modem
Jun 22 05:22:06 roam pppd[16579]: Local IP address changed to 67.1.104.200
Jun 22 05:22:06 roam pppd[16579]: Remote IP address changed to 67.1.96.3
Jun 22 05:22:06 roam pppd[16579]: Script /etc/ppp/ip-up started (pid 16595)
Jun 22 05:22:06 roam pppd[16579]: Script /etc/ppp/ip-up finished (pid 16595), status = 0x0
Jun 22 09:40:32 roam pppd[16579]: Terminating connection due to lack of activity.
Jun 22 09:40:32 roam pppd[16579]: Script /etc/ppp/ip-down started (pid 17057)
Jun 22 09:40:32 roam pppd[16579]: Connection terminated.
Jun 22 09:40:32 roam pppd[16579]: Connect time 258.5 minutes.
Jun 22 09:40:32 roam pppd[16579]: Sent 717344 bytes, received 14285061 bytes.
Jun 22 09:40:32 roam pppd[16579]: Script /etc/ppp/ip-down finished (pid 17057),
status = 0x1

The system then automatically redialed but after that time (9:40am) it was unable to maintain connections, getting disconnected after about 12 minutes each time.

I'm going to let this thing autodial all night and see if maybe it's related to the time-of-day. And this weekend maybe I'll just stay up all night and look at it.

mainbuss
Tl Posts:
145

USA
Posted - 6/22/2004 5:43:58 PM  Show Profile  Email Poster  Edit Message

Edited by - mainbuss on 7/10/2004 10:13:28 PM
error
Tl Posts:
8

USA
Posted - 6/22/2004 5:52:14 PM  Show Profile  Email Poster  Edit Message
It's definitely the right firmware; the flash utility included identifies it as a match. This log from yesterday:

root@roam ~ # tar -zxvf Linux-5686.03.04.05.D.E-v5.4.62.tar.gz
Linux-5686.03.04.05.D.E-v5.4.62/
Linux-5686.03.04.05.D.E-v5.4.62/5686.03.04.05.D.E-v5.4.62.dmf
Linux-5686.03.04.05.D.E-v5.4.62/mdmflash
Linux-5686.03.04.05.D.E-v5.4.62/README
tar: A lone zero block at 987
root@roam ~ # cd Linux-5686.03.04.05.D.E-v5.4.62
root@roam ~/Linux-5686.03.04.05.D.E-v5.4.62 # less README
root@roam ~/Linux-5686.03.04.05.D.E-v5.4.62 # ./mdmflash /dev/modem 5686.03.04.05.D.E-v5.4.62.dmf
Firmware Rev: 5.4.62
Firmware Date: 2004/03/17
This modem firmware is used for the following U.S. Robotics product(s):
00568603
00568604
00568605

This may take a few minutes......
Preparing to download modem firmware
Flash process is finished, checking.......
Your U.S. Robotics modem firmware has successfully loaded.
root@roam ~/Linux-5686.03.04.05.D.E-v5.4.62 #

error
Tl Posts:
8

USA
Posted - 6/23/2004 1:53:09 PM  Show Profile  Email Poster  Edit Message
I called the ISP up and it turns out they thought I was some kind of "heavy user" and so they were disconnecting my connection after a few minutes every time. Everything's fine now. Thanks again for your help and sorry to bother you all with something which turned out to be my fault anyway.
mainbuss
Tl Posts:
145

USA
Posted - 6/23/2004 8:55:22 PM  Show Profile  Email Poster  Edit Message

Edited by - mainbuss on 7/10/2004 10:13:48 PM

Click Here To Close Thread, Administrators & Moderators Only.

Show All Forums |