radlast output
Sergio Belkin
sebelk at gmail.com
Tue Jul 10 17:40:53 CEST 2012
Hi,
radlast shows NAS-Identifier trunked
lbazch 009:AP-PV-PB Tue Jul 10 12:10 still logged in
mfembe 004:AP-PI-PB Tue Jul 10 12:10 still logged in
msabad 005:oficina- Tue Jul 10 12:10 still logged in
Why? Is a bug? A misconfiguration?
You want the debug output, ok you have it :)
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 = no
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 = "nvam890"
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 = "nvam890"
nastype = "other"
}
client 192.168.1.5 {
require_message_authenticator = no
secret = "nvam890"
shortname = "vivalapepa.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.62.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-yocadorneotucadorneas-SS"
}
client 10.129.80.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-PB"
}
client 10.129.180.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-PB-SUM"
}
client 10.128.255.81 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-I"
}
client 10.129.81.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-I"
}
client 10.128.255.82 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-II"
}
client 10.129.82.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-II"
}
client 10.128.250.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-Bridge"
}
client 10.128.255.172 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-I_bis_test"
}
client 10.128.255.83 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-III"
}
client 10.129.83.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-III"
}
client 10.129.183.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-III"
}
client 10.129.84.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-IV"
}
client 10.129.184.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-IV-Bis"
}
client 10.129.194.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-IV-Bis-2"
}
client 10.128.255.181 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-I_bis"
}
client 10.129.181.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-I_bis"
}
client 10.129.162.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-I_bis_2"
}
client 10.128.255.86 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-VI"
}
client 10.129.86.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-VI"
}
client 10.128.255.87 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-VII"
}
client 10.129.87.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-VII"
}
client 10.129.187.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-VII-Derecho"
}
client 10.129.99.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-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-yocadorneotucadorneas-V"
}
client 10.129.85.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-V"
}
client 10.129.189.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-IX-HD"
}
client 10.129.88.1 {
require_message_authenticator = no
secret = "sarlangalad0-Red-398952"
shortname = "AP-yocadorneotucadorneas-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-yocadorneotucadorneas-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-vivalapepa-key.pem"
certificate_file = "/etc/pki/tls/certs/vivalapepa.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"
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 = yes
}
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: Linked to module rlm_linelog
Module: Instantiating module "linelog" from file
/etc/raddb-testing/modules/linelog
linelog {
filename = "/usr/local-test/var/log/radius/linelog"
permissions = 384
format = "%{Packet-Type} %{reply:Packet-Type} %{User-Name}
%{EAP-Type:-PAP} %{NAS-IP-Address} %{NAS-Identifier}"
}
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: 0x6cb0ac0
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
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"
}
}
listen {
type = "auth"
ipaddr = 127.0.0.1
port = 18121
}
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 authentication address 127.0.0.1 port 18121 as server inner-tunnel
Ready to process requests.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=58, length=167
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a1000b016d6c656e6f69
Message-Authenticator = 0x88fcf4ca35b563fb01a0f63ff55a27d4
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 161 length 11
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[unix] returns notfound
++[files] returns noop
++[expiration] returns noop
++[logintime] returns noop
[pap] WARNING! No "known good" password found for the user.
Authentication may fail because of this.
++[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 58 to 10.129.180.1 port 55764
EAP-Message = 0x01a200160410eba586f1a4e43e386b7cba670d11fc58
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb88b6daa97df52ad5b75d5386
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=59, length=180
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a200060319
State = 0x8814deeb88b6daa97df52ad5b75d5386
Message-Authenticator = 0x1e5fcf13dc906487e9bc6138d2def512
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 162 length 6
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[unix] returns notfound
++[files] returns noop
++[expiration] returns noop
++[logintime] returns noop
[pap] WARNING! No "known good" password found for the user.
Authentication may fail because of this.
++[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] Flushing SSL sessions (of #0)
[tls] Initiate
[tls] Start returned 1
++[eap] returns handled
Sending Access-Challenge of id 59 to 10.129.180.1 port 55764
EAP-Message = 0x01a300061920
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb89b7c7a97df52ad5b75d5386
Finished request 1.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=60, length=240
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a30042190016030100370100003303014ffc4751a6a0a85eeb3cb3cc0924f3d862ce97c74999acb91562f01c3c4ccef500000c0013000a0033002f000500040100
State = 0x8814deeb89b7c7a97df52ad5b75d5386
Message-Authenticator = 0x3fba2ff705f2bf305cb8c711deff0b96
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 163 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 60 to 10.129.180.1 port 55764
EAP-Message = 0x01a4040019c000001381160301004a0200004603014ffc4812c847086e3bf550b27dec5092792445e353e4d1a3e2db9eaa97196478205c12f92d381891c8b63481c5b06d636edd829eb656da4bb5fe754809f8f741f8000a0016030113240b00132000131d00071730820713308205fba0030201020214101b7f691cb7a76e4d2434f172207f0d6457bfd6300d06092a864886f70d01010505003081b0310b3009060355040613024553310f300d060355040813064d4144524944310f300d060355040713064d414452494431243022060355040a131b6970732043657274696669636174696f6e20417574686f7269747931183016060355040b130f
EAP-Message = 0x43657274696669636163696f6e657331193017060355040313106970734341204c6576656c20312043413124302206092a864886f70d010901161569707363616c6576656c314069707363612e636f6d301e170d3132303132373132303731335a170d3134303230313132303731335a30818d310b3009060355040613024152311530130603550407130c4275656e6f73204169726573311f301d060355040a1316556e6976657273696461642064652050616c65726d6f31273025060355040b131e446570617274616d656e746f20646520436f6d756e69636163696f6e6573311d301b06035504031314737065637472756d2e70616c65726d6f2e
EAP-Message = 0x65647530820122300d06092a864886f70d01010105000382010f003082010a0282010100a8efabc6c785b1314fc7a643f75a6b1e1ae645b4ad47d23a5ce062cd3fa5a998112d48b88960da17628181430eb1e6dbcd806eb3b77ad9ca5728e86d333f9a910107d90c0e2dad1951587fb6ebe0b1f99665fad04e352e1d87dbf1a1292ae3cc8bb936511b10cc25facb79db7df50a443359a5c46213253cfbee9db5a262221e23d6961c6f2e4bff6c7702fe05eeff8c97c3c4558f84d3d61a1571017d5638863ec4f341613113aca1b385ae7598065503f28f78c83c632ebb0183d6d8ffd21edd8cd4db50c1550443f12706847a053769c1c5c7f94eff9fff
EAP-Message = 0x8c3091d3892db2f35ab46dc208d1e03f37b82fb96d7fba474b42279ecb74157fdc521c038949dd0203010001a38203443082034030090603551d1304023000301106096086480186f8420101040403020640300b0603551d0f0404030205a030130603551d25040c300a06082b06010505070301301d0603551d0e04160414d57dbba6130341755d2138e3ed9faacb3e65cdcb301f0603551d230418301680147d9e6b0efc13e1c48ba77f61ae6021cfcda0d30630090603551d1104023000305b0603551d1204543052a450304e310b300906035504061302455331243022060355040a131b6970732043657274696669636174696f6e20417574686f
EAP-Message = 0x726974793119301706035504
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb8ab0c7a97df52ad5b75d5386
Finished request 2.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=61, length=180
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a400061900
State = 0x8814deeb8ab0c7a97df52ad5b75d5386
Message-Authenticator = 0x6151ed5595147071dcca331db578ce31
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 164 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 61 to 10.129.180.1 port 55764
EAP-Message = 0x01a503fc19400313106970734341204c6576656c2031204341307106096086480186f842010d046416624f7267616e697a6174696f6e20496e666f726d6174696f6e204e4f542056414c4944415445442e204c4556454c3120536572766572204365727469666963617465206973737565642062792068747470733a2f2f7777772e69707363612e636f6d2f302906096086480186f8420102041c161a687474703a2f2f6c6576656c3130312e69707363612e636f6d2f303c06096086480186f8420104042f162d687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f69707363616c6576656c312e63726c3043060960864801
EAP-Message = 0x86f842010304361634687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f7265766f636174696f6e4c4556454c312e68746d6c3f304006096086480186f842010704331631687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f72656e6577616c4c4556454c312e68746d6c3f303e06096086480186f84201080431162f687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f706f6c6963794c4556454c312e68746d6c30730603551d1f046c306a3033a031a02f862d687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f69707363616c6576656c312e63
EAP-Message = 0x726c3033a031a02f862d687474703a2f2f6c6576656c3130322e69707363612e636f6d2f63726c2f69707363616c6576656c312e63726c303e06082b0601050507010104323030302e06082b060105050730018622687474703a2f2f6f6373706c6576656c3130312e69707363612e636f6d2f6f637370300d06092a864886f70d010105050003820101004b61ec4cf7163dad3601e3de9938175ec4ec75d60f658eabf37b1e331283419e7438e584e8cfc47c087c7cba005dcd9d7d165a470bd7aaea70b69b1a18ad2a6cc136cf2ff5cb948ae2866b1c46bbf8ef999ecb510407f28a091e7aa75684d90938f85c3fcd39580112b6979f3284c581f86b
EAP-Message = 0x998bc211c1de82e87fd57ee7a975905e9dec75020feda29cf4f29dc59dc3946ccf328f7380c6f3f4064d3f6f496fffd640ed2c813c44d648f9ee0143f894d41f4970f30e158064b305a4ae264887a62b5ee51f4f7f3241ddeebcd1153f836262d7c24c4cd7a09f2ab6bc052cd2ecf78e948f240e526538478893fb776f27d44d620c8e58641b4231958c85d758080005f2308205ee308204d6a00302010202141000000000000000000000000000000000000011300d06092a864886f70d01010505003081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d06035504
EAP-Message = 0x0a13264950532043
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb8bb1c7a97df52ad5b75d5386
Finished request 3.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=62, length=180
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a500061900
State = 0x8814deeb8bb1c7a97df52ad5b75d5386
Message-Authenticator = 0x67cd523cc7b68fde1645669d61b7fd97
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 165 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 62 to 10.129.180.1 port 55764
EAP-Message = 0x01a603fc1940657274696669636174696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b13056970734341311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d301e170d3039313231303131333835325a170d3239313232343131333835325a3081b0310b3009060355040613024553310f300d060355040813064d4144524944310f300d060355040713064d414452494431243022060355040a131b6970732043657274696669636174696f6e20417574686f7269747931183016060355040b130f43
EAP-Message = 0x657274696669636163696f6e657331193017060355040313106970734341204c6576656c20312043413124302206092a864886f70d010901161569707363616c6576656c314069707363612e636f6d30820122300d06092a864886f70d01010105000382010f003082010a02820101009f4db33023c13a798527825d45ce5b64f82bafe15d6001e2940ed501863645858c0c8e76e1a0a40d935417986aeeb2840b23eabf217cc0ee49c026791954d6311890f7fb970be3a8c51640de2eb88c655b32d953f7c8ff06fb896654f8ea44420fb74fc7b0e94fd1d0bbfa968a33e346b7fa64bc65b11fb1e0e105f80cdd4af58b3097b4480a94feaf1d63f269
EAP-Message = 0x2c6b1b446afd3bd9dae70df0c68ab6e0190160a309a2b320401b14073a8c22df33f476c185b862b849b975c196ed1108af3c3f4e59e840dc995a134747e3b2840a7e8130b71c969f2e0d1cd0e5845e5bad3cce4a6b7d684522f54d5ae79f5c19004827a5787882d3e2ffb1e680dfeb2a125bb10203010001a38201fa308201f6302a06096086480186f8420102041d161b68747470733a2f2f6c6576656c3130312e69707363612e636f6d2f302106096086480186f84201030414161265737461646f2f65737461646f2e6173703f302706096086480186f8420104041a161865737461646f4341544553542f65737461646f2e6173703f3022060960
EAP-Message = 0x86480186f84201070415161365737461646f2f72656e756576612e6173703f302006096086480186f84201080413161165737461646f2f706f6c6963792e617370302406096086480186f842010d04171615436572746966696361646f20706f72206970734341301106096086480186f8420101040403020007300c0603551d13040530030101ff301d0603551d0e041604147d9e6b0efc13e1c48ba77f61ae6021cfcda0d306303e0603551d1f043730353033a031a02f862d687474703a2f2f6c6576656c3130312e69707363612e636f6d2f63726c2f69707363616c6576656c312e63726c303a06082b06010505070101042e302c302a06082b06
EAP-Message = 0x010505073001861e
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb8cb2c7a97df52ad5b75d5386
Finished request 4.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=63, length=180
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a600061900
State = 0x8814deeb8cb2c7a97df52ad5b75d5386
Message-Authenticator = 0xf9928a64da7f9a2233d6f45dd4ddd309
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 166 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 63 to 10.129.180.1 port 55764
EAP-Message = 0x01a703fc1940687474703a2f2f6f6373706c6576656c3130312e69707363612e636f6d2f300b0603551d0f04040302010630470603551d250440303e06082b0601050507030106082b0601050507030206082b0601050507030306082b0601050507030406082b06010505070308060a2b0601040182370a0304300d06092a864886f70d010105050003820101008737bf8f76d31d2eca683935839d2958fe74add252963aff06e84cb0308e3316c5972d29aebe28e77e10ab20e1ed509ecfbbd394fe1da47370d27e6239b31cd636e1d4782bace12bedc753a14dd4281f588e56e2c924f956ec0ad0df5268575ea4393bb9e46619c4cff0a7fbb7717f
EAP-Message = 0xd7f247a501f8245587996ac61064ada017958080eb6d4bd3e9171685a951ae6e69419776e8de7f43fb891b853397030059549676d110ed837018f76ca7231a20647365211bee7e1e67f8026ad21c2e37a31e7001bb866076bc7adc7eff3475f2e33e94c60ed70ce792cc33c31c32df09e853cf3587c59453f98efa685cce193a482a52f3da46c2e6bd5d02b5471eb9954000060b30820607308204efa003020102020100300d06092a864886f70d01010505003081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d060355040a132649505320436572746966696361
EAP-Message = 0x74696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b13056970734341311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d301e170d3039303930373134333834345a170d3239313232353134333834345a3081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d060355040a13264950532043657274696669636174696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b130569707343
EAP-Message = 0x41311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d30820122300d06092a864886f70d01010105000382010f003082010a0282010100a7efcc8030b091244fb068f8c3ca2d1538555882e23863b0f7a3926f83b8b05eb08cac54b177d050e097b390ad8ab31f392b4556f7aae2df7cb2ec6f532f9acbd0e666cbc913e872e2b4cd31578712b593e8fa72ceea47f28cb4b063d70400b764363997e895f188f9710d03278c61cf0883964f83c54ee85cf80670f102aa1c1ea9c8aa7ee75dcd8d3c146f67d01ba923488b21283a8a4ce6
EAP-Message = 0x1131f9212eb26766
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb8db3c7a97df52ad5b75d5386
Finished request 5.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=64, length=180
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a700061900
State = 0x8814deeb8db3c7a97df52ad5b75d5386
Message-Authenticator = 0xed341e6a8b2de2aae596dcc6c65dc1c9
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 167 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 64 to 10.129.180.1 port 55764
EAP-Message = 0x01a803af1900c6296e9493cf4096fcb03dbfb2b493bf5671b6a54187b058b559232849b898f9501e2d15280b4cac49d184a99b9ae77254b738d0dbc9fea973d56d10cd8e75ebfe97fd803cfcb4d848f499460b8814a4b62edb4c60f421c16c809514d5afd50203010001a382022430820220301d0603551d0e0416041415a69680b1154b31c3c29cf6e7130b4bf318cd863081df0603551d230481d73081d4801415a69680b1154b31c3c29cf6e7130b4bf318cd86a181b8a481b53081b2310b3009060355040613024553310f300d060355040813064d6164726964310f300d060355040713064d6164726964312f302d060355040a13264950532043
EAP-Message = 0x657274696669636174696f6e20417574686f7269747920732e6c2e206970734341310e300c060355040b13056970734341311d301b06035504031314697073434120476c6f62616c20434120526f6f743121301f06092a864886f70d0109011612676c6f62616c30314069707363612e636f6d820100300c0603551d13040530030101ff300b0603551d0f04040302010630470603551d250440303e06082b0601050507030106082b0601050507030206082b0601050507030306082b0601050507030406082b06010505070308060a2b0601040182370a0304301d0603551d11041630148112676c6f62616c30314069707363612e636f6d301d0603
EAP-Message = 0x551d12041630148112676c6f62616c30314069707363612e636f6d30410603551d1f043a30383036a034a0328630687474703a2f2f63726c676c6f62616c30312e69707363612e636f6d2f63726c2f63726c676c6f62616c30312e63726c303806082b06010505070101042c302a302806082b06010505073001861c687474703a2f2f63726c676c6f62616c30312e69707363612e636f6d300d06092a864886f70d0101050500038201010018f4aefe800f8ec1776fa25a47489f2355a1536bf95da730a524be432ff8c1d157f93e2c8025cc46a936f3495b1df67cd763b34d3e78f6a7b40277f8790d3e6acb1860b8fd00af0cdd54e3548f223df310
EAP-Message = 0x6f110db51e7a8d27cc08b85bc3b81a5f2ba7603f001cf70f5c4266649e8712807089e0fa57280e4e1f102fd90580b6802f1c69f0f6b66534056fcad93ef8d45d3732c7b82bccff73930071e001c8aa43bda9f1cefa80f9f1431291a665e560074d47ba2b2f04f64a8529886510c9b253629c6c9b605c1a1bd3aec51d729906ff05cc862673b4d45405dd1e6b003bb789e8e391022012ebefe9fe0a29238123a300da70cc925f3723d01c7b355c037a16030100040e000000
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb8ebcc7a97df52ad5b75d5386
Finished request 6.
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=65, length=500
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a8014419001603010106100001020100422704cd2992a92b33a0a1516a61525d92c4dfb23f82f13d7b5f56317b8668a17155e3e2db2f75abdc226796641cb7b202dbb1848b69d8dfbc9516be04e509aea5daa181ff82a299d1461247d5eaeac52c51c4e0fd970eda3675f726e29e528089f432cf1969857b47a5589ae03dedc4b2504710c7bff51ec058c224cb9d9c03e67635e9491f822d5f2b7b4cc325df76f6d7b4f95ae47a83d736e4013e02e4636b883d00cd9efd5faab5074cd2d5d2ef6200d92c35ef95a04c8943228e3d54f9c864bd52472a461a4f4a001a34004855f560759d43b008102d6ca5316311ac5d169ad14ff2ae6de1df49f05c
EAP-Message = 0x8381e6e6b4115f6cea0ee09eb3e6d38b1358d7781403010001011603010028d07f0c5c09b511758626eb89bb222bd25ea4a04957e579211de5c394aa80202f9f928fe9b2cfef6f
State = 0x8814deeb8ebcc7a97df52ad5b75d5386
Message-Authenticator = 0x5e5b913676276daf39e1c9ff83c259aa
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 168 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
5c12f92d381891c8b63481c5b06d636edd829eb656da4bb5fe754809f8f741f8 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 65 to 10.129.180.1 port 55764
EAP-Message = 0x01a9003919001403010001011603010028d821d133aa4769658355f7b458637264e48e690e4e79bdb4b0d2d18ef509335e35e751de3bf1d351
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb8fbdc7a97df52ad5b75d5386
Finished request 7.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=66, length=180
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02a900061900
State = 0x8814deeb8fbdc7a97df52ad5b75d5386
Message-Authenticator = 0xca4cc7ef534339b7d9aeaf0a2a352aa5
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 169 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 66 to 10.129.180.1 port 55764
EAP-Message = 0x01aa002b1900170301002086365ff559740ef850f6911a41fa412f9b1630f7051310898c0fc537065e9e2e
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb80bec7a97df52ad5b75d5386
Finished request 8.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=67, length=246
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02aa0048190017030100185c83e2174ed058a36cc14e00cc4fae5a9179da770e44ac83170301002078727b4506bc63126fa2517afc18e439fd9f2f4ffdd00d99700217f127b402dd
State = 0x8814deeb80bec7a97df52ad5b75d5386
Message-Authenticator = 0xecc9f19ff811e3e27e70eae209dbb6e9
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 170 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 - yyyyy
[peap] Got inner identity 'yyyyy'
[peap] Setting default EAP type for tunneled EAP session.
[peap] Got tunneled request
EAP-Message = 0x02aa000b016d6c656e6f69
server {
[peap] Setting User-Name to yyyyy
Sending tunneled request
EAP-Message = 0x02aa000b016d6c656e6f69
FreeRADIUS-Proxied-To = 127.0.0.1
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
NAS-IP-Address = 10.129.180.1
server inner-tunnel {
# Executing section authorize from file
/etc/raddb-testing/sites-enabled/inner-tunnel
+- entering group authorize {...}
[auth_log] expand: %{Virtual-Server} -> inner-tunnel
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-inner-tunnel-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-inner-tunnel-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 170 length 11
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for yyyyy
[ldap] expand: (uid=%u) -> (uid=yyyyy)
[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] attempting LDAP reconnection
[ldap] (re)connect to ldap.sarlanga.edu:636, authentication 0
[ldap] setting TLS mode to 1
[ldap] setting TLS CACert File to /etc/raddb-testing/cacert.pem
[ldap] setting TLS Require Cert to demand
[ldap] setting TLS Key File to /dev/urandom
[ldap] bind as
cn=freeradius,ou=applications,dc=sarlanga,dc=edu/sarlanga to
ldap.sarlanga.edu:636
[ldap] waiting for bind result ...
[ldap] Bind was successful
[ldap] performing search in ou=people,dc=sarlanga,dc=edu, with
filter (uid=yyyyy)
[ldap] checking if remote access for yyyyy is allowed by radiusAllowed
[ldap] looking for check items in directory...
[ldap] userPassword -> Password-With-Header == "{crypt}5.glupOqHA"
[ldap] radiusPassword -> Cleartext-Password == "pulgas"
[ldap] looking for reply items in directory...
[ldap] user yyyyy authorized to use remote access
[ldap] ldap_release_conn: Release Id: 0
++[ldap] 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/inner-tunnel
+- entering group authenticate {...}
[eap] EAP Identity
[eap] processing type mschapv2
rlm_eap_mschapv2: Issuing Challenge
++[eap] returns handled
} # server inner-tunnel
[peap] Got tunneled reply code 11
EAP-Message = 0x01ab00201a01ab001b109bf4c3c47d874e0e30116053130d22176d6c656e6f69
Message-Authenticator = 0x00000000000000000000000000000000
State = 0xbb51c5a6bbfadfaf825abcaa22d694a6
[peap] Got tunneled reply RADIUS code 11
EAP-Message = 0x01ab00201a01ab001b109bf4c3c47d874e0e30116053130d22176d6c656e6f69
Message-Authenticator = 0x00000000000000000000000000000000
State = 0xbb51c5a6bbfadfaf825abcaa22d694a6
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 67 to 10.129.180.1 port 55764
EAP-Message = 0x01ab0043190017030100384becf00fe9503ff392eb0ef0d3775f51ebbbdc99abb097e7e43649e4cf5a6b045b10dd51fae88ce51dd17e63c292e1d3b6bc4d2b5e524350
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb81bfc7a97df52ad5b75d5386
Finished request 9.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=68, length=302
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02ab008019001703010018e5c8db5aac6c066c485ed9d84349c06661d80cb88cac9bd71703010058f95b5203bf5406a11f8204e5c9ff3c031497b8c48e2c4ed596a8f9cfa51ff75e2b9bf76ac3c68495721e19293d195ed2d472041ba9539e60d5c703a1829363d37341dddc900803343450801dbcd56b5ebae15794da693e6d
State = 0x8814deeb81bfc7a97df52ad5b75d5386
Message-Authenticator = 0x692eac82692b4c4c30c5e03ca653c1de
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 171 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 = 0x02ab00411a02ab003c313eb695228fced3448bf448185a1b560b0000000000000000f252c6370bc3705bdfe5555ae9338a10b5ba72288de07e4a006d6c656e6f69
server {
[peap] Setting User-Name to yyyyy
Sending tunneled request
EAP-Message = 0x02ab00411a02ab003c313eb695228fced3448bf448185a1b560b0000000000000000f252c6370bc3705bdfe5555ae9338a10b5ba72288de07e4a006d6c656e6f69
FreeRADIUS-Proxied-To = 127.0.0.1
User-Name = "yyyyy"
State = 0xbb51c5a6bbfadfaf825abcaa22d694a6
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
NAS-IP-Address = 10.129.180.1
server inner-tunnel {
# Executing section authorize from file
/etc/raddb-testing/sites-enabled/inner-tunnel
+- entering group authorize {...}
[auth_log] expand: %{Virtual-Server} -> inner-tunnel
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-inner-tunnel-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-inner-tunnel-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 171 length 65
[eap] No EAP Start, assuming it's an on-going EAP conversation
++[eap] returns updated
++[files] returns noop
[ldap] performing user authorization for yyyyy
[ldap] expand: (uid=%u) -> (uid=yyyyy)
[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=yyyyy)
[ldap] checking if remote access for yyyyy is allowed by radiusAllowed
[ldap] looking for check items in directory...
[ldap] userPassword -> Password-With-Header == "{crypt}5.glupOqHA"
[ldap] radiusPassword -> Cleartext-Password == "pulgas"
[ldap] looking for reply items in directory...
[ldap] user yyyyy authorized to use remote access
[ldap] ldap_release_conn: Release Id: 0
++[ldap] 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/inner-tunnel
+- 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
[mschapv2] +- entering group MS-CHAP {...}
[mschap] Creating challenge hash with username: yyyyy
[mschap] Told to do MS-CHAPv2 for yyyyy with NT-Password
[mschap] adding MS-CHAPv2 MPPE keys
++[mschap] returns ok
MSCHAP Success
++[eap] returns handled
} # server inner-tunnel
[peap] Got tunneled reply code 11
EAP-Message = 0x01ac00331a03ab002e533d39413841374339354142433645443831334534384146373535453037463639433846314244443044
Message-Authenticator = 0x00000000000000000000000000000000
State = 0xbb51c5a6bafddfaf825abcaa22d694a6
[peap] Got tunneled reply RADIUS code 11
EAP-Message = 0x01ac00331a03ab002e533d39413841374339354142433645443831334534384146373535453037463639433846314244443044
Message-Authenticator = 0x00000000000000000000000000000000
State = 0xbb51c5a6bafddfaf825abcaa22d694a6
[peap] Got tunneled Access-Challenge
++[eap] returns handled
Sending Access-Challenge of id 68 to 10.129.180.1 port 55764
EAP-Message = 0x01ac005319001703010048582dc8183c53ae3d2134db71275f243f43601712a6c44627b4d1381f1c2141a19c9aaba8810d9d9de13075eec7e6a1cff66065961e308bf24cf9a473d8f5d0dc43be68270b31990c
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb82b8c7a97df52ad5b75d5386
Finished request 10.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=69, length=238
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02ac004019001703010018b43d2d7c7f82555756d2fd3b16e87a5af6b0ac44b0b5d2a61703010018fd3842857f995c59fa42e79d67210d7146eec97a1d953fd1
State = 0x8814deeb82b8c7a97df52ad5b75d5386
Message-Authenticator = 0xbdc84070e732333a170a84aceec7dd0a
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 172 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 = 0x02ac00061a03
server {
[peap] Setting User-Name to yyyyy
Sending tunneled request
EAP-Message = 0x02ac00061a03
FreeRADIUS-Proxied-To = 127.0.0.1
User-Name = "yyyyy"
State = 0xbb51c5a6bafddfaf825abcaa22d694a6
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
NAS-IP-Address = 10.129.180.1
server inner-tunnel {
# Executing section authorize from file
/etc/raddb-testing/sites-enabled/inner-tunnel
+- entering group authorize {...}
[auth_log] expand: %{Virtual-Server} -> inner-tunnel
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-inner-tunnel-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-inner-tunnel-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[control] returns noop
[eap] EAP packet type response id 172 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 yyyyy
[ldap] expand: (uid=%u) -> (uid=yyyyy)
[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=yyyyy)
[ldap] checking if remote access for yyyyy is allowed by radiusAllowed
[ldap] looking for check items in directory...
[ldap] userPassword -> Password-With-Header == "{crypt}5.glupOqHA"
[ldap] radiusPassword -> Cleartext-Password == "pulgas"
[ldap] looking for reply items in directory...
[ldap] user yyyyy authorized to use remote access
[ldap] ldap_release_conn: Release Id: 0
++[ldap] 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/inner-tunnel
+- entering group authenticate {...}
[eap] Request found, released from the list
[eap] EAP/mschapv2
[eap] processing type mschapv2
[eap] Freeing handler
++[eap] returns ok
Login OK: [yyyyy] (from client AP-yocadorneotucadorneas-PB-SUM port 5
cli A8-FF-FF-AA-E7-48 via TLS tunnel)
# Executing section post-auth from file
/etc/raddb-testing/sites-enabled/inner-tunnel
+- entering group post-auth {...}
[linelog] expand: /usr/local-test/var/log/radius/linelog ->
/usr/local-test/var/log/radius/linelog
[linelog] WARNING: Deprecated conditional expansion ":-". See "man
unlang" for details
[linelog] expand: %{Packet-Type} %{reply:Packet-Type} %{User-Name}
%{EAP-Type:-PAP} %{NAS-IP-Address} %{NAS-Identifier} -> Access-Request
Access-Accept yyyyy MS-CHAP-V2 10.129.180.1
AP-yocadorneotucadorneas-PB-SUM
++[linelog] returns ok
[reply_log] expand: %{Virtual-Server} -> inner-tunnel
[reply_log] expand:
/usr/local-test/var/log/radius/radacct/replies/%{Client-IP-Address}/reply-detail-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/replies/10.129.180.1/reply-detail-inner-tunnel-20120710
[reply_log] /usr/local-test/var/log/radius/radacct/replies/%{Client-IP-Address}/reply-detail-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/replies/10.129.180.1/reply-detail-inner-tunnel-20120710
[reply_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[reply_log] returns ok
} # server inner-tunnel
[peap] Got tunneled reply code 2
MS-MPPE-Encryption-Policy = 0x00000001
MS-MPPE-Encryption-Types = 0x00000006
MS-MPPE-Send-Key = 0x016b3d4d79555d8ffdd2999bdc4ed987
MS-MPPE-Recv-Key = 0xb01b2bb020cf345a4141d5d2d6c82ca9
EAP-Message = 0x03ac0004
Message-Authenticator = 0x00000000000000000000000000000000
User-Name = "yyyyy"
[peap] Got tunneled reply RADIUS code 2
MS-MPPE-Encryption-Policy = 0x00000001
MS-MPPE-Encryption-Types = 0x00000006
MS-MPPE-Send-Key = 0x016b3d4d79555d8ffdd2999bdc4ed987
MS-MPPE-Recv-Key = 0xb01b2bb020cf345a4141d5d2d6c82ca9
EAP-Message = 0x03ac0004
Message-Authenticator = 0x00000000000000000000000000000000
User-Name = "yyyyy"
[peap] Tunneled authentication was successful.
[peap] SUCCESS
[peap] Saving tunneled attributes for later
++[eap] returns handled
Sending Access-Challenge of id 69 to 10.129.180.1 port 55764
EAP-Message = 0x01ad002b19001703010020be08b0114c9fff08b9bec860f8bea503abcbdafac449467b0b92a56001336215
Message-Authenticator = 0x00000000000000000000000000000000
State = 0x8814deeb83b9c7a97df52ad5b75d5386
Finished request 11.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Access-Request packet from host 10.129.180.1 port 55764,
id=70, length=246
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
Framed-MTU = 1400
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
EAP-Message = 0x02ad004819001703010018256b110d9946f17c6d89933febaccaf415e820c89ea931981703010020af0105fc0964b833222e642a69e790f244caea25a0a4219d56da823f8c03ed88
State = 0x8814deeb83b9c7a97df52ad5b75d5386
Message-Authenticator = 0x187841b23947f774d7a9ce533effc1db
# 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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
++[chap] returns noop
++[mschap] returns noop
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
[eap] EAP packet type response id 173 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 success
[peap] Received EAP-TLV response.
[peap] Success
[peap] Using saved attributes from the original Access-Accept
User-Name = "yyyyy"
[peap] Saving response in the cache
[eap] Freeing handler
++[eap] returns ok
Login OK: [yyyyy] (from client AP-yocadorneotucadorneas-PB-SUM port 5
cli A8-FF-FF-AA-E7-48)
# Executing section post-auth from file /etc/raddb-testing/sites-enabled/default
+- entering group post-auth {...}
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[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.180.1/auth-detail-AP-yocadorneotucadorneas-PB-SUM-DEFAULT-20120710
[auth_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[auth_log] returns ok
[linelog] expand: /usr/local-test/var/log/radius/linelog ->
/usr/local-test/var/log/radius/linelog
[linelog] WARNING: Deprecated conditional expansion ":-". See "man
unlang" for details
[linelog] expand: %{Packet-Type} %{reply:Packet-Type} %{User-Name}
%{EAP-Type:-PAP} %{NAS-IP-Address} %{NAS-Identifier} -> Access-Request
Access-Accept yyyyy PEAP 10.129.180.1 AP-yocadorneotucadorneas-PB-SUM
++[linelog] returns ok
[reply_log] expand: %{Virtual-Server} ->
[reply_log] ... expanding second conditional
[reply_log] expand:
/usr/local-test/var/log/radius/radacct/replies/%{Client-IP-Address}/reply-detail-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/replies/10.129.180.1/reply-detail-DEFAULT-20120710
[reply_log] /usr/local-test/var/log/radius/radacct/replies/%{Client-IP-Address}/reply-detail-%{%{Virtual-Server}:-DEFAULT}-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/replies/10.129.180.1/reply-detail-DEFAULT-20120710
[reply_log] expand: %t -> Tue Jul 10 12:19:46 2012
++[reply_log] returns ok
++[exec] returns noop
Sending Access-Accept of id 70 to 10.129.180.1 port 55764
User-Name = "yyyyy"
MS-MPPE-Recv-Key =
0xe51a247fdc7439415a900365b5d85218ff058272cf645fdbef6c6e90b5bb1dea
MS-MPPE-Send-Key =
0x9fc773164859d4fe14b4890fb97748a4253016cde71c265c05fd7436040a4569
EAP-Message = 0x03ad0004
Message-Authenticator = 0x00000000000000000000000000000000
Finished request 12.
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Accounting-Request packet from host 10.129.180.1 port 48923,
id=71, length=161
Acct-Session-Id = "4FFC46F9-00000004"
Acct-Status-Type = Start
Acct-Authentic = RADIUS
User-Name = "yyyyy"
NAS-Identifier = "AP-yocadorneotucadorneas-PB-SUM"
NAS-Port = 5
Called-Station-Id = "00-XX-XX-XX-25-D0:sarlanga-I"
Calling-Station-Id = "A8-FF-FF-AA-E7-48"
NAS-Port-Type = Wireless-802.11
Connect-Info = "CONNECT 54Mbps 802.11g"
# Executing section preacct from file /etc/raddb-testing/sites-enabled/default
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 5,Client-IP-Address =
10.129.180.1,NAS-IP-Address = 10.129.180.1,Acct-Session-Id =
"4FFC46F9-00000004",User-Name = "yyyyy"'
[acct_unique] Acct-Unique-Session-ID = "dddf83abe2685566".
++[acct_unique] returns ok
[suffix] No '@' in User-Name = "yyyyy", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] returns noop
++[files] returns noop
# Executing section accounting from file
/etc/raddb-testing/sites-enabled/default
+- entering group accounting {...}
[detail] expand:
/usr/local-test/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
-> /usr/local-test/var/log/radius/radacct/10.129.180.1/detail-20120710
[detail] /usr/local-test/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d
expands to /usr/local-test/var/log/radius/radacct/10.129.180.1/detail-20120710
[detail] expand: %t -> Tue Jul 10 12:19:46 2012
++[detail] returns ok
++[unix] returns ok
[radutmp] expand: /usr/local-test/var/log/radius/radutmp ->
/usr/local-test/var/log/radius/radutmp
[radutmp] expand: %{User-Name} -> yyyyy
++[radutmp] returns ok
++[exec] returns noop
[attr_filter.accounting_response] expand: %{User-Name} -> yyyyy
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 71 to 10.129.180.1 port 48923
Finished request 13.
Cleaning up request 13 ID 71 with timestamp +2
Going to the next request
Waking up in 4.6 seconds.
Thanks in advance
--
--
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