Привет!Возникла проблема с доступом в интернет через l2tp посредством MPD 5
После нескольких неудачных попыток соединиться, MPD более не пытается это сделать,
хотя макс.кол-во попыток установлено в 0.
Вот что пишет в лог. И так раз в несколько дней:
Jun 20 21:30:54 r mpd: [Lup1] Link: Leave bundle "Bup1"
Jun 20 21:30:54 r mpd: [Bup1] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Jun 20 21:30:54 r mpd: [Bup1] IPCP: Close event
Jun 20 21:30:54 r mpd: [Bup1] IPCP: state change Stopped --> Closed
Jun 20 21:30:54 r mpd: [Bup1] IPCP: Down event
Jun 20 21:30:54 r mpd: [Bup1] IPCP: state change Closed --> Initial
Jun 20 21:30:54 r mpd: [Lup1] LCP: SendTerminateReq #48
Jun 20 21:30:54 r mpd: [Lup1] LCP: LayerDown
Jun 20 21:30:54 r mpd: [Lup1] rec'd proto IP during terminate phase
Jun 20 21:30:56 r mpd: last message repeated 283 times
Jun 20 21:30:56 r mpd: [Lup1] LCP: SendTerminateReq #49
Jun 20 21:30:56 r mpd: [Lup1] rec'd proto IP during terminate phase
Jun 20 21:30:56 r mpd: [Lup1] LCP: rec'd Terminate Ack #49 (Closing)
Jun 20 21:30:56 r mpd: [Lup1] LCP: state change Closing --> Closed
Jun 20 21:30:56 r mpd: [Lup1] LCP: LayerFinish
Jun 20 21:30:56 r mpd: [Lup1] L2TP: Call #4550006 terminated locally
Jun 20 21:30:56 r mpd: [Lup1] Link: DOWN event
Jun 20 21:30:56 r mpd: [Lup1] LCP: Down event
Jun 20 21:30:56 r mpd: [Lup1] LCP: state change Closed --> Initial
Jun 20 21:31:06 r mpd: L2TP: Control connection 0x28614808 terminated: 0 (no more sessions exist in this tunnel)
Jun 20 21:31:17 r mpd: L2TP: Control connection 0x28614808 destroyed
и всё. помогает рестарт демона.
Провайдер - Корбина (Билайн).
Вот конфиг:
default:
load uplink1
load pptp_server
uplink1:
create bundle static Bup1
# set bundle no multilink
# set bundle disable multilink
set bundle no compression
set bundle no encryption
# set bundle no noretry
set ipcp ranges 0.0.0.0/0 0.0.0.0/0
# set ipcp no vjcomp
set ipcp disable vjcomp
# set iface route default
set iface disable on-demand
set iface enable tcpmssfix
set iface disable proxy-arp
set iface idle 0
set iface up-script up.sh
set iface down-script down.sh
create link static Lup1 l2tp
set l2tp peer 85.21.0.251
set l2tp hostname my_host
set l2tp disable outcall
# set l2tp disable incoming
# set l2tp enable originate
# set l2tp enable always-ack
# set l2tp disable delayed-ack
set link no pap chap eap
set link accept chap
# set link enable no-orig-auth
set auth authname "my_login"
# set link no acfcomp protocomp
set link disable acfcomp protocomp
set link mtu 1460
set link mru 1460
set link keep-alive 30 120
set link max-redial 0
set link action bundle Bup1
open
Маршрут к сети vpn серверов прописан статиком и не сносится. Фаервол для этой сети открыт.
В скрипте поднятия ифейса прописывается default, правила фаервола.
Все работает, но до какого-то момента. Несколько месяцев назад работало нормально
(но и адрес сервера был другой).
А вот полный лог с момента прошлого удачного подключения:
Jun 19 15:40:26 r mpd: [Bup1] IPADDR a.b.c.d
Jun 19 15:40:26 r mpd: [Bup1] IPCP: state change Ack-Sent --> Opened
Jun 19 15:40:26 r mpd: [Bup1] IPCP: LayerUp
Jun 19 15:40:26 r mpd: [Bup1] a.b.c.d -> 85.21.0.251
Jun 19 15:40:26 r mpd: [Bup1] IFACE: Up event
Jun 20 21:08:43 r mpd: [Lup1] LCP: rec'd Terminate Request #2 (Opened)
Jun 20 21:08:43 r mpd: [Lup1] LCP: state change Opened --> Stopping
Jun 20 21:08:43 r mpd: [Lup1] Link: Leave bundle "Bup1"
Jun 20 21:08:43 r mpd: [Bup1] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Jun 20 21:08:43 r mpd: [Bup1] IPCP: Close event
Jun 20 21:08:43 r mpd: [Bup1] IPCP: state change Opened --> Closing
Jun 20 21:08:43 r mpd: [Bup1] IPCP: SendTerminateReq #14
Jun 20 21:08:43 r mpd: [Bup1] IPCP: LayerDown
Jun 20 21:08:43 r mpd: [Bup1] IFACE: Down event
Jun 20 21:08:43 r mpd: [Bup1] IPCP: Down event
Jun 20 21:08:43 r mpd: [Bup1] IPCP: LayerFinish
Jun 20 21:08:43 r mpd: [Bup1] Bundle: No NCPs left. Closing links...
Jun 20 21:08:43 r mpd: [Bup1] IPCP: state change Closing --> Initial
Jun 20 21:08:43 r mpd: [Lup1] LCP: SendTerminateAck #30
Jun 20 21:08:43 r mpd: [Lup1] LCP: LayerDown
Jun 20 21:08:43 r mpd: [Lup1] L2TP: call #4550003 terminated: result=2 error=6 errmsg="Locally generated disconnect"
Jun 20 21:08:43 r mpd: [Lup1] Link: DOWN event
Jun 20 21:08:43 r mpd: [Lup1] LCP: Down event
Jun 20 21:08:43 r mpd: [Lup1] LCP: state change Stopping --> Starting
Jun 20 21:08:43 r mpd: [Lup1] Link: reconnection attempt 1 in 4 seconds
Jun 20 21:08:47 r mpd: [Lup1] Link: reconnection attempt 1
Jun 20 21:08:47 r mpd: [Lup1] L2TP: Incoming call #4550004 via control connection 0x28614808 initiated
Jun 20 21:08:47 r mpd: [Lup1] L2TP: Call #4550004 connected
Jun 20 21:08:47 r mpd: [Lup1] Link: UP event
Jun 20 21:08:47 r mpd: [Lup1] LCP: Up event
Jun 20 21:08:47 r mpd: [Lup1] LCP: state change Starting --> Req-Sent
Jun 20 21:08:47 r mpd: [Lup1] LCP: SendConfigReq #31
Jun 20 21:08:47 r mpd: [Lup1] MRU 1460
Jun 20 21:08:47 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:08:49 r mpd: [Lup1] LCP: SendConfigReq #32
Jun 20 21:08:49 r mpd: [Lup1] MRU 1460
Jun 20 21:08:49 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:08:51 r mpd: [Lup1] LCP: SendConfigReq #33
Jun 20 21:08:51 r mpd: [Lup1] MRU 1460
Jun 20 21:08:51 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:08:53 r mpd: [Lup1] LCP: SendConfigReq #34
Jun 20 21:08:53 r mpd: [Lup1] MRU 1460
Jun 20 21:08:53 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:08:55 r mpd: [Lup1] LCP: SendConfigReq #35
Jun 20 21:08:55 r mpd: [Lup1] MRU 1460
Jun 20 21:08:55 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:08:57 r mpd: [Lup1] LCP: SendConfigReq #36
Jun 20 21:08:57 r mpd: [Lup1] MRU 1460
Jun 20 21:08:57 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:08:59 r mpd: [Lup1] LCP: SendConfigReq #37
Jun 20 21:08:59 r mpd: [Lup1] MRU 1460
Jun 20 21:08:59 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:09:01 r mpd: [Lup1] LCP: SendConfigReq #38
Jun 20 21:09:01 r mpd: [Lup1] MRU 1460
Jun 20 21:09:01 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:09:03 r mpd: [Lup1] LCP: SendConfigReq #39
Jun 20 21:09:03 r mpd: [Lup1] MRU 1460
Jun 20 21:09:03 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:09:05 r mpd: [Lup1] LCP: SendConfigReq #40
Jun 20 21:09:05 r mpd: [Lup1] MRU 1460
Jun 20 21:09:05 r mpd: [Lup1] MAGICNUM 92e447bb
Jun 20 21:09:07 r mpd: [Lup1] LCP: parameter negotiation failed
Jun 20 21:09:07 r mpd: [Lup1] LCP: state change Req-Sent --> Stopped
Jun 20 21:09:07 r mpd: [Lup1] LCP: LayerFinish
Jun 20 21:09:07 r mpd: [Lup1] L2TP: Call #4550004 terminated locally
Jun 20 21:09:07 r mpd: [Lup1] Link: DOWN event
Jun 20 21:09:07 r mpd: [Lup1] LCP: Down event
Jun 20 21:09:07 r mpd: [Lup1] LCP: state change Stopped --> Starting
Jun 20 21:09:07 r mpd: [Lup1] LCP: LayerStart
Jun 20 21:09:07 r mpd: [Lup1] Link: reconnection attempt 2 in 1 seconds
Jun 20 21:09:08 r mpd: [Lup1] Link: reconnection attempt 2
Jun 20 21:09:08 r mpd: [Lup1] L2TP: Incoming call #4550005 via control connection 0x28614808 initiated
Jun 20 21:09:48 r mpd: [Lup1] L2TP: Call #4550005 connected
Jun 20 21:09:48 r mpd: [Lup1] Link: UP event
Jun 20 21:09:48 r mpd: [Lup1] LCP: Up event
Jun 20 21:09:48 r mpd: [Lup1] LCP: state change Starting --> Req-Sent
Jun 20 21:09:48 r mpd: [Lup1] LCP: SendConfigReq #41
Jun 20 21:09:48 r mpd: [Lup1] MRU 1460
Jun 20 21:09:48 r mpd: [Lup1] MAGICNUM a61cf75c
Jun 20 21:09:50 r mpd: [Lup1] LCP: SendConfigReq #42
Jun 20 21:09:50 r mpd: [Lup1] MRU 1460
Jun 20 21:09:50 r mpd: [Lup1] MAGICNUM a61cf75c
Jun 20 21:09:50 r mpd: [Lup1] LCP: rec'd Configure Request #1 (Req-Sent)
Jun 20 21:09:50 r mpd: [Lup1] MRU 1460
Jun 20 21:09:50 r mpd: [Lup1] AUTHPROTO CHAP MD5
Jun 20 21:09:50 r mpd: [Lup1] MAGICNUM 9fd04b70
Jun 20 21:09:50 r mpd: [Lup1] LCP: SendConfigAck #1
Jun 20 21:09:50 r mpd: [Lup1] MRU 1460
Jun 20 21:09:50 r mpd: [Lup1] AUTHPROTO CHAP MD5
Jun 20 21:09:50 r mpd: [Lup1] MAGICNUM 9fd04b70
Jun 20 21:09:50 r mpd: [Lup1] LCP: state change Req-Sent --> Ack-Sent
Jun 20 21:09:50 r mpd: [Lup1] LCP: rec'd Configure Ack #42 (Ack-Sent)
Jun 20 21:09:50 r mpd: [Lup1] MRU 1460
Jun 20 21:09:50 r mpd: [Lup1] MAGICNUM a61cf75c
Jun 20 21:09:50 r mpd: [Lup1] LCP: state change Ack-Sent --> Opened
Jun 20 21:09:50 r mpd: [Lup1] LCP: auth: peer wants CHAP, I want nothing
Jun 20 21:09:50 r mpd: [Lup1] LCP: LayerUp
Jun 20 21:09:50 r mpd: [Lup1] CHAP: rec'd CHALLENGE #1 len: 28
Jun 20 21:09:50 r mpd: [Lup1] Name: "bras251"
Jun 20 21:09:50 r mpd: [Lup1] CHAP: Using authname "my_login"
Jun 20 21:09:50 r mpd: [Lup1] CHAP: sending RESPONSE #1 len: 29
Jun 20 21:09:50 r mpd: [Lup1] CHAP: rec'd SUCCESS #1 len: 4
Jun 20 21:09:50 r mpd: [Lup1] LCP: authorization successful
Jun 20 21:09:50 r mpd: [Lup1] Link: Matched action 'bundle "Bup1" ""'
Jun 20 21:09:50 r mpd: [Lup1] Link: Join bundle "Bup1"
Jun 20 21:09:50 r mpd: [Bup1] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Jun 20 21:09:50 r mpd: [Bup1] IPCP: Open event
Jun 20 21:09:50 r mpd: [Bup1] IPCP: state change Initial --> Starting
Jun 20 21:09:50 r mpd: [Bup1] IPCP: LayerStart
Jun 20 21:09:50 r mpd: [Bup1] IPCP: Up event
Jun 20 21:09:50 r mpd: [Bup1] IPCP: state change Starting --> Req-Sent
Jun 20 21:09:50 r mpd: [Bup1] IPCP: SendConfigReq #15
Jun 20 21:09:50 r mpd: [Bup1] IPADDR 0.0.0.0
Jun 20 21:09:50 r mpd: [Bup1] IPCP: rec'd Configure Request #1 (Req-Sent)
Jun 20 21:09:50 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:09:50 r mpd: [Bup1] 85.21.0.251 is OK
Jun 20 21:09:50 r mpd: [Bup1] IPCP: SendConfigAck #1
Jun 20 21:09:50 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:09:50 r mpd: [Bup1] IPCP: state change Req-Sent --> Ack-Sent
Jun 20 21:09:50 r mpd: [Bup1] IPCP: rec'd Configure Nak #15 (Ack-Sent)
Jun 20 21:09:50 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:09:50 r mpd: [Bup1] a.b.c.d is OK
Jun 20 21:09:50 r mpd: [Bup1] IPCP: SendConfigReq #16
Jun 20 21:09:50 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:09:50 r mpd: [Bup1] IPCP: rec'd Configure Ack #16 (Ack-Sent)
Jun 20 21:09:50 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:09:50 r mpd: [Bup1] IPCP: state change Ack-Sent --> Opened
Jun 20 21:09:50 r mpd: [Bup1] IPCP: LayerUp
Jun 20 21:09:50 r mpd: [Bup1] a.b.c.d -> 85.21.0.251
Jun 20 21:09:50 r mpd: [Bup1] IFACE: Up event
Jun 20 21:30:22 r mpd: [Lup1] LCP: rec'd Terminate Request #2 (Opened)
Jun 20 21:30:22 r mpd: [Lup1] LCP: state change Opened --> Stopping
Jun 20 21:30:22 r mpd: [Lup1] Link: Leave bundle "Bup1"
Jun 20 21:30:22 r mpd: [Bup1] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Jun 20 21:30:22 r mpd: [Bup1] IPCP: Close event
Jun 20 21:30:22 r mpd: [Bup1] IPCP: state change Opened --> Closing
Jun 20 21:30:22 r mpd: [Bup1] IPCP: SendTerminateReq #17
Jun 20 21:30:22 r mpd: [Bup1] IPCP: LayerDown
Jun 20 21:30:22 r mpd: [Bup1] IFACE: Down event
Jun 20 21:30:22 r mpd: [Bup1] IPCP: Down event
Jun 20 21:30:22 r mpd: [Bup1] IPCP: LayerFinish
Jun 20 21:30:22 r mpd: [Bup1] Bundle: No NCPs left. Closing links...
Jun 20 21:30:22 r mpd: [Bup1] IPCP: state change Closing --> Initial
Jun 20 21:30:22 r mpd: [Lup1] LCP: SendTerminateAck #43
Jun 20 21:30:22 r mpd: [Lup1] LCP: LayerDown
Jun 20 21:30:22 r mpd: [Lup1] L2TP: call #4550005 terminated: result=2 error=6 errmsg="Locally generated disconnect"
Jun 20 21:30:22 r mpd: [Lup1] Link: DOWN event
Jun 20 21:30:22 r mpd: [Lup1] LCP: Down event
Jun 20 21:30:22 r mpd: [Lup1] LCP: state change Stopping --> Starting
Jun 20 21:30:22 r mpd: [Lup1] Link: reconnection attempt 1 in 3 seconds
Jun 20 21:30:25 r mpd: [Lup1] Link: reconnection attempt 1
Jun 20 21:30:25 r mpd: [Lup1] L2TP: Incoming call #4550006 via control connection 0x28614808 initiated
Jun 20 21:30:25 r mpd: [Lup1] L2TP: Call #4550006 connected
Jun 20 21:30:25 r mpd: [Lup1] Link: UP event
Jun 20 21:30:25 r mpd: [Lup1] LCP: Up event
Jun 20 21:30:25 r mpd: [Lup1] LCP: state change Starting --> Req-Sent
Jun 20 21:30:25 r mpd: [Lup1] LCP: SendConfigReq #44
Jun 20 21:30:25 r mpd: [Lup1] MRU 1460
Jun 20 21:30:25 r mpd: [Lup1] MAGICNUM b8d22821
Jun 20 21:30:27 r mpd: [Lup1] LCP: SendConfigReq #45
Jun 20 21:30:27 r mpd: [Lup1] MRU 1460
Jun 20 21:30:27 r mpd: [Lup1] MAGICNUM b8d22821
Jun 20 21:30:28 r mpd: [Lup1] LCP: rec'd Configure Request #1 (Req-Sent)
Jun 20 21:30:28 r mpd: [Lup1] MRU 1460
Jun 20 21:30:28 r mpd: [Lup1] AUTHPROTO CHAP MD5
Jun 20 21:30:28 r mpd: [Lup1] MAGICNUM 9fe38a34
Jun 20 21:30:28 r mpd: [Lup1] LCP: SendConfigAck #1
Jun 20 21:30:28 r mpd: [Lup1] MRU 1460
Jun 20 21:30:28 r mpd: [Lup1] AUTHPROTO CHAP MD5
Jun 20 21:30:28 r mpd: [Lup1] MAGICNUM 9fe38a34
Jun 20 21:30:28 r mpd: [Lup1] LCP: state change Req-Sent --> Ack-Sent
Jun 20 21:30:29 r mpd: [Lup1] LCP: SendConfigReq #46
Jun 20 21:30:29 r mpd: [Lup1] MRU 1460
Jun 20 21:30:29 r mpd: [Lup1] MAGICNUM b8d22821
Jun 20 21:30:29 r mpd: [Lup1] LCP: rec'd Configure Ack #46 (Ack-Sent)
Jun 20 21:30:29 r mpd: [Lup1] MRU 1460
Jun 20 21:30:29 r mpd: [Lup1] MAGICNUM b8d22821
Jun 20 21:30:29 r mpd: [Lup1] LCP: state change Ack-Sent --> Opened
Jun 20 21:30:29 r mpd: [Lup1] LCP: auth: peer wants CHAP, I want nothing
Jun 20 21:30:29 r mpd: [Lup1] LCP: LayerUp
Jun 20 21:30:30 r mpd: [Lup1] LCP: rec'd Configure Request #2 (Opened)
Jun 20 21:30:30 r mpd: [Lup1] MRU 1460
Jun 20 21:30:30 r mpd: [Lup1] AUTHPROTO CHAP MD5
Jun 20 21:30:30 r mpd: [Lup1] MAGICNUM 9fe38a34
Jun 20 21:30:30 r mpd: [Lup1] LCP: LayerDown
Jun 20 21:30:30 r mpd: [Lup1] LCP: SendConfigReq #47
Jun 20 21:30:30 r mpd: [Lup1] MRU 1460
Jun 20 21:30:30 r mpd: [Lup1] MAGICNUM b8d22821
Jun 20 21:30:30 r mpd: [Lup1] LCP: SendConfigAck #2
Jun 20 21:30:30 r mpd: [Lup1] MRU 1460
Jun 20 21:30:30 r mpd: [Lup1] AUTHPROTO CHAP MD5
Jun 20 21:30:30 r mpd: [Lup1] MAGICNUM 9fe38a34
Jun 20 21:30:30 r mpd: [Lup1] LCP: state change Opened --> Ack-Sent
Jun 20 21:30:30 r mpd: [Lup1] LCP: rec'd Configure Ack #47 (Ack-Sent)
Jun 20 21:30:30 r mpd: [Lup1] MRU 1460
Jun 20 21:30:30 r mpd: [Lup1] MAGICNUM b8d22821
Jun 20 21:30:30 r mpd: [Lup1] LCP: state change Ack-Sent --> Opened
Jun 20 21:30:30 r mpd: [Lup1] LCP: auth: peer wants CHAP, I want nothing
Jun 20 21:30:30 r mpd: [Lup1] LCP: LayerUp
Jun 20 21:30:30 r mpd: [Lup1] CHAP: rec'd CHALLENGE #1 len: 28
Jun 20 21:30:30 r mpd: [Lup1] Name: "bras251"
Jun 20 21:30:30 r mpd: [Lup1] CHAP: Using authname "my_login"
Jun 20 21:30:30 r mpd: [Lup1] CHAP: sending RESPONSE #1 len: 29
Jun 20 21:30:32 r mpd: [Lup1] CHAP: sending RESPONSE #1 len: 29
Jun 20 21:30:32 r mpd: [Lup1] CHAP: rec'd SUCCESS #1 len: 4
Jun 20 21:30:32 r mpd: [Lup1] LCP: authorization successful
Jun 20 21:30:32 r mpd: [Lup1] Link: Matched action 'bundle "Bup1" ""'
Jun 20 21:30:32 r mpd: [Lup1] Link: Join bundle "Bup1"
Jun 20 21:30:32 r mpd: [Bup1] Bundle: Status update: up 1 link, total bandwidth 64000 bps
Jun 20 21:30:32 r mpd: [Bup1] IPCP: Open event
Jun 20 21:30:32 r mpd: [Bup1] IPCP: state change Initial --> Starting
Jun 20 21:30:32 r mpd: [Bup1] IPCP: LayerStart
Jun 20 21:30:32 r mpd: [Bup1] IPCP: Up event
Jun 20 21:30:32 r mpd: [Bup1] IPCP: state change Starting --> Req-Sent
Jun 20 21:30:32 r mpd: [Bup1] IPCP: SendConfigReq #18
Jun 20 21:30:32 r mpd: [Bup1] IPADDR 0.0.0.0
Jun 20 21:30:32 r mpd: [Bup1] IPCP: rec'd Configure Request #1 (Req-Sent)
Jun 20 21:30:32 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:30:32 r mpd: [Bup1] 85.21.0.251 is OK
Jun 20 21:30:32 r mpd: [Bup1] IPCP: SendConfigAck #1
Jun 20 21:30:32 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:30:32 r mpd: [Bup1] IPCP: state change Req-Sent --> Ack-Sent
Jun 20 21:30:32 r mpd: [Bup1] IPCP: rec'd Configure Nak #18 (Ack-Sent)
Jun 20 21:30:32 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:32 r mpd: [Bup1] a.b.c.d is OK
Jun 20 21:30:32 r mpd: [Bup1] IPCP: SendConfigReq #19
Jun 20 21:30:32 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:34 r mpd: [Bup1] IPCP: SendConfigReq #20
Jun 20 21:30:34 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:34 r mpd: [Bup1] IPCP: rec'd Configure Ack #20 (Ack-Sent)
Jun 20 21:30:34 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:34 r mpd: [Bup1] IPCP: state change Ack-Sent --> Opened
Jun 20 21:30:34 r mpd: [Bup1] IPCP: LayerUp
Jun 20 21:30:34 r mpd: [Bup1] a.b.c.d -> 85.21.0.251
Jun 20 21:30:34 r mpd: [Bup1] IFACE: Up event
Jun 20 21:30:34 r mpd: [Bup1] IPCP: rec'd Configure Request #2 (Opened)
Jun 20 21:30:34 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:30:34 r mpd: [Bup1] 85.21.0.251 is OK
Jun 20 21:30:34 r mpd: [Bup1] IPCP: LayerDown
Jun 20 21:30:34 r mpd: [Bup1] IFACE: Down event
Jun 20 21:30:34 r mpd: [Bup1] IPCP: SendConfigReq #21
Jun 20 21:30:34 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:34 r mpd: [Bup1] IPCP: SendConfigAck #2
Jun 20 21:30:34 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:30:34 r mpd: [Bup1] IPCP: state change Opened --> Ack-Sent
Jun 20 21:30:36 r mpd: [Bup1] IPCP: rec'd Configure Request #3 (Ack-Sent)
Jun 20 21:30:36 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:30:36 r mpd: [Bup1] 85.21.0.251 is OK
Jun 20 21:30:36 r mpd: [Bup1] IPCP: SendConfigAck #3
Jun 20 21:30:36 r mpd: [Bup1] IPADDR 85.21.0.251
Jun 20 21:30:36 r mpd: [Bup1] IPCP: SendConfigReq #22
Jun 20 21:30:36 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:36 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:38 r mpd: last message repeated 303 times
Jun 20 21:30:38 r mpd: [Bup1] IPCP: SendConfigReq #23
Jun 20 21:30:38 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:38 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:40 r mpd: last message repeated 324 times
Jun 20 21:30:40 r mpd: [Bup1] IPCP: SendConfigReq #24
Jun 20 21:30:40 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:40 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:42 r mpd: last message repeated 326 times
Jun 20 21:30:42 r mpd: [Bup1] IPCP: SendConfigReq #25
Jun 20 21:30:42 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:42 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:44 r mpd: last message repeated 312 times
Jun 20 21:30:44 r mpd: [Bup1] IPCP: SendConfigReq #26
Jun 20 21:30:44 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:44 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:46 r mpd: last message repeated 264 times
Jun 20 21:30:46 r mpd: [Bup1] IPCP: SendConfigReq #27
Jun 20 21:30:46 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:46 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:48 r mpd: last message repeated 262 times
Jun 20 21:30:48 r mpd: [Bup1] IPCP: SendConfigReq #28
Jun 20 21:30:48 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:48 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:50 r mpd: last message repeated 271 times
Jun 20 21:30:50 r mpd: [Bup1] IPCP: SendConfigReq #29
Jun 20 21:30:50 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:50 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:52 r mpd: last message repeated 329 times
Jun 20 21:30:52 r mpd: [Bup1] IPCP: SendConfigReq #30
Jun 20 21:30:52 r mpd: [Bup1] IPADDR a.b.c.d
Jun 20 21:30:52 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:54 r mpd: last message repeated 303 times
Jun 20 21:30:54 r mpd: [Bup1] IPCP: parameter negotiation failed
Jun 20 21:30:54 r mpd: [Bup1] IPCP: state change Ack-Sent --> Stopped
Jun 20 21:30:54 r mpd: [Bup1] IPCP: LayerFinish
Jun 20 21:30:54 r mpd: [Bup1] Bundle: No NCPs left. Closing links...
Jun 20 21:30:54 r mpd: [Bup1] Bundle: closing link "Lup1"...
Jun 20 21:30:54 r mpd: [Lup1] rec'd unexpected protocol IP
Jun 20 21:30:54 r mpd: [Lup1] Link: CLOSE event
Jun 20 21:30:54 r mpd: [Lup1] LCP: Close event
Jun 20 21:30:54 r mpd: [Lup1] LCP: state change Opened --> Closing
Jun 20 21:30:54 r mpd: [Lup1] Link: Leave bundle "Bup1"
Jun 20 21:30:54 r mpd: [Bup1] Bundle: Status update: up 0 links, total bandwidth 9600 bps
Jun 20 21:30:54 r mpd: [Bup1] IPCP: Close event
Jun 20 21:30:54 r mpd: [Bup1] IPCP: state change Stopped --> Closed
Jun 20 21:30:54 r mpd: [Bup1] IPCP: Down event
Jun 20 21:30:54 r mpd: [Bup1] IPCP: state change Closed --> Initial
Jun 20 21:30:54 r mpd: [Lup1] LCP: SendTerminateReq #48
Jun 20 21:30:54 r mpd: [Lup1] LCP: LayerDown
Jun 20 21:30:54 r mpd: [Lup1] rec'd proto IP during terminate phase
Jun 20 21:30:56 r mpd: last message repeated 283 times
Jun 20 21:30:56 r mpd: [Lup1] LCP: SendTerminateReq #49
Jun 20 21:30:56 r mpd: [Lup1] rec'd proto IP during terminate phase
Jun 20 21:30:56 r mpd: [Lup1] LCP: rec'd Terminate Ack #49 (Closing)
Jun 20 21:30:56 r mpd: [Lup1] LCP: state change Closing --> Closed
Jun 20 21:30:56 r mpd: [Lup1] LCP: LayerFinish
Jun 20 21:30:56 r mpd: [Lup1] L2TP: Call #4550006 terminated locally
Jun 20 21:30:56 r mpd: [Lup1] Link: DOWN event
Jun 20 21:30:56 r mpd: [Lup1] LCP: Down event
Jun 20 21:30:56 r mpd: [Lup1] LCP: state change Closed --> Initial
Jun 20 21:31:06 r mpd: L2TP: Control connection 0x28614808 terminated: 0 (no more sessions exist in this tunnel)
Jun 20 21:31:17 r mpd: L2TP: Control connection 0x28614808 destroyed