ошибка 691
Добавлено: Чт окт 12, 2006 11:44 am
Собственно проблема с настройкой.
FreeBSD 6.1, Abills, radius - 1.1.2 устанавливал из портов. Сконфигурировал все как написано в руководстве, провел бессоную ночь, перечитал форум. Идентичной проблеммы так и не нашел.
В итоге так и не получилось законнектиться по впну (EXPPP).
Радиус пишет:
v-lan# radiusd -x
Starting - reading configuration files ...
Module: Loaded exec
rlm_exec: Wait=yes but no output defined. Did you mean output=none?
Module: Instantiated exec (exec)
Module: Loaded expr
Module: Instantiated expr (expr)
Module: Loaded PAP
Module: Instantiated pap (pap)
Module: Loaded CHAP
Module: Instantiated chap (chap)
Module: Loaded MS-CHAP
Module: Instantiated mschap (mschap)
Module: Loaded System
Module: Instantiated unix (unix)
Module: Loaded eap
rlm_eap: Loaded and initialized type md5
rlm_eap: Loaded and initialized type leap
rlm_eap: Loaded and initialized type gtc
rlm_eap: Loaded and initialized type mschapv2
Module: Instantiated eap (eap)
Module: Loaded preprocess
Module: Instantiated preprocess (preprocess)
Module: Loaded realm
Module: Instantiated realm (suffix)
Module: Loaded files
Module: Instantiated files (files)
Module: Loaded Acct-Unique-Session-Id
Module: Instantiated acct_unique (acct_unique)
Module: Loaded detail
Module: Instantiated detail (detail)
Module: Loaded radutmp
Module: Instantiated radutmp (radutmp)
Initializing the thread pool...
Listening on authentication *:1812
Listening on accounting *:1813
Ready to process requests.
rad_recv: Access-Request packet from host 127.0.0.1:49400, id=10, length=121
Calling-Station-Id = "192.168.0.5"
Called-Station-Id = "192.168.0.8"
Service-Type = VPN
User-Name = "test"
Framed-Protocol = PPP
CHAP-Password = 0x01c08eff1975b839f2e3d5e24b1b569776
CHAP-Challenge = 0x39373430313637363931383238373438
NAS-Identifier = "v-lan.com.ua"
NAS-Port-Type = Virtual
rlm_unix: Attribute "User-Password" is required for authentication. Cannot use "CHAP-Password".
rad_recv: Access-Request packet from host 127.0.0.1:49400, id=10, length=121
Sending Access-Reject of id 10 to 127.0.0.1 port 49400
===
я так и не понял почему Called-Station-Id = "192.168.0.8" везде прописано локалхост.
дальше рртрд пишет :
Oct 12 14:35:19 v-lan pptpd[2527]: MGR: Manager process started
Oct 12 14:35:22 v-lan kernel: pid 2528 (pptpd), uid 0: exited on signal 11 (core dumped)
Oct 12 14:35:36 v-lan pptpd[2533]: MGR: Manager process started
Oct 12 14:35:55 v-lan pptpd[2538]: MGR: Launching /usr/local/sbin/pptpctrl to handle client
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: pppd options file = /etc/ppp/ppp.conf
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Client 192.168.0.5 control connection started
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 1)
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Made a START CTRL CONN RPLY packet
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: I wrote 156 bytes to the client.
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Sent packet to client
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 7)
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Set parameters to 100000000 maxbps, 64 window size
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Made a OUT CALL RPLY packet
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Starting call (launching pppd, opening GRE)
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: pty_fd = 7
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: tty_fd = 6
Oct 12 14:35:55 v-lan pptpd[2539]: CTRL (PPPD Launcher): program binary = /usr/sbin/ppp
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: I wrote 32 bytes to the client.
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: Sent packet to client
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 15)
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #0
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #1
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #2
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #3
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #4
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #5
Oct 12 14:36:00 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 15)
Oct 12 14:36:00 v-lan pptpd[2538]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
Oct 12 14:36:00 v-lan kernel: Oct 12 14:36:00 v-lan pptpd[2538]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #6
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #7
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #8
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #9
Oct 12 14:36:01 v-lan pptpd[2538]: GRE: accepting packet #10
Oct 12 14:36:03 v-lan pptpd[2538]: GRE: accepting packet #11
Oct 12 14:36:05 v-lan pptpd[2538]: GRE: accepting packet #12
Oct 12 14:36:07 v-lan pptpd[2538]: GRE: accepting packet #13
Oct 12 14:36:09 v-lan pptpd[2538]: GRE: accepting packet #14
Oct 12 14:36:11 v-lan pptpd[2538]: GRE: accepting packet #15
Oct 12 14:36:13 v-lan pptpd[2538]: GRE: accepting packet #16
Oct 12 14:36:15 v-lan pptpd[2538]: GRE: accepting packet #17
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 15)
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Oct 12 14:36:16 v-lan pptpd[2538]: GRE: accepting packet #18
Oct 12 14:36:16 v-lan pptpd[2538]: GRE: read(fd=7,buffer=804d5a0,len=8196) from PTY failed: status = 0 error = No error
Oct 12 14:36:16 v-lan kernel: Oct 12 14:36:16 v-lan pptpd[2538]: GRE: read(fd=7,buffer=804d5a0,len=8196) from PTY failed: status = 0 error = No error
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: PTY read or GRE write failed (pty,gre)=(7,6)
Oct 12 14:36:16 v-lan kernel: Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: PTY read or GRE write failed (pty,gre)=(7,6)
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Reaping child PPP[2539]
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Client 192.168.0.5 control connection finished
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Exiting now
Oct 12 14:36:16 v-lan pptpd[2533]: MGR: Reaped child 2538
===
abills.log молчит
но если раскоментировать в radiusd.conf - chap
то при старте радиуса пишет :
2006-10-12 14:20:28 LOG_WARNING: ACCT [-] NAS: 0 Not specified NAS server
2006-10-12 14:20:28 LOG_WARNING: AUTH [] NAS: 0 Unknow server ''
----
Скажите что делать, где искать. А то уже терпения не хватает... Спасибо.
FreeBSD 6.1, Abills, radius - 1.1.2 устанавливал из портов. Сконфигурировал все как написано в руководстве, провел бессоную ночь, перечитал форум. Идентичной проблеммы так и не нашел.
В итоге так и не получилось законнектиться по впну (EXPPP).
Радиус пишет:
v-lan# radiusd -x
Starting - reading configuration files ...
Module: Loaded exec
rlm_exec: Wait=yes but no output defined. Did you mean output=none?
Module: Instantiated exec (exec)
Module: Loaded expr
Module: Instantiated expr (expr)
Module: Loaded PAP
Module: Instantiated pap (pap)
Module: Loaded CHAP
Module: Instantiated chap (chap)
Module: Loaded MS-CHAP
Module: Instantiated mschap (mschap)
Module: Loaded System
Module: Instantiated unix (unix)
Module: Loaded eap
rlm_eap: Loaded and initialized type md5
rlm_eap: Loaded and initialized type leap
rlm_eap: Loaded and initialized type gtc
rlm_eap: Loaded and initialized type mschapv2
Module: Instantiated eap (eap)
Module: Loaded preprocess
Module: Instantiated preprocess (preprocess)
Module: Loaded realm
Module: Instantiated realm (suffix)
Module: Loaded files
Module: Instantiated files (files)
Module: Loaded Acct-Unique-Session-Id
Module: Instantiated acct_unique (acct_unique)
Module: Loaded detail
Module: Instantiated detail (detail)
Module: Loaded radutmp
Module: Instantiated radutmp (radutmp)
Initializing the thread pool...
Listening on authentication *:1812
Listening on accounting *:1813
Ready to process requests.
rad_recv: Access-Request packet from host 127.0.0.1:49400, id=10, length=121
Calling-Station-Id = "192.168.0.5"
Called-Station-Id = "192.168.0.8"
Service-Type = VPN
User-Name = "test"
Framed-Protocol = PPP
CHAP-Password = 0x01c08eff1975b839f2e3d5e24b1b569776
CHAP-Challenge = 0x39373430313637363931383238373438
NAS-Identifier = "v-lan.com.ua"
NAS-Port-Type = Virtual
rlm_unix: Attribute "User-Password" is required for authentication. Cannot use "CHAP-Password".
rad_recv: Access-Request packet from host 127.0.0.1:49400, id=10, length=121
Sending Access-Reject of id 10 to 127.0.0.1 port 49400
===
я так и не понял почему Called-Station-Id = "192.168.0.8" везде прописано локалхост.
дальше рртрд пишет :
Oct 12 14:35:19 v-lan pptpd[2527]: MGR: Manager process started
Oct 12 14:35:22 v-lan kernel: pid 2528 (pptpd), uid 0: exited on signal 11 (core dumped)
Oct 12 14:35:36 v-lan pptpd[2533]: MGR: Manager process started
Oct 12 14:35:55 v-lan pptpd[2538]: MGR: Launching /usr/local/sbin/pptpctrl to handle client
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: pppd options file = /etc/ppp/ppp.conf
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Client 192.168.0.5 control connection started
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 1)
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Made a START CTRL CONN RPLY packet
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: I wrote 156 bytes to the client.
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Sent packet to client
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 7)
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Set parameters to 100000000 maxbps, 64 window size
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Made a OUT CALL RPLY packet
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: Starting call (launching pppd, opening GRE)
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: pty_fd = 7
Oct 12 14:35:55 v-lan pptpd[2538]: CTRL: tty_fd = 6
Oct 12 14:35:55 v-lan pptpd[2539]: CTRL (PPPD Launcher): program binary = /usr/sbin/ppp
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: I wrote 32 bytes to the client.
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: Sent packet to client
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 15)
Oct 12 14:35:57 v-lan pptpd[2538]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #0
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #1
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #2
Oct 12 14:35:57 v-lan pptpd[2538]: GRE: accepting packet #3
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #4
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #5
Oct 12 14:36:00 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 15)
Oct 12 14:36:00 v-lan pptpd[2538]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
Oct 12 14:36:00 v-lan kernel: Oct 12 14:36:00 v-lan pptpd[2538]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #6
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #7
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #8
Oct 12 14:36:00 v-lan pptpd[2538]: GRE: accepting packet #9
Oct 12 14:36:01 v-lan pptpd[2538]: GRE: accepting packet #10
Oct 12 14:36:03 v-lan pptpd[2538]: GRE: accepting packet #11
Oct 12 14:36:05 v-lan pptpd[2538]: GRE: accepting packet #12
Oct 12 14:36:07 v-lan pptpd[2538]: GRE: accepting packet #13
Oct 12 14:36:09 v-lan pptpd[2538]: GRE: accepting packet #14
Oct 12 14:36:11 v-lan pptpd[2538]: GRE: accepting packet #15
Oct 12 14:36:13 v-lan pptpd[2538]: GRE: accepting packet #16
Oct 12 14:36:15 v-lan pptpd[2538]: GRE: accepting packet #17
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Received PPTP Control Message (type: 15)
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Got a SET LINK INFO packet with standard ACCMs
Oct 12 14:36:16 v-lan pptpd[2538]: GRE: accepting packet #18
Oct 12 14:36:16 v-lan pptpd[2538]: GRE: read(fd=7,buffer=804d5a0,len=8196) from PTY failed: status = 0 error = No error
Oct 12 14:36:16 v-lan kernel: Oct 12 14:36:16 v-lan pptpd[2538]: GRE: read(fd=7,buffer=804d5a0,len=8196) from PTY failed: status = 0 error = No error
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: PTY read or GRE write failed (pty,gre)=(7,6)
Oct 12 14:36:16 v-lan kernel: Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: PTY read or GRE write failed (pty,gre)=(7,6)
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Reaping child PPP[2539]
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Client 192.168.0.5 control connection finished
Oct 12 14:36:16 v-lan pptpd[2538]: CTRL: Exiting now
Oct 12 14:36:16 v-lan pptpd[2533]: MGR: Reaped child 2538
===
abills.log молчит
но если раскоментировать в radiusd.conf - chap
то при старте радиуса пишет :
2006-10-12 14:20:28 LOG_WARNING: ACCT [-] NAS: 0 Not specified NAS server
2006-10-12 14:20:28 LOG_WARNING: AUTH [] NAS: 0 Unknow server ''
----
Скажите что делать, где искать. А то уже терпения не хватает... Спасибо.