Конфиги все по умолчанию, брал из misc.
test# radtest rusbit 1 127.0.0.1:1812 0 radsecret 0 127.0.0.1
Код: Выделить всё
Sending Access-Request of id 133 to 127.0.0.1 port 1812
User-Name = "rusbit"
User-Password = "1"
NAS-IP-Address = 127.0.0.1
NAS-Port = 0
Framed-Protocol = PPP
rad_recv: Access-Accept packet from host 127.0.0.1:1812, id=133, length=38
Session-Timeout = 811739
Framed-IP-Address = 192.168.1.20
Framed-IP-Netmask = 255.255.255.255
Код: Выделить всё
2008-06-21 22:31:01 LOG_INFO: AUTH [rusbit] NAS: 1 (127.0.0.1) GT: 0.34318
mpd.log
Код: Выделить всё
Jun 21 22:29:50 test mpd: PPTP: Incoming control connection from 10.0.7.6 3274 to 10.0.6.11 1723
Jun 21 22:29:50 test mpd: pptp0: attached to connection with 10.0.7.6 3274
Jun 21 22:29:50 test mpd: [pptp0] Accepting PPTP connection
Jun 21 22:29:50 test mpd: [pptp0] opening link "pptp0"...
Jun 21 22:29:50 test mpd: [pptp0] link: OPEN event
Jun 21 22:29:50 test mpd: [pptp0] LCP: Open event
Jun 21 22:29:50 test mpd: [pptp0] LCP: state change Initial --> Starting
Jun 21 22:29:50 test mpd: [pptp0] LCP: LayerStart
Jun 21 22:29:50 test mpd: [pptp0] PPTP: attaching to peer's outgoing call
Jun 21 22:29:50 test mpd: [pptp0] link: UP event
Jun 21 22:29:50 test mpd: [pptp0] link: origination is remote
Jun 21 22:29:50 test mpd: [pptp0] LCP: Up event
Jun 21 22:29:50 test mpd: [pptp0] LCP: state change Starting --> Req-Sent
Jun 21 22:29:50 test mpd: [pptp0] LCP: SendConfigReq #68
Jun 21 22:29:50 test mpd: ACFCOMP
Jun 21 22:29:50 test mpd: PROTOCOMP
Jun 21 22:29:50 test mpd: MRU 1500
Jun 21 22:29:50 test mpd: MAGICNUM c7075076
Jun 21 22:29:50 test mpd: AUTHPROTO CHAP MSOFTv2
Jun 21 22:29:50 test mpd: MP MRRU 1600
Jun 21 22:29:50 test mpd: MP SHORTSEQ
Jun 21 22:29:50 test mpd: ENDPOINTDISC [802.1] 00 02 a5 fe d9 a8
Jun 21 22:29:50 test mpd: [pptp0] LCP: rec'd Configure Request #0 (Req-Sent)
Jun 21 22:29:50 test mpd: MRU 1400
Jun 21 22:29:50 test mpd: MAGICNUM 191b099f
Jun 21 22:29:50 test mpd: PROTOCOMP
Jun 21 22:29:50 test mpd: ACFCOMP
Jun 21 22:29:50 test mpd: CALLBACK 6
Jun 21 22:29:50 test mpd: [pptp0] LCP: SendConfigRej #0
Jun 21 22:29:50 test mpd: CALLBACK 6
Jun 21 22:29:50 test mpd: [pptp0] LCP: rec'd Configure Request #1 (Req-Sent)
Jun 21 22:29:50 test mpd: MRU 1400
Jun 21 22:29:50 test mpd: MAGICNUM 191b099f
Jun 21 22:29:50 test mpd: PROTOCOMP
Jun 21 22:29:50 test mpd: ACFCOMP
Jun 21 22:29:50 test mpd: [pptp0] LCP: SendConfigAck #1
Jun 21 22:29:50 test mpd: MRU 1400
Jun 21 22:29:50 test mpd: MAGICNUM 191b099f
Jun 21 22:29:50 test mpd: PROTOCOMP
Jun 21 22:29:50 test mpd: ACFCOMP
Jun 21 22:29:50 test mpd: [pptp0] LCP: state change Req-Sent --> Ack-Sent
Jun 21 22:29:52 test mpd: [pptp0] LCP: SendConfigReq #69
Jun 21 22:29:52 test mpd: ACFCOMP
Jun 21 22:29:52 test mpd: PROTOCOMP
Jun 21 22:29:52 test mpd: MRU 1500
Jun 21 22:29:52 test mpd: MAGICNUM c7075076
Jun 21 22:29:52 test mpd: AUTHPROTO CHAP MSOFTv2
Jun 21 22:29:52 test mpd: MP MRRU 1600
Jun 21 22:29:52 test mpd: MP SHORTSEQ
Jun 21 22:29:52 test mpd: ENDPOINTDISC [802.1] 00 02 a5 fe d9 a8
Jun 21 22:29:52 test mpd: [pptp0] LCP: rec'd Configure Reject #69 (Ack-Sent)
Jun 21 22:29:52 test mpd: MP MRRU 1600
Jun 21 22:29:52 test mpd: MP SHORTSEQ
Jun 21 22:29:52 test mpd: ENDPOINTDISC [802.1] 00 02 a5 fe d9 a8
Jun 21 22:29:52 test mpd: [pptp0] LCP: SendConfigReq #70
Jun 21 22:29:52 test mpd: ACFCOMP
Jun 21 22:29:52 test mpd: PROTOCOMP
Jun 21 22:29:52 test mpd: MRU 1500
Jun 21 22:29:52 test mpd: MAGICNUM c7075076
Jun 21 22:29:52 test mpd: AUTHPROTO CHAP MSOFTv2
Jun 21 22:29:52 test mpd: [pptp0] LCP: rec'd Configure Ack #70 (Ack-Sent)
Jun 21 22:29:52 test mpd: ACFCOMP
Jun 21 22:29:52 test mpd: PROTOCOMP
Jun 21 22:29:52 test mpd: MRU 1500
Jun 21 22:29:52 test mpd: MAGICNUM c7075076
Jun 21 22:29:52 test mpd: AUTHPROTO CHAP MSOFTv2
Jun 21 22:29:52 test mpd: [pptp0] LCP: state change Ack-Sent --> Opened
Jun 21 22:29:52 test mpd: [pptp0] LCP: auth: peer wants nothing, I want CHAP
Jun 21 22:29:52 test mpd: [pptp0] CHAP: sending CHALLENGE len:17
Jun 21 22:29:52 test mpd: [pptp0] LCP: LayerUp
Jun 21 22:29:52 test mpd: [pptp0] LCP: rec'd Ident #2 (Opened)
Jun 21 22:29:52 test mpd: [pptp0] LCP: rec'd Ident #3 (Opened)
Jun 21 22:29:52 test mpd: [pptp0] CHAP: rec'd RESPONSE #1
Jun 21 22:29:52 test mpd: Name: "rusbit"
Jun 21 22:29:52 test mpd: [pptp0] AUTH: Auth-Thread started
Jun 21 22:29:52 test mpd: [pptp0] AUTH: Trying RADIUS
Jun 21 22:29:52 test mpd: [pptp0] RADIUS: RadiusAuthenticate for: rusbit
Jun 21 22:29:54 test mpd: [pptp0] AUTH: Thread already running, dropping this packet
Jun 21 22:29:56 test mpd: [pptp0] AUTH: Thread already running, dropping this packet
Jun 21 22:29:56 test mpd: [pptp0] RADIUS: rec'd RAD_ACCESS_REJECT for user rusbit
Jun 21 22:29:56 test mpd: [pptp0] RADIUS: RadiusGetParams: PANIC no MS-CHAPv2 response received
Jun 21 22:29:56 test mpd: [pptp0] AUTH: RADIUS returned failed
Jun 21 22:29:56 test mpd: [pptp0] AUTH: Trying INTERNAL
Jun 21 22:29:56 test mpd: OpenConfFile: Can't open file '/usr/local/etc/mpd4/mpd.secret': No such file or directory
Jun 21 22:29:56 test mpd: AUTH: User "rusbit" not found in secret file
Jun 21 22:29:56 test mpd: [pptp0] AUTH: INTERNAL returned failed
Jun 21 22:29:56 test mpd: [pptp0] AUTH: ran out of backends
Jun 21 22:29:56 test mpd: [pptp0] AUTH: Auth-Thread finished normally
Jun 21 22:29:56 test mpd: [pptp0] CHAP: ChapInputFinish: status failed
Jun 21 22:29:56 test mpd: Reply message: E=691 R=0 M=Login incorrect
Jun 21 22:29:56 test mpd: [pptp0] CHAP: sending FAILURE len:27
Jun 21 22:29:56 test mpd: [pptp0] LCP: authorization failed
Jun 21 22:29:56 test mpd: [pptp0] LCP: parameter negotiation failed
Jun 21 22:29:56 test mpd: [pptp0] LCP: state change Opened --> Stopping
Jun 21 22:29:56 test mpd: [pptp0] AUTH: Cleanup
Jun 21 22:29:56 test mpd: [pptp0] LCP: SendTerminateReq #71
Jun 21 22:29:56 test mpd: [pptp0] LCP: LayerDown
Jun 21 22:29:56 test mpd: [pptp0] LCP: rec'd Terminate Ack #71 (Stopping)
Jun 21 22:29:56 test mpd: [pptp0] LCP: state change Stopping --> Stopped
Jun 21 22:29:56 test mpd: [pptp0] LCP: LayerFinish
Jun 21 22:29:56 test mpd: pptp0-0: clearing call
Jun 21 22:29:56 test mpd: pptp0-0: killing channel
Jun 21 22:29:56 test mpd: [pptp0] PPTP call terminated
Jun 21 22:29:56 test mpd: [pptp0] link: DOWN event
Jun 21 22:29:56 test mpd: [pptp0] LCP: Close event
Jun 21 22:29:56 test mpd: [pptp0] LCP: state change Stopped --> Closed
Jun 21 22:29:56 test mpd: [pptp0] LCP: Down event
Jun 21 22:29:56 test mpd: [pptp0] LCP: state change Closed --> Initial
Jun 21 22:29:56 test mpd: pptp0: closing connection with 10.0.7.6 3274
Jun 21 22:29:56 test mpd: pptp0: CID 0xc000 in CallClearRequest not found
Jun 21 22:29:56 test mpd: pptp0: killing connection with 10.0.7.6 3274
Из за чего проблемы?