pptpd обрывы подключения

[---nebo---]

Всем привет!
Стоит элементарная задача организовать VPN сервер.
Исходные данные: OS Debian 5.0.6, pptpd v.1.3.4.
Конфигурация:
/etc/pptpd.conf

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

ppp /usr/sbin/pppd
option /etc/ppp/pptpd-options
debug
noipparam
localip 10.10.11.247-249
remoteip 10.10.11.250-252

/etc/ppp/pptpd-options

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

name pptpd
refuse-pap
refuse-chap
refuse-mschap
require-mschap-v2
require-mppe-128
proxyarp
nodefaultroute
debug
lock

Модули , загруженные в ядро (относящиеся к ВПН соединению):

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

/lib/modules/2.6.26-2-686/kernel/net/ipv4/ip_gre.ko
/lib/modules/2.6.26-2-686/kernel/net/netfilter/nf_conntrack_proto_gre.ko
/lib/modules/2.6.26-2-686/kernel/net/ipv4/netfilter/nf_nat_proto_gre.ko
/lib/modules/2.6.26-2-686/kernel/net/ipv4/tunnel4.ko

При подключении пользователя проверка логина и пароля проходит успешно, подключение происходит. Пользователи обмениваются пакетами, "видят" друг друга. Секунд через 30-40 соединение обрывается. При переподключении - Ошибка 621.

В логе:

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

Jan 21 16:18:45 web2 pppd[8891]: pppd 2.4.4 started by root, uid 0
Jan 21 16:18:45 web2 pppd[8891]: Using interface ppp0
Jan 21 16:18:45 web2 pppd[8891]: Connect: ppp0 <--> /dev/pts/3
Jan 21 16:18:48 web2 pppd[8891]: MPPE 128-bit stateless compression enabled
Jan 21 16:18:49 web2 pppd[8891]: found interface eth2 for proxy arp
Jan 21 16:18:49 web2 pppd[8891]: local  IP address 10.10.11.247
Jan 21 16:18:49 web2 pppd[8891]: remote IP address 10.10.11.250
Jan 21 16:18:55 web2 pppd[8891]: Modem hangup
Jan 21 16:18:55 web2 pppd[8891]: Connect time 0.1 minutes.
Jan 21 16:18:55 web2 pppd[8891]: Sent 3766 bytes, received 656 bytes.
Jan 21 16:18:55 web2 pppd[8891]: Connection terminated.
Jan 21 16:18:55 web2 pppd[8891]: Exit.

Раньше, при настройке pptpd на debian с такой проблемой ни разу не сталкивался.

[Хостинг HostFood.ru]

Тарифы на хостинг в России, от 12 рублей: https://www.host-food.ru/tariffs/hosting/
Тарифы на виртуальные сервера (VPS/VDS/KVM) в РФ, от 189 руб.: https://www.host-food.ru/tariffs/virtualny-server-vps/
Выделенные сервера, Россия, Москва, от 2000 рублей (HP Proliant G5, Intel Xeon E5430 (2.66GHz, Quad-Core, 12Mb), 8Gb RAM, 2x300Gb SAS HDD, P400i, 512Mb, BBU):
https://www.host-food.ru/tariffs/vydelennyi-server-ds/
Недорогие домены в популярных зонах: https://www.host-food.ru/domains/

[Гость]

1) это не дебаг лог, ничего не видно
2) дебаг лог нужно проблемы, а не какойто информации, проблема как звучит? обрыв и не возможность переподключится
вот этот лог расширеный и показывайте

[---nebo---]

Запускаю

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

pptpd -c /etc/pptpd.conf -d  -o /etc/ppp/pptpd-options -t 1

Получаю

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

Jan 22 20:29:27 web2 pptpd[19862]: MGR: Reaped child 19944
Jan 22 20:33:39 web2 pptpd[19992]: MGR: Maximum of 100 connections reduced to 3, not enough IP addresses given
Jan 22 20:33:39 web2 pptpd[19993]: MGR: Manager process started
Jan 22 20:33:39 web2 pptpd[19993]: MGR: Maximum of 3 connections available
Jan 22 20:34:14 web2 pptpd[20001]: MGR: Launching /usr/sbin/pptpctrl to handle client
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: local address = 10.10.11.247
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: remote address = 10.10.11.250
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: pppd options file = /etc/ppp/pptpd-options
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Client 10.11.11.30 control connection started
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Received PPTP Control Message (type: 1)
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Made a START CTRL CONN RPLY packet
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: I wrote 156 bytes to the client.
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Sent packet to client
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Received PPTP Control Message (type: 7)
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Set parameters to 100000000 maxbps, 64 window size
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Made a OUT CALL RPLY packet
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Starting call (launching pppd, opening GRE)
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: pty_fd = 6
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: tty_fd = 7
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: I wrote 32 bytes to the client.
Jan 22 20:34:14 web2 pptpd[20002]: CTRL (PPPD Launcher): program binary = /usr/sbin/pppd
Jan 22 20:34:14 web2 pptpd[20002]: CTRL (PPPD Launcher): local address = 10.10.11.247
Jan 22 20:34:14 web2 pptpd[20002]: CTRL (PPPD Launcher): remote address = 10.10.11.250
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Sent packet to client
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Received PPTP Control Message (type: 15)
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Jan 22 20:34:14 web2 pptpd[20001]: GRE: read(fd=7,buffer=80505a0,len=8260) from network failed: status = -1 error = Protocol not available
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: GRE read or PTY write failed (gre,pty)=(7,6)
Jan 22 20:34:14 web2 pptpd[20001]: CTRL: Reaping child PPP[20002]
Jan 22 20:34:15 web2 pptpd[20001]: CTRL: Client 10.11.11.30 control connection finished
Jan 22 20:34:15 web2 pptpd[20001]: CTRL: Exiting now
Jan 22 20:34:15 web2 pptpd[19993]: MGR: Reaped child 20001

[Гость]

pppd дебаг лог нужен
а не pptp
а еще лучше когда они в одном файле

[---nebo---]

общий лог

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

Jan 23 13:06:15 web2 pptpd[26140]: GRE: accepting packet #149
Jan 23 13:06:45 web2 pptpd[26140]: CTRL: Reaping child PPP[26141]
Jan 23 13:06:45 web2 pppd[26141]: Script /etc/ppp/ip-down started (pid 26178)
Jan 23 13:06:45 web2 pppd[26141]: sent [LCP TermReq id=0x2 "MPPE disabled"]
Jan 23 13:06:45 web2 pppd[26141]: Waiting for 1 child processes...
Jan 23 13:06:45 web2 pppd[26141]:   script /etc/ppp/ip-down, pid 26178
Jan 23 13:06:45 web2 pppd[26141]: Script /etc/ppp/ip-down finished (pid 26178), status = 0x0
Jan 23 13:06:45 web2 pptpd[20107]: MGR: Reaped child 26140
Jan 23 13:06:45 web2 pptpd[26140]: CTRL: Exiting now

Кстати заметил особенность. У сервера есть два интерфейса: с реальным адресом и приватным. Когда подключаюсь на приватный адрес - получаю следующую проблему. Когда подключаюсь с этого же компа/клиента на реальный адрес, когда пакеты проходят через 3 Cisco маршрутизатора - все работает замечательно.

[Гость]

тяжело с людьми который первый раз видят юникс..
или не первый?

пот показываю вам приблизительный дебаг лог

Nov 29 14:43:24 ppp pppd[3985]: pppd 2.3.5 started by root, uid 0
Nov 29 14:43:24 ppp pppd[3985]: Using interface ppp1
Nov 29 14:43:24 ppp pppd[3985]: Connect: ppp1 <--> /dev/ttydd
Nov 29 14:43:24 ppp pppd[3985]: sent [LCP ConfReq id=0x1 <auth pap> <magic 0x833a459> <pcomp> <accomp>]
Nov 29 14:43:24 ppp pppd[3985]: rcvd [LCP ConfAck id=0x1 <auth pap> <magic 0x833a459> <pcomp> <accomp>]
Nov 29 14:43:26 ppp pppd[3985]: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0> <magic 0x29df3909> <pcomp> <accomp> <callback 0x600>]
Nov 29 14:43:26 ppp pppd[3985]: sent [LCP ConfRej id=0x2 <callback 0x623>]
Nov 29 14:43:27 ppp pppd[3985]: sent [LCP ConfReq id=0x1 <auth pap> <magic 0x833a459> <pcomp> <accomp>]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP ConfReq id=0x3 <asyncmap 0x0> <magic 0x29df3909> <pcomp> <accomp>]
Nov 29 14:43:27 ppp pppd[3985]: sent [LCP ConfAck id=0x3 <asyncmap 0x0> <magic 0x29df3909> <pcomp> <accomp>]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP ConfAck id=0x1 <auth pap> <magic 0x833a459> <pcomp> <accomp>]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP code=0xc id=0x4 29 df 39 09 4d 53 52 41 53 56 35 2e 31 30]
Nov 29 14:43:27 ppp pppd[3985]: sent [LCP CodeRej id=0x2 0c 04 00 12 29 df 39 09 4d 53 52 41 53 56 35 2e 31 30]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP code=0xc id=0x5 29 df 39 09 4d 53 52 41 53 2d 30 2d 45 34 34 33 35 32 35 45 45 41 34 42 34 45 44]
Nov 29 14:43:27 ppp pppd[3985]: sent [LCP CodeRej id=0x3 0c 05 00 1f 29 df 39 09 4d 53 52 41 53 2d 30 2d 45 34 34 33 35 32 35 45 45 41 34 42 34 45 44]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [PAP AuthReq id=0x1 user="lissyara" password="55555555555"]
Nov 29 14:43:27 ppp pppd[3985]: sent [PAP AuthNak id=0x1 "Login incorrect"]
Nov 29 14:43:27 ppp pppd[3985]: sent [LCP TermReq id=0x4 "Authentication failed"]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP ProtRej id=0x6 70 70 70 64 3a 20]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP ProtRej id=0x7 50 41 50 20 61 75 74 68 65 6e 74 69 63 61 74 69 6f 6e 20 66 61 69 6c 75 72 65 20 66 6f 72 20 41 47 41 54 33]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP TermReq id=0x8 ")\377777777379\t\000<\37777777715t\000\000\002\37777777663"]
Nov 29 14:43:27 ppp pppd[3985]: sent [LCP TermAck id=0x8]
Nov 29 14:43:27 ppp pppd[3985]: rcvd [LCP TermAck id=0x4 "Authentication failed"]
Nov 29 14:43:27 ppp pppd[3985]: Connection terminated, connected for 1 minutes
Nov 29 14:43:28 ppp pppd[3985]: Hangup (SIGHUP)
Nov 29 14:43:28 ppp pppd[3985]: Exit.

а то что вы показали это не дебаг лог, это просто лог запуска работы pptp+pppd
по которому ничего нельзя определить