Ascend Archive
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
(ASCEND) P75 takes longer and longer to connect to Portmaster
Hi all,
I connect to a Portmaster w/5BRI card with my P75.
My problem is that the P75 takes progressively longer to
negotiate with the Portmaster. After a reset, the P75
negotiates the link in just under 2 sec. After 30 or so
connect the negotiation time is up to 5 sec.
An abridged syslog output is included below, generated by
manually calling & disconnecting in succession. Notice the
negotiation starts out at ~2 sec and by the 28th call is
up to ~5 sec.
Using the P75 WANNEXT 128 debug mode command seems
to shed some light on what is happening. The 1st call after
a reset and the 30th differ in only 1 way that I can see. The
first two frames from each of the 1st and 29th call follow:
>XMIT-1:(task: 25BE90, time: 150.92) 25 octets @ 266F14
> [0000]: FF 03 C0 21 01 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
0.00s Sent to port 1: 23 bytes LCP Request-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
>XMIT-1:(task: 23F850, time: 151.90) 25 octets @ 266F14
> [0000]: FF 03 C0 21 01 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
0.98s Sent to port 1: 23 bytes LCP Request-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
After this the negotiations proceed normally (the full output is
included below in case I missed something) in about 1 additional
second. Notice that the P75 retransmits its first request. Why it
does this I don't know, but at this point it seems innocent
enough.
The first two frames of the 29th call:
>XMIT-29:(task: 205914, time: 1296.35) 25 octets @ 266F14
> [0000]: FF 03 C0 21 01 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
0.00s Sent to port 29: 23 bytes LCP Request-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
>XMIT-29:(task: 205914, time: 1300.40) 25 octets @ 266F14
> [0000]: FF 03 C0 21 01 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
4.05s Sent to port 29: 23 bytes LCP Request-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
Notice that they appear identical to those from the 1st call
except for the fact that the P75 waits ~4 sec to do the
retransmission. The rest of the negotiations proceed at
the same rate as the first call, about additional 1 sec.
My questions:
Why does the P75 retransmit the first frame?
Why does the retransmit take longer on successive calls?
Is there anything I can do to get the P75 to consistantly
connect quickly to this Portmaster?
Thanks in advance,
Bill
============ syslog output =================
18:42:27 slot 0 port 0, Ethernet Up
18:42:55 -0 TCP_ACCEPT s=206.168.159.225,1624 d=206.168.159.230,23
18:42:55 -0 OPEN/NOPWD s=206.168.159.225,1624 d=206.168.159.230,23
18:43:00 slot 2 port 1, Outgoing Call, 2253822
18:43:01 slot 2 port 1, line 1, channel 1, Call Connected, MBID 001
18:43:01 call 1 OR slot 2 port 1 64K 2253822
18:43:03 slot 2 port 1, LAN session up, net+
18:49:34 slot 2 port 1, LAN session down, net+
18:49:34 slot 2 port 1, Call Terminated
18:58:07 slot 2 port 1, Outgoing Call, 2253822
18:58:08 slot 2 port 1, line 1, channel 1, Call Connected, MBID 002
18:58:08 call 2 OR slot 2 port 1 64K 2253822
18:58:10 slot 2 port 1, LAN session up, net+
18:58:14 slot 2 port 1, LAN session down, net+
18:58:14 slot 2 port 1, Call Terminated
[ skip to call #28 ]
19:03:29 slot 2 port 1, Outgoing Call, 2253822
19:03:30 slot 2 port 1, line 1, channel 1, Call Connected, MBID 028
19:03:30 call 28 OR slot 2 port 1 64K 2253822
19:03:35 slot 2 port 1, LAN session up, net+
19:03:40 slot 2 port 1, LAN session down, net+
19:03:40 slot 2 port 1, Call Terminated
19:04:01 slot 2 port 1, Outgoing Call, 2253822
19:04:02 slot 2 port 1, line 1, channel 1, Call Connected, MBID 029
19:04:02 call 29 OR slot 2 port 1 64K 2253822
19:04:07 slot 2 port 1, LAN session up, net+
19:04:11 slot 2 port 1, LAN session down, net+
19:04:11 slot 2 port 1, Call Terminated
============== ppp negotiation ===============
Found Ascend dump format
>XMIT-1:(task: 25BE90, time: 150.92) 25 octets @ 266F14
> [0000]: FF 03 C0 21 01 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
0.00s Sent to port 1: 23 bytes LCP Request-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
>XMIT-1:(task: 23F850, time: 151.90) 25 octets @ 266F14
> [0000]: FF 03 C0 21 01 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
0.98s Sent to port 1: 23 bytes LCP Request-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
>RECV-1:(task: 205914, time: 152.43) 33 octets @ 262BE0
> [0000]: FF 03 C0 21 01 18 00 1D 05 06 A6 06 1E 00 03 04
> [0010]: C0 23 11 04 06 1C 12 02 13 09 03 00 C0 05 01 2E
> [0020]: 61
1.51s Recvd from port 1: 31 bytes LCP Request-24
Magic-Number = 0xa6061e00
Authentication-Protocol = PAP
MP-MRRU = 1564
MP-Short-Seq-Num-Header
MP-Endpoint-Disc = 0x0300c005012e61
>RECV-1:(task: 25BE90, time: 152.43) 25 octets @ 2631FC
> [0000]: FF 03 C0 21 02 01 00 15 01 04 05 F4 11 04 05 F4
> [0010]: 13 09 03 00 C0 7B 5D FB A9
1.51s Recvd from port 1: 23 bytes LCP Accept-1
Max-Recieve-Unit = 1524
MP-MRRU = 1524
MP-Endpoint-Disc = 0x0300c07b5dfba9
>XMIT-1:(task: 25BE90, time: 152.44) 10 octets @ 266F14
> [0000]: FF 03 C0 21 04 18 00 06 12 02
1.52s Sent to port 1: 8 bytes LCP Reject-24
MP-Short-Seq-Num-Header
>RECV-1:(task: 205914, time: 152.46) 31 octets @ 263818
> [0000]: FF 03 C0 21 01 19 00 1B 05 06 A6 06 1E 00 03 04
> [0010]: C0 23 11 04 06 1C 13 09 03 00 C0 05 01 2E 61
1.54s Recvd from port 1: 29 bytes LCP Request-25
Magic-Number = 0xa6061e00
Authentication-Protocol = PAP
MP-MRRU = 1564
MP-Endpoint-Disc = 0x0300c005012e61
>XMIT-1:(task: 205914, time: 152.46) 31 octets @ 266F14
> [0000]: FF 03 C0 21 02 19 00 1B 05 06 A6 06 1E 00 03 04
> [0010]: C0 23 11 04 06 1C 13 09 03 00 C0 05 01 2E 61
1.54s Sent to port 1: 29 bytes LCP Accept-25
Magic-Number = 0xa6061e00
Authentication-Protocol = PAP
MP-MRRU = 1564
MP-Endpoint-Disc = 0x0300c005012e61
[ send username and password ]
>RECV-1:(task: 205914, time: 152.73) 24 octets @ 263E34
> [0000]: FF 03 C0 23 02 01 00 14 0F 4C 6F 67 69 6E 20 53
> [0010]: 75 63 63 65 65 64 65 64
1.81s Recvd from port 1: 22 bytes PAP Accept-1
<Login Succeeded>
>RECV-1:(task: 25BE90, time: 152.73) 20 octets @ 264450
> [0000]: FF 03 80 21 01 01 00 10 02 06 00 2D 0F 00 03 06
> [0010]: CE A8 12 F1
1.81s Recvd from port 1: 18 bytes IPCP Request-1
IP Comp Proto = Van Jacobson 15 0
IP Address = 206.168.18.241
>XMIT-1:(task: 205914, time: 152.74) 44 octets @ 267530
> [0000]: FF 03 00 3D C0 00 00 00 80 21 01 01 00 22 03 06
> [0010]: CE A8 9F E6 81 06 00 00 00 00 82 06 00 00 00 00
> [0020]: 83 06 00 00 00 00 84 06 00 00 00 00
1.82s Sent to port 1: 42 bytes m IPCP Request-1
IP Address = 206.168.159.230
Pri DNS = 0.0.0.0
Pri Netbios NS = 0.0.0.0
Sec DNS = 0.0.0.0
Secy Netbios NS = 0.0.0.0
>XMIT-1:(task: 205914, time: 152.74) 20 octets @ 266F14
> [0000]: FF 03 00 3D C0 00 00 01 80 21 04 01 00 0A 02 06
> [0010]: 00 2D 0F 00
1.82s Sent to port 1: 18 bytes m IPCP Reject-1
IP Comp Proto = Van Jacobson 15 0
>RECV-1:(task: 205914, time: 152.76) 14 octets @ 264A6C
> [0000]: FF 03 80 21 04 01 00 0A 84 06 00 00 00 00
1.84s Recvd from port 1: 12 bytes IPCP Reject-1
Secy Netbios NS = 0.0.0.0
>RECV-1:(task: 25BE90, time: 152.77) 18 octets @ 265088
> [0000]: FF 03 80 21 01 02 00 0E 02 04 00 2D 03 06 CE A8
> [0010]: 12 F1
1.85s Recvd from port 1: 16 bytes IPCP Request-2
IP Comp Proto = Van Jacobson *** no parms
IP Address = 206.168.18.241
>XMIT-1:(task: 205914, time: 152.77) 38 octets @ 266F14
1.85s Sent to port 1: 38 bytes unk<0x0>
>XMIT-1:(task: 205914, time: 152.77) 38 octets @ 266F14
> [0010]: CE A8 9F E6 81 06 00 00 00 00 82 06 00 00 00 00
> [0020]: 83 06 00 00 00 00
1.85s Sent to port 1: 38 bytes unk<0xcea8> 9f e6 81 06 00 00 00 00 82 06 00
00 00 00 83 06
>XMIT-1:(task: 205914, time: 152.77) 18 octets @ 267530
> [0000]: FF 03 00 3D C0 00 00 03 80 21 04 02 00 08 02 04
> [0010]: 00 2D
1.85s Sent to port 1: 16 bytes m IPCP Reject-2
IP Comp Proto = Van Jacobson *** no parms
>RECV-1:(task: 205914, time: 152.79) 20 octets @ 2656A4
> [0000]: FF 03 80 21 03 02 00 10 82 06 00 00 00 00 83 06
> [0010]: CC F8 A8 F0
1.87s Recvd from port 1: 18 bytes IPCP Refuse-2
Pri Netbios NS = 0.0.0.0
Sec DNS = 204.248.168.240
>RECV-1:(task: 205914, time: 152.79) 14 octets @ 265CC0
> [0000]: FF 03 80 21 01 03 00 0A 03 06 CE A8 12 F1
1.87s Recvd from port 1: 12 bytes IPCP Request-3
IP Address = 206.168.18.241
>XMIT-1:(task: 205914, time: 152.80) 26 octets @ 267530
> [0000]: FF 03 00 3D C0 00 00 04 80 21 01 03 00 10 03 06
> [0010]: CE A8 9F E6 81 06 00 00 00 00
1.88s Sent to port 1: 24 bytes m IPCP Request-3
IP Address = 206.168.159.230
Pri DNS = 0.0.0.0
>XMIT-1:(task: 205914, time: 152.80) 20 octets @ 266F14
> [0000]: FF 03 00 3D C0 00 00 05 80 21 02 03 00 0A 03 06
> [0010]: CE A8 12 F1
1.88s Sent to port 1: 18 bytes m IPCP Accept-3
IP Address = 206.168.18.241
>RECV-1:(task: 205914, time: 152.82) 14 octets @ 2662DC
> [0000]: FF 03 80 21 03 03 00 0A 81 06 CE A8 12 01
1.90s Recvd from port 1: 12 bytes IPCP Refuse-3
Pri DNS = 206.168.18.1
>XMIT-1:(task: 205914, time: 152.83) 20 octets @ 266F14
> [0000]: FF 03 00 3D C0 00 00 06 80 21 01 04 00 0A 03 06
> [0010]: CE A8 9F E6
1.91s Sent to port 1: 18 bytes m IPCP Request-4
IP Address = 206.168.159.230
>RECV-1:(task: 205914, time: 152.84) 14 octets @ 2668F8
> [0000]: FF 03 80 21 02 04 00 0A 03 06 CE A8 9F E6
1.92s Recvd from port 1: 12 bytes IPCP Accept-4
IP Address = 206.168.159.230
>Skipping:
++ Ascend Users Mailing List ++
To unsubscribe: send unsubscribe to ascend-users-request@bungi.com
To get FAQ'd: <http://www.shore.net/~dreaming/ascend-faq>
or <ftp://ftp.shore.net/members/dreaming/ascend-faq.txt>