[pptp-server] GRE: discarding out of order packet

Eric B Powell powell at agande.com
Thu Mar 9 08:20:59 CST 2000


Hello All!

Been reading the list for a couple of months while getting our PPTP server
up and running. So far so good, but...One client (Win98) using Mindspring
is generating "GRE: discarding out of order packet" errors out wazoo when
he connects. Three other clinets (all three Win98 on different ISP's
(Quest Internet, Netpath and Bellsouth)) can all successfully connect
without problems. I am inclined to believe the problem is on the one
machine or in Mindsprings set-up. Has anyone encountered anything similar?

The last time the client connected, he reported being able to transmitt
data but that the connection was extremely slow (even though it showed a
conenct speed of 48000kbs). Any thoughts?

A snippet from the log from this connection and the traceroute info for
this connection follows.

TIA

Eric

# Start pptpd.log snippet #

Mar  7 09:40:27 poptop pptpd[11634]: CTRL: Client 165.247.116.251 control
connection started
Mar  7 09:40:27 poptop pptpd[11634]: CTRL: Starting call (launching pppd,
opening GRE)
Mar  7 09:40:29 poptop pppd[11635]: pppd 2.3.8 started by root, uid 0
Mar  7 09:40:29 poptop pppd[11635]: Using interface ppp0
Mar  7 09:40:29 poptop pppd[11635]: Connect: ppp0 <--> /dev/pts/2
Mar  7 09:40:29 poptop pppd[11635]: sent [LCP ConfReq id=0x1 <asyncmap
0x0> <auth chap 81> <magic 0x8bbdb282> <pcomp> <accomp>]
Mar  7 09:40:31 poptop pppd[11635]: rcvd [LCP ConfReq id=0x1 <asyncmap
0xa0000> <magic 0x44d7d> <pcomp> <accomp> < 0d 03 06>]
Mar  7 09:40:31 poptop pppd[11635]: sent [LCP ConfRej id=0x1 < 0d 03 06>]
Mar  7 09:40:31 poptop pppd[11635]: rcvd [LCP ConfReq id=0x2 <asyncmap
0xa0000> <magic 0x44d7d> <pcomp> <accomp>]
Mar  7 09:40:31 poptop pppd[11635]: sent [LCP ConfAck id=0x2 <asyncmap
0xa0000> <magic 0x44d7d> <pcomp> <accomp>]
Mar  7 09:40:32 poptop pppd[11635]: sent [LCP ConfReq id=0x1 <asyncmap
0x0> <auth chap 81> <magic 0x8bbdb282> <pcomp> <accomp>]
Mar  7 09:40:32 poptop pppd[11635]: rcvd [LCP ConfNak id=0x1 <auth chap
m$oft> <magic 0x8bbdb282>]
Mar  7 09:40:32 poptop pppd[11635]: sent [LCP ConfReq id=0x2 <asyncmap
0x0> <auth chap m$oft> <magic 0x2191067b> <pcomp> <accomp>]
Mar  7 09:40:33 poptop pppd[11635]: rcvd [LCP ConfAck id=0x2 <asyncmap
0x0> <auth chap m$oft> <magic 0x2191067b> <pcomp> <accomp>]
Mar  7 09:40:33 poptop pppd[11635]: sent [CHAP Challenge id=0x1
<81b5977075950c47>, name = "poptop"]
Mar  7 09:40:33 poptop pppd[11635]: rcvd [CHAP Response id=0x1
<065b8c46c4ee37fb6dde4b2976e9d6fc7ec36e6aa34189d0e3ce224862d560a6a35c53cfd17c4d5b6a7499a0766d258b01>,
name = "XXXXX"]
Mar  7 09:40:33 poptop pppd[11635]: sent [CHAP Success id=0x1 "Welcome to
poptop."]
Mar  7 09:40:33 poptop pppd[11635]: sent [IPCP ConfReq id=0x1 <addr
207.3.16.162> <compress VJ 0f 01>]
Mar  7 09:40:35 poptop modprobe: can't locate module ppp-compress-18
Mar  7 09:40:38 poptop modprobe: can't locate module ppp-compress-18
Mar  7 09:40:38 poptop pppd[11635]: sent [CCP ConfReq id=0x1 <deflate 15>
<deflate(old#) 15> <bsd v1 15>]
Mar  7 09:40:38 poptop pppd[11635]: MSCHAP peer authentication succeeded
for xxxxxx
Mar  7 09:40:38 poptop pppd[11635]: sent [IPCP ConfReq id=0x1 <addr
207.3.16.162> <compress VJ 0f 01>]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [IPCP ConfReq id=0x1 <addr
0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 192.168.1.1> <ms-dns3 0.0.0.0>
<ms-wins 0.0.0.0>]
Mar  7 09:40:38 poptop pppd[11635]: sent [IPCP ConfRej id=0x1 <ms-dns1
0.0.0.0> <ms-dns3 0.0.0.0>]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [IPCP ConfReq id=0x2 <addr
0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 192.168.1.1> <ms-dns3 0.0.0.0>
<ms-wins 0.0.0.0>]
Mar  7 09:40:38 poptop pppd[11635]: sent [IPCP ConfRej id=0x2 <ms-dns1
0.0.0.0> <ms-dns3 0.0.0.0>]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [LCP ProtRej id=0x3 80 fd 01 01
00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [IPCP ConfRej id=0x1 <compress VJ
0f 01>]
Mar  7 09:40:38 poptop pppd[11635]: sent [IPCP ConfReq id=0x2 <addr
207.3.16.162>]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [IPCP ConfReq id=0x3 <addr
0.0.0.0> <ms-wins 192.168.1.1> <ms-wins 0.0.0.0>]
Mar  7 09:40:38 poptop pppd[11635]: sent [IPCP ConfNak id=0x3 <addr
192.168.1.126> <ms-wins 192.168.1.1>]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [IPCP ConfAck id=0x2 <addr
207.3.16.162>]
Mar  7 09:40:38 poptop pppd[11635]: rcvd [IPCP ConfReq id=0x4 <addr
192.168.1.126> <ms-wins 192.168.1.1> <ms-wins 192.168.1.1>]
Mar  7 09:40:38 poptop pppd[11635]: sent [IPCP ConfAck id=0x4 <addr
192.168.1.126> <ms-wins 192.168.1.1> <ms-wins 192.168.1.1>]
Mar  7 09:40:38 poptop pppd[11635]: found interface eth0 for proxy arp
Mar  7 09:40:38 poptop pppd[11635]: local  IP address 207.3.16.162
Mar  7 09:40:38 poptop pppd[11635]: remote IP address 192.168.1.126
Mar  7 09:40:38 poptop pppd[11635]: Script /etc/ppp/ip-up started (pid
11645)
Mar  7 09:40:41 poptop pppd[11635]: Script /etc/ppp/ip-up finished (pid
11645), status = 0x0
Mar  7 09:42:16 poptop pptpd[11634]: GRE: Discarding out of order packet
Mar  7 09:42:53 poptop last message repeated 3 times
Mar  7 09:43:54 poptop last message repeated 7 times
Mar  7 09:44:56 poptop last message repeated 7 times
Mar  7 09:45:58 poptop last message repeated 8 times
Mar  7 09:47:18 poptop last message repeated 10 times
Mar  7 09:48:21 poptop last message repeated 7 times
Mar  7 09:49:29 poptop last message repeated 15 times
Mar  7 09:50:37 poptop last message repeated 9 times
Mar  7 09:51:49 poptop last message repeated 8 times
Mar  7 09:52:50 poptop last message repeated 9 times
Mar  7 09:53:07 poptop last message repeated 5 times
Mar  7 09:53:43 poptop pppd[11635]: rcvd [LCP TermReq id=0x4]
Mar  7 09:53:43 poptop pppd[11635]: LCP terminated by peer
Mar  7 09:53:43 poptop pppd[11635]: Script /etc/ppp/ip-down started (pid
11678)
Mar  7 09:53:43 poptop pppd[11635]: sent [LCP TermAck id=0x4]
Mar  7 09:53:44 poptop pptpd[11634]: CTRL: Error with select(), quitting
Tue Mar  7 09:53:44 EST 2000: ip-down   1:ppp0 2:/dev/pts/2 3:115200
4:207.3.16.162 5:192.168.1.126 6:
Mar  7 09:53:44 poptop pptpd[11634]: CTRL: Client 165.247.116.251 control
connection finished
Mar  7 09:53:44 poptop pppd[11635]: Modem hangup
Mar  7 09:53:44 poptop pppd[11635]: Connection terminated.
Mar  7 09:53:44 poptop pppd[11635]: Connect time 13.3 minutes.
Mar  7 09:53:44 poptop pppd[11635]: Sent 162963 bytes, received 1130489
bytes.
Mar  7 09:53:44 poptop pppd[11635]: Waiting for 1 child processes...
Mar  7 09:53:44 poptop pppd[11635]:   script /etc/ppp/ip-down, pid 11678
Tue Mar  7 09:53:44 EST 2000: ip-down  Firewall rules removed for
ppp0:192.168.1.126
Mar  7 09:53:45 poptop pppd[11635]: Script /etc/ppp/ip-down finished (pid
11678), status = 0x0
Mar  7 09:53:45 poptop pppd[11635]: Exit.
Mar  9 08:50:21 poptop ftpd[12715]: FTP LOGIN FROM powell @ Tux.agande.com
[192.168.1.121], ebpowell

# End snippet#

Traceoute data from our location to his address:

# begin traceroute: #

 1  ADSL.ATM40.RedBack.Greensboro.netmcr.com (207.3.16.1)  56.501 ms
26.970 ms  16.658 ms
 2  Ethernet1.Cisco4700M.Greensboro.netmcr.com (206.154.10.1)  19.758 ms
14.346 ms  17.496 ms
 3  border7-serial4-1-4.Greensboro.cw.net (204.70.227.125)  50.933 ms
23.291 ms  22.070 ms
 4  core2-fddi-0.Greensboro.cw.net (204.70.80.49)  133.869 ms  204.526 ms
256.648 ms
 5  core7.Washington.cw.net (204.70.4.117)  33.220 ms  71.556 ms  28.342
ms
 6  dca1-core10-s3-1.atlas.digex.net (165.117.59.25)  44.118 ms  48.390 ms
35.243 ms
 7  dca1-core11-pos7-0.atlas.digex.net (165.117.48.198)  41.653 ms  27.510
ms  30.565 ms
 8  dca1-core12-pos7-0.atlas.digex.net (165.117.48.202)  61.445 ms  28.905
ms  38.940 ms
 9  atl2-core2-s1-1-0.atlas.digex.net (165.117.51.109)  68.578 ms  98.246
ms  68.290 ms
10  cisco-2-h1-0.atl2.mindspring.net (209.49.169.166)  61.072 ms  70.494
ms  73.074 ms
11  cisco-3-f4-1-0.atl2.mindspring.net (207.69.223.172)  55.963 ms  58.863
ms  67.215 ms
12  cisco-s0-0-1-1.colum2.mindspring.net (207.69.131.118)  50.998 ms
79.489 ms  55.257 ms
13  cisco-s6-0-0.rtp.mindspring.net (207.69.131.114)  75.893 ms  66.152 ms
69.253 ms
14  cisco-s2-0-1.norva2.mindspring.net (207.69.230.241)  90.486 ms
127.399 ms  91.651 ms
15  209.86.66.174 (209.86.66.174)  108.627 ms  97.339 ms  101.990 ms
16  arc-5a.rmond.mindspring.net (207.69.144.92)  114.204 ms  100.371 ms
97.749 ms
17  user-2ivet7r.dialup.mindspring.com (165.247.116.251)  215.855 ms
211.286 ms  216.013 ms

#End traceroute

Eric B Powell
Network Administrator
Applied Geosciences and Engineering
405-A Parkway Dr
Greensboro, NC 27401
Phone: (336) 274-9456
Fax: (336) 274-9486
E-mail: Powell at AGandE.com
Website: http://www.agande.com






More information about the pptp-server mailing list