Framed-IP-Address

ХимТех · Чт янв 11, 2007 3:14 pm

Здравствуйте.
У меня такая проблема: radius выдает ip не те, которые я прописал в Dialup / VPN. Похоже проблема с Framed-IP-Address. Куда рыть?? Какие логи показать?

Пт янв 12, 2007 8:50 am

abills/libexec/radtest.sh

ХимТех · Пт янв 12, 2007 11:04 am

mysql - 5.0.24a
freeradius 1.1.2
pppd 2.4.4
pptpd 1.3.0
# tail -f /var/log/freeradius/radacct/127.0.0.1/detail-200070308

Код: Выделить всё

Acct-Session-Id = "45F03037259600"
        User-Name = "chemtech"
        Acct-Status-Type = Start
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Calling-Station-Id = "192.168.0.18"
        Acct-Authentic = RADIUS
        NAS-Port-Type = Async
        Framed-IP-Address = 192.168.3.1
        NAS-IP-Address = 192.168.0.201
        NAS-Port = 0
        Acct-Delay-Time = 0
        Client-IP-Address = 127.0.0.1
        Acct-Unique-Session-Id = "bebe6296de47c3fc"
        Timestamp = 1173368887

# ./radtest.sh auth

Код: Выделить всё

auth
/usr/abills/libexec
Acct-Interim-Interval = 60,
Session-Timeout = 7849,
PPPD-Upstream-Speed-Limit = 0,
Octets-Direction = 1,
Framed-IP-Address = 192.168.3.17,
Session-Octets-Limit = 16777216,
Framed-IP-Netmask = 255.255.255.255,
PPPD-Downstream-Speed-Limit = 0,

Auth test end

gw2:/usr/abills/libexec# netstat -nl | grep 18

Код: Выделить всё

udp        0      0 0.0.0.0:1812            0.0.0.0:*
udp        0      0 0.0.0.0:1813            0.0.0.0:*

# tail -f /var/log/syslog

Код: Выделить всё

Mar  8 22:03:02 gw2 pptpd[10518]: MGR: Launching /usr/sbin/pptpctrl to handle client
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: local address = 192.168.0.201
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: remote address = 192.168.1.1
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: pppd options file = /etc/ppp/pptpd-options
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Client 192.168.0.18 control connection started
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Received PPTP Control Message (type: 1)
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Made a START CTRL CONN RPLY packet
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: I wrote 156 bytes to the client.
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Sent packet to client
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Received PPTP Control Message (type: 7)
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Set parameters to 100000000 maxbps, 64 window size
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Made a OUT CALL RPLY packet
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Starting call (launching pppd, opening GRE)
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: pty_fd = 6
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: tty_fd = 7
Mar  8 22:03:02 gw2 pptpd[10519]: CTRL (PPPD Launcher): program binary = /usr/sbin/pppd
Mar  8 22:03:02 gw2 pptpd[10519]: CTRL (PPPD Launcher): local address = 192.168.0.201
Mar  8 22:03:02 gw2 pptpd[10519]: CTRL (PPPD Launcher): remote address = 192.168.1.1
Mar  8 22:03:02 gw2 pppd[10519]: Plugin radius.so loaded.
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: I wrote 32 bytes to the client.
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Sent packet to client
Mar  8 22:03:02 gw2 pppd[10519]: RADIUS plugin initialized.
Mar  8 22:03:02 gw2 pppd[10519]: Plugin radattr.so loaded.
Mar  8 22:03:02 gw2 pppd[10519]: RADATTR plugin initialized.
Mar  8 22:03:02 gw2 pppd[10519]: pppd 2.4.4 started by root, uid 0
Mar  8 22:03:02 gw2 pppd[10519]: using channel 51
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Received PPTP Control Message (type: 15)
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Mar  8 22:03:02 gw2 pppd[10519]: Using interface ppp0
Mar  8 22:03:02 gw2 pppd[10519]: Connect: ppp0 <--> /dev/pts/0
Mar  8 22:03:02 gw2 pppd[10519]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MD5> <magic 0xfe27b261> <pcomp> <accomp>]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: Bad checksum from pppd.
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #0
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #1
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [LCP ConfReq id=0x0 <mru 1400> <magic 0x330164ee> <pcomp> <accomp> <callback CBCP>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [LCP ConfRej id=0x0 <callback CBCP>]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <auth chap MD5> <magic 0xfe27b261> <pcomp> <accomp>]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #2
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [LCP ConfReq id=0x1 <mru 1400> <magic 0x330164ee> <pcomp> <accomp>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [LCP ConfAck id=0x1 <mru 1400> <magic 0x330164ee> <pcomp> <accomp>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [LCP EchoReq id=0x0 magic=0xfe27b261]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #3
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #4
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #5
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Received PPTP Control Message (type: 15)
Mar  8 22:03:02 gw2 pptpd[10518]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
Mar  8 22:03:02 gw2 pppd[10519]: sent [CHAP Challenge id=0xb9 <6e76a1dd4bfeb3f05d637e3dacb6ff37496a>, name = "pptpd"]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [LCP Ident id=0x2 magic=0x330164ee "MSRASV5.10"]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #6
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [LCP Ident id=0x3 magic=0x330164ee "MSRAS-0-CHEMTECH"]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [LCP EchoRep id=0x0 magic=0x330164ee]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [CHAP Response id=0xb9 <e6726516c511e49d5255c15d8d2ac14e>, name = "chemtech"]
Mar  8 22:03:02 gw2 pppd[10519]: RADATTR plugin wrote 0 line(s) to file /var/run/radattr.ppp0.
Mar  8 22:03:02 gw2 pppd[10519]: sent [CHAP Success id=0xb9 ""]
Mar  8 22:03:02 gw2 pppd[10519]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.0.201>]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #7
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #8
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #9
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #10
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [CCP ConfReq id=0x4 <mppe +H -M -S -L -D +C>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [CCP ConfRej id=0x4 <mppe +H -M -S -L -D +C>]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [IPCP ConfReq id=0x5 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns3 0.0.0.0> <ms-wins 0.0.0.0>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [IPCP ConfRej id=0x5 <ms-dns1 0.0.0.0> <ms-wins 0.0.0.0> <ms-dns3 0.0.0.0> <ms-wins 0.0.0.0>]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [CCP ConfRej id=0x1 <deflate 15> <deflate(old#) 15>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [CCP ConfReq id=0x2]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [IPCP ConfReq id=0x2 <addr 192.168.0.201>]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #11
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #12
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #13
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [CCP TermReq id=0x6"3\001d\37777777756\000<\37777777715t\000\000\002\37777777734"]
Mar  8 22:03:02 gw2 pppd[10519]: sent [CCP TermAck id=0x6]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [IPCP ConfReq id=0x7 <addr 0.0.0.0>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [IPCP ConfNak id=0x7 <addr 192.168.1.1>]
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [IPCP ConfAck id=0x2 <addr 192.168.0.201>]
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #14
Mar  8 22:03:02 gw2 pppd[10519]: rcvd [IPCP ConfReq id=0x8 <addr 192.168.1.1>]
Mar  8 22:03:02 gw2 pppd[10519]: sent [IPCP ConfAck id=0x8 <addr 192.168.1.1>]
Mar  8 22:03:02 gw2 pppd[10519]: found interface eth0 for proxy arp
Mar  8 22:03:02 gw2 pppd[10519]: local  IP address 192.168.0.201
Mar  8 22:03:02 gw2 pppd[10519]: remote IP address 192.168.1.1
Mar  8 22:03:02 gw2 pptpd[10518]: GRE: accepting packet #15
Mar  8 22:03:03 gw2 pptpd[10518]: GRE: accepting packet #16
Mar  8 22:03:03 gw2 pptpd[10518]: GRE: accepting packet #17
Mar  8 22:03:03 gw2 pppd[10519]: Script /etc/ppp/ip-up started (pid 10525)
Mar  8 22:03:03 gw2 pppd[10519]: Script /etc/ppp/ip-up finished (pid 10525), status = 0x0
Mar  8 22:03:03 gw2 pptpd[10518]: GRE: accepting packet #18
Mar  8 22:03:04 gw2 pptpd[10518]: GRE: accepting packet #19
Mar  8 22:03:05 gw2 pptpd[10518]: GRE: accepting packet #20
Mar  8 22:03:05 gw2 pppd[10519]: sent [CCP ConfReq id=0x2]
Mar  8 22:03:05 gw2 pptpd[10518]: GRE: accepting packet #21
Mar  8 22:03:05 gw2 pppd[10519]: rcvd [CCP TermAck id=0x2]
Mar  8 22:03:05 gw2 pppd[10519]: sent [CCP TermReq id=0x3"No compression negotiated"]
Mar  8 22:03:05 gw2 pptpd[10518]: GRE: accepting packet #22
Mar  8 22:03:05 gw2 pppd[10519]: rcvd [CCP TermAck id=0x3"No compression negotiated"]
Mar  8 22:03:05 gw2 pptpd[10518]: GRE: accepting packet #23
Mar  8 22:03:06 gw2 pptpd[10518]: GRE: accepting packet #24
Mar  8 22:03:06 gw2 pptpd[10518]: GRE: accepting packet #25
Mar  8 22:03:06 gw2 pptpd[10518]: GRE: accepting packet #26
Mar  8 22:03:07 gw2 pptpd[10518]: GRE: accepting packet #27
Mar  8 22:03:08 gw2 pptpd[10518]: GRE: accepting packet #28
Mar  8 22:03:08 gw2 pptpd[10518]: GRE: accepting packet #29
Mar  8 22:03:08 gw2 pptpd[10518]: GRE: accepting packet #30
Mar  8 22:03:09 gw2 pptpd[10518]: GRE: accepting packet #31
Mar  8 22:03:09 gw2 pptpd[10518]: CTRL: Received PPTP Control Message (type: 15)
Mar  8 22:03:09 gw2 pptpd[10518]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Mar  8 22:03:09 gw2 pptpd[10518]: GRE: accepting packet #32
Mar  8 22:03:09 gw2 pppd[10519]: rcvd [LCP TermReq id=0x9 "3\001d\37777777756\000<\37777777715t\000\000\000\000"]
Mar  8 22:03:09 gw2 pppd[10519]: LCP terminated by peer (3^AdM-n^@<M-Mt^@^@^@^@)
Mar  8 22:03:09 gw2 pppd[10519]: Connect time 0.2 minutes.
Mar  8 22:03:09 gw2 pppd[10519]: Sent 33 bytes, received 2132 bytes.
Mar  8 22:03:09 gw2 pppd[10519]: Script /etc/ppp/ip-down started (pid 10532)
Mar  8 22:03:09 gw2 pppd[10519]: sent [LCP TermAck id=0x9]
Mar  8 22:03:09 gw2 pppd[10519]: Script /etc/ppp/ip-down finished (pid 10532), status = 0x0
Mar  8 22:03:12 gw2 pppd[10519]: Connection terminated.
Mar  8 22:03:12 gw2 pppd[10519]: Modem hangup
Mar  8 22:03:12 gw2 pppd[10519]: RADATTR plugin removed file /var/run/radattr.ppp0.
Mar  8 22:03:12 gw2 pppd[10519]: Exit.
Mar  8 22:03:12 gw2 pptpd[10518]: GRE: read(fd=6,buffer=80505a0,len=8196) from PTY failed: status = -1 error = Input/output error, usually caused by unexpected termination of pppd, check option syntax and pppd logs
Mar  8 22:03:12 gw2 pptpd[10518]: CTRL: PTY read or GRE write failed (pty,gre)=(6,7)
Mar  8 22:03:12 gw2 pptpd[10518]: CTRL: Reaping child PPP[10519]
Mar  8 22:03:12 gw2 pptpd[10518]: CTRL: Client 192.168.0.18 control connection finished
Mar  8 22:03:12 gw2 pptpd[10518]: CTRL: Exiting now
Mar  8 22:03:12 gw2 pptpd[10516]: MGR: Reaped child 10518

ХимТех · Чт янв 25, 2007 4:35 am

Все сделал. И даже написал статью. Она здесь:
http://omsk.lug.ru/wacko/Abills

Чт янв 25, 2007 9:02 am

Отлично.
Есть же люди.

mishas · Чт янв 25, 2007 9:53 am

ХимТех писал(а):Все сделал. И даже написал статью. Она здесь:
http://omsk.lug.ru/wacko/Abills

Тоже работаю под debian. Ядро 2.6.18 с поддержкой MPPC/MPPE.

Удалось вам запустить VPN соединение MPPE? У меня не получается. Пока оставил chap аутентификацию.

ХимТех · Чт янв 25, 2007 10:09 am

И у меня также. Пока времени нет этим заниматься.
Кстати, ядро скомпилил 2.6.19.2, может в нем есть изменения??

mishas · Чт янв 25, 2007 10:17 am

ХимТех писал(а):И у меня также. Пока времени нет этим заниматься.
Кстати, ядро скомпилил 2.6.19.2, может в нем есть изменения??

У меня уже 2.6.19.1 ядро. Не помогает.

Предлагаю продолжить общение здесь.
http://abills.asmodeus.com.ua/forum/vie ... php?t=3240