логи
Код:
Aug 29 15:38:22 st-bgw pppd[721]: Script /etc/ppp/ip-down started (pid 5094)
Aug 29 15:38:22 st-bgw pppd[721]: sent [LCP TermReq id=0x2d "User request"]
Aug 29 15:38:22 st-bgw pppd[721]: Script pptp 193.5.7.6 --nolaunchpppd finished (pid 4912), status = 0x0
Aug 29 15:38:22 st-bgw pppd[721]: Modem hangup
Aug 29 15:38:22 st-bgw pppd[721]: Connection terminated.
Aug 29 15:38:22 st-bgw postfix/master[1285]: reload -- version 2.6.5, configuration /etc/postfix
Aug 29 15:38:22 st-bgw postfix/anvil[5070]: statistics: max connection rate 1/60s for (smtp:89.249.21.204) at Aug 29 15:37:48
Aug 29 15:38:22 st-bgw postfix/anvil[5070]: statistics: max connection count 1 for (smtp:89.249.21.204) at Aug 29 15:37:48
Aug 29 15:38:22 st-bgw postfix/anvil[5070]: statistics: max cache size 1 at Aug 29 15:37:48
Aug 29 15:38:22 st-bgw pppd[721]: Waiting for 1 child processes...
Aug 29 15:38:22 st-bgw pppd[721]: script /etc/ppp/ip-down, pid 5094
Aug 29 15:38:22 st-bgw pppd[721]: Script /etc/ppp/ip-down finished (pid 5094), status = 0x0
Aug 29 15:38:22 st-bgw pppd[721]: Exit.
Aug 29 15:38:28 st-bgw pppd[5129]: pppd 2.4.5 started by root, uid 0
Aug 29 15:38:28 st-bgw pppd[5129]: using channel 48
Aug 29 15:38:28 st-bgw pppd[5129]: Using interface ppp0
Aug 29 15:38:28 st-bgw pppd[5129]: Connect: ppp0 <--> /dev/pts/1
Aug 29 15:38:28 st-bgw pptp[5130]: anon log[main:pptp.c:314]: The synchronous pptp option is NOT activated
Aug 29 15:38:28 st-bgw pptp[5134]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 1 'Start-Control-Connection-Request'
Aug 29 15:38:28 st-bgw pptp[5134]: anon log[ctrlp_disp:pptp_ctrl.c:739]: Received Start Control Connection Reply
Aug 29 15:38:28 st-bgw pptp[5134]: anon log[ctrlp_disp:pptp_ctrl.c:773]: Client connection established.
Aug 29 15:38:29 st-bgw pppd[5129]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xd1fb115e> <pcomp> <accomp>]
Aug 29 15:38:29 st-bgw pptp[5134]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 7 'Outgoing-Call-Request'
Aug 29 15:38:29 st-bgw pptp[5134]: anon log[ctrlp_disp:pptp_ctrl.c:858]: Received Outgoing Call Reply.
Aug 29 15:38:29 st-bgw pptp[5134]: anon log[ctrlp_disp:pptp_ctrl.c:897]: Outgoing call established (call ID 0, peer's call ID 46137).
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x0 <mru 1400> <auth eap> <magic 0x1f542806> <pcomp> <accomp> <callback CBCP>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [LCP ConfRej id=0x0 <callback CBCP>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xd1fb115e> <pcomp> <accomp>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x1 <mru 1400> <auth eap> <magic 0x1f542806> <pcomp> <accomp>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [LCP ConfNak id=0x1 <auth chap MS-v2>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x2 <mru 1400> <auth chap MS-v2> <magic 0x1f542806> <pcomp> <accomp>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [LCP ConfAck id=0x2 <mru 1400> <auth chap MS-v2> <magic 0x1f542806> <pcomp> <accomp>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [LCP EchoReq id=0x0 magic=0xd1fb115e]
Aug 29 15:38:29 st-bgw pptp[5134]: anon log[ctrlp_disp:pptp_ctrl.c:950]: PPTP_SET_LINK_INFO received from peer_callid 59210
Aug 29 15:38:29 st-bgw pptp[5134]: anon log[ctrlp_disp:pptp_ctrl.c:953]: send_accm is 00000000, recv_accm is FFFFFFFF
Aug 29 15:38:29 st-bgw pptp[5134]: anon warn[ctrlp_disp:pptp_ctrl.c:956]: Non-zero Async Control Character Maps are not supported!
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [CHAP Challenge id=0x0 <cfe9229fb4607099441e3abff0c375c7>, name = "HIGHLANDER"]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [CHAP Response id=0x0 <c7e686e5113996717788beca1dbb141000000000000000001a78a00d04a53eb4907b515978e87
1f93189285a6fedd33a00>, name =
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [LCP EchoRep id=0x0 magic=0x1f542806]
Aug 29 15:38:29 st-bgw pppd[5129]: CHAP authentication succeeded
Aug 29 15:38:29 st-bgw pppd[5129]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 192.168.4.1>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [CCP ConfReq id=0x4 <mppe +H -M -S -L -D +C>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [CCP ConfReq id=0x1]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [CCP ConfRej id=0x4 <mppe +H -M -S -L -D +C>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [IPCP ConfReq id=0x5 <addr 192.168.2.1>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [IPCP ConfAck id=0x5 <addr 192.168.2.1>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [IPCP ConfReq id=0x2 <addr 192.168.4.1>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [CCP ConfAck id=0x1]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [CCP TermReq id=0x6 1f 54 28 06 00 3c cd 74 00 00 02 dc]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [CCP TermAck id=0x6]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [IPCP ConfNak id=0x2 <addr 192.168.2.4>]
Aug 29 15:38:29 st-bgw pppd[5129]: sent [IPCP ConfReq id=0x3 <addr 192.168.2.4>]
Aug 29 15:38:29 st-bgw pppd[5129]: rcvd [IPCP ConfAck id=0x3 <addr 192.168.2.4>]
Aug 29 15:38:29 st-bgw pppd[5129]: Cannot determine ethernet address for proxy ARP
Aug 29 15:38:29 st-bgw pppd[5129]: local IP address 192.168.2.4
Aug 29 15:38:29 st-bgw pppd[5129]: remote IP address 192.168.2.1
Aug 29 15:38:29 st-bgw pppd[5129]: Script /etc/ppp/ip-up started (pid 5135)
Aug 29 15:38:31 st-bgw postfix/master[1285]: reload -- version 2.6.5, configuration /etc/postfix
Aug 29 15:38:31 st-bgw pppd[5129]: Script /etc/ppp/ip-up finished (pid 5135), status = 0x0
Aug 29 15:38:32 st-bgw pppd[5129]: sent [CCP ConfReq id=0x1]
Aug 29 15:38:32 st-bgw pppd[5129]: rcvd [CCP TermAck id=0x1]
Aug 29 15:38:32 st-bgw pppd[5129]: sent [CCP TermReq id=0x2"No compression negotiated"]
Aug 29 15:38:32 st-bgw pppd[5129]: rcvd [CCP TermAck id=0x2"No compression negotiated"]
Aug 29 15:38:48 st-bgw pptp[5130]: anon log[decaps_gre:pptp_gre.c:414]: buffering packet 63 (expecting 62, lost or reordered)
Aug 29 15:38:48 st-bgw pptp[5130]: anon log[decaps_gre:pptp_gre.c:414]: buffering packet 64 (expecting 62, lost or reordered)
Aug 29 15:38:53 st-bgw pptp[5130]: anon warn[decaps_gre:pptp_gre.c:331]: short read (-1): Message too long
Aug 29 15:38:53 st-bgw pptp[5134]: anon log[callmgr_main:pptp_callmgr.c:234]: Closing connection (unhandled)
Aug 29 15:38:53 st-bgw pptp[5134]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 12 'Call-Clear-Request'
Aug 29 15:38:53 st-bgw pptp[5134]: anon log[call_callback:pptp_callmgr.c:79]: Closing connection (call state)
Aug 29 15:38:53 st-bgw pppd[5129]: Script pptp 193.5.7.6 --nolaunchpppd finished (pid 5130), status = 0x0
Aug 29 15:38:53 st-bgw pppd[5129]: Modem hangup
Aug 29 15:38:53 st-bgw pppd[5129]: Connect time 0.4 minutes.
Aug 29 15:38:53 st-bgw pppd[5129]: Sent 7691 bytes, received 5835 bytes.
Aug 29 15:38:53 st-bgw pppd[5129]: Script /etc/ppp/ip-down started (pid 5208)
Aug 29 15:38:53 st-bgw pppd[5129]: Connection terminated.
Aug 29 15:38:53 st-bgw postfix/master[1285]: reload -- version 2.6.5, configuration /etc/postfix
Aug 29 15:38:53 st-bgw pppd[5129]: using channel 49
Aug 29 15:38:53 st-bgw pppd[5129]: Using interface ppp0
Aug 29 15:38:53 st-bgw pppd[5129]: Connect: ppp0 <--> /dev/pts/1
Aug 29 15:38:53 st-bgw pppd[5129]: Script /etc/ppp/ip-down finished (pid 5208), status = 0x0
Aug 29 15:38:53 st-bgw pptp[5241]: anon log[main:pptp.c:314]: The synchronous pptp option is NOT activated
Aug 29 15:38:53 st-bgw pptp[5245]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 1 'Start-Control-Connection-Request'
Aug 29 15:38:53 st-bgw pptp[5245]: anon log[ctrlp_disp:pptp_ctrl.c:739]: Received Start Control Connection Reply
Aug 29 15:38:53 st-bgw pptp[5245]: anon log[ctrlp_disp:pptp_ctrl.c:773]: Client connection established.
Aug 29 15:38:54 st-bgw pppd[5129]: sent [LCP ConfReq id=0x2 <asyncmap 0x0> <magic 0x590826ea> <pcomp> <accomp>]
Aug 29 15:38:54 st-bgw pptp[5245]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 7 'Outgoing-Call-Request'
Aug 29 15:38:54 st-bgw pptp[5245]: anon log[ctrlp_disp:pptp_ctrl.c:858]: Received Outgoing Call Reply.
Aug 29 15:38:54 st-bgw pptp[5245]: anon log[ctrlp_disp:pptp_ctrl.c:897]: Outgoing call established (call ID 0, peer's call ID 34752).
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x0 <mru 1400> <auth eap> <magic 0x5f3b23fd> <pcomp> <accomp> <callback CBCP>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [LCP ConfRej id=0x0 <callback CBCP>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [LCP ConfAck id=0x2 <asyncmap 0x0> <magic 0x590826ea> <pcomp> <accomp>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x1 <mru 1400> <auth eap> <magic 0x5f3b23fd> <pcomp> <accomp>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [LCP ConfNak id=0x1 <auth chap MS-v2>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x2 <mru 1400> <auth chap MS-v2> <magic 0x5f3b23fd> <pcomp> <accomp>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [LCP ConfAck id=0x2 <mru 1400> <auth chap MS-v2> <magic 0x5f3b23fd> <pcomp> <accomp>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [LCP EchoReq id=0x0 magic=0x590826ea]
Aug 29 15:38:54 st-bgw pptp[5245]: anon log[ctrlp_disp:pptp_ctrl.c:950]: PPTP_SET_LINK_INFO received from peer_callid 59215
Aug 29 15:38:54 st-bgw pptp[5245]: anon log[ctrlp_disp:pptp_ctrl.c:953]: send_accm is 00000000, recv_accm is FFFFFFFF
Aug 29 15:38:54 st-bgw pptp[5245]: anon warn[ctrlp_disp:pptp_ctrl.c:956]: Non-zero Async Control Character Maps are not supported!
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [CHAP Challenge id=0x0 <48fb6f98635d4b861086eaa97d2a8d6d>, name = "HIGHLANDER"]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [CHAP Response id=0x0 <a4f5c5d49298618723817c6ab7b3388e0000000000000000209d67ef304c5cbdd881f3eaf3549
e0354e7816e16b81d7e00>, name =
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [LCP EchoRep id=0x0 magic=0x5f3b23fd]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [CHAP Success id=0x0 "S=CD5E456513B7BEEB7CA7850CFF30871C00C7D797"]
Aug 29 15:38:54 st-bgw pppd[5129]: CHAP authentication succeeded
Aug 29 15:38:54 st-bgw pppd[5129]: sent [IPCP ConfReq id=0x4 <compress VJ 0f 01> <addr 192.168.2.4>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [CCP ConfReq id=0x4 <mppe +H -M -S -L -D +C>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [CCP ConfReq id=0x3]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [CCP ConfRej id=0x4 <mppe +H -M -S -L -D +C>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [IPCP ConfReq id=0x5 <addr 192.168.2.1>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [IPCP ConfAck id=0x5 <addr 192.168.2.1>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [IPCP ConfRej id=0x4 <compress VJ 0f 01>]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [IPCP ConfReq id=0x5 <addr 192.168.2.4>]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [CCP ConfAck id=0x3]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [CCP TermReq id=0x6"_;#\37777777775\000<\37777777715t\000\000\002\37777777734"]
Aug 29 15:38:54 st-bgw pppd[5129]: sent [CCP TermAck id=0x6]
Aug 29 15:38:54 st-bgw pppd[5129]: rcvd [IPCP ConfAck id=0x5 <addr 192.168.2.4>]
Aug 29 15:38:54 st-bgw pppd[5129]: Cannot determine ethernet address for proxy ARP
Aug 29 15:38:54 st-bgw pppd[5129]: local IP address 192.168.2.4
Aug 29 15:38:54 st-bgw pppd[5129]: remote IP address 192.168.2.1
Aug 29 15:38:54 st-bgw pppd[5129]: Script /etc/ppp/ip-up started (pid 5246)
Aug 29 15:38:56 st-bgw postfix/master[1285]: reload -- version 2.6.5, configuration /etc/postfix
Aug 29 15:38:56 st-bgw pppd[5129]: Script /etc/ppp/ip-up finished (pid 5246), status = 0x0
Aug 29 15:38:57 st-bgw pptp[5241]: anon warn[decaps_gre:pptp_gre.c:331]: short read (-1): Message too long
Aug 29 15:38:57 st-bgw pptp[5245]: anon log[callmgr_main:pptp_callmgr.c:234]: Closing connection (unhandled)
Aug 29 15:38:57 st-bgw pptp[5245]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 12 'Call-Clear-Request'
Aug 29 15:38:57 st-bgw pptp[5245]: anon log[call_callback:pptp_callmgr.c:79]: Closing connection (call state)
Aug 29 15:38:57 st-bgw pppd[5129]: Script pptp 193.5.7.6 --nolaunchpppd finished (pid 5241), status = 0x0
Aug 29 15:38:57 st-bgw pppd[5129]: Modem hangup
Aug 29 15:38:57 st-bgw pppd[5129]: Connect time 0.1 minutes.
Aug 29 15:38:57 st-bgw pppd[5129]: Sent 1400 bytes, received 0 bytes.
Aug 29 15:38:57 st-bgw pppd[5129]: Script /etc/ppp/ip-down started (pid 5318)
Aug 29 15:38:57 st-bgw pppd[5129]: Connection terminated.
Aug 29 15:38:57 st-bgw postfix/master[1285]: reload -- version 2.6.5, configuration /etc/postfix
Aug 29 15:38:57 st-bgw pptp[5351]: anon log[main:pptp.c:314]: The synchronous pptp option is NOT activated
Aug 29 15:38:57 st-bgw pppd[5129]: using channel 50
Aug 29 15:38:57 st-bgw pppd[5129]: Using interface ppp0
Aug 29 15:38:57 st-bgw pppd[5129]: Connect: ppp0 <--> /dev/pts/1
Aug 29 15:38:57 st-bgw pppd[5129]: Script /etc/ppp/ip-down finished (pid 5318), status = 0x0
Aug 29 15:38:58 st-bgw pptp[5356]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 1 'Start-Control-Connection-Request'
Aug 29 15:38:58 st-bgw pptp[5356]: anon log[ctrlp_disp:pptp_ctrl.c:739]: Received Start Control Connection Reply
Aug 29 15:38:58 st-bgw pptp[5356]: anon log[ctrlp_disp:pptp_ctrl.c:773]: Client connection established.
Aug 29 15:38:58 st-bgw pppd[5129]: sent [LCP ConfReq id=0x3 <asyncmap 0x0> <magic 0x35b7e26e> <pcomp> <accomp>]
Aug 29 15:38:59 st-bgw pptp[5356]: anon log[ctrlp_rep:pptp_ctrl.c:251]: Sent control packet type is 7 'Outgoing-Call-Request'
Aug 29 15:38:59 st-bgw pptp[5356]: anon log[ctrlp_disp:pptp_ctrl.c:858]: Received Outgoing Call Reply.
Aug 29 15:38:59 st-bgw pptp[5356]: anon log[ctrlp_disp:pptp_ctrl.c:897]: Outgoing call established (call ID 0, peer's call ID 37221).
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x0 <mru 1400> <auth eap> <magic 0x190a6c5f> <pcomp> <accomp> <callback CBCP>]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [LCP ConfRej id=0x0 <callback CBCP>]
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [LCP ConfAck id=0x3 <asyncmap 0x0> <magic 0x35b7e26e> <pcomp> <accomp>]
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x1 <mru 1400> <auth eap> <magic 0x190a6c5f> <pcomp> <accomp>]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [LCP ConfNak id=0x1 <auth chap MS-v2>]
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [LCP ConfReq id=0x2 <mru 1400> <auth chap MS-v2> <magic 0x190a6c5f> <pcomp> <accomp>]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [LCP ConfAck id=0x2 <mru 1400> <auth chap MS-v2> <magic 0x190a6c5f> <pcomp> <accomp>]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [LCP EchoReq id=0x0 magic=0x35b7e26e]
Aug 29 15:38:59 st-bgw pptp[5356]: anon log[ctrlp_disp:pptp_ctrl.c:950]: PPTP_SET_LINK_INFO received from peer_callid 59220
Aug 29 15:38:59 st-bgw pptp[5356]: anon log[ctrlp_disp:pptp_ctrl.c:953]: send_accm is 00000000, recv_accm is FFFFFFFF
Aug 29 15:38:59 st-bgw pptp[5356]: anon warn[ctrlp_disp:pptp_ctrl.c:956]: Non-zero Async Control Character Maps are not supported!
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [CHAP Challenge id=0x0 <2994b5add15d82d6a33b54af0ebdbf23>, name = "HIGHLANDER"]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [CHAP Response id=0x0 <6aa03f67353e764e2141b06f1e824b0d000000000000000070fc420f13de94938dc6a84b8b9d5
bd0e548a82f03ba0c8d00>, name =
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [LCP EchoRep id=0x0 magic=0x190a6c5f]
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [CHAP Success id=0x0 "S=618FD4EE6C2FF9EE3ACB56E7F7117ACC44BA7369"]
Aug 29 15:38:59 st-bgw pppd[5129]: CHAP authentication succeeded
Aug 29 15:38:59 st-bgw pppd[5129]: sent [IPCP ConfReq id=0x6 <compress VJ 0f 01> <addr 192.168.2.4>]
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [CCP ConfReq id=0x4 <mppe +H -M -S -L -D +C>]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [CCP ConfReq id=0x4]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [CCP ConfRej id=0x4 <mppe +H -M -S -L -D +C>]
Aug 29 15:38:59 st-bgw pppd[5129]: rcvd [IPCP ConfReq id=0x5 <addr 192.168.2.1>]
Aug 29 15:38:59 st-bgw pppd[5129]: sent [IPCP ConfAck id=0x5 <addr 192.168.2.1>]
Работало уже более полугода. Сегодня внезапно перестало
Подскажите где может быть проблема?