[pptp-server] Fw: [LRP] cant ping the client and others

Christopher Kuhl chrisk at ciris.net
Thu Nov 4 19:16:44 CST 1999


I sorry for putting this on both lists, but I'm not sure which is causing
the problem.
>Below is a sample of my setup and my log files to see if anyone can see
>anything.
>
>
>-----Original Message-----
>From: Christopher Kuhl <chrisk at ciris.net>
>To: linux-router at linuxrouter.org <linux-router at linuxrouter.org>
>Date: Thursday, November 04, 1999 2:11 PM
>Subject: Re: [LRP] cant ping the client and others
>
>
>>I am having the same problem.  I have asked for help serveral times with
no
>>results.  My setup is this:
>>
>>private
>>network(10.111.1.0/24)-----LRP+POPTOP(10.111.1.1)--------internet------LRP
+
>P
>>PTP client(10.111.200.1)-----private network(10.111.200.0/24)
>>
>>I am using poptop on one side and the linux pptp client on the other.
When
>>I connect to the Poptop server with a Windows machine I can ping and use
>the
>>entire network fine.  But from the linux pptp client, I can only ping the
>>Poptop router(ping 10.111.1.1) and vice versa.  I can not ping other
>>machines on the remote network.  I changed my ip-up and down scripts to
add
>>and delete routes like this
>>
>>Poptop side:
>>route add -net 10.111.200.0 netmask 255.255.255.0 gw $5 $1   ;  $5 is the
>ip
>>address I am giving the client router.
>>
>>Cleint side:
>>route add -net 10.111.1.0 netmask 255.255.255.0 gw $5 $1   ; $5 is the
>>remote ip that is passed by pppd.
>>
>>I checked my routing tables, and they are correct.  I also delete these
>>routes when ip-down runs.
>>
>>In my firewall scripts, I only masq connection going the ppp0 interface,
no
>>other interface.  I added two rules to allow traffic on ppp0:
>>
>>ipfwadm -I -a accept -W ppp1
>>ipfwadm -O -a accept -Wppp1
>>
>>Now, if I go back and masq this interface also, it does work fine, but I
>get
>>a lot of TCP/UDP checksum errors and makes things very, very unstable.
>This
>>does tell me however that my trafic is not being stopped by the firewall.
>I
>>do have ip forwarding enabled, and I tried using ips on the same subnet
>with
>>proxyarp, but I had the same results.  I can post my firewall, ip-up,
>>ip-down scripts, and anything else you might need, just let me know.  I
>just
>>want you guys to realize that I am not looking to get someone to just do
>>this for me, I have read everthing I can think of, I even tried gated.
>>
>
>i  ifconfig -a
>lo        Link encap:Local Loopback
>          inet addr:127.0.0.1  Bcast:127.255.255.255  Mask:255.0.0.0
>          UP BROADCAST LOOPBACK RUNNING  MTU:3584  Metric:1
>          RX packets:33 errors:0 dropped:0 overruns:0 frame:0
>          TX packets:33 errors:0 dropped:0 overruns:0 carrier:0
>          Collisions:0
>
>eth0      Link encap:Ethernet  HWaddr 00:C0:F0:44:5B:E7
>          inet addr:10.111.1.1  Bcast:10.111.1.255  Mask:255.255.255.0
>          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
>          RX packets:2228 errors:0 dropped:0 overruns:0 frame:0
>          TX packets:8049 errors:0 dropped:0 overruns:0 carrier:0
>          Collisions:0
>          Interrupt:10 Base address:0x300
>
>ppp0      Link encap:Point-to-Point Protocol
>          inet addr:207.51.XXX.XXX  P-t-P:207.51.228.8  Mask:255.255.255.0
>          UP POINTOPOINT RUNNING NOARP MULTICAST  MTU:1500  Metric:1
>          RX packets:2632 errors:0 dropped:0 overruns:0 frame:0
>          TX packets:2270 errors:0 dropped:0 overruns:0 carrier:0
>          Collisions:0
>
>ppp2      Link encap:Point-to-Point Protocol
>          inet addr:10.111.1.10  P-t-P:10.111.1.29  Mask:255.255.255.0
>          POINTOPOINT NOARP MULTICAST  MTU:1500  Metric:1
>          RX packets:27 errors:0 dropped:0 overruns:0 frame:0
>          TX packets:28 errors:0 dropped:0 overruns:0 carrier:0
>          Collisions:0
>
>ppp1      Link encap:Point-to-Point Protocol
>          inet addr:10.111.1.10  P-t-P:10.111.1.29  Mask:255.255.255.0
>          UP POINTOPOINT RUNNING NOARP MULTICAST  MTU:1500  Metric:1
>          RX packets:17 errors:0 dropped:0 overruns:0 frame:0
>          TX packets:19 errors:0 dropped:0 overruns:0 carrier:0
>          Collisions:0
>
>hrouter# route -n
>Kernel IP routing table
>Destination     Gateway         Genmask         Flags Metric Ref    Use
>Iface
>127.0.0.1       0.0.0.0         255.255.255.255 UH    0      0        2 lo
>207.51.XXX.XXX  0.0.0.0         255.255.255.255 UH    0      0        0
ppp0
>207.51.XXX.XXX  0.0.0.0         255.255.255.255 UH    0      0        1 lo
>10.111.1.29     0.0.0.0         255.255.255.255 UH    0      0        0
ppp1
>10.111.1.10     0.0.0.0         255.255.255.255 UH    0      0        0 lo
>10.111.1.0      0.0.0.0         255.255.255.0   U     0      0       11
eth0
>10.111.200.0    10.111.1.29     255.255.255.0   UG    0      0        1
ppp1
>0.0.0.0         207.51.XXX.XXX  0.0.0.0         UG    0      0       31
ppp0
>
>
>hrouter# cat /var/log/syslog
>Nov  4 13:53:04 hrouter syslogd 1.3-3#31: restart.
>Nov  4 13:53:04 hrouter kernel: klogd 1.3-3#31, log source = /proc/kmsg
>started.
>Nov  4 13:53:04 hrouter kernel: Cannot find map file.
>Nov  4 13:53:04 hrouter kernel: Loaded 84 symbols from 15 modules.
>Nov  4 13:53:04 hrouter kernel: Memory: sized by int13 088h
>Nov  4 13:53:04 hrouter kernel: Console: 16 point font, 400 scans
>Nov  4 13:53:04 hrouter kernel: Console: mono EGA+ 80x25, 1 virtual console
>(max 63)
>Nov  4 13:53:04 hrouter kernel: pcibios_init : BIOS32 Service Directory
>structure at 0x000f5b20
>Nov  4 13:53:04 hrouter kernel: pcibios_init : BIOS32 Service Directory
>entry at 0xfd1e4
>Nov  4 13:53:04 hrouter kernel: pcibios_init : PCI BIOS revision 2.10 entry
>at 0xfce08
>Nov  4 13:53:04 hrouter kernel: Probing PCI hardware.
>Nov  4 13:53:04 hrouter kernel: PCI bridge optimization.
>Nov  4 13:53:04 hrouter kernel:     Cache L2: Not supported.
>Nov  4 13:53:04 hrouter kernel:     CPU-PCI posted write: Not supported.
>Nov  4 13:53:04 hrouter kernel:     CPU-Memory posted write: Not supported.
>Nov  4 13:53:04 hrouter kernel:     PCI-Memory posted write: Not supported.
>Nov  4 13:53:04 hrouter kernel:     PCI burst: Not supported.
>Nov  4 13:53:04 hrouter kernel: Calibrating delay loop.. ok - 49.87
BogoMIPS
>Nov  4 13:53:04 hrouter kernel: Memory: 30108k/32768k available (652k
kernel
>code, 384k reserved, 812k data)
>Nov  4 13:53:04 hrouter kernel: This processor honours the WP bit even when
>in supervisor mode. Good.
>Nov  4 13:53:04 hrouter kernel: Swansea University Computer Society
NET3.035
>for Linux 2.0
>Nov  4 13:53:04 hrouter kernel: NET3: Unix domain sockets 0.13 for Linux
>NET3.035.
>Nov  4 13:53:04 hrouter kernel: Swansea University Computer Society TCP/IP
>for NET3.034
>Nov  4 13:53:04 hrouter kernel: IP Protocols: IGMP, ICMP, UDP, TCP
>Nov  4 13:53:04 hrouter kernel: Linux IP multicast router 0.07.
>Nov  4 13:53:04 hrouter kernel: Checking 386/387 coupling... Ok, fpu using
>exception 16 error reporting.
>Nov  4 13:53:04 hrouter kernel: Checking 'hlt' instruction... Ok.
>Nov  4 13:53:04 hrouter kernel: Linux version 2.0.36 (root at ccrouter) (gcc
>version 2.7.2.3) #2 Wed Oct 27 14:24:53 CDT 1999
>Nov  4 13:53:04 hrouter kernel: Starting kswapd v 1.4.2.2
>Nov  4 13:53:04 hrouter kernel: Software Watchdog Timer: 0.04, timer
margin:
>60 sec
>Nov  4 13:53:04 hrouter kernel: Real Time Clock Driver v1.09
>Nov  4 13:53:04 hrouter kernel: Ramdisk driver initialized : 16 ramdisks of
>10240K size
>Nov  4 13:53:04 hrouter kernel: loop: registered device at major 7
>Nov  4 13:53:04 hrouter kernel: hda: QUANTUM FIREBALL_TM1280A, 1222MB
w/76kB
>Cache, CHS=621/64/63
>Nov  4 13:53:04 hrouter kernel: ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
>Nov  4 13:53:04 hrouter kernel: Floppy drive(s): fd0 is 1.44M
>Nov  4 13:53:04 hrouter kernel: FDC 0 is a post-1991 82077
>Nov  4 13:53:04 hrouter kernel: Ethernet Bridge 002 for NET3.035 (Linux
2.0)
>Nov  4 13:53:04 hrouter kernel: Partition check:
>Nov  4 13:53:04 hrouter kernel:  hda: hda1 hda2 < hda5 >
>Nov  4 13:53:04 hrouter kernel: RAMDISK: Compressed image found at block 0
>Nov  4 13:53:04 hrouter kernel: RAMDISK: Auto Filesystem - minix: 3413i
>10240bk 112fdz(112) 1024zs 2147483647ms
>Nov  4 13:53:04 hrouter kernel: RAMDISK: Uncompressing root archive: done.
>Nov  4 13:53:04 hrouter kernel: VFS: Mounted root (minix filesystem).
>Nov  4 13:53:04 hrouter kernel: RAMDISK: Extracting root archive: done.
>Nov  4 13:53:04 hrouter kernel: Serial driver version 4.13 with no serial
>options enabled
>Nov  4 13:53:04 hrouter kernel: tty01 at 0x02f8 (irq = 3) is a 16550A
>Nov  4 13:53:04 hrouter kernel: ne.c:v1.10 9/23/94 Donald Becker
>(becker at cesdis.gsfc.nasa.gov)
>Nov  4 13:53:04 hrouter kernel: NE*000 ethercard probe at 0x300: 00 c0 f0
44
>5b e7
>Nov  4 13:53:04 hrouter kernel: eth0: NE2000 found at 0x300, using IRQ 10.
>Nov  4 13:53:04 hrouter kernel: WAN Router v1.1 (c) 1995-1997 Sangoma
>Technologies Inc.
>Nov  4 13:53:04 hrouter kernel: CSLIP: code copyright 1989 Regents of the
>University of California
>Nov  4 13:53:04 hrouter kernel: PPP: version 2.3.8 (demand dialling)
>Nov  4 13:53:04 hrouter kernel: PPP line discipline registered.
>Nov  4 13:53:04 hrouter kernel: PPP BSD Compression module registered
>Nov  4 13:53:04 hrouter kernel: PPP Deflate Compression module registered
>Nov  4 13:53:04 hrouter kernel: PPP MPPE compression module registered
>Nov  4 13:53:04 hrouter /usr/sbin/cron[697]: (CRON) STARTUP (fork ok)
>Nov  4 13:53:05 hrouter gated[703]: Start gated[703] version 3-5-8 built
Sun
>Feb 15 03:50:14 GMT 1998
>Nov  4 13:53:05 hrouter gated[703]: trace_on: tracing to
>"/var/log/gated.log" started
>Nov  4 13:53:05 hrouter gated[703]: Commence routing updates
>Nov  4 13:53:05 hrouter named[705]: starting.  named 8.1.2-T3B Sun Jan  3
>23:06:10 MST 1999
>
>^Ibdale at rover:/home/bdale/debian/bind-8.1.2/target/bin/named
>Nov  4 13:53:05 hrouter named[705]: cache zone "" (IN) loaded (serial 0)
>Nov  4 13:53:05 hrouter named[705]: master zone "localhost" (IN) loaded
>(serial 1)
>Nov  4 13:53:05 hrouter named[705]: master zone "0.0.127.in-addr.arpa" (IN)
>loaded (serial 1)
>Nov  4 13:53:05 hrouter named[705]: listening on [127.0.0.1].53 (lo)
>Nov  4 13:53:05 hrouter named[705]: listening on [10.111.1.1].53 (eth0)
>Nov  4 13:53:05 hrouter named[705]: Forwarding source address is
>[0.0.0.0].1029
>Nov  4 13:53:05 hrouter named[706]: Ready to answer queries.
>Nov  4 13:53:05 hrouter kernel: registered device ppp0
>Nov  4 13:53:05 hrouter pppd[712]: pppd 2.3.8 started by root, uid 0
>Nov  4 13:53:05 hrouter pptpd[715]: MGR: Manager process started
>Nov  4 13:53:06 hrouter connect: Initializing Modem
>Nov  4 13:53:07 hrouter connect: Dialing system
>Nov  4 13:53:28 hrouter connect: Connected
>Nov  4 13:53:28 hrouter connect: Loggin in
>Nov  4 13:53:31 hrouter connect: Protocol started
>Nov  4 13:53:31 hrouter pppd[712]: Serial connection established.
>Nov  4 13:53:31 hrouter pppd[712]: Using interface ppp0
>Nov  4 13:53:31 hrouter pppd[712]: Connect: ppp0 <--> /dev/ttyS1
>Nov  4 13:53:32 hrouter pppd[712]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
><magic 0xf7d558e9> <pcomp> <accomp>]
>Nov  4 13:53:32 hrouter pppd[712]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0>
><magic 0xf7d558e9> <pcomp> <accomp>]
>Nov  4 13:53:34 hrouter pppd[712]: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0>
><magic 0x974730d1> <pcomp> <accomp>]
>Nov  4 13:53:34 hrouter pppd[712]: sent [LCP ConfAck id=0x2 <asyncmap 0x0>
><magic 0x974730d1> <pcomp> <accomp>]
>Nov  4 13:53:34 hrouter pppd[712]: sent [IPCP ConfReq id=0x1 <addr
>207.51.228.149> <compress VJ 0f 01>]
>Nov  4 13:53:34 hrouter pppd[712]: sent [CCP ConfReq id=0x1 <deflate 15>
><deflate(old#) 15> <bsd v1 15>]
>Nov  4 13:53:34 hrouter pppd[712]: rcvd [IPCP ConfReq id=0x1 <compress VJ
0f
>00> <addr 207.51.228.8>]
>Nov  4 13:53:34 hrouter pppd[712]: sent [IPCP ConfAck id=0x1 <compress VJ
0f
>00> <addr 207.51.228.8>]
>Nov  4 13:53:34 hrouter pppd[712]: rcvd [IPCP ConfAck id=0x1 <addr
>207.51.228.149> <compress VJ 0f 01>]
>Nov  4 13:53:34 hrouter pppd[712]: local  IP address 207.51.XXX.XXX
>Nov  4 13:53:34 hrouter pppd[712]: remote IP address 207.51.XXX.XXX
>Nov  4 13:53:34 hrouter pppd[712]: Script /etc/ppp/ip-up started (pid 730)
>Nov  4 13:53:34 hrouter pppd[712]: rcvd [LCP ProtRej id=0x3 80 fd 01 01 00
>0f 1a 04 78 00 18 04 78 00 15 03 2f]
>Nov  4 13:53:34 hrouter ip-up: ppp0 /dev/ttyS1 38400 207.51.XXX.XXX
>207.51.XXX.XXX
>Nov  4 13:53:34 hrouter pppd[712]: Script /etc/ppp/ip-up finished (pid
730),
>status = 0x0
>Nov  4 13:53:34 hrouter gated[703]: EVENT <Add> ppp0 index 3 <Up
>PointToPoint Multicast> address 802.2 0:0:0:0:0:0
>Nov  4 13:53:34 hrouter gated[703]: EVENT Add ppp0 207.51.XXX.XXX ->
>207.51.XXX.XXX <Up PointToPoint Multicast>
>Nov  4 14:00:00 hrouter /USR/SBIN/CRON[738]: (root) CMD (/etc/multicron-p)
>Nov  4 14:15:00 hrouter /USR/SBIN/CRON[751]: (root) CMD (/etc/multicron-p)
>Nov  4 14:30:00 hrouter /USR/SBIN/CRON[756]: (root) CMD (/etc/multicron-p)
>Nov  4 14:31:07 hrouter pptpd[760]: MGR: Launching /usr/local/sbin/pptpctrl
>to handle client
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: local address = 10.111.1.10
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: remote address = 10.111.1.20
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: pppd speed = 38400
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: pppd options file =
>/etc/ppp/pptpd.options
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: Client 12.73.237.96 control
>connection started
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: Received PPTP Control Message
>(type: 1)
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: Made a START CTRL CONN RPLY
packet
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: I wrote 156 bytes to the client.
>Nov  4 14:31:07 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: Received PPTP Control Message
>(type: 7)
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: Set parameters to 152 maxbps, 3
>window size
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: Made a OUT CALL RPLY packet
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: Starting call (launching pppd,
>opening GRE)
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: pty_fd = 5
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: tty_fd = 6
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: I wrote 32 bytes to the client.
>Nov  4 14:31:08 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:31:08 hrouter pptpd[761]: CTRL (PPPD Launcher): Connection speed
=
>38400
>Nov  4 14:31:08 hrouter pptpd[761]: CTRL (PPPD Launcher): local address =
>10.111.1.10
>Nov  4 14:31:08 hrouter pptpd[761]: CTRL (PPPD Launcher): remote address =
>10.111.1.20
>Nov  4 14:31:09 hrouter pppd[761]: pppd 2.3.8 started by root, uid 0
>Nov  4 14:31:09 hrouter kernel: registered device ppp1
>Nov  4 14:31:09 hrouter pppd[761]: Using interface ppp1
>Nov  4 14:31:09 hrouter pppd[761]: Connect: ppp1 <--> /dev/ttyp0
>Nov  4 14:31:09 hrouter pppd[761]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x7a0e52e0> <pcomp>
>
><accomp>]
>Nov  4 14:31:12 hrouter pppd[761]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x7a0e52e0> <pcomp>
>
><accomp>]
>Nov  4 14:31:12 hrouter pptpd[760]: GRE: Discarding duplicate packet
>Nov  4 14:31:12 hrouter pppd[761]: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x3b3e2ddd> <pcomp>
>
><accomp>]
>Nov  4 14:31:12 hrouter pppd[761]: sent [LCP ConfAck id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x3b3e2ddd> <pcomp>
>
><accomp>]
>Nov  4 14:31:15 hrouter pppd[761]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x7a0e52e0> <pcomp>
>
><accomp>]
>Nov  4 14:31:15 hrouter pppd[761]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x7a0e52e0> <pcomp>
>
><accomp>]
>Nov  4 14:31:21 hrouter pppd[761]: MSCHAP-v2 peer authentication succeeded
>for ccrouter
>Nov  4 14:31:22 hrouter pppd[761]: rcvd [IPCP ConfReq id=0x1 <addr 0.0.0.0>
><compress VJ 0f 01>]
>Nov  4 14:31:22 hrouter pppd[761]: sent [IPCP ConfNak id=0x1 <addr
>10.111.1.29>]
>Nov  4 14:31:22 hrouter pppd[761]: rcvd [CCP ConfReq id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:31:22 hrouter kernel: options are bad: 1a 4
>Nov  4 14:31:22 hrouter pppd[761]: sent [CCP ConfAck id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:31:22 hrouter kernel: compress rejected:
opt_len=17,o[0]=1a,o[1]=4
>Nov  4 14:31:22 hrouter pppd[761]: rcvd [IPCP ConfAck id=0x1 <addr
>10.111.1.10> <compress VJ 0f 01>]
>Nov  4 14:31:22 hrouter pppd[761]: rcvd [CCP ConfAck id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:31:22 hrouter pppd[761]: Deflate (15) compression enabled
>Nov  4 14:31:22 hrouter pppd[761]: rcvd [IPCP ConfReq id=0x2 <addr
>10.111.1.29> <compress VJ 0f 01>]
>Nov  4 14:31:22 hrouter pppd[761]: sent [IPCP ConfAck id=0x2 <addr
>10.111.1.29> <compress VJ 0f 01>]
>Nov  4 14:31:22 hrouter pppd[761]: local  IP address 10.111.1.10
>Nov  4 14:31:22 hrouter pppd[761]: remote IP address 10.111.1.29
>Nov  4 14:31:22 hrouter pppd[761]: Script /etc/ppp/ip-up started (pid 762)
>Nov  4 14:31:22 hrouter ip-up: ppp1 /dev/ttyp0 38400 10.111.1.10
10.111.1.29
>Nov  4 14:31:22 hrouter pppd[761]: Script /etc/ppp/ip-up finished (pid
762),
>status = 0x0
>Nov  4 14:31:34 hrouter gated[703]: EVENT <Add> ppp1 index 4 <Up
>PointToPoint Multicast> address 802.2 0:0:0:0:0:0
>Nov  4 14:31:34 hrouter gated[703]: EVENT Add ppp1 10.111.1.10 ->
>10.111.1.29 <Up PointToPoint Multicast>
>Nov  4 14:32:09 hrouter pptpd[760]: CTRL: Received PPTP Control Message
>(type: 5)
>Nov  4 14:32:09 hrouter pptpd[760]: CTRL: Made a ECHO RPLY packet
>Nov  4 14:32:09 hrouter pptpd[760]: CTRL: I wrote 20 bytes to the client.
>Nov  4 14:32:09 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:33:09 hrouter pptpd[760]: CTRL: Received PPTP Control Message
>(type: 5)
>Nov  4 14:33:09 hrouter pptpd[760]: CTRL: Made a ECHO RPLY packet
>Nov  4 14:33:09 hrouter pptpd[760]: CTRL: I wrote 20 bytes to the client.
>Nov  4 14:33:09 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:34:14 hrouter pptpd[760]: CTRL: Sending ECHO REQ id 1
>Nov  4 14:34:14 hrouter pptpd[760]: CTRL: Made a ECHO REQ packet
>Nov  4 14:34:14 hrouter pptpd[760]: CTRL: I wrote 16 bytes to the client.
>Nov  4 14:34:14 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:35:13 hrouter pptpd[770]: MGR: Launching /usr/local/sbin/pptpctrl
>to handle client
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: local address = 10.111.1.10
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: remote address = 10.111.1.21
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: pppd speed = 38400
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: pppd options file =
>/etc/ppp/pptpd.options
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: Client 12.73.237.69 control
>connection started
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: Received PPTP Control Message
>(type: 1)
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: Made a START CTRL CONN RPLY
packet
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: I wrote 156 bytes to the client.
>Nov  4 14:35:13 hrouter pptpd[770]: CTRL: Sent packet to client
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: Received PPTP Control Message
>(type: 7)
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: Set parameters to 152 maxbps, 3
>window size
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: Made a OUT CALL RPLY packet
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: Starting call (launching pppd,
>opening GRE)
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: pty_fd = 5
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: tty_fd = 6
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: I wrote 32 bytes to the client.
>Nov  4 14:35:14 hrouter pptpd[771]: CTRL (PPPD Launcher): Connection speed
=
>38400
>Nov  4 14:35:14 hrouter pptpd[771]: CTRL (PPPD Launcher): local address =
>10.111.1.10
>Nov  4 14:35:14 hrouter pptpd[771]: CTRL (PPPD Launcher): remote address =
>10.111.1.21
>Nov  4 14:35:14 hrouter pptpd[770]: CTRL: Sent packet to client
>Nov  4 14:35:14 hrouter pppd[771]: pppd 2.3.8 started by root, uid 0
>Nov  4 14:35:14 hrouter kernel: registered device ppp2
>Nov  4 14:35:14 hrouter pppd[771]: Using interface ppp2
>Nov  4 14:35:14 hrouter pppd[771]: Connect: ppp2 <--> /dev/ttyp1
>Nov  4 14:35:14 hrouter pppd[771]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0xe1c760d1> <pcomp>
>
><accomp>]
>Nov  4 14:35:16 hrouter pptpd[770]: GRE: Discarding duplicate packet
>Nov  4 14:35:17 hrouter pppd[771]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0xe1c760d1> <pcomp>
>
><accomp>]
>Nov  4 14:35:17 hrouter pppd[771]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0xe1c760d1> <pcomp>
>
><accomp>]
>Nov  4 14:35:17 hrouter pppd[771]: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x81678fd8> <pcomp>
>
><accomp>]
>Nov  4 14:35:17 hrouter pppd[771]: sent [LCP ConfAck id=0x1 <asyncmap 0x0>
><auth chap 81> <magic 0x81678fd8> <pcomp>
>
><accomp>]
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Session timed out, ending call
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Client 12.73.237.96 control
>connection finished
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Exiting with active call
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Made a CALL DISCONNECT RPLY
packet
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: I wrote 148 bytes to the client.
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Made a STOP CTRL REQ packet
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: I wrote 16 bytes to the client.
>Nov  4 14:35:19 hrouter pptpd[760]: CTRL: Sent packet to client
>Nov  4 14:35:19 hrouter pppd[761]: Modem hangup
>Nov  4 14:35:19 hrouter pppd[761]: Script /etc/ppp/ip-down started (pid
772)
>Nov  4 14:35:19 hrouter pppd[761]: Connection terminated.
>Nov  4 14:35:19 hrouter pppd[761]: Connect time 4.2 minutes.
>Nov  4 14:35:19 hrouter pppd[761]: Sent 1403 bytes, received 1617 bytes.
>Nov  4 14:35:19 hrouter pppd[761]: Waiting for 1 child processes...
>Nov  4 14:35:19 hrouter pppd[761]:   script /etc/ppp/ip-down, pid 772
>Nov  4 14:35:19 hrouter ip-down: ppp1 /dev/ttyp0 38400 10.111.1.10
>10.111.1.29
>Nov  4 14:35:19 hrouter pppd[761]: Script /etc/ppp/ip-down finished (pid
>772), status = 0x0
>Nov  4 14:35:19 hrouter pppd[761]: Exit.
>Nov  4 14:35:19 hrouter gated[703]: EVENT <Delete UpDown> ppp1 index 4
><PointToPoint Multicast> address 802.2 0:0:0:0:0:0
>Nov  4 14:35:19 hrouter gated[703]: EVENT Delete UpDown ppp1 10.111.1.10 ->
>10.111.1.29 <PointToPoint Multicast>
>Nov  4 14:35:19 hrouter gated[703]: KRT SEND DELETE 10.111.1.10     mask
>255.255.255.255 router 127.0.0.1       flags <UP GW
>
>HOST>7: No such process
>Nov  4 14:35:21 hrouter pppd[771]: MSCHAP-v2 peer authentication succeeded
>for ccrouter
>Nov  4 14:35:21 hrouter pppd[771]: sent [IPCP ConfReq id=0x1 <addr
>10.111.1.10> <compress VJ 0f 01>]
>Nov  4 14:35:21 hrouter pppd[771]: sent [CCP ConfReq id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:35:21 hrouter pppd[771]: rcvd [IPCP ConfReq id=0x1 <addr 0.0.0.0>
><compress VJ 0f 01>]
>Nov  4 14:35:21 hrouter pppd[771]: sent [IPCP ConfNak id=0x1 <addr
>10.111.1.29>]
>Nov  4 14:35:21 hrouter pppd[771]: rcvd [CCP ConfReq id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:35:21 hrouter pppd[771]: sent [CCP ConfAck id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:35:21 hrouter kernel: compress rejected:
opt_len=17,o[0]=1a,o[1]=4
>Nov  4 14:35:22 hrouter pppd[771]: rcvd [IPCP ConfAck id=0x1 <addr
>10.111.1.10> <compress VJ 0f 01>]
>Nov  4 14:35:22 hrouter kernel: options are bad: 1a 4
>Nov  4 14:35:22 hrouter pppd[771]: rcvd [CCP ConfAck id=0x1 <deflate 15>
><deflate(old#) 15> <mppe 0 0 0 20> <bsd v1 15>]
>Nov  4 14:35:22 hrouter pppd[771]: Deflate (15) compression enabled
>Nov  4 14:35:22 hrouter pppd[771]: rcvd [IPCP ConfReq id=0x2 <addr
>10.111.1.29> <compress VJ 0f 01>]
>Nov  4 14:35:22 hrouter pppd[771]: sent [IPCP ConfAck id=0x2 <addr
>10.111.1.29> <compress VJ 0f 01>]
>Nov  4 14:35:22 hrouter pppd[771]: local  IP address 10.111.1.10
>Nov  4 14:35:22 hrouter pppd[771]: remote IP address 10.111.1.29
>Nov  4 14:35:22 hrouter pppd[771]: Script /etc/ppp/ip-up started (pid 778)
>Nov  4 14:35:22 hrouter ip-up: ppp2 /dev/ttyp1 38400 10.111.1.10
10.111.1.29
>Nov  4 14:35:22 hrouter pppd[771]: Script /etc/ppp/ip-up finished (pid
778),
>status = 0x0
>Nov  4 14:35:24 hrouter pptpd[715]: MGR: Reaped child 760
>Nov  4 14:35:24 hrouter pptpd[760]: CTRL: Exiting now
>Nov  4 14:35:34 hrouter gated[703]: EVENT <Add> ppp2 index 4 <Up
>PointToPoint Multicast> address 802.2 0:0:0:0:0:0
>Nov  4 14:35:34 hrouter gated[703]: EVENT Add ppp2 10.111.1.10 ->
>10.111.1.29 <Up PointToPoint Multicast>
>Nov  4 14:47:17 hrouter pptpd[770]: CTRL: Received PPTP Control Message
>(type: 5)
>Nov  4 14:47:17 hrouter pptpd[770]: CTRL: Made a ECHO RPLY packet
>Nov  4 14:47:17 hrouter pptpd[770]: CTRL: I wrote 20 bytes to the client.
>Nov  4 14:47:17 hrouter pptpd[770]: CTRL: Sent packet to client
>Nov  4 14:47:39 hrouter pppd[771]: rcvd [LCP TermReq id=0x2 "User request"]
>Nov  4 14:47:39 hrouter pppd[771]: LCP terminated by peer (User request)
>Nov  4 14:47:39 hrouter pppd[771]: Script /etc/ppp/ip-down started (pid
791)
>Nov  4 14:47:39 hrouter pppd[771]: sent [LCP TermAck id=0x2]
>Nov  4 14:47:39 hrouter ip-down: ppp2 /dev/ttyp1 38400 10.111.1.10
>10.111.1.29
>Nov  4 14:47:39 hrouter pptpd[715]: MGR: Reaped child 770
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Received PPTP Control Message
>(type: 12)
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Made a CALL DISCONNECT RPLY
packet
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Received CALL CLR request
(closing
>call)
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: I wrote 148 bytes to the client.
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Sent packet to client
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Error with select(), quitting
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Client 12.73.237.69 control
>connection finished
>Nov  4 14:47:39 hrouter pptpd[770]: CTRL: Exiting now
>Nov  4 14:47:39 hrouter pppd[771]: Modem hangup
>Nov  4 14:47:39 hrouter pppd[771]: Connection terminated.
>Nov  4 14:47:39 hrouter pppd[771]: Connect time 12.5 minutes.
>Nov  4 14:47:39 hrouter pppd[771]: Sent 1953 bytes, received 2518 bytes.
>Nov  4 14:47:39 hrouter pppd[771]: Waiting for 1 child processes...
>Nov  4 14:47:39 hrouter pppd[771]:   script /etc/ppp/ip-down, pid 791
>Nov  4 14:47:39 hrouter pppd[771]: Script /etc/ppp/ip-down finished (pid
>791), status = 0x0
>Nov  4 14:47:39 hrouter pppd[771]: Exit.
>
>
>
>
>hrouter# cat /etc/ppp/ip-up
>#!/bin/sh
>#
>PATH=/bin:/sbin:/usr/bin:/usr/sbin
>
>message () {
>    logger -p local2.info -t ip-up "$*"
>}
>
>message "$1 $2 $3 $4 $5"
># When ip is up, these are the arguments pass on.
># Arg Name  Example
># $1  interface name  ppp0
># $2  tty   /dev/ttyS0
># $3  speed   115200
># $4  local ip
># $5  remote ip
>
>if [ "$5" = 10.111.1.29 ]; then
>    route add -net 10.111.200.0 netmask 255.255.255.0 gw $5 #1
>fi
>
>
># Keep a log of what happened. This log is also used by other script to
># determine which interface to shut down.
>
>PPP=$1
>TTY=$2
>SPEED=$3
>LOCAL_IP=$4
>REMOTE_IP=$5
>
>set -- $(echo $2 | sed s/\\/\dev\\///)
>TTY=$1
>LOG="/var/log/ppp/$TTY.log"
>
>/bin/cat << EOF > $LOG
>PPP=$PPP
>TTY=$TTY
>SPEED=$SPEED
>IPADDR=$LOCAL_IP
>REMOTE_IP=$REMOTE_IP
>
>EOF
>
>
>
>ipdown script:
>
>
>#!/bin/sh
>
>PATH=/bin:/sbin:/usr/bin:/usr/sbin
>message () {
>    logger -p local2.info -t ip-down "$*"
>}
>
>if [ -f /var/run/$1.pid ]; then
>        kill -INT cat `/var/run/$1.pid`
>
> rm /var/run/$1.pid
>        ifconfig $1 down
>fi
>
>message "$1 $2 $3 $4 $5"
>
># Restart dialer using the same ppp device name
>set -- $(echo $2 | sed s/\\/\dev\\///)
>TTY=$1
>
>if [ "$5" = 10.111.1.29 ]; then
>    route del -net 10.111.200.0 netmask 255.255.255.0 gw $5 $1
>fi
>
>[ -f /var/log/ppp/$TTY.log ] && rm /var/log/ppp/$TTY.log
>
>if [ "$TTY" = "ttyS1" ]; then
>        /etc/init.d/ppp start $TTY
>fi
>
>





More information about the pptp-server mailing list