Jan 1 00:28:45 pptp[1227]: Connect time 8.5 minutes.
Jan 1 00:28:45 pptp[1227]: Sent 109069 bytes, received 2041583 bytes.
Jan 1 00:28:45 pptp[1227]: Connect time 8.5 minutes.
Jan 1 00:28:45 pptp[1227]: Sent 109109 bytes, received 2041583 bytes.
Jan 1 00:29:15 pptp[1227]: Connect time 9.0 minutes.
Jan 1 00:29:15 pptp[1227]: Sent 152385 bytes, received 2657611 bytes.
Jan 1 00:29:15 pptp[1227]: Connect time 9.0 minutes.
Jan 1 00:29:15 pptp[1227]: Sent 152385 bytes, received 2657611 bytes.
Jan 1 00:29:15 pptp[1227]: Connect time 9.0 minutes.
Jan 1 00:29:15 pptp[1227]: Sent 152385 bytes, received 2657611 bytes.
Jan 1 00:29:45 pptp[1227]: Connect time 9.5 minutes.
Jan 1 00:29:45 pptp[1227]: Sent 172295 bytes, received 3351077 bytes.
Jan 1 00:29:45 pptp[1227]: Connect time 9.5 minutes.
Jan 1 00:29:45 pptp[1227]: Sent 172295 bytes, received 3351077 bytes.
Jan 1 00:29:45 pptp[1227]: Connect time 9.5 minutes.
Jan 1 00:29:45 pptp[1227]: Sent 172295 bytes, received 3351077 bytes.
Jan 1 00:29:45 pptp[1227]: Connect time 9.5 minutes.
Jan 1 00:29:45 pptp[1227]: Sent 172295 bytes, received 3351077 bytes.
Jan 1 00:29:49 conf_wan[1391]: begin wan_conf
Jan 1 00:29:49 conf_wan[1391]: CONFIG_ACTION_READ - start
Jan 1 00:30:11 event: send event "ipoe lease fail"
Jan 1 00:30:11 resident: record = action:leasefail;iface:eth2.5;
Jan 1 00:30:11 resident: phys_iface eth2.5
Jan 1 00:30:11 test: ip_type = (null)
Jan 1 00:30:11 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:30:11 resident: phys_iface
Jan 1 00:30:11 resident: resident_ipoe_handler - 2
Jan 1 00:30:11 resident: resident_ipoe_handler - Not contag found
Jan 1 00:30:12 event: send event "ipoe up"
Jan 1 00:30:12 resident: record = action:up;iface:eth2.5;contag:1;ipaddr:10.25.15.64 ;netmask:255.255.252.0 ;gateway:10.25.12.1 ;dns1:109.69.72.22;dns2:109.69.72.26;
Jan 1 00:30:12 resident: phys_iface eth2.5
Jan 1 00:30:12 test: ip_type = (null)
Jan 1 00:30:12 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:30:12 resident: phys_iface
Jan 1 00:30:12 resident: resident_ipoe_handler - 2
Jan 1 00:30:12 resident: resident_ipoe_handler - 3, name: eth2.5_1
Jan 1 00:30:12 resident: resident_ipoe_handler - l2:eth2.5, l3:eth2.5_1, tun:eth2.5_3, ip_type:0
Jan 1 00:30:12 resident: resident_ipoe_handler - ipv4
Jan 1 00:30:12 resident: start ip_is_up on iface eth2.5_1
Jan 1 00:30:12 resident: ip_is_up for link eth2.5_1
Jan 1 00:30:12 set_dhcp_routes: set routes for iface eth2.5
Jan 1 00:30:12 resident: update dns
Jan 1 00:30:12 resident: update rip
Jan 1 00:30:12 resident: update igmpx
Jan 1 00:30:12 resident: stop igmpx
Jan 1 00:30:12 dnsmasq[822]: read /tmp/hosts - 2 addresses
Jan 1 00:30:12 dnsmasq-dhcp[822]: read /etc/ethers - 0 addresses
Jan 1 00:30:12 dnsmasq[822]: using nameserver 193.34.8.6#53
Jan 1 00:30:12 dnsmasq[822]: using nameserver 78.31.75.228#53
Jan 1 00:30:12 kernel: [ 1512.440000] eth2.5: dev_set_allmulti(master, -1)
Jan 1 00:30:12 iface: this is eth2.5
Jan 1 00:30:12 resident: igmpx eth2.5
Jan 1 00:30:12 syslog: Loading liblogger v2.0.1
Jan 1 00:30:12 syslog: upstream ifaces: eth2.5
Jan 1 00:30:12 syslog: downstream ifaces: br0
Jan 1 00:30:12 syslog: hews interval = 120.0 sec
Jan 1 00:30:12 syslog: doublet join enabled
Jan 1 00:30:12 syslog: Using old argv style
Jan 1 00:30:12 syslog: daemonizing ...
Jan 1 00:30:12 syslog: kernel multicast version is 305 (v3.05 ?)
Jan 1 00:30:12 syslog: kernel mroute inited
Jan 1 00:30:12 syslog: proxy prepared
Jan 1 00:30:12 kernel: [ 1512.532000] eth2.5: dev_set_allmulti(master, 1)
Jan 1 00:30:12 syslog: vifi #0 added for eth2.5
Jan 1 00:30:12 syslog: vifi #1 added for br0
Jan 1 00:30:12 syslog: valid VIF's configured: upstreams=1, downstreams=1. Ok.
Jan 1 00:30:12 resident: update igmpx compiled
Jan 1 00:30:12 resident: update ntpclient
Jan 1 00:30:12 update_ntpclient: ntpclient is disable
Jan 1 00:30:12 start_pppd: tunnel: ifaces/eth2.5/services/eth2.5_1/tunnels/eth2.5_3/
Jan 1 00:30:12 resident: start pppd on eth2.5_3
Jan 1 00:30:12 resident: stop pppd on eth2.5_3
Jan 1 00:30:12 resident: set lock on eth2.5_3, with "/var/lock/eth2.5_3.lock"
Jan 1 00:30:12 pptp[1227]: Connect time 10.0 minutes.
Jan 1 00:30:12 pptp[1227]: Sent 203396 bytes, received 3889506 bytes.
Jan 1 00:30:12 pptp[1227]: Terminating on signal 15
Jan 1 00:30:12 pptp[1227]: lcp_close: unit:0, reason: "User request" (status: 5, state: 9, was_ip_down: 0)
Jan 1 00:30:12 pptp[1227]: Connect time 10.0 minutes.
Jan 1 00:30:12 pptp[1227]: Sent 203396 bytes, received 3889506 bytes.
Jan 1 00:30:12 pptp[1227]: Down ppp with status (5)5
Jan 1 00:30:12 resident: stopped link(contype:pptp, iface:eth2.5_3)
Jan 1 00:30:12 event: ppp_down - do event
Jan 1 00:30:12 pptp[1227]: Connect time 10.0 minutes.
Jan 1 00:30:12 pptp[1227]: Sent 203396 bytes, received 3889506 bytes.
Jan 1 00:30:12 resident_ppp_handler: record = action:down;iface:ppp0;link:eth2.5_3;status:5;
Jan 1 00:30:12 pptp[1227]: Connect time 10.0 minutes.
Jan 1 00:30:12 pptp[1227]: Sent 203396 bytes, received 3889506 bytes.
Jan 1 00:30:12 pptp[1227]: Connection terminated.
Jan 1 00:30:12 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:30:12 pptp[1229]: Closing connection (unhandled)
Jan 1 00:30:12 pptp[1229]: Sent control packet type is 12 'Call-Clear-Request'
Jan 1 00:30:12 pptp[1229]: Closing connection (call state)
Jan 1 00:30:12 pptp[1227]: lcp_close: unit:0, reason: "" (status: 5, state: 0, was_ip_down: 1)
Jan 1 00:30:12 pptp[1227]: Exit.(5)
Jan 1 00:30:12 pptp[1442]: Plugin /usr/lib/pppd/pptp.so loaded.
Jan 1 00:30:12 pptp[1442]: PPTP plugin version 0.8.3 compiled against pppd 2.4.4
Jan 1 00:30:12 pptp[1443]: pppd 2.4.4 started by admin, uid 0
Jan 1 00:30:12 pptp[1443]: Check server vpn.nlink.ru
Jan 1 00:30:12 pptp[1443]: route_add: have route to host on this dev eth2.5
Jan 1 00:30:12 pptp[1444]: IP: 78.31.78.10
Jan 1 00:30:12 pptp[1444]: control connection
Jan 1 00:30:12 pptp[1444]: unix_sock
Jan 1 00:30:12 pptp[1445]: Sent control packet type is 1 'Start-Control-Connection-Request'
Jan 1 00:30:12 pptp[1445]: Received Start Control Connection Reply
Jan 1 00:30:12 pptp[1445]: Client connection established.
Jan 1 00:30:12 kernel: [ 1512.764000] MulticastFilterTableInsertEntry: already in Members list.
Jan 1 00:30:13 pptp[1445]: Sent control packet type is 7 'Outgoing-Call-Request'
Jan 1 00:30:13 pptp[1445]: Received Outgoing Call Reply.
Jan 1 00:30:13 pptp[1445]: Outgoing call established (call ID 4, peer's call ID 43220).
Jan 1 00:30:13 pptp[1443]: Using interface ppp0
Jan 1 00:30:13 pptp[1443]: Connect: ppp0 <--> pptp (vpn.nlink.ru)
Jan 1 00:30:13 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:13 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:13 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:13 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:15 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:15 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:15 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:15 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:15 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:15 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:15 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:15 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:15 resident: resident_ppp_handler - l2:eth2.5, l3:eth2.5_1, tun:eth2.5_3
Jan 1 00:30:15 ppp_handler: ppp state 5
Jan 1 00:30:15 resident: resident_ppp_handler - status: 5 (5)
Jan 1 00:30:15 resident: ppp_is_down on eth2.5_3
Jan 1 00:30:15 resident: update dns
Jan 1 00:30:15 dnsmasq[822]: read /tmp/hosts - 2 addresses
Jan 1 00:30:15 dnsmasq-dhcp[822]: read /etc/ethers - 0 addresses
Jan 1 00:30:15 dnsmasq[822]: using nameserver 109.69.72.26#53
Jan 1 00:30:15 dnsmasq[822]: using nameserver 109.69.72.22#53
Jan 1 00:30:16 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:16 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:16 pptp[1443]: CHAP authentication succeeded
Jan 1 00:30:16 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:16 pptp[1443]: Sent 22 bytes, received 16 bytes.
Jan 1 00:30:16 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:16 pptp[1443]: Sent 32 bytes, received 38 bytes.
Jan 1 00:30:16 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:16 pptp[1443]: Sent 54 bytes, received 48 bytes.
Jan 1 00:30:16 pptp[1443]: Connect time 30.3 minutes.
Jan 1 00:30:16 pptp[1443]: Sent 64 bytes, received 70 bytes.
Jan 1 00:30:16 pptp[1443]: local IP address 176.96.228.237
Jan 1 00:30:16 pptp[1443]: remote IP address 172.17.0.6
Jan 1 00:30:16 pptp[1443]: primary DNS address 78.31.75.228
Jan 1 00:30:16 pptp[1443]: secondary DNS address 193.34.8.6
Jan 1 00:30:16 pptp[1443]: Connect time 0.0 minutes.
Jan 1 00:30:16 pptp[1443]: Sent 0 bytes, received 0 bytes.
Jan 1 00:30:16 resident_ppp_handler: record = action:up;iface:ppp0;link:eth2.5_3;ipaddr:176.96.228.237;netmask:255.255.255.255;gateway:172.17.0.6;dns1:78.31.75.228;dns2:193.34.8.6
Jan 1 00:30:16 resident: resident_ipoe_handler - Set default type: ipv4
Jan 1 00:30:16 resident: resident_ppp_handler - l2:eth2.5, l3:eth2.5_1, tun:eth2.5_3
Jan 1 00:30:16 resident: update dns
Jan 1 00:30:16 dnsmasq[822]: read /tmp/hosts - 2 addresses
Jan 1 00:30:16 dnsmasq-dhcp[822]: read /etc/ethers - 0 addresses
Jan 1 00:30:16 dnsmasq[822]: using nameserver 193.34.8.6#53
Jan 1 00:30:16 dnsmasq[822]: using nameserver 78.31.75.228#53
Jan 1 00:30:16 resident: update rip
Jan 1 00:30:16 resident: update igmpx
Jan 1 00:30:16 resident: stop igmpx
Jan 1 00:30:16 kernel: [ 1516.620000] eth2.5: dev_set_allmulti(master, -1)
Jan 1 00:30:16 iface: this is eth2.5
Jan 1 00:30:16 resident: igmpx eth2.5
Jan 1 00:30:16 syslog: Loading liblogger v2.0.1
Jan 1 00:30:16 syslog: upstream ifaces: eth2.5
Jan 1 00:30:16 syslog: downstream ifaces: br0
Jan 1 00:30:16 syslog: hews interval = 120.0 sec
Jan 1 00:30:16 syslog: doublet join enabled
Jan 1 00:30:16 syslog: Using old argv style
Jan 1 00:30:16 syslog: daemonizing ...
Jan 1 00:30:16 syslog: kernel multicast version is 305 (v3.05 ?)
Jan 1 00:30:16 syslog: kernel mroute inited
Jan 1 00:30:16 syslog: proxy prepared
Jan 1 00:30:16 kernel: [ 1516.712000] eth2.5: dev_set_allmulti(master, 1)
Jan 1 00:30:16 syslog: vifi #0 added for eth2.5
Jan 1 00:30:16 syslog: vifi #1 added for br0
Jan 1 00:30:16 syslog: valid VIF's configured: upstreams=1, downstreams=1. Ok.
Jan 1 00:30:16 resident: update igmpx compiled
Jan 1 00:30:16 resident: update ntpclient
Jan 1 00:30:16 update_ntpclient: ntpclient is disable
Jan 1 00:30:18 kernel: [ 1518.240000] MulticastFilterTableInsertEntry: already in Members list.
Jan 1 00:30:18 syslog: added membership for 239.255.255.250 on upstream #0 10.25.15.64
Jan 1 00:30:18 syslog: added new route 239.255.255.250: 10.25.15.64 -> 192.168.0.1
Jan 1 00:30:23 conf_wan[1488]: begin wan_conf
Jan 1 00:30:23 conf_wan[1488]: CONFIG_ACTION_READ - start
pe = (null)