Problems with Huntgroup
Sergio Belkin
sebelk at gmail.com
Mon Jun 4 14:34:40 CEST 2012
Hi (sorry I resend the email because in my earlier one the subject was
missing by mistake)
I'm trying to get working huntgroups but I can't do it:
I've appended something like to huntgroups file
mb NAS-IP-Address == 10.129.189.1
mb NAS-IP-Address == 10.129.84.1
mb Called-Station-Id == 00-1B-7E-DC-AB-1A:UP-PVIII-I
And in users files:
pruebita Huntgroup-Name == "mb",Cleartext-Password := "pruebon"
But is not working user pruebita does not get an Access-Accept
Please could you help me to solve it?
Below the debug messages (I've trunked a bit for mail can be sent)
FreeRADIUS Version 2.1.12, for host x86_64-unknown-linux-gnu, built on
Jan 3 2012 at 16:18:16
Copyright (C) 1999-2009 The FreeRADIUS server project and contributors.
There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A
PARTICULAR PURPOSE.
You may redistribute copies of FreeRADIUS under the terms of the
GNU General Public License v2.
Starting - reading configuration files ...
including configuration file /etc/raddb-testing/radiusd.conf
including configuration file /etc/raddb-testing/proxy.conf
including configuration file /etc/raddb-testing/clients.conf
including files in directory /etc/raddb-testing/modules/
including configuration file /etc/raddb-testing/modules/chap
including configuration file /etc/raddb-testing/modules/mschap
including configuration file
/etc/raddb-testing/modules/sqlcounter_expire_on_login
including configuration file /etc/raddb-testing/modules/exec
including configuration file /etc/raddb-testing/modules/realm
including configuration file /etc/raddb-testing/modules/checkval
including configuration file /etc/raddb-testing/modules/rediswho
including configuration file /etc/raddb-testing/modules/passwd
including configuration file /etc/raddb-testing/modules/attr_filter
including configuration file /etc/raddb-testing/modules/linelog
including configuration file /etc/raddb-testing/modules/wimax
including configuration file /etc/raddb-testing/modules/pam
including configuration file /etc/raddb-testing/modules/inner-eap
including configuration file /etc/raddb-testing/modules/echo
including configuration file /etc/raddb-testing/modules/soh
including configuration file /etc/raddb-testing/modules/replicate
including configuration file /etc/raddb-testing/modules/acct_unique
including configuration file /etc/raddb-testing/modules/etc_group
including configuration file /etc/raddb-testing/modules/pap
including configuration file /etc/raddb-testing/modules/expr
including configuration file /etc/raddb-testing/modules/smbpasswd
including configuration file /etc/raddb-testing/modules/attr_rewrite
including configuration file /etc/raddb-testing/modules/radutmp
including configuration file /etc/raddb-testing/modules/mac2ip
including configuration file /etc/raddb-testing/modules/logintime
including configuration file /etc/raddb-testing/modules/sql_log
including configuration file /etc/raddb-testing/modules/smsotp
including configuration file /etc/raddb-testing/modules/preprocess
including configuration file /etc/raddb-testing/modules/policy
including configuration file /etc/raddb-testing/modules/cui
including configuration file /etc/raddb-testing/modules/perl
including configuration file /etc/raddb-testing/modules/digest
including configuration file /etc/raddb-testing/modules/mac2vlan
including configuration file /etc/raddb-testing/modules/otp
including configuration file /etc/raddb-testing/modules/files
including configuration file /etc/raddb-testing/modules/always
including configuration file /etc/raddb-testing/modules/ntlm_auth
including configuration file /etc/raddb-testing/modules/detail
including configuration file /etc/raddb-testing/modules/krb5
including configuration file /etc/raddb-testing/modules/sradutmp
including configuration file /etc/raddb-testing/modules/opendirectory
including configuration file /etc/raddb-testing/modules/counter
including configuration file /etc/raddb-testing/modules/detail.example.com
including configuration file /etc/raddb-testing/modules/ippool
including configuration file /etc/raddb-testing/modules/expiration
including configuration file /etc/raddb-testing/modules/dynamic_clients
including configuration file /etc/raddb-testing/modules/detail.log
including configuration file /etc/raddb-testing/modules/redis
including configuration file /etc/raddb-testing/modules/ldap
including configuration file /etc/raddb-testing/modules/unix
including configuration file /etc/raddb-testing/eap.conf
including configuration file /etc/raddb-testing/policy.conf
including files in directory /etc/raddb-testing/sites-enabled/
including configuration file /etc/raddb-testing/sites-enabled/status
including configuration file /etc/raddb-testing/sites-enabled/control-socket
including configuration file /etc/raddb-testing/sites-enabled/inner-tunnel
including configuration file /etc/raddb-testing/sites-enabled/default
including configuration file /etc/raddb-testing/sites-enabled/inner-tunnel-peap
main {
user = "radiusd"
group = "radiusd"
allow_core_dumps = no
}
including dictionary file /etc/raddb-testing/dictionary
main {
name = "radiusd"
prefix = "/usr/local-test"
localstatedir = "/usr/local-test/var"
sbindir = "/usr/local-test/sbin"
logdir = "/usr/local-test/var/log/radius"
run_dir = "/usr/local-test/var/run/radiusd"
libdir = "/usr/local-test/lib"
radacctdir = "/usr/local-test/var/log/radius/radacct"
hostname_lookups = no
max_request_time = 30
cleanup_delay = 5
max_requests = 1024
pidfile = "/usr/local-test/var/run/radiusd/radiusd.pid"
checkrad = "/usr/local-test/sbin/checkrad"
debug_level = 0
proxy_requests = yes
log {
stripped_names = yes
auth = yes
auth_badpass = no
auth_goodpass = no
}
security {
max_attributes = 200
reject_delay = 1
status_server = yes
}
}
radiusd: #### Loading Realms and Home Servers ####
proxy server {
retry_delay = 5
retry_count = 3
default_fallback = no
dead_time = 120
wake_all_if_all_dead = no
}
home_server localhost {
ipaddr = 127.0.0.1
port = 1812
type = "auth"
secret = "testing123"
response_window = 20
max_outstanding = 65536
require_message_authenticator = yes
zombie_period = 40
status_check = "status-server"
ping_interval = 30
check_interval = 30
num_answers_to_alive = 3
num_pings_to_alive = 3
revive_interval = 120
status_check_timeout = 4
coa {
irt = 2
mrt = 16
mrc = 5
mrd = 30
}
}
home_server_pool my_auth_failover {
type = fail-over
home_server = localhost
}
realm example.com {
auth_pool = my_auth_failover
}
realm LOCAL {
}
radiusd: #### Loading Clients ####
client localhost {
ipaddr = 127.0.0.1
require_message_authenticator = no
secret = "testing123"
nastype = "other"
}
client spectrum {
require_message_authenticator = no
secret = "testing123"
shortname = "spectrum.sarlanga.edu"
}
client 10.129.100.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-PB"
}
client 10.129.10.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-SS"
}
client 10.129.11.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-1"
}
client 10.129.111.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-1"
}
client 10.129.12.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-2"
}
client 10.129.13.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-3"
}
client 10.129.14.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-4"
}
client 10.129.199.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "PIVOT-LINKSYS"
}
client 10.129.200.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "PIVOT-TPLINK"
}
client 10.129.254.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "Transitional"
}
client 10.129.15.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-5"
}
client 10.129.16.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-6"
}
client 10.129.17.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-3-winnie"
shortname = "AP-PI-7"
}
client 10.129.60.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-Sociales-0"
}
client 10.129.61.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-Sociales-I"
}
client 10.129.158.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-SS"
}
client 10.129.80.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-PB"
}
client 10.129.180.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-PB-SUM"
}
client 10.128.255.81 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-I"
}
client 10.129.81.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-I"
}
client 10.128.255.82 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-II"
}
client 10.129.82.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-II"
}
client 10.128.250.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-Bridge"
}
client 10.128.255.172 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-I_bis_test"
}
client 10.128.255.83 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-III"
}
client 10.129.83.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-III"
}
client 10.129.183.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-III"
}
client 10.129.84.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-IV"
}
client 10.129.184.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-IV-Bis"
}
client 10.129.194.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-IV-Bis-2"
}
client 10.128.255.181 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-I_bis"
}
client 10.129.181.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-I_bis"
}
client 10.129.162.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-I_bis_2"
}
client 10.128.255.86 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-VI"
}
client 10.129.86.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-VI"
}
client 10.128.255.87 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-VII"
}
client 10.129.87.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-VII"
}
client 10.129.187.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-VII-Derecho"
}
client 10.129.99.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-Pivot"
}
client 10.129.52.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PV-PB"
}
client 10.128.255.85 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-V"
}
client 10.129.85.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-V"
}
client 10.129.189.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-IX-HD"
}
client 10.129.88.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-VIII"
}
client 10.129.89.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "oficina-test"
}
client 10.129.160.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-Sociales-Auditorio"
}
client 10.129.182.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-PVIII-X"
}
client 192.168.2.53 {
require_message_authenticator = no
secret = "akantilad0-Green-22"
shortname = "sarlanga3"
}
client 192.168.45 {
require_message_authenticator = no
secret = "sarlangalad0-black-54"
shortname = "sarlanga4"
}
client 192.168.3.201 {
require_message_authenticator = no
secret = "sarlangalad0-blue-246692"
shortname = "sarlanga7"
}
client 192.168.4 {
require_message_authenticator = no
secret = "Zarag0Za-Muppet5-32"
shortname = "AP-sarlanga7"
}
client 192.168.142.240 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-Cabre-1"
}
client 192.168.142.241 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-Cabre-2"
}
client 192.168.142.242 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-Cabre-3"
}
radiusd: #### Instantiating modules ####
instantiate {
Module: Linked to module rlm_exec
Module: Instantiating module "exec" from file /etc/raddb-testing/modules/exec
exec {
wait = no
input_pairs = "request"
shell_escape = yes
}
Module: Linked to module rlm_expr
Module: Instantiating module "expr" from file /etc/raddb-testing/modules/expr
Module: Linked to module rlm_expiration
Module: Instantiating module "expiration" from file
/etc/raddb-testing/modules/expiration
expiration {
reply-message = "Password Has Expired "
}
Module: Linked to module rlm_logintime
Module: Instantiating module "logintime" from file
/etc/raddb-testing/modules/logintime
logintime {
reply-message = "You are calling outside your allowed timespan "
minimum-timeout = 60
}
}
radiusd: #### Loading Virtual Servers ####
server { # from file /etc/raddb-testing/radiusd.conf
modules {
Module: Creating Post-Auth-Type = REJECT
Module: Checking authenticate {...} for more modules to load
Module: Linked to module rlm_pap
Module: Instantiating module "pap" from file /etc/raddb-testing/modules/pap
pap {
encryption_scheme = "auto"
auto_header = yes
}
Module: Linked to module rlm_chap
Module: Instantiating module "chap" from file /etc/raddb-testing/modules/chap
Module: Linked to module rlm_mschap
Module: Instantiating module "mschap" from file
/etc/raddb-testing/modules/mschap
mschap {
use_mppe = yes
require_encryption = no
require_strong = no
with_ntdomain_hack = no
allow_retry = yes
}
Module: Linked to module rlm_pam
Module: Instantiating module "pam" from file /etc/raddb-testing/modules/pam
pam {
pam_auth = "radiusd"
}
Module: Linked to module rlm_unix
Module: Instantiating module "unix" from file /etc/raddb-testing/modules/unix
unix {
radwtmp = "/usr/local-test/var/log/radius/radwtmp"
}
Module: Linked to module rlm_eap
Module: Instantiating module "eap" from file /etc/raddb-testing/eap.conf
eap {
default_eap_type = "md5"
timer_expire = 600
ignore_unknown_eap_types = no
cisco_accounting_username_bug = no
max_sessions = 4096
}
Module: Linked to sub-module rlm_eap_md5
Module: Instantiating eap-md5
Module: Linked to sub-module rlm_eap_leap
Module: Instantiating eap-leap
Module: Linked to sub-module rlm_eap_gtc
Module: Instantiating eap-gtc
gtc {
challenge = "Password: "
auth_type = "PAP"
}
Module: Linked to sub-module rlm_eap_tls
Module: Instantiating eap-tls
tls {
rsa_key_exchange = no
dh_key_exchange = yes
rsa_key_length = 512
dh_key_length = 512
verify_depth = 0
pem_file_type = yes
private_key_file = "/etc/pki/tls/certs/ips-spectrum-key.pem"
certificate_file = "/etc/pki/tls/certs/spectrum.sarlanga.edu.cer"
CA_file = "/etc/pki/tls/certs/IPS-IPSCABUNDLE.crt"
dh_file = "/etc/raddb-testing/certs/dh"
random_file = "/etc/raddb-testing/certs/random"
fragment_size = 1024
include_length = yes
check_crl = no
cipher_list = "DEFAULT"
cache {
enable = yes
lifetime = 6
max_entries = 255
}
verify {
}
ocsp {
enable = no
override_cert_url = yes
url = "http://127.0.0.1/ocsp/"
}
}
Module: Linked to sub-module rlm_eap_ttls
Module: Instantiating eap-ttls
ttls {
default_eap_type = "md5"
copy_request_to_tunnel = yes
use_tunneled_reply = yes
virtual_server = "inner-tunnel"
include_length = yes
}
Module: Linked to sub-module rlm_eap_peap
Module: Instantiating eap-peap
peap {
default_eap_type = "mschapv2"
copy_request_to_tunnel = yes
use_tunneled_reply = yes
proxy_tunneled_request_as_eap = yes
virtual_server = "inner-tunnel-peap"
soh = no
}
Module: Linked to sub-module rlm_eap_mschapv2
Module: Instantiating eap-mschapv2
mschapv2 {
with_ntdomain_hack = no
send_error = yes
}
Module: Checking authorize {...} for more modules to load
Module: Linked to module rlm_preprocess
Module: Instantiating module "preprocess" from file
/etc/raddb-testing/modules/preprocess
preprocess {
huntgroups = "/etc/raddb-testing/huntgroups"
hints = "/etc/raddb-testing/hints"
with_ascend_hack = no
ascend_channels_per_line = 23
with_ntdomain_hack = no
with_specialix_jetstream_hack = no
with_cisco_vsa_hack = no
with_alvarion_vsa_hack = no
}
Module: Linked to module rlm_detail
Module: Instantiating module "auth_log" from file
/etc/raddb-testing/modules/detail.log
detail auth_log {
detailfile =
"/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d"
header = "%t"
detailperm = 384
dirperm = 493
locking = no
log_packet_header = no
}
Module: Linked to module rlm_realm
Module: Instantiating module "suffix" from file
/etc/raddb-testing/modules/realm
realm suffix {
format = "suffix"
delimiter = "@"
ignore_default = no
ignore_null = no
}
Module: Linked to module rlm_files
Module: Instantiating module "files" from file /etc/raddb-testing/modules/files
files {
usersfile = "/etc/raddb-testing/users"
acctusersfile = "/etc/raddb-testing/acct_users"
preproxy_usersfile = "/etc/raddb-testing/preproxy_users"
compat = "no"
}
Module: Checking preacct {...} for more modules to load
Module: Linked to module rlm_acct_unique
Module: Instantiating module "acct_unique" from file
/etc/raddb-testing/modules/acct_unique
acct_unique {
key = "User-Name, Acct-Session-Id, NAS-IP-Address,
Client-IP-Address, NAS-Port"
}
Module: Checking accounting {...} for more modules to load
Module: Instantiating module "detail" from file
/etc/raddb-testing/modules/detail
detail {
detailfile =
"/usr/local-test/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d"
header = "%t"
detailperm = 384
dirperm = 493
locking = no
log_packet_header = no
}
Module: Linked to module rlm_radutmp
Module: Instantiating module "radutmp" from file
/etc/raddb-testing/modules/radutmp
radutmp {
filename = "/usr/local-test/var/log/radius/radutmp"
username = "%{User-Name}"
case_sensitive = yes
check_with_nas = yes
perm = 384
callerid = yes
}
Module: Linked to module rlm_attr_filter
Module: Instantiating module "attr_filter.accounting_response" from
file /etc/raddb-testing/modules/attr_filter
attr_filter attr_filter.accounting_response {
attrsfile = "/etc/raddb-testing/attrs.accounting_response"
key = "%{User-Name}"
relaxed = no
}
Module: Checking session {...} for more modules to load
Module: Checking post-proxy {...} for more modules to load
Module: Checking post-auth {...} for more modules to load
Module: Instantiating module "reply_log" from file
/etc/raddb-testing/modules/detail.log
detail reply_log {
detailfile =
"/usr/local-test/var/log/radius/radacct/replies/%{Client-IP-Address}/reply-detail-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d"
header = "%t"
detailperm = 384
dirperm = 493
locking = no
log_packet_header = no
}
Module: Instantiating module "attr_filter.access_reject" from file
/etc/raddb-testing/modules/attr_filter
attr_filter attr_filter.access_reject {
attrsfile = "/etc/raddb-testing/attrs.access_reject"
key = "%{User-Name}"
relaxed = no
}
} # modules
} # server
server status { # from file /etc/raddb-testing/sites-enabled/status
modules {
Module: Creating Autz-Type = Status-Server
Module: Checking authorize {...} for more modules to load
Module: Linked to module rlm_always
Module: Instantiating module "ok" from file /etc/raddb-testing/modules/always
always ok {
rcode = "ok"
simulcount = 0
mpp = no
}
} # modules
} # server
server inner-tunnel { # from file /etc/raddb-testing/sites-enabled/inner-tunnel
modules {
Module: Creating Auth-Type = LDAP
Module: Checking authenticate {...} for more modules to load
Module: Linked to module rlm_ldap
Module: Instantiating module "ldap" from file /etc/raddb-testing/modules/ldap
ldap {
server = "ldap.sarlanga.edu"
port = 636
password = "sarlanga"
identity = "cn=freeradius,ou=applications,dc=sarlanga,dc=edu"
net_timeout = 10
timeout = 120
timelimit = 30
tls_mode = no
start_tls = no
tls_require_cert = "allow"
tls {
start_tls = no
cacertfile = "/etc/raddb-testing/cacert.pem"
randfile = "/dev/urandom"
require_cert = "demand"
}
basedn = "ou=people,dc=sarlanga,dc=edu"
filter = "(uid=%u)"
base_filter = "(objectclass=radiusprofile)"
auto_header = no
access_attr = "radiusAllowed"
access_attr_used_for_allow = yes
groupname_attribute = "cn"
groupmembership_filter =
"(|(&(objectClass=GroupOfNames)(member=%{Ldap-UserDn}))(&(objectClass=GroupOfUniqueNames)(uniquemember=%{Ldap-UserDn})))"
dictionary_mapping = "/etc/raddb-testing/ldap.attrmap"
ldap_debug = 40
ldap_connections_number = 15
compare_check_items = no
do_xlat = yes
set_auth_type = yes
keepalive {
interval = 3
}
}
rlm_ldap: Registering ldap_groupcmp for Ldap-Group
rlm_ldap: Registering ldap_xlat with xlat_name ldap
rlm_ldap: reading ldap<->radius mappings from file
/etc/raddb-testing/ldap.attrmap
rlm_ldap: LDAP radiusCheckItem mapped to RADIUS $GENERIC$
rlm_ldap: LDAP radiusReplyItem mapped to RADIUS $GENERIC$
rlm_ldap: LDAP radiusPassword mapped to RADIUS Cleartext-Password
rlm_ldap: LDAP radiusAuthType mapped to RADIUS Auth-Type
rlm_ldap: LDAP radiusSimultaneousUse mapped to RADIUS Simultaneous-Use
rlm_ldap: LDAP radiusCalledStationId mapped to RADIUS Called-Station-Id
rlm_ldap: LDAP radiusCallingStationId mapped to RADIUS Calling-Station-Id
rlm_ldap: LDAP lmPassword mapped to RADIUS LM-Password
rlm_ldap: LDAP ntPassword mapped to RADIUS NT-Password
rlm_ldap: LDAP sambaLmPassword mapped to RADIUS LM-Password
rlm_ldap: LDAP sambaNtPassword mapped to RADIUS NT-Password
rlm_ldap: LDAP dBCSPwd mapped to RADIUS LM-Password
rlm_ldap: LDAP userPassword mapped to RADIUS Password-With-Header
rlm_ldap: LDAP acctFlags mapped to RADIUS SMB-Account-CTRL-TEXT
rlm_ldap: LDAP radiusExpiration mapped to RADIUS Expiration
rlm_ldap: LDAP radiusNASIpAddress mapped to RADIUS NAS-IP-Address
rlm_ldap: LDAP radiusServiceType mapped to RADIUS Service-Type
rlm_ldap: LDAP radiusFramedProtocol mapped to RADIUS Framed-Protocol
rlm_ldap: LDAP radiusFramedIPAddress mapped to RADIUS Framed-IP-Address
rlm_ldap: LDAP radiusFramedIPNetmask mapped to RADIUS Framed-IP-Netmask
rlm_ldap: LDAP radiusFramedRoute mapped to RADIUS Framed-Route
rlm_ldap: LDAP radiusFramedRouting mapped to RADIUS Framed-Routing
rlm_ldap: LDAP radiusFilterId mapped to RADIUS Filter-Id
rlm_ldap: LDAP radiusFramedMTU mapped to RADIUS Framed-MTU
rlm_ldap: LDAP radiusFramedCompression mapped to RADIUS Framed-Compression
rlm_ldap: LDAP radiusLoginIPHost mapped to RADIUS Login-IP-Host
rlm_ldap: LDAP radiusLoginService mapped to RADIUS Login-Service
rlm_ldap: LDAP radiusLoginTCPPort mapped to RADIUS Login-TCP-Port
rlm_ldap: LDAP radiusCallbackNumber mapped to RADIUS Callback-Number
rlm_ldap: LDAP radiusCallbackId mapped to RADIUS Callback-Id
rlm_ldap: LDAP radiusFramedIPXNetwork mapped to RADIUS Framed-IPX-Network
rlm_ldap: LDAP radiusClass mapped to RADIUS Class
rlm_ldap: LDAP radiusSessionTimeout mapped to RADIUS Session-Timeout
rlm_ldap: LDAP radiusIdleTimeout mapped to RADIUS Idle-Timeout
rlm_ldap: LDAP radiusTerminationAction mapped to RADIUS Termination-Action
rlm_ldap: LDAP radiusLoginLATService mapped to RADIUS Login-LAT-Service
rlm_ldap: LDAP radiusLoginLATNode mapped to RADIUS Login-LAT-Node
rlm_ldap: LDAP radiusLoginLATGroup mapped to RADIUS Login-LAT-Group
rlm_ldap: LDAP radiusFramedAppleTalkLink mapped to RADIUS Framed-AppleTalk-Link
rlm_ldap: LDAP radiusFramedAppleTalkNetwork mapped to RADIUS
Framed-AppleTalk-Network
rlm_ldap: LDAP radiusFramedAppleTalkZone mapped to RADIUS Framed-AppleTalk-Zone
rlm_ldap: LDAP radiusPortLimit mapped to RADIUS Port-Limit
rlm_ldap: LDAP radiusLoginLATPort mapped to RADIUS Login-LAT-Port
rlm_ldap: LDAP radiusReplyMessage mapped to RADIUS Reply-Message
rlm_ldap: LDAP radiusTunnelType mapped to RADIUS Tunnel-Type
rlm_ldap: LDAP radiusTunnelMediumType mapped to RADIUS Tunnel-Medium-Type
rlm_ldap: LDAP radiusTunnelPrivateGroupId mapped to RADIUS
Tunnel-Private-Group-Id
conns: 0x1ffc1270
Module: Checking authorize {...} for more modules to load
Module: Checking session {...} for more modules to load
Module: Checking post-proxy {...} for more modules to load
Module: Instantiating module "post_proxy_log" from file
/etc/raddb-testing/modules/detail.log
detail post_proxy_log {
detailfile =
"/usr/local-test/var/log/radius/radacct/postproxy/%{Client-IP-Address}/post-proxy-detail-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d"
header = "%t"
detailperm = 384
dirperm = 493
locking = no
log_packet_header = no
}
Module: Checking post-auth {...} for more modules to load
} # modules
} # server
server inner-tunnel-peap { # from file
/etc/raddb-testing/sites-enabled/inner-tunnel-peap
modules {
Module: Checking authenticate {...} for more modules to load
Module: Checking authorize {...} for more modules to load
Module: Checking session {...} for more modules to load
Module: Checking post-proxy {...} for more modules to load
Module: Checking post-auth {...} for more modules to load
} # modules
} # server
radiusd: #### Opening IP addresses and Ports ####
listen {
type = "auth"
ipaddr = 192.168.1.5
port = 0
}
listen {
type = "acct"
ipaddr = 192.168.1.5
port = 0
}
listen {
type = "control"
listen {
socket = "/usr/local-test/var/run/radiusd/radiusd.sock"
}
}
listen {
type = "status"
ipaddr = 127.0.0.1
port = 18120
client admin {
ipaddr = 127.0.0.1
require_message_authenticator = no
secret = "YellowSubmarine"
}
}
... adding new socket proxy address * port 54388
Listening on authentication address 192.168.1.5 port 1812
Listening on accounting address 192.168.1.5 port 1813
Listening on command file /usr/local-test/var/run/radiusd/radiusd.sock
Listening on status address 127.0.0.1 port 18120 as server status
Listening on proxy address 192.168.1.5 port 1814
Ready to process requests.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=74, length=170
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x0238000d017072756562697461
Message-Authenticator = 0x510c83d2d8d716e25fa8e00162124f28
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 56 length 13
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[unix] returns notfound
[files] users: Matched entry pruebita at line 434
++[files] returns ok
++[expiration] returns noop
++[logintime] returns noop
[pap] WARNING: Auth-Type already set. Not setting to PAP
++[pap] returns noop
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] EAP Identity
[eap] processing type md5
rlm_eap_md5: Issuing Challenge
++[eap] returns handled
Sending Access-Challenge of id 74 to 10.129.89.1 port 38848
EAP-Message = 0x013900160410381a962cdd81a78cdd529de9d83f2b61
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f51fce56b215acf310f5bc900
Finished request 28.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=75, length=181
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x023900060319
State = 0x51c5e19f51fce56b215acf310f5bc900
Message-Authenticator = 0x9a66eb7b5a106c018d00e0b57f80f262
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 57 length 6
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[unix] returns notfound
[files] users: Matched entry pruebita at line 434
++[files] returns ok
++[expiration] returns noop
++[logintime] returns noop
[pap] WARNING: Auth-Type already set. Not setting to PAP
++[pap] returns noop
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP NAK
[eap] EAP-NAK asked for EAP-Type/peap
[eap] processing type tls
[tls] Initiate
[tls] Start returned 1
++[eap] returns handled
Sending Access-Challenge of id 75 to 10.129.89.1 port 38848
EAP-Message = 0x013a00061920
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f50fff86b215acf310f5bc900
Finished request 29.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=76, length=241
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message =
0x023a0042190016030100370100003303014fc89ccd9ef24a5acabf352713ed67aad4acfb2a2f0d4c5ad746a761a24f976800000c0013000a0033002f000500040100
State = 0x51c5e19f50fff86b215acf310f5bc900
Message-Authenticator = 0xb1b6655fab2a4f02abdddc4928d46870
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 58 length 66
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] eaptls_verify returned 7
[peap] Done initial handshake
[peap] (other): before/accept initialization
[peap] TLS_accept: before/accept initialization
[peap] <<< TLS 1.0 Handshake [length 0037], ClientHello
[peap] TLS_accept: SSLv3 read client hello A
[peap] >>> TLS 1.0 Handshake [length 004a], ServerHello
[peap] TLS_accept: SSLv3 write server hello A
[peap] >>> TLS 1.0 Handshake [length 1324], Certificate
[peap] TLS_accept: SSLv3 write certificate A
[peap] >>> TLS 1.0 Handshake [length 0004], ServerHelloDone
[peap] TLS_accept: SSLv3 write server done A
[peap] TLS_accept: SSLv3 flush data
[peap] TLS_accept: Need to read more data: SSLv3 read client certificate A
In SSL Handshake Phase
In SSL Accept mode
[peap] eaptls_process returned 13
[peap] EAPTLS_HANDLED
++[eap] returns handled
Sending Access-Challenge of id 76 to 10.129.89.1 port 38848
EAP-Message =
0x013b040019c000001381160301004a0200004603014fc89cce0c471ae8314022655c37dcbb1fe882ed8735b93cfda7f5029188744220189eb3cfe1bd6b3b6b87fa215018f64ad2b414cda3740799b6d6c814cb3f7700000a0016030113240b00132000131d00071730820713308205fba0030201020214101b7f691cb7a76e4d2434f172207f0d6457bfd6300d06092a864886f70d01010505003081b0310b3009060355040613024553310f300d060355040813064d4144524944310f300d060355040713064d414452494431243022060355040a131b6970732043657274696669636174696f6e20417574686f7269747931183016060355040b130f
EAP-Message =
0x43657274696669636163696f6e657331193017060355040313106970734341204c6576656c20312043413124302206092a864886f70d010901161569707363616c6576656c314069707363612e636f6d301e170d3132303132373132303731335a170d3134303230313132303731335a30818d310b3009060355040613024152311530130603550407130c4275656e6f73204169726573311f301d060355040a1316556e6976657273696461642064652050616c65726d6f31273025060355040b131e446570617274616d656e746f20646520436f6d756e69636163696f6e6573311d301b06035504031314737065637472756d2e70616c65726d6f2e
EAP-Message =
0x65647530820122300d06092a864886f70d01010105000382010f003082010a0282010100a8efabc6c785b1314fc7a643f75a6b1e1ae645b4ad47d23a5ce062cd3fa5a998112d48b88960da17628181430eb1e6dbcd806eb3b77ad9ca5728e86d333f9a910107d90c0e2dad1951587fb6ebe0b1f99665fad04e352e1d87dbf1a1292ae3cc8bb936511b10cc25facb79db7df50a443359a5c46213253cfbee9db5a262221e23d6961c6f2e4bff6c7702fe05eeff8c97c3c4558f84d3d61a1571017d5638863ec4f341613113aca1b385ae7598065503f28f78c83c632ebb0183d6d8ffd21edd8cd4db50c1550443f12706847a053769c1c5c7f94eff9fff
EAP-Message =
0x8c3091d3892db2f35ab46dc208d1e03f37b82fb96d7fba474b42279ecb74157fdc521c038949dd0203010001a38203443082034030090603551d1304023000301106096086480186f8420101040403020640300b0603551d0f0404030205a030130603551d25040c300a06082b06010505070301301d0603551d0e04160414d57dbba6130341755d2138e3ed9faacb3e65cdcb301f0603551d230418301680147d9e6b0efc13e1c48ba77f61ae6021cfcda0d30630090603551d1104023000305b0603551d1204543052a450304e310b300906035504061302455331243022060355040a131b6970732043657274696669636174696f6e20417574686f
EAP-Message = 0x726974793119301706035504
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f53fef86b215acf310f5bc900
Finished request 30.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=77, length=181
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x023b00061900
State = 0x51c5e19f53fef86b215acf310f5bc900
Message-Authenticator = 0xa4a26c588cef259c66f231f46e99c8da
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 59 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] Received TLS ACK
[peap] ACK handshake fragment handler
[peap] eaptls_verify returned 1
[peap] eaptls_process returned 13
[peap] EAPTLS_HANDLED
++[eap] returns handled
Sending Access-Challenge of id 77 to 10.129.89.1 port 38848
EAP-Message =
0x013c03fc19400313106970734341204c6576656c2031204341307106096086480186f842010d046416624f7267616e697a6174696f6e20496e666f726d6174696f6e204e4f542056414c4944415445442e204c4556454c3120536572766572204365727469666963617465206973737565642062792068747470733a2f2f7777772e69707363612e636f6d2f302906096086480186f8420102041c161a687474703a2f2f6c6576656c3130312e69707363612e636f6d2f303c06096086480186f8420104042f162d687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f69707363616c6576656c312e63726c3043060960864801
EAP-Message =
0x86f842010304361634687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f7265766f636174696f6e4c4556454c312e68746d6c3f304006096086480186f842010704331631687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f72656e6577616c4c4556454c312e68746d6c3f303e06096086480186f84201080431162f687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f706f6c6963794c4556454c312e68746d6c30730603551d1f046c306a3033a031a02f862d687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f69707363616c6576656c312e63
EAP-Message =
0x726c3033a031a02f862d687474703a2f2f6c6576656c3130322e69707363612e636f6d2f63726c2f69707363616c6576656c312e63726c303e06082b0601050507010104323030302e06082b060105050730018622687474703a2f2f6f6373706c6576656c3130312e69707363612e636f6d2f6f637370300d06092a864886f70d010105050003820101004b61ec4cf7163dad3601e3de9938175ec4ec75d60f658eabf37b1e331283419e7438e584e8cfc47c087c7cba005dcd9d7d165a470bd7aaea70b69b1a18ad2a6cc136cf2ff5cb948ae2866b1c46bbf8ef999ecb510407f28a091e7aa75684d90938f85c3fcd39580112b6979f3284c581f86b
EAP-Message =
0x998bc211c1de82e87fd57ee7a975905e9dec75020feda29cf4f29dc59dc3946ccf328f7380c6f3f4064d3f6f496fffd640ed2c813c44d648f9ee0143f894d41f4970f30e158064b305a4ae264887a62b5ee51f4f7f3241ddeebcd1153f836262d7c24c4cd7a09f2ab6bc052cd2ecf78e948f240e526538478893fb776f27d44d620c8e58641b4231958c85d758080005f2308205ee308204d6a00302010202141000000000000000000000000000000000000011300d06092a864886f70d01010505003081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d06035504
EAP-Message = 0x0a13264950532043
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f52f9f86b215acf310f5bc900
Finished request 31.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=78, length=181
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x023c00061900
State = 0x51c5e19f52f9f86b215acf310f5bc900
Message-Authenticator = 0xf15626a2f70fb625cfbdee8873d99f4f
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 60 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] Received TLS ACK
[peap] ACK handshake fragment handler
[peap] eaptls_verify returned 1
[peap] eaptls_process returned 13
[peap] EAPTLS_HANDLED
++[eap] returns handled
Sending Access-Challenge of id 78 to 10.129.89.1 port 38848
EAP-Message =
0x013d03fc1940657274696669636174696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b13056970734341311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d301e170d3039313231303131333835325a170d3239313232343131333835325a3081b0310b3009060355040613024553310f300d060355040813064d4144524944310f300d060355040713064d414452494431243022060355040a131b6970732043657274696669636174696f6e20417574686f7269747931183016060355040b130f43
EAP-Message =
0x657274696669636163696f6e657331193017060355040313106970734341204c6576656c20312043413124302206092a864886f70d010901161569707363616c6576656c314069707363612e636f6d30820122300d06092a864886f70d01010105000382010f003082010a02820101009f4db33023c13a798527825d45ce5b64f82bafe15d6001e2940ed501863645858c0c8e76e1a0a40d935417986aeeb2840b23eabf217cc0ee49c026791954d6311890f7fb970be3a8c51640de2eb88c655b32d953f7c8ff06fb896654f8ea44420fb74fc7b0e94fd1d0bbfa968a33e346b7fa64bc65b11fb1e0e105f80cdd4af58b3097b4480a94feaf1d63f269
EAP-Message =
0x2c6b1b446afd3bd9dae70df0c68ab6e0190160a309a2b320401b14073a8c22df33f476c185b862b849b975c196ed1108af3c3f4e59e840dc995a134747e3b2840a7e8130b71c969f2e0d1cd0e5845e5bad3cce4a6b7d684522f54d5ae79f5c19004827a5787882d3e2ffb1e680dfeb2a125bb10203010001a38201fa308201f6302a06096086480186f8420102041d161b68747470733a2f2f6c6576656c3130312e69707363612e636f6d2f302106096086480186f84201030414161265737461646f2f65737461646f2e6173703f302706096086480186f8420104041a161865737461646f4341544553542f65737461646f2e6173703f3022060960
EAP-Message =
0x86480186f84201070415161365737461646f2f72656e756576612e6173703f302006096086480186f84201080413161165737461646f2f706f6c6963792e617370302406096086480186f842010d04171615436572746966696361646f20706f72206970734341301106096086480186f8420101040403020007300c0603551d13040530030101ff301d0603551d0e041604147d9e6b0efc13e1c48ba77f61ae6021cfcda0d306303e0603551d1f043730353033a031a02f862d687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f69707363616c6576656c312e63726c303a06082b06010505070101042e302c302a06082b06
EAP-Message = 0x010505073001861e
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f55f8f86b215acf310f5bc900
Finished request 32.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=79, length=181
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x023d00061900
State = 0x51c5e19f55f8f86b215acf310f5bc900
Message-Authenticator = 0x4ce902814c105901520df2f8036166c3
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 61 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] Received TLS ACK
[peap] ACK handshake fragment handler
[peap] eaptls_verify returned 1
[peap] eaptls_process returned 13
[peap] EAPTLS_HANDLED
++[eap] returns handled
Sending Access-Challenge of id 79 to 10.129.89.1 port 38848
EAP-Message =
0x013e03fc1940687474703a2f2f6f6373706c6576656c3130312e69707363612e636f6d2f300b0603551d0f04040302010630470603551d250440303e06082b0601050507030106082b0601050507030206082b0601050507030306082b0601050507030406082b06010505070308060a2b0601040182370a0304300d06092a864886f70d010105050003820101008737bf8f76d31d2eca683935839d2958fe74add252963aff06e84cb0308e3316c5972d29aebe28e77e10ab20e1ed509ecfbbd394fe1da47370d27e6239b31cd636e1d4782bace12bedc753a14dd4281f588e56e2c924f956ec0ad0df5268575ea4393bb9e46619c4cff0a7fbb7717f
EAP-Message =
0xd7f247a501f8245587996ac61064ada017958080eb6d4bd3e9171685a951ae6e69419776e8de7f43fb891b853397030059549676d110ed837018f76ca7231a20647365211bee7e1e67f8026ad21c2e37a31e7001bb866076bc7adc7eff3475f2e33e94c60ed70ce792cc33c31c32df09e853cf3587c59453f98efa685cce193a482a52f3da46c2e6bd5d02b5471eb9954000060b30820607308204efa003020102020100300d06092a864886f70d01010505003081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d060355040a132649505320436572746966696361
EAP-Message =
0x74696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b13056970734341311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d301e170d3039303930373134333834345a170d3239313232353134333834345a3081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d060355040a13264950532043657274696669636174696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b130569707343
EAP-Message =
0x41311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d30820122300d06092a864886f70d01010105000382010f003082010a0282010100a7efcc8030b091244fb068f8c3ca2d1538555882e23863b0f7a3926f83b8b05eb08cac54b177d050e097b390ad8ab31f392b4556f7aae2df7cb2ec6f532f9acbd0e666cbc913e872e2b4cd31578712b593e8fa72ceea47f28cb4b063d70400b764363997e895f188f9710d03278c61cf0883964f83c54ee85cf80670f102aa1c1ea9c8aa7ee75dcd8d3c146f67d01ba923488b21283a8a4ce6
EAP-Message = 0x1131f9212eb26766
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f54fbf86b215acf310f5bc900
Finished request 33.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=80, length=181
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x023e00061900
State = 0x51c5e19f54fbf86b215acf310f5bc900
Message-Authenticator = 0x419616a5e5f69204aaca365aa417d934
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 62 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] Received TLS ACK
[peap] ACK handshake fragment handler
[peap] eaptls_verify returned 1
[peap] eaptls_process returned 13
[peap] EAPTLS_HANDLED
++[eap] returns handled
Sending Access-Challenge of id 80 to 10.129.89.1 port 38848
EAP-Message =
0x013f03af1900c6296e9493cf4096fcb03dbfb2b493bf5671b6a54187b058b559232849b898f9501e2d15280b4cac49d184a99b9ae77254b738d0dbc9fea973d56d10cd8e75ebfe97fd803cfcb4d848f499460b8814a4b62edb4c60f421c16c809514d5afd50203010001a382022430820220301d0603551d0e0416041415a69680b1154b31c3c29cf6e7130b4bf318cd863081df0603551d230481d73081d4801415a69680b1154b31c3c29cf6e7130b4bf318cd86a181b8a481b53081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d060355040a13264950532043
EAP-Message =
0x657274696669636174696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b13056970734341311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d820100300c0603551d13040530030101ff300b0603551d0f04040302010630470603551d250440303e06082b0601050507030106082b0601050507030206082b0601050507030306082b0601050507030406082b06010505070308060a2b0601040182370a0304301d0603551d11041630148112676c6f62616c30314069707363612e636f6d301d0603
EAP-Message =
0x551d12041630148112676c6f62616c30314069707363612e636f6d30410603551d1f043a30383036a034a0328630687474703a2f2f63726c676c6f62616c30312e69707363612e636f6d2f63726c2f63726c676c6f62616c30312e63726c303806082b06010505070101042c302a302806082b06010505073001861c687474703a2f2f63726c676c6f62616c30312e69707363612e636f6d300d06092a864886f70d0101050500038201010018f4aefe800f8ec1776fa25a47489f2355a1536bf95da730a524be432ff8c1d157f93e2c8025cc46a936f3495b1df67cd763b34d3e78f6a7b40277f8790d3e6acb1860b8fd00af0cdd54e3548f223df310
EAP-Message =
0x6f110db51e7a8d27cc08b85bc3b81a5f2ba7603f001cf70f5c4266649e8712807089e0fa57280e4e1f102fd90580b6802f1c69f0f6b66534056fcad93ef8d45d3732c7b82bccff73930071e001c8aa43bda9f1cefa80f9f1431291a665e560074d47ba2b2f04f64a8529886510c9b253629c6c9b605c1a1bd3aec51d729906ff05cc862673b4d45405dd1e6b003bb789e8e391022012ebefe9fe0a29238123a300da70cc925f3723d01c7b355c037a16030100040e000000
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f57faf86b215acf310f5bc900
Finished request 34.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=81, length=501
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message =
0x023f014419001603010106100001020100615e16737ca27664e029e9464b6d38d0e96d10e9fa36dcc345d6c2bebc5b46b7f6f57dee94e3445d5addd0c341d0330731effdda2d1300f6163f8f9e639e7f29d6d5e01f75cc38ae18ea18c5db3b29b96255f6928c2a420882655e8cb81ea6c6df4fe2f5d37b0de031b7c81556d94022fb272852e078572cba44e3e8151e9660e6816d10fdba3a51b36e43119417ce6ca34e1d37d659a2f8b1f8bb4248ed807392bf7f5f453cf26f00fbcdfc6ec84f1798737710ade7141b2ecd78d77e6ba428ba468a36405c92a816c5a4868fa9ebb0b5f8a726d4b1ce9892fa2fe554e645d16522c263f3c5f86cd03171d0
EAP-Message =
0x8053a3c19d3fe2901eac4ee34cc1a51f2d9068191403010001011603010028dc45b3ecdbce94b5a878b480e812ee79a9c17150a92671fa177236cf97bf02bffc1a52c026dbbb2a
State = 0x51c5e19f57faf86b215acf310f5bc900
Message-Authenticator = 0xf86876fb7612ab7ff8a644817293b53b
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 63 length 253
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] eaptls_verify returned 7
[peap] Done initial handshake
[peap] <<< TLS 1.0 Handshake [length 0106], ClientKeyExchange
[peap] TLS_accept: SSLv3 read client key exchange A
[peap] <<< TLS 1.0 ChangeCipherSpec [length 0001]
[peap] <<< TLS 1.0 Handshake [length 0010], Finished
[peap] TLS_accept: SSLv3 read finished A
[peap] >>> TLS 1.0 ChangeCipherSpec [length 0001]
[peap] TLS_accept: SSLv3 write change cipher spec A
[peap] >>> TLS 1.0 Handshake [length 0010], Finished
[peap] TLS_accept: SSLv3 write finished A
[peap] TLS_accept: SSLv3 flush data
SSL: adding session
189eb3cfe1bd6b3b6b87fa215018f64ad2b414cda3740799b6d6c814cb3f7700 to
cache
[peap] (other): SSL negotiation finished successfully
SSL Connection Established
[peap] eaptls_process returned 13
[peap] EAPTLS_HANDLED
++[eap] returns handled
Sending Access-Challenge of id 81 to 10.129.89.1 port 38848
EAP-Message =
0x0140003919001403010001011603010028120ba7581f67afee3fe93d71202a3b8eef45d44ed59366641e4e901d1d30295d67644c20f0636c95
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f5685f86b215acf310f5bc900
Finished request 35.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=82, length=181
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x024000061900
State = 0x51c5e19f5685f86b215acf310f5bc900
Message-Authenticator = 0x9876211434267235d34177c6baada0a0
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 64 length 6
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] Received TLS ACK
[peap] ACK handshake is finished
[peap] eaptls_verify returned 3
[peap] eaptls_process returned 3
[peap] EAPTLS_SUCCESS
[peap] Session established. Decoding tunneled attributes.
[peap] Peap state TUNNEL ESTABLISHED
++[eap] returns handled
Sending Access-Challenge of id 82 to 10.129.89.1 port 38848
EAP-Message =
0x0141002b19001703010020a7bad7bd5b08f24e8165859c7202d96fbb32d601cf63a81969b692422bbce7f0
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f5984f86b215acf310f5bc900
Finished request 36.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=83, length=247
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message =
0x02410048190017030100182c80dd585307c00c58051a0ea4faa27e4a5df95720469a7a170301002095ab5282b093ae854c63cc7d3ba67d506c23bddff057c2a98511a4bf854240c9
State = 0x51c5e19f5984f86b215acf310f5bc900
Message-Authenticator = 0x39c120e0dca7d430448165505dc8dd6c
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 65 length 72
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] eaptls_verify returned 7
[peap] Done initial handshake
[peap] eaptls_process returned 7
[peap] EAPTLS_OK
[peap] Session established. Decoding tunneled attributes.
[peap] Peap state WAITING FOR INNER IDENTITY
[peap] Identity - pruebita
[peap] Got inner identity 'pruebita'
[peap] Setting default EAP type for tunneled EAP session.
[peap] Got tunneled request
EAP-Message = 0x0241000d017072756562697461
server {
[peap] Setting User-Name to pruebita
Sending tunneled request
EAP-Message = 0x0241000d017072756562697461
FreeRADIUS-Proxied-To = 127.0.0.1
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
NAS-IP-Address = 10.129.89.1
server inner-tunnel-peap {
# Executing section authorize from file
/etc/raddb-testing/sites-enabled/inner-tunnel-peap
+- entering group authorize {...}
++[chap] returns noop
++[mschap] returns noop
++[unix] returns notfound
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 65 length 13
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for pruebita
[ldap] expand: (uid=%u) -> (uid=pruebita)
[ldap] expand: ou=people,dc=sarlanga,dc=edu -> ou=people,dc=sarlanga,dc=edu
[ldap] ldap_get_conn: Checking Id: 0
[ldap] ldap_get_conn: Got Id: 0
[ldap] performing search in ou=people,dc=sarlanga,dc=edu, with
filter (uid=pruebita)
[ldap] object not found
[ldap] search failed
[ldap] ldap_release_conn: Release Id: 0
++[ldap] returns notfound
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns noop
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/inner-tunnel-peap
+- entering group authenticate {...}
[eap] EAP Identity
[eap] processing type mschapv2
rlm_eap_mschapv2: Issuing Challenge
++[eap] returns handled
} # server inner-tunnel-peap
[peap] Got tunneled reply code 11
EAP-Message =
0x014200221a0142001d1044c4caf16d9a7e43d6e3fbad805501237072756562697461
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x63fdd7b563bfcd4b0f3934ebfe7a85b9
[peap] Got tunneled reply RADIUS code 11
EAP-Message =
0x014200221a0142001d1044c4caf16d9a7e43d6e3fbad805501237072756562697461
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x63fdd7b563bfcd4b0f3934ebfe7a85b9
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 83 to 10.129.89.1 port 38848
EAP-Message =
0x0142004319001703010038359eaf0224c732f9e83935d0da09d2f6b169503605cb8311ba6d9e3485d51cb6a25ddfc336d6bae781180ce0d413562af3bdcfde5180c80f
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f5887f86b215acf310f5bc900
Finished request 37.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=84, length=303
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message =
0x0242008019001703010018f3e980063f7cfb058900cf00b2760b697de7aba67e199b4f17030100588febd03280df614d10106a127d9ce496c4fccaad9681a12dd4f8d4641a2e337486c608e136ed1cbeac8af33318136b2dfa9b9a952cb7b61837ad54a90d1330537628ee52fde4e6af685b3d573bbbf04388bbaeecb4ea8e17
State = 0x51c5e19f5887f86b215acf310f5bc900
Message-Authenticator = 0x0c1ae63b5d7e03e33800ad87364eed83
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 66 length 128
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] eaptls_verify returned 7
[peap] Done initial handshake
[peap] eaptls_process returned 7
[peap] EAPTLS_OK
[peap] Session established. Decoding tunneled attributes.
[peap] Peap state phase2
[peap] EAP type mschapv2
[peap] Got tunneled request
EAP-Message =
0x024200431a0242003e314a6d7e7fe98db69bbc4fc8cceb9dfb8d0000000000000000cedcbce414bab2e5f0f7952223f1b126947ce80dd6929378007072756562697461
server {
[peap] Setting User-Name to pruebita
Sending tunneled request
EAP-Message =
0x024200431a0242003e314a6d7e7fe98db69bbc4fc8cceb9dfb8d0000000000000000cedcbce414bab2e5f0f7952223f1b126947ce80dd6929378007072756562697461
FreeRADIUS-Proxied-To = 127.0.0.1
User-Name = "pruebita"
State = 0x63fdd7b563bfcd4b0f3934ebfe7a85b9
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
NAS-IP-Address = 10.129.89.1
server inner-tunnel-peap {
# Executing section authorize from file
/etc/raddb-testing/sites-enabled/inner-tunnel-peap
+- entering group authorize {...}
++[chap] returns noop
++[mschap] returns noop
++[unix] returns notfound
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 66 length 67
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for pruebita
[ldap] expand: (uid=%u) -> (uid=pruebita)
[ldap] expand: ou=people,dc=sarlanga,dc=edu -> ou=people,dc=sarlanga,dc=edu
[ldap] ldap_get_conn: Checking Id: 0
[ldap] ldap_get_conn: Got Id: 0
[ldap] performing search in ou=people,dc=sarlanga,dc=edu, with
filter (uid=pruebita)
[ldap] object not found
[ldap] search failed
[ldap] ldap_release_conn: Release Id: 0
++[ldap] returns notfound
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns noop
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/inner-tunnel-peap
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/mschapv2
[eap] processing type mschapv2
[mschapv2] # Executing group from file
/etc/raddb-testing/sites-enabled/inner-tunnel-peap
[mschapv2] +- entering group MS-CHAP {...}
[mschap] No Cleartext-Password configured. Cannot create LM-Password.
[mschap] No Cleartext-Password configured. Cannot create NT-Password.
[mschap] Creating challenge hash with username: pruebita
[mschap] Told to do MS-CHAPv2 for pruebita with NT-Password
[mschap] FAILED: No NT/LM-Password. Cannot perform authentication.
[mschap] FAILED: MS-CHAP2-Response is incorrect
++[mschap] returns reject
MSCHAP Failure
++[eap] returns handled
} # server inner-tunnel-peap
[peap] Got tunneled reply code 11
EAP-Message = 0x014300121a0442000d453d36393120523d31
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x63fdd7b562becd4b0f3934ebfe7a85b9
[peap] Got tunneled reply RADIUS code 11
EAP-Message = 0x014300121a0442000d453d36393120523d31
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x63fdd7b562becd4b0f3934ebfe7a85b9
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 84 to 10.129.89.1 port 38848
EAP-Message =
0x014300331900170301002888636a6445053d18018a230fd21f9959466fd90802b7210f8b788a09a4494fc64d1f7b6ae050f021
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f5b86f86b215acf310f5bc900
Finished request 38.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=85, length=239
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message =
0x0243004019001703010018e16554d32843bdba9b707d3e41f21023c12b34e85e7f7df517030100186d29c7588683f31175ad338f971a6426cac9ffe6b6eaa912
State = 0x51c5e19f5b86f86b215acf310f5bc900
Message-Authenticator = 0x10df06a435d2fc959d36eb7ecb637292
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 67 length 64
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] eaptls_verify returned 7
[peap] Done initial handshake
[peap] eaptls_process returned 7
[peap] EAPTLS_OK
[peap] Session established. Decoding tunneled attributes.
[peap] Peap state phase2
[peap] EAP type mschapv2
[peap] Got tunneled request
EAP-Message = 0x024300061a04
server {
[peap] Setting User-Name to pruebita
Sending tunneled request
EAP-Message = 0x024300061a04
FreeRADIUS-Proxied-To = 127.0.0.1
User-Name = "pruebita"
State = 0x63fdd7b562becd4b0f3934ebfe7a85b9
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
NAS-IP-Address = 10.129.89.1
server inner-tunnel-peap {
# Executing section authorize from file
/etc/raddb-testing/sites-enabled/inner-tunnel-peap
+- entering group authorize {...}
++[chap] returns noop
++[mschap] returns noop
++[unix] returns notfound
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 67 length 6
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for pruebita
[ldap] expand: (uid=%u) -> (uid=pruebita)
[ldap] expand: ou=people,dc=sarlanga,dc=edu -> ou=people,dc=sarlanga,dc=edu
[ldap] ldap_get_conn: Checking Id: 0
[ldap] ldap_get_conn: Got Id: 0
[ldap] performing search in ou=people,dc=sarlanga,dc=edu, with
filter (uid=pruebita)
[ldap] object not found
[ldap] search failed
[ldap] ldap_release_conn: Release Id: 0
++[ldap] returns notfound
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns noop
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/inner-tunnel-peap
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/mschapv2
[eap] processing type mschapv2
[eap] Freeing handler
++[eap] returns reject
Failed to authenticate the user.
Login incorrect ( [ldap] User not found): [pruebita] (from client
oficina-test port 3 cli E8-3E-B6-26-C3-28 via TLS tunnel)
} # server inner-tunnel-peap
[peap] Got tunneled reply code 3
EAP-Message = 0x04430004
Message-Authenticator = 0x00000000000000000000000000000000
[peap] Got tunneled reply RADIUS code 3
EAP-Message = 0x04430004
Message-Authenticator = 0x00000000000000000000000000000000
[peap] Tunneled authentication was rejected.
[peap] FAILURE
++[eap] returns handled
Sending Access-Challenge of id 85 to 10.129.89.1 port 38848
EAP-Message =
0x0144002b1900170301002083387441294d575a9779c1b19e136da15935afcd9f001a1d2e4b5b87e236d164
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x51c5e19f5a81f86b215acf310f5bc900
Finished request 39.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.89.1 port 38848,
id=86, length=247
User-Name = "pruebita"
NAS-Identifier = "AP-PVIII-IX-OF"
NAS-Port = 3
Called-Station-Id = "00:1B-7E-DC-AB-1A:sarlanga-I"
Calling-Station-Id = "E8-3E-B6-26-C3-28"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message =
0x024400481900170301001854ac58595af316bc6d8484be6039a67508204d0ecaea270a1703010020b983c87ab4edfd3bc018184ba6271d50216bc96f1f430e19808d9e1a4ec9180a
State = 0x51c5e19f5a81f86b215acf310f5bc900
Message-Authenticator = 0xae08495c38c1461cb67d946cdf22ceae
# Executing section authorize from file /etc/raddb-testing/sites-enabled/default
+- entering group authorize {...}
++[preprocess] returns ok
[auth_log] expand: %{Virtual-Server} ->
[auth_log] ... expanding second conditional
[auth_log] expand:
/usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] /usr/local-test/var/log/radius/radacct/requests/%{Client-IP-Address}/auth-detail-%{NAS-Identifier}-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/requests/10.129.89.1/auth-detail-AP-PVIII-IX-OF-DEFAULT-20120601
[auth_log] expand: %t -> Fri Jun 1 07:43:26 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "pruebita", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 68 length 72
[eap] Continuing tunnel setup.
++[eap] returns ok
Found Auth-Type = EAP
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/peap
[eap] processing type peap
[peap] processing EAP-TLS
[peap] eaptls_verify returned 7
[peap] Done initial handshake
[peap] eaptls_process returned 7
[peap] EAPTLS_OK
[peap] Session established. Decoding tunneled attributes.
[peap] Peap state send tlv failure
[peap] Received EAP-TLV response.
[peap] The users session was previously rejected: returning reject (again.)
[peap] *** This means you need to read the PREVIOUS messages in the
debug output
[peap] *** to find out the reason why the user was rejected.
[peap] *** Look for "reject" or "fail". Those earlier messages will tell you.
[peap] *** what went wrong, and how to fix the problem.
SSL: Removing session
189eb3cfe1bd6b3b6b87fa215018f64ad2b414cda3740799b6d6c814cb3f7700 from
the cache
[eap] Handler failed in EAP/peap
[eap] Failed in EAP select
++[eap] returns invalid
Failed to authenticate the user.
Login incorrect: [pruebita] (from client oficina-test port 3 cli
E8-3E-B6-26-C3-28)
Using Post-Auth-Type Reject
# Executing group from file /etc/raddb-testing/sites-enabled/default
+- entering group REJECT {...}
[attr_filter.access_reject] expand: %{User-Name} -> pruebita
attr_filter: Matched entry DEFAULT at line 11
++[attr_filter.access_reject] returns updated
Delaying reject of request 40 for 1 seconds
Going to the next request
Waking up in 0.9 seconds.
--
--
Sergio Belkin http://www.sergiobelkin.com
Watch More TV http://sebelk.blogspot.com
LPIC-2 Certified - http://www.lpi.org
More information about the Freeradius-Users
mailing list