[sisyphus] MPPE/MPPC

[sisyphus] MPPE/MPPC

[Vladimir V. Bolnokin]

[-- Attachment #1: Type: text/plain, Size: 211 bytes --]

Доброе время суток!
Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на 
ядро и pppd?


-- 
Best regards, Vladimir. (BOBAH AT sysadmins.ru)
--
Wake up Neo! Matrrrrr2|234.%f3^@af4ga NO CARRIER

[-- Attachment #2: BOBAH.vcf --]
[-- Type: text/x-vcard, Size: 131 bytes --]

begin:vcard
fn:Vladimir Bolnokin
n:Bolnokin;Vladimir
email;internet:BOBAH@sysadmins.ru
x-mozilla-html:FALSE
version:2.1
end:vcard

Re: [sisyphus] MPPE/MPPC

[Valery V. Inozemtsev]

[-- Attachment #1: Type: text/plain, Size: 293 bytes --]

В сообщении от 25 Сентябрь 2004 15:56 Vladimir V. Bolnokin написал(a):
> Доброе время суток!
> Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на
> ядро и pppd?

да

-- 
Valery V. Inozemtsev

Powered by ALT Linux Sisyphus (20040921)
ftp://ftp.altlinux.ru/pub/people/shrek/

[-- Attachment #2: signature --]
[-- Type: application/pgp-signature, Size: 189 bytes --]

Re: [sisyphus] MPPE/MPPC

[Vladimir V. Bolnokin]

[-- Attachment #1: Type: text/plain, Size: 895 bytes --]

On 25.09.2004 16:21, Valery V. Inozemtsev пишет:
> В сообщении от 25 Сентябрь 2004 15:56 Vladimir V. Bolnokin написал(a):
> 
>>Доброе время суток!
>>Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на
>>ядро и pppd?
Нарвался я на глюк.
Админ в нашей локалке поднял версию патчей до последней и у меня 
начались чудеса.
То udp ходит, а tcp не ходит, то вообще ничего, при том, что ничего 
особенного кроме того, что на сервере (не alt, ядро самосборное) в логе 
сервера "Received bad configure-ack: 1a 04 78 00 18 04 78 00 15 03 2f"
и по туннелю ничего не ходит.
После некоторого выяснения, он выставил на сервере явно nomppe и у меня 
всё поехало как надо.
Может ли влиять различие в патчах клиента и сервера (pppd и ядро) на 
работоспособность туннеля?

> 
> 
> да
> 



-- 
Best regards, Vladimir. (BOBAH AT sysadmins.ru)
--
Wake up Neo! Matrrrrr2|234.%f3^@af4ga NO CARRIER

[-- Attachment #2: BOBAH.vcf --]
[-- Type: text/x-vcard, Size: 131 bytes --]

begin:vcard
fn:Vladimir Bolnokin
n:Bolnokin;Vladimir
email;internet:BOBAH@sysadmins.ru
x-mozilla-html:FALSE
version:2.1
end:vcard

Re: [sisyphus] MPPE/MPPC

[Sergey Vlasov]

[-- Attachment #1: Type: text/plain, Size: 248 bytes --]

On Sat, Sep 25, 2004 at 03:56:40PM +0400, Vladimir V. Bolnokin wrote:
> Доброе время суток!
> Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на 
> ядро и pppd?

Поддержка MPPE есть (используется другой патч), MPPC - нет.

[-- Attachment #2: Type: application/pgp-signature, Size: 189 bytes --]

Re: [sisyphus] MPPE/MPPC

[Valery V. Inozemtsev]

[-- Attachment #1: Type: text/plain, Size: 1013 bytes --]

В сообщении от 25 Сентябрь 2004 16:51 Sergey Vlasov написал(a):
> On Sat, Sep 25, 2004 at 03:56:40PM +0400, Vladimir V. Bolnokin wrote:
> > Доброе время суток!
> > Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на
> > ядро и pppd?
>
> Поддержка MPPE есть (используется другой патч), MPPC - нет.

а вот это? 

Вск Апр 25 2004 Sergey Vlasov <vsu@> 2.4.25-alt7

- Updated kernel-feat-cpufreq:
  + longhaul: Nehemiah disabled again - no specs available from VIA
  + fix for (un)signed int wrap in proc_handler (CAN-2004-0228)
- Updated kernel-feat-drivers-media-v4l2:
  + updated main v4l2 patch to v4l2-2.4.26
- Updated kernel-feat-net-ppp-mppe:
^^^^^^^^^^^^^^^^^^^^^^
  + fix interoperability problem ("Unsupported protocol 0x2145 received") with
    some implementations that perform protocol field compression for the
    encrypted data

собственно после чего mppc у меня и заработал

-- 
Valery V. Inozemtsev

Powered by ALT Linux Sisyphus (20040921)
ftp://ftp.altlinux.ru/pub/people/shrek/

[-- Attachment #2: signature --]
[-- Type: application/pgp-signature, Size: 189 bytes --]

Re: [sisyphus] MPPE/MPPC

[Sergey Vlasov]

[-- Attachment #1: Type: text/plain, Size: 1739 bytes --]

On Sat, Sep 25, 2004 at 05:13:36PM +0400, Valery V. Inozemtsev wrote:
> В сообщении от 25 Сентябрь 2004 16:51 Sergey Vlasov написал(a):
> > On Sat, Sep 25, 2004 at 03:56:40PM +0400, Vladimir V. Bolnokin wrote:
> > > Доброе время суток!
> > > Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на
> > > ядро и pppd?
> >
> > Поддержка MPPE есть (используется другой патч), MPPC - нет.
> 
> а вот это? 
> 
> Вск Апр 25 2004 Sergey Vlasov <vsu@> 2.4.25-alt7
> 
> - Updated kernel-feat-cpufreq:
>   + longhaul: Nehemiah disabled again - no specs available from VIA
>   + fix for (un)signed int wrap in proc_handler (CAN-2004-0228)
> - Updated kernel-feat-drivers-media-v4l2:
>   + updated main v4l2 patch to v4l2-2.4.26
> - Updated kernel-feat-net-ppp-mppe:
> ^^^^^^^^^^^^^^^^^^^^^^
>   + fix interoperability problem ("Unsupported protocol 0x2145 received") with
>     some implementations that perform protocol field compression for the
>     encrypted data
> 
> собственно после чего mppc у меня и заработал

Protocol field compression - это не MPPC, а стандартная опция PPP.
Вообще для поля номера протокола в PPP отведено 2 байта, но номера
протоколов выбираются так, что для основных протоколов, используемых при
передаче данных, старший (нулевой) байт может не передаваться.
Специфика MPPE в том, что этот номер из исходного пакета оказывается
внутри поля данных MPPE, и использование там PFC не обрабатывалось - вот
эта обработка и была добавлена.  При этом в отправляемых пакетах этот
номер передаётся без сжатия, чтобы сохранить совместимость со старыми
версиями патча.

А вот в патче для ядер 2.6.x, лежащем сейчас в kernel-feat-net-ppp-mppe,
действительно есть поддержка MPPC.

[-- Attachment #2: Type: application/pgp-signature, Size: 189 bytes --]

Re: [sisyphus] MPPE/MPPC

[Sergey Vlasov]

[-- Attachment #1: Type: text/plain, Size: 1008 bytes --]

On Sat, Sep 25, 2004 at 04:38:17PM +0400, Vladimir V. Bolnokin wrote:
> On 25.09.2004 16:21, Valery V. Inozemtsev пишет:
> >В сообщении от 25 Сентябрь 2004 15:56 Vladimir V. Bolnokin написал(a):
> >
> >>Доброе время суток!
> >>Поддерживаются-ли в сизифе эти http://www.polbox.com/h/hs001/ патчи на
> >>ядро и pppd?
> Нарвался я на глюк.
> Админ в нашей локалке поднял версию патчей до последней и у меня 
> начались чудеса.
> То udp ходит, а tcp не ходит, то вообще ничего, при том, что ничего 
> особенного кроме того, что на сервере (не alt, ядро самосборное) в логе 
> сервера "Received bad configure-ack: 1a 04 78 00 18 04 78 00 15 03 2f"
> и по туннелю ничего не ходит.
> После некоторого выяснения, он выставил на сервере явно nomppe и у меня 
> всё поехало как надо.
> Может ли влиять различие в патчах клиента и сервера (pppd и ядро) на 
> работоспособность туннеля?

Может - см. хотя бы на вышеуказанной странице раздел Known Bugs (пункт
2).  Хотя тут ситуация какая-то другая.

[-- Attachment #2: Type: application/pgp-signature, Size: 189 bytes --]

Re: [sisyphus] MPPE/MPPC

[Vladimir V. Bolnokin]

[-- Attachment #1: Type: text/plain, Size: 296 bytes --]

On 25.09.2004 20:02, Sergey Vlasov пишет:
> Может - см. хотя бы на вышеуказанной странице раздел Known Bugs (пункт
> 2).  Хотя тут ситуация какая-то другая.
прилагаю логи сервера и клиента.


-- 
Best regards, Vladimir. (BOBAH AT sysadmins.ru)
--
Wake up Neo! Matrrrrr2|234.%f3^@af4ga NO CARRIER

[-- Attachment #2: messages.client --]
[-- Type: text/plain, Size: 18082 bytes --]

Sep 25 15:28:34 bob pppd[3739]: pppd 2.4.2 started by root, uid 0
Sep 25 15:28:34 bob pppd[3739]: Serial connection established.
Sep 25 15:28:34 bob pppd: Serial connection established.
Sep 25 15:28:34 bob pppd: using channel 5
Sep 25 15:28:34 bob pptp[3740]: anon log[main:pptp.c:243]: The synchronous pptp option is NOT activated 
Sep 25 15:28:34 bob pppd[3739]: Using interface ppp0
Sep 25 15:28:34 bob pppd[3739]: Connect: ppp0 <--> /dev/pts/0
Sep 25 15:28:34 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 1 'Start-Control-Connection-Request' 
Sep 25 15:28:34 bob pppd: Using interface ppp0
Sep 25 15:28:34 bob pppd: Connect: ppp0 <--> /dev/pts/0
Sep 25 15:28:34 bob pptp[3744]: anon log[ctrlp_disp:pptp_ctrl.c:721]: Received Start Control Connection Reply
Sep 25 15:28:34 bob pptp[3744]: anon log[ctrlp_disp:pptp_ctrl.c:755]: Client connection established.
Sep 25 15:28:35 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 7 'Outgoing-Call-Request' 
Sep 25 15:28:35 bob pppd: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x87b89a04> <pcomp> <accomp>]
Sep 25 15:28:35 bob pptp[3744]: anon log[ctrlp_disp:pptp_ctrl.c:841]: Received Outgoing Call Reply.
Sep 25 15:28:35 bob pptp[3744]: anon log[ctrlp_disp:pptp_ctrl.c:880]: Outgoing call established (call ID 0, peer's call ID 8960). 
Sep 25 15:28:35 bob pppd: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x87b89a04> <pcomp> <accomp>]
Sep 25 15:28:35 bob pppd: sent [LCP ConfNak id=0x1 <magic 0x5f9f47dc>]
Sep 25 15:28:35 bob pppd: rcvd [LCP ConfNak id=0x1 <magic 0x5f9f47dc>]
Sep 25 15:28:35 bob pppd: sent [LCP ConfReq id=0x2 <asyncmap 0x0> <magic 0xcf9198dd> <pcomp> <accomp>]
Sep 25 15:28:35 bob pppd: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf7f5afe5> <pcomp> <accomp> <mrru 1500> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:28:35 bob pppd: sent [LCP ConfRej id=0x1 <mrru 1500>]
Sep 25 15:28:35 bob pppd: rcvd [LCP ConfAck id=0x2 <asyncmap 0x0> <magic 0xcf9198dd> <pcomp> <accomp>]
Sep 25 15:28:35 bob pppd: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf7f5afe5> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:28:35 bob pppd: sent [LCP ConfAck id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf7f5afe5> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:28:35 bob pppd: rcvd [CHAP Challenge id=0x55 <a31e6c2add94c2c2d2f4e68517291fa4>, name = "gamuza.status-m.ru"]
Sep 25 15:28:35 bob pppd: sent [CHAP Response id=0x55 <06f2d7449d70b7b2afc785a629db873200000000000000006b3cd8747cf43ee8c9087343708dcb897b732557360ba16d00>, name = "bobah"]
Sep 25 15:28:35 bob pppd: rcvd [CHAP Success id=0x55 "S=AE96E865A76AD7E9F6EB93B5545BB6B0BB25D132"]
Sep 25 15:28:35 bob pppd: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:28:35 bob pppd: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.10.10>]
Sep 25 15:28:35 bob pppd: rcvd [CCP ConfReq id=0x1 <mppe -H -M -S -L -D +C> <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:28:35 bob pppd: sent [CCP ConfRej id=0x1 <mppe -H -M -S -L -D +C>]
Sep 25 15:28:35 bob pppd: rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:28:35 bob pppd: sent [IPCP ConfAck id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:28:35 bob pppd: rcvd [CCP ConfAck id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:28:35 bob pppd: rcvd [IPCP ConfNak id=0x1 <addr 10.0.10.10>]
Sep 25 15:28:35 bob pppd: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:28:35 bob pppd[3739]: Deflate (15) compression enabled
Sep 25 15:28:35 bob pppd: rcvd [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:28:35 bob pppd: sent [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:28:35 bob pppd: Deflate (15) compression enabled
Sep 25 15:28:35 bob pppd: rcvd [IPCP ConfAck id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:28:35 bob pppd[3739]: local  IP address 10.0.10.10
Sep 25 15:28:35 bob pppd[3739]: remote IP address 10.0.2.100
Sep 25 15:28:35 bob pppd: local  IP address 10.0.10.10
Sep 25 15:28:35 bob pppd: remote IP address 10.0.2.100
Sep 25 15:28:35 bob pptptunnel: pppd startup succeeded
Sep 25 15:28:38 bob pppd[3751]: Deflate (15) compression enabled
Sep 25 15:29:02 bob last message repeated 8 times
Sep 25 15:29:35 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:29:35 bob pptp[3744]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:30:35 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:30:35 bob pptp[3744]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:31:35 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:31:35 bob pptp[3744]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:31:52 bob pppd[3751]: Terminating on signal 15.
Sep 25 15:31:52 bob pppd[3751]: Connection terminated.
Sep 25 15:31:52 bob pppd[3751]: Connect time 3.3 minutes.
Sep 25 15:31:52 bob pppd[3751]: Sent 670 bytes, received 363 bytes.
Sep 25 15:31:52 bob pptp[3740]: anon warn[decaps_hdlc:pptp_gre.c:197]: short read (-1): Input/output error
Sep 25 15:31:52 bob pptp[3740]: anon warn[decaps_hdlc:pptp_gre.c:209]: pppd may have shutdown, see pppd log
Sep 25 15:31:52 bob pptp[3744]: anon log[callmgr_main:pptp_callmgr.c:228]: Closing connection
Sep 25 15:31:52 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 12 'Call-Clear-Request' 
Sep 25 15:31:52 bob pptp[3744]: anon log[ctrlp_disp:pptp_ctrl.c:912]: Call disconnect notification received (call id 8960)
Sep 25 15:31:52 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 12 'Call-Clear-Request' 
Sep 25 15:31:52 bob pptp[3744]: anon log[pptp_conn_close:pptp_ctrl.c:425]: Closing PPTP connection
Sep 25 15:31:52 bob pptp[3744]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 3 'Stop-Control-Connection-Request' 
Sep 25 15:31:52 bob pppd[3751]: Connect time 3.3 minutes.
Sep 25 15:31:52 bob pppd[3751]: Sent 670 bytes, received 363 bytes.
Sep 25 15:31:52 bob pppd[3751]: Exit.
Sep 25 15:31:52 bob pptp[3744]: anon log[ctrlp_disp:pptp_ctrl.c:912]: Call disconnect notification received (call id 65535)
Sep 25 15:31:53 bob pptptunnel: pppd shutdown succeeded
Sep 25 15:31:54 bob pptp[3744]: anon log[call_callback:pptp_callmgr.c:77]: Closing connection
Sep 25 15:32:01 bob pppd[3996]: pppd 2.4.2 started by root, uid 0
Sep 25 15:32:01 bob pppd[3996]: Serial connection established.
Sep 25 15:32:01 bob pppd: Serial connection established.
Sep 25 15:32:01 bob pppd: using channel 6
Sep 25 15:32:01 bob pppd[3996]: Using interface ppp0
Sep 25 15:32:01 bob pppd[3996]: Connect: ppp0 <--> /dev/pts/0
Sep 25 15:32:01 bob pppd: Using interface ppp0
Sep 25 15:32:01 bob pppd: Connect: ppp0 <--> /dev/pts/0
Sep 25 15:32:01 bob pptp[3997]: anon log[main:pptp.c:243]: The synchronous pptp option is NOT activated 
Sep 25 15:32:01 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 1 'Start-Control-Connection-Request' 
Sep 25 15:32:01 bob pptp[4002]: anon log[ctrlp_disp:pptp_ctrl.c:721]: Received Start Control Connection Reply
Sep 25 15:32:01 bob pptp[4002]: anon log[ctrlp_disp:pptp_ctrl.c:755]: Client connection established.
Sep 25 15:32:02 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 7 'Outgoing-Call-Request' 
Sep 25 15:32:02 bob pppd: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x901e057d> <pcomp> <accomp>]
Sep 25 15:32:02 bob pptp[4002]: anon log[ctrlp_disp:pptp_ctrl.c:841]: Received Outgoing Call Reply.
Sep 25 15:32:02 bob pptp[4002]: anon log[ctrlp_disp:pptp_ctrl.c:880]: Outgoing call established (call ID 0, peer's call ID 9088). 
Sep 25 15:32:02 bob pppd: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x901e057d> <pcomp> <accomp>]
Sep 25 15:32:02 bob pppd: sent [LCP ConfNak id=0x1 <magic 0x12e8c061>]
Sep 25 15:32:02 bob pppd: rcvd [LCP ConfNak id=0x1 <magic 0x12e8c061>]
Sep 25 15:32:02 bob pppd: sent [LCP ConfReq id=0x2 <asyncmap 0x0> <magic 0x98bd677e> <pcomp> <accomp>]
Sep 25 15:32:02 bob pppd: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf878c722> <pcomp> <accomp> <mrru 1500> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:32:02 bob pppd: sent [LCP ConfRej id=0x1 <mrru 1500>]
Sep 25 15:32:02 bob pppd: rcvd [LCP ConfAck id=0x2 <asyncmap 0x0> <magic 0x98bd677e> <pcomp> <accomp>]
Sep 25 15:32:02 bob pppd: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf878c722> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:32:02 bob pppd: sent [LCP ConfAck id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf878c722> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:32:02 bob pppd: rcvd [CHAP Challenge id=0xa6 <93ca74419ce37d572642f0c2b999af85>, name = "gamuza.status-m.ru"]
Sep 25 15:32:02 bob pppd: sent [CHAP Response id=0xa6 <24dc8c3cde337bb258c4fd2b02da1c9f000000000000000006229321f0c9470f8e6dfb606515e867cc135722f94ff80100>, name = "bobah"]
Sep 25 15:32:02 bob pppd: rcvd [CHAP Success id=0xa6 "S=F4916B53A62F77C60D2CE709260DE95AE6D09E34"]
Sep 25 15:32:02 bob pppd: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 bob pppd: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.10.10>]
Sep 25 15:32:02 bob pppd: rcvd [CCP ConfReq id=0x1 <mppe -H -M -S -L -D +C> <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 bob pppd: sent [CCP ConfRej id=0x1 <mppe -H -M -S -L -D +C>]
Sep 25 15:32:02 bob pppd: rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:32:02 bob pppd: sent [IPCP ConfAck id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:32:02 bob pppd: rcvd [CCP ConfAck id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 bob pppd: rcvd [IPCP ConfNak id=0x1 <addr 10.0.10.10>]
Sep 25 15:32:02 bob pppd: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:32:02 bob pppd[3996]: Deflate (15) compression enabled
Sep 25 15:32:02 bob pppd: rcvd [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 bob pppd: sent [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 bob pppd: Deflate (15) compression enabled
Sep 25 15:32:03 bob pppd: rcvd [IPCP ConfAck id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:32:03 bob pppd[3996]: local  IP address 10.0.10.10
Sep 25 15:32:03 bob pppd[3996]: remote IP address 10.0.2.100
Sep 25 15:32:03 bob pppd: local  IP address 10.0.10.10
Sep 25 15:32:03 bob pppd: remote IP address 10.0.2.100
Sep 25 15:32:03 bob pptptunnel: pppd startup succeeded
Sep 25 15:32:06 bob pppd[4008]: Deflate (15) compression enabled
Sep 25 15:32:30 bob last message repeated 8 times
Sep 25 15:33:02 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:33:02 bob pptp[4002]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:34:02 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:34:02 bob pptp[4002]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:35:02 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:35:02 bob pptp[4002]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:36:02 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 5 'Echo-Request' 
Sep 25 15:36:02 bob pptp[4002]: anon log[logecho:pptp_ctrl.c:659]: Echo Reply received.
Sep 25 15:36:19 bob pppd[4008]: Terminating on signal 15.
Sep 25 15:36:19 bob pppd[4008]: Connection terminated.
Sep 25 15:36:19 bob pppd[4008]: Connect time 4.3 minutes.
Sep 25 15:36:19 bob pppd[4008]: Sent 2170 bytes, received 451 bytes.
Sep 25 15:36:19 bob pptp[3997]: anon warn[decaps_hdlc:pptp_gre.c:197]: short read (-1): Input/output error
Sep 25 15:36:19 bob pptp[3997]: anon warn[decaps_hdlc:pptp_gre.c:209]: pppd may have shutdown, see pppd log
Sep 25 15:36:19 bob pptp[4002]: anon log[callmgr_main:pptp_callmgr.c:228]: Closing connection
Sep 25 15:36:19 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 12 'Call-Clear-Request' 
Sep 25 15:36:19 bob pppd[4008]: Connect time 4.3 minutes.
Sep 25 15:36:19 bob pppd[4008]: Sent 2170 bytes, received 451 bytes.
Sep 25 15:36:19 bob pppd[4008]: Exit.
Sep 25 15:36:19 bob pptp[4002]: anon log[ctrlp_disp:pptp_ctrl.c:912]: Call disconnect notification received (call id 9088)
Sep 25 15:36:19 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 12 'Call-Clear-Request' 
Sep 25 15:36:19 bob pptp[4002]: anon log[pptp_conn_close:pptp_ctrl.c:425]: Closing PPTP connection
Sep 25 15:36:19 bob pptp[4002]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 3 'Stop-Control-Connection-Request' 
Sep 25 15:36:19 bob pptp[4002]: anon log[ctrlp_disp:pptp_ctrl.c:912]: Call disconnect notification received (call id 65535)
Sep 25 15:36:19 bob pptptunnel: pppd shutdown succeeded
Sep 25 15:36:21 bob pptp[4002]: anon log[call_callback:pptp_callmgr.c:77]: Closing connection
Sep 25 15:36:26 bob pppd[4104]: pppd 2.4.2 started by root, uid 0
Sep 25 15:36:26 bob pppd[4104]: Serial connection established.
Sep 25 15:36:26 bob pppd: Serial connection established.
Sep 25 15:36:26 bob pppd: using channel 7
Sep 25 15:36:26 bob pptp[4105]: anon log[main:pptp.c:243]: The synchronous pptp option is NOT activated 
Sep 25 15:36:26 bob pppd[4104]: Using interface ppp0
Sep 25 15:36:26 bob pppd: Using interface ppp0
Sep 25 15:36:26 bob pppd[4104]: Connect: ppp0 <--> /dev/pts/0
Sep 25 15:36:26 bob pppd: Connect: ppp0 <--> /dev/pts/0
Sep 25 15:36:26 bob pptp[4110]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 1 'Start-Control-Connection-Request' 
Sep 25 15:36:26 bob pptp[4110]: anon log[ctrlp_disp:pptp_ctrl.c:721]: Received Start Control Connection Reply
Sep 25 15:36:26 bob pptp[4110]: anon log[ctrlp_disp:pptp_ctrl.c:755]: Client connection established.
Sep 25 15:36:27 bob pptp[4110]: anon log[ctrlp_rep:pptp_ctrl.c:243]: Sent control packet type is 7 'Outgoing-Call-Request' 
Sep 25 15:36:27 bob pppd: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xcce43424> <pcomp> <accomp>]
Sep 25 15:36:27 bob pptp[4110]: anon log[ctrlp_disp:pptp_ctrl.c:841]: Received Outgoing Call Reply.
Sep 25 15:36:27 bob pptp[4110]: anon log[ctrlp_disp:pptp_ctrl.c:880]: Outgoing call established (call ID 0, peer's call ID 9216). 
Sep 25 15:36:27 bob pppd: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xcce43424> <pcomp> <accomp>]
Sep 25 15:36:27 bob pppd: sent [LCP ConfNak id=0x1 <magic 0xd528a77c>]
Sep 25 15:36:27 bob pppd: rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x59c50674> <pcomp> <accomp> <mrru 1500> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:36:27 bob pppd: sent [LCP ConfRej id=0x1 <mrru 1500>]
Sep 25 15:36:27 bob pppd: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf96138c> <pcomp> <accomp> <mrru 1500> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:36:27 bob pppd: sent [LCP ConfRej id=0x2 <mrru 1500>]
Sep 25 15:36:27 bob pppd: rcvd [LCP ConfReq id=0x3 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf96138c> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:36:27 bob pppd: sent [LCP ConfAck id=0x3 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf96138c> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:36:30 bob pppd: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xcce43424> <pcomp> <accomp>]
Sep 25 15:36:30 bob pppd: rcvd [LCP ConfReq id=0x3 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf96138c> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:36:30 bob pppd: sent [LCP ConfAck id=0x3 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf96138c> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:36:30 bob pppd: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xcce43424> <pcomp> <accomp>]
Sep 25 15:36:30 bob pppd: rcvd [CHAP Challenge id=0xdd <f936efa9a9786fad0a4dc8522d6d6fff>, name = "gamuza.status-m.ru"]
Sep 25 15:36:30 bob pppd: sent [CHAP Response id=0xdd <2ef5176fd0329662c807298df0f099c60000000000000000e90aa8b576a1d6e5a70bc30023758675fda04cd7a38ce48e00>, name = "bobah"]
Sep 25 15:36:30 bob pppd: rcvd [CHAP Success id=0xdd "S=8F708F508D9B2B034DB3E6775E119A19B7DD8166"]
Sep 25 15:36:30 bob pppd: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:36:30 bob pppd: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.10.10>]
Sep 25 15:36:30 bob pppd: rcvd [CCP ConfReq id=0x1 <mppe -H -M -S -L -D +C> <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:36:30 bob pppd: sent [CCP ConfRej id=0x1 <mppe -H -M -S -L -D +C>]
Sep 25 15:36:30 bob pppd[4104]: Deflate (15) compression enabled
Sep 25 15:36:30 bob pppd: rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:36:30 bob pppd: sent [IPCP ConfAck id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:36:30 bob pppd: rcvd [CCP ConfAck id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:36:30 bob pppd: rcvd [IPCP ConfNak id=0x1 <addr 10.0.10.10>]
Sep 25 15:36:30 bob pppd: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:36:30 bob pppd: rcvd [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:36:30 bob pppd: sent [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:36:30 bob pppd: Deflate (15) compression enabled
Sep 25 15:36:30 bob pppd: rcvd [IPCP ConfAck id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:36:30 bob pppd[4104]: local  IP address 10.0.10.10
Sep 25 15:36:30 bob pppd[4104]: remote IP address 10.0.2.100
Sep 25 15:36:30 bob pppd: local  IP address 10.0.10.10
Sep 25 15:36:30 bob pppd: remote IP address 10.0.2.100
Sep 25 15:36:30 bob pptptunnel: pppd startup succeeded

[-- Attachment #3: messages.server --]
[-- Type: text/plain, Size: 9213 bytes --]

Sep 25 15:31:59 gamuza pppd[6812]: Plugin radius.so loaded.
Sep 25 15:31:59 gamuza pppd[6812]: RADIUS plugin initialized.
Sep 25 15:31:59 gamuza pppd[6812]: Plugin radattr.so loaded.
Sep 25 15:31:59 gamuza pppd[6812]: RADATTR plugin initialized.
Sep 25 15:31:59 gamuza pppd[6812]: pppd 2.4.2 started by root, uid 0
Sep 25 15:31:59 gamuza pppd[6812]: using channel 74
Sep 25 15:31:59 gamuza pppd[6812]: Starting negotiation on /dev/pts/5
Sep 25 15:31:59 gamuza pppd[6812]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf878c722> <pcomp> <accomp> <mrru 1500> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [LCP ConfReq id=0x2 <asyncmap 0x0> <magic 0x98bd677e> <pcomp> <accomp>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [LCP ConfAck id=0x2 <asyncmap 0x0> <magic 0x98bd677e> <pcomp> <accomp>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [LCP ConfRej id=0x1 <mrru 1500>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [LCP ConfReq id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf878c722> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [LCP ConfAck id=0x2 <asyncmap 0x0> <auth chap MS-v2> <magic 0xf878c722> <pcomp> <accomp> <endpoint [MAC:00:0c:f1:6d:8e:49]>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [CHAP Challenge id=0xa6 <93ca74419ce37d572642f0c2b999af85>, name = "gamuza.status-m.ru"]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [CHAP Response id=0xa6 <24dc8c3cde337bb258c4fd2b02da1c9f000000000000000006229321f0c9470f8e6dfb606515e867cc135722f94ff80100>, name = "bobah"]
Sep 25 15:31:59 gamuza pppd[6812]: rc_map2id: can't find tty /dev/ in map database
Sep 25 15:31:59 gamuza pppd[6812]: sent [CHAP Success id=0xa6 "S=F4916B53A62F77C60D2CE709260DE95AE6D09E34"]
Sep 25 15:31:59 gamuza pppd[6812]: Using interface ppp0
Sep 25 15:31:59 gamuza pppd[6812]: sent [CCP ConfReq id=0x1 <mppe -H -M -S -L -D +C> <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [CCP ConfAck id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.10.10>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [IPCP ConfNak id=0x1 <addr 10.0.10.10>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [CCP ConfRej id=0x1 <mppe -H -M -S -L -D +C>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [IPCP ConfAck id=0x1 <compress VJ 0f 01> <addr 10.0.2.100>]
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:31:59 gamuza pppd[6812]: sent [IPCP ConfAck id=0x2 <compress VJ 0f 01> <addr 10.0.10.10>]
Sep 25 15:31:59 gamuza pppd[6812]: Cannot determine ethernet address for proxy ARP
Sep 25 15:31:59 gamuza pppd[6812]: local  IP address 10.0.2.100
Sep 25 15:31:59 gamuza pppd[6812]: remote IP address 10.0.10.10
Sep 25 15:31:59 gamuza pppd[6812]: Script /etc/ppp/ip-up started (pid 6820)
Sep 25 15:31:59 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:31:59 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:02 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 gamuza pppd[6812]: sent [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:02 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:05 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:05 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x3 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:05 gamuza pppd[6812]: sent [CCP ConfAck id=0x3 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:05 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:05 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:08 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:09 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x4 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:09 gamuza pppd[6812]: sent [CCP ConfAck id=0x4 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:09 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:09 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:12 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:12 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x5 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:12 gamuza pppd[6812]: sent [CCP ConfAck id=0x5 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:12 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:12 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:15 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:15 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x6 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:15 gamuza pppd[6812]: sent [CCP ConfAck id=0x6 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:15 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:15 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:18 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:18 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x7 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:18 gamuza pppd[6812]: sent [CCP ConfAck id=0x7 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:18 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:18 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:21 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:21 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x8 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:21 gamuza pppd[6812]: sent [CCP ConfAck id=0x8 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:21 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:21 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:24 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:24 gamuza pppd[6812]: rcvd [CCP ConfReq id=0x9 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:24 gamuza pppd[6812]: sent [CCP ConfAck id=0x9 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:24 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:24 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:27 gamuza pppd[6812]: sent [CCP ConfReq id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:27 gamuza pppd[6812]: rcvd [CCP ConfReq id=0xa <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:27 gamuza pppd[6812]: sent [CCP ConfAck id=0xa <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:27 gamuza pppd[6812]: rcvd [CCP ConfAck id=0x2 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Sep 25 15:32:27 gamuza pppd[6812]: Received bad configure-ack:  1a 04 78 00 18 04 78 00 15 03 2f
Sep 25 15:32:30 gamuza pppd[6812]: CCP: timeout sending Config-Requests 
Sep 25 15:36:16 gamuza pppd[6812]: rcvd [LCP TermReq id=0x3 "User request"]
Sep 25 15:36:16 gamuza pppd[6812]: LCP terminated by peer (User request)
Sep 25 15:36:16 gamuza pppd[6812]: sent [LCP TermAck id=0x3]
Sep 25 15:36:16 gamuza pppd[6812]: Modem hangup
Sep 25 15:36:16 gamuza pppd[6812]: Connection terminated.
Sep 25 15:36:16 gamuza pppd[6812]: Connect time 4.3 minutes.
Sep 25 15:36:16 gamuza pppd[6812]: Sent 13767 bytes, received 2170 bytes.
Sep 25 15:36:16 gamuza pppd[6812]: Waiting for 1 child processes...
Sep 25 15:36:16 gamuza pppd[6812]:   script /etc/ppp/ip-up, pid 6820
Sep 25 15:36:16 gamuza pppd[6812]: Script /etc/ppp/ip-up finished (pid 6820), status = 0x0
Sep 25 15:36:16 gamuza pppd[6812]: Terminating on signal 2.
Sep 25 15:36:16 gamuza pppd[6812]: Script /etc/ppp/ip-down started (pid 6895)
Sep 25 15:36:16 gamuza pppd[6812]: Script /etc/ppp/ip-down finished (pid 6895), status = 0x0
Sep 25 15:36:16 gamuza pppd[6812]: Connect time 4.3 minutes.
Sep 25 15:36:16 gamuza pppd[6812]: Sent 13767 bytes, received 2170 bytes.
Sep 25 15:36:16 gamuza pppd[6812]: Exit.

[-- Attachment #4: BOBAH.vcf --]
[-- Type: text/x-vcard, Size: 131 bytes --]

begin:vcard
fn:Vladimir Bolnokin
n:Bolnokin;Vladimir
email;internet:BOBAH@sysadmins.ru
x-mozilla-html:FALSE
version:2.1
end:vcard