FreeRADIUS Version 2.1.12, for host x86_64-pc-linux-gnu, built on Feb 24 2014 at 14:57:57 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/freeradius/radiusd.conf including configuration file /etc/freeradius/proxy.conf including configuration file /etc/freeradius/clients.conf including files in directory /etc/freeradius/modules/ including configuration file /etc/freeradius/modules/smsotp including configuration file /etc/freeradius/modules/replicate including configuration file /etc/freeradius/modules/radutmp including configuration file /etc/freeradius/modules/attr_filter including configuration file /etc/freeradius/modules/echo including configuration file /etc/freeradius/modules/mschap including configuration file /etc/freeradius/modules/soh including configuration file /etc/freeradius/modules/detail including configuration file /etc/freeradius/modules/checkval including configuration file /etc/freeradius/modules/ldap including configuration file /etc/freeradius/modules/cui including configuration file /etc/freeradius/modules/always including configuration file /etc/freeradius/modules/etc_group including configuration file /etc/freeradius/modules/expiration including configuration file /etc/freeradius/modules/realm including configuration file /etc/freeradius/modules/perl including configuration file /etc/freeradius/modules/expr including configuration file /etc/freeradius/modules/sql_log including configuration file /etc/freeradius/modules/sradutmp including configuration file /etc/freeradius/modules/ippool including configuration file /etc/freeradius/modules/inner-eap including configuration file /etc/freeradius/modules/krb5 including configuration file /etc/freeradius/modules/smbpasswd including configuration file /etc/freeradius/modules/pap including configuration file /etc/freeradius/modules/counter including configuration file /etc/freeradius/modules/wimax including configuration file /etc/freeradius/modules/detail.example.com including configuration file /etc/freeradius/modules/files including configuration file /etc/freeradius/modules/redis including configuration file /etc/freeradius/modules/acct_unique including configuration file /etc/freeradius/modules/digest including configuration file /etc/freeradius/modules/passwd including configuration file /etc/freeradius/modules/exec including configuration file /etc/freeradius/modules/linelog including configuration file /etc/freeradius/modules/logintime including configuration file /etc/freeradius/modules/detail.log including configuration file /etc/freeradius/modules/rediswho including configuration file /etc/freeradius/modules/dynamic_clients including configuration file /etc/freeradius/modules/mac2vlan including configuration file /etc/freeradius/modules/mac2ip including configuration file /etc/freeradius/modules/ntlm_auth including configuration file /etc/freeradius/modules/chap including configuration file /etc/freeradius/modules/policy including configuration file /etc/freeradius/modules/otp including configuration file /etc/freeradius/modules/attr_rewrite including configuration file /etc/freeradius/modules/opendirectory including configuration file /etc/freeradius/modules/sqlcounter_expire_on_login including configuration file /etc/freeradius/modules/preprocess including configuration file /etc/freeradius/modules/pam including configuration file /etc/freeradius/modules/unix including configuration file /etc/freeradius/eap.conf including configuration file /etc/freeradius/policy.conf including files in directory /etc/freeradius/sites-enabled/ including configuration file /etc/freeradius/sites-enabled/default including configuration file /etc/freeradius/sites-enabled/inner-tunnel main { user = "freerad" group = "freerad" allow_core_dumps = no } including dictionary file /etc/freeradius/dictionary main { name = "freeradius" prefix = "/usr" localstatedir = "/var" sbindir = "/usr/sbin" logdir = "/var/log/freeradius" run_dir = "/var/run/freeradius" libdir = "/usr/lib/freeradius" radacctdir = "/var/log/freeradius/radacct" hostname_lookups = no max_request_time = 30 cleanup_delay = 5 max_requests = 1024 pidfile = "/var/run/freeradius/freeradius.pid" checkrad = "/usr/sbin/checkrad" debug_level = 0 proxy_requests = yes log { stripped_names = no auth = no 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 = "WLAN4zyxel" nastype = "other" } client 10.160.199.11 { require_message_authenticator = no secret = "WLAN4zyxel" } client 10.160.4.5 { require_message_authenticator = no secret = "testing123" } radiusd: #### Instantiating modules #### instantiate { Module: Linked to module rlm_exec Module: Instantiating module "exec" from file /etc/freeradius/modules/exec exec { wait = no input_pairs = "request" shell_escape = yes } Module: Linked to module rlm_expr Module: Instantiating module "expr" from file /etc/freeradius/modules/expr Module: Linked to module rlm_expiration Module: Instantiating module "expiration" from file /etc/freeradius/modules/expiration expiration { reply-message = "Password Has Expired " } Module: Linked to module rlm_logintime Module: Instantiating module "logintime" from file /etc/freeradius/modules/logintime logintime { reply-message = "You are calling outside your allowed timespan " minimum-timeout = 60 } } radiusd: #### Loading Virtual Servers #### server { # from file /etc/freeradius/radiusd.conf modules { Module: Creating Auth-Type = Perl Module: Creating Auth-Type = digest Module: Creating Post-Auth-Type = Perl Module: Creating Post-Auth-Type = REJECT Module: Checking authenticate {...} for more modules to load Module: Linked to module rlm_perl Module: Instantiating module "perl" from file /etc/freeradius/modules/perl perl { module = "/etc/freeradius/tiri_rlm_perl.pl" func_authorize = "authorize" func_authenticate = "authenticate" func_accounting = "accounting" func_preacct = "preacct" func_checksimul = "checksimul" func_detach = "detach" func_xlat = "xlat" func_pre_proxy = "pre_proxy" func_post_proxy = "post_proxy" func_post_auth = "post_auth" func_recv_coa = "recv_coa" func_send_coa = "send_coa" } Module: Linked to module rlm_pap Module: Instantiating module "pap" from file /etc/freeradius/modules/pap pap { encryption_scheme = "auto" auto_header = yes } Module: Linked to module rlm_chap Module: Instantiating module "chap" from file /etc/freeradius/modules/chap Module: Linked to module rlm_mschap Module: Instantiating module "mschap" from file /etc/freeradius/modules/mschap mschap { use_mppe = yes require_encryption = no require_strong = no with_ntdomain_hack = no ntlm_auth = "/usr/bin/ntlm_auth --request-nt-key --username=%{%{Stripped-User-Name}:-%{User-Name:-None}} --domain=%{%{mschap:NT-Domain}:-SWBT} --challenge=%{mschap:Challenge:-00} --nt-response=%{mschap:NT-Response:-00}" allow_retry = yes } Module: Linked to module rlm_digest Module: Instantiating module "digest" from file /etc/freeradius/modules/digest Module: Linked to module rlm_unix Module: Instantiating module "unix" from file /etc/freeradius/modules/unix unix { radwtmp = "/var/log/freeradius/radwtmp" } Module: Linked to module rlm_eap Module: Instantiating module "eap" from file /etc/freeradius/eap.conf eap { default_eap_type = "peap" timer_expire = 60 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 CA_path = "/etc/freeradius/certs" pem_file_type = yes private_key_file = "/etc/freeradius/certs/server.key" certificate_file = "/etc/freeradius/certs/server.pem" CA_file = "/etc/freeradius/certs/ca.pem" private_key_password = "WLAN4hotspot" dh_file = "/etc/freeradius/certs/dh" random_file = "/dev/urandom" fragment_size = 1024 include_length = yes check_crl = no cipher_list = "DEFAULT" make_cert_command = "/etc/freeradius/certs/bootstrap" ecdh_curve = "prime256v1" cache { enable = no lifetime = 24 max_entries = 255 } verify { tmpdir = "/tmp/freeradius" client = "/usr/bin/openssl verify -CAfile /etc/freeradius/certs/ca.pem -CApath /etc/freeradius/certs %{TLS-Client-Cert-Filename}" } 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 = no 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 = no 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 = no } Module: Checking authorize {...} for more modules to load Module: Linked to module rlm_preprocess Module: Instantiating module "preprocess" from file /etc/freeradius/modules/preprocess preprocess { huntgroups = "/etc/freeradius/huntgroups" hints = "/etc/freeradius/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/freeradius/modules/detail.log detail auth_log { detailfile = "/var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%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/freeradius/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/freeradius/modules/files files { usersfile = "/etc/freeradius/users" acctusersfile = "/etc/freeradius/acct_users" preproxy_usersfile = "/etc/freeradius/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/freeradius/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/freeradius/modules/detail detail { detailfile = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-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/freeradius/modules/radutmp radutmp { filename = "/var/log/freeradius/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/freeradius/modules/attr_filter attr_filter attr_filter.accounting_response { attrsfile = "/etc/freeradius/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 "attr_filter.access_reject" from file /etc/freeradius/modules/attr_filter attr_filter attr_filter.access_reject { attrsfile = "/etc/freeradius/attrs.access_reject" key = "%{User-Name}" relaxed = no } } # modules } # server server inner-tunnel { # from file /etc/freeradius/sites-enabled/inner-tunnel modules { Module: Creating Post-Proxy-Type = Fail 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 = * port = 0 } listen { type = "acct" ipaddr = * port = 0 } listen { type = "auth" ipaddr = 127.0.0.1 port = 18120 } ... adding new socket proxy address * port 39991 Listening on authentication address * port 1812 Listening on accounting address * port 1813 Listening on authentication address 127.0.0.1 port 18120 as server inner-tunnel Listening on proxy address * port 1814 Ready to process requests. rad_recv: Access-Request packet from host 10.160.4.5 port 11306, id=0, length=126 User-Name = "wlan_test" NAS-IP-Address = 127.0.0.1 Calling-Station-Id = "70-6F-6C-69-73-68" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 11Mbps 802.11b" EAP-Message = 0x0200000e01776c616e5f74657374 Message-Authenticator = 0x2392e704cb9c9b24df26f836ca3f63d2 # Executing section authorize from file /etc/freeradius/sites-enabled/default +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] expand: %t -> Sun Jul 26 19:12:28 2015 ++[auth_log] returns ok ++[chap] returns noop ++[mschap] returns noop ++[digest] returns noop [suffix] No '@' in User-Name = "wlan_test", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 0 length 14 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated ++[files] returns noop rlm_perl: RAD_REQUEST: EAP-Message = 0x0200000e01776c616e5f74657374 rlm_perl: RAD_REQUEST: NAS-IP-Address = 127.0.0.1 rlm_perl: RAD_REQUEST: Message-Authenticator = 0x2392e704cb9c9b24df26f836ca3f63d2 rlm_perl: RAD_REQUEST: Framed-MTU = 1400 rlm_perl: RAD_REQUEST: Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: RAD_REQUEST: EAP-Type = Identity rlm_perl: RAD_REQUEST: User-Name = wlan_test rlm_perl: RAD_REQUEST: Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: RAD_REQUEST: NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair EAP-Message = 0x0200000e01776c616e5f74657374 rlm_perl: Added pair NAS-IP-Address = 127.0.0.1 rlm_perl: Added pair Message-Authenticator = 0x2392e704cb9c9b24df26f836ca3f63d2 rlm_perl: Added pair Framed-MTU = 1400 rlm_perl: Added pair Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: Added pair EAP-Type = Identity rlm_perl: Added pair User-Name = wlan_test rlm_perl: Added pair Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: Added pair NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair Reply-Message = rlm_perl authorize function rlm_perl: Added pair Auth-Type = EAP ++[perl] returns ok ++? if (!EAP-Message) ? Evaluating !(EAP-Message) -> FALSE ++? if (!EAP-Message) -> FALSE ++[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/freeradius/sites-enabled/default +- entering group authenticate {...} [eap] EAP Identity [eap] processing type tls [tls] Initiate [tls] Start returned 1 ++[eap] returns handled Sending Access-Challenge of id 0 to 10.160.4.5 port 11306 Reply-Message = "rlm_perl authorize function" EAP-Message = 0x010100061920 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x2bfd86792bfc9f32b981faab4170b1d3 Finished request 0. Going to the next request Waking up in 4.9 seconds. rad_recv: Access-Request packet from host 10.160.4.5 port 11306, id=1, length=136 User-Name = "wlan_test" NAS-IP-Address = 127.0.0.1 Calling-Station-Id = "70-6F-6C-69-73-68" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 11Mbps 802.11b" EAP-Message = 0x02010006030d State = 0x2bfd86792bfc9f32b981faab4170b1d3 Message-Authenticator = 0xbb77aca8bd322b71880d664e0f75d49f # Executing section authorize from file /etc/freeradius/sites-enabled/default +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] expand: %t -> Sun Jul 26 19:12:28 2015 ++[auth_log] returns ok ++[chap] returns noop ++[mschap] returns noop ++[digest] returns noop [suffix] No '@' in User-Name = "wlan_test", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 1 length 6 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated ++[files] returns noop rlm_perl: RAD_REQUEST: EAP-Message = 0x02010006030d rlm_perl: RAD_REQUEST: NAS-IP-Address = 127.0.0.1 rlm_perl: RAD_REQUEST: Message-Authenticator = 0xbb77aca8bd322b71880d664e0f75d49f rlm_perl: RAD_REQUEST: Framed-MTU = 1400 rlm_perl: RAD_REQUEST: Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: RAD_REQUEST: EAP-Type = NAK rlm_perl: RAD_REQUEST: User-Name = wlan_test rlm_perl: RAD_REQUEST: State = 0x2bfd86792bfc9f32b981faab4170b1d3 rlm_perl: RAD_REQUEST: Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: RAD_REQUEST: NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair EAP-Message = 0x02010006030d rlm_perl: Added pair NAS-IP-Address = 127.0.0.1 rlm_perl: Added pair Message-Authenticator = 0xbb77aca8bd322b71880d664e0f75d49f rlm_perl: Added pair Framed-MTU = 1400 rlm_perl: Added pair Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: Added pair EAP-Type = NAK rlm_perl: Added pair User-Name = wlan_test rlm_perl: Added pair State = 0x2bfd86792bfc9f32b981faab4170b1d3 rlm_perl: Added pair Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: Added pair NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair Reply-Message = rlm_perl authorize function rlm_perl: Added pair Auth-Type = EAP ++[perl] returns ok ++? if (!EAP-Message) ? Evaluating !(EAP-Message) -> FALSE ++? if (!EAP-Message) -> FALSE ++[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/freeradius/sites-enabled/default +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP NAK [eap] EAP-NAK asked for EAP-Type/tls [eap] processing type tls [tls] Requiring client certificate [tls] Initiate [tls] Start returned 1 ++[eap] returns handled Sending Access-Challenge of id 1 to 10.160.4.5 port 11306 Reply-Message = "rlm_perl authorize function" EAP-Message = 0x010200060d20 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x2bfd86792aff8b32b981faab4170b1d3 Finished request 1. Going to the next request Waking up in 4.9 seconds. rad_recv: Access-Request packet from host 10.160.4.5 port 11306, id=2, length=223 User-Name = "wlan_test" NAS-IP-Address = 127.0.0.1 Calling-Station-Id = "70-6F-6C-69-73-68" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 11Mbps 802.11b" EAP-Message = 0x0202005d0d0016030100520100004e030155b514c726b984258a51da5a9dd2e46f03015fca25cf72e7bfa7a0605c996a7500002600390038003500160013000a00330032002f0005000400150012000900140011000800060003020100 State = 0x2bfd86792aff8b32b981faab4170b1d3 Message-Authenticator = 0x3c6664f9405a2bfdf2589cc5220479d0 # Executing section authorize from file /etc/freeradius/sites-enabled/default +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] expand: %t -> Sun Jul 26 19:12:28 2015 ++[auth_log] returns ok ++[chap] returns noop ++[mschap] returns noop ++[digest] returns noop [suffix] No '@' in User-Name = "wlan_test", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 2 length 93 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated ++[files] returns noop rlm_perl: RAD_REQUEST: EAP-Message = 0x0202005d0d0016030100520100004e030155b514c726b984258a51da5a9dd2e46f03015fca25cf72e7bfa7a0605c996a7500002600390038003500160013000a00330032002f0005000400150012000900140011000800060003020100 rlm_perl: RAD_REQUEST: NAS-IP-Address = 127.0.0.1 rlm_perl: RAD_REQUEST: Message-Authenticator = 0x3c6664f9405a2bfdf2589cc5220479d0 rlm_perl: RAD_REQUEST: Framed-MTU = 1400 rlm_perl: RAD_REQUEST: Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: RAD_REQUEST: EAP-Type = EAP-TLS rlm_perl: RAD_REQUEST: User-Name = wlan_test rlm_perl: RAD_REQUEST: State = 0x2bfd86792aff8b32b981faab4170b1d3 rlm_perl: RAD_REQUEST: Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: RAD_REQUEST: NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair EAP-Message = 0x0202005d0d0016030100520100004e030155b514c726b984258a51da5a9dd2e46f03015fca25cf72e7bfa7a0605c996a7500002600390038003500160013000a00330032002f0005000400150012000900140011000800060003020100 rlm_perl: Added pair NAS-IP-Address = 127.0.0.1 rlm_perl: Added pair Message-Authenticator = 0x3c6664f9405a2bfdf2589cc5220479d0 rlm_perl: Added pair Framed-MTU = 1400 rlm_perl: Added pair Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: Added pair EAP-Type = EAP-TLS rlm_perl: Added pair User-Name = wlan_test rlm_perl: Added pair State = 0x2bfd86792aff8b32b981faab4170b1d3 rlm_perl: Added pair Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: Added pair NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair Reply-Message = rlm_perl authorize function rlm_perl: Added pair Auth-Type = EAP ++[perl] returns ok ++? if (!EAP-Message) ? Evaluating !(EAP-Message) -> FALSE ++? if (!EAP-Message) -> FALSE ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns noop Found Auth-Type = EAP # Executing group from file /etc/freeradius/sites-enabled/default +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/tls [eap] processing type tls [tls] Authenticate [tls] processing EAP-TLS [tls] eaptls_verify returned 7 [tls] Done initial handshake [tls] (other): before/accept initialization [tls] TLS_accept: before/accept initialization [tls] <<< TLS 1.0 Handshake [length 0052], ClientHello [tls] TLS_accept: SSLv3 read client hello A [tls] >>> TLS 1.0 Handshake [length 002a], ServerHello [tls] TLS_accept: SSLv3 write server hello A [tls] >>> TLS 1.0 Handshake [length 080a], Certificate [tls] TLS_accept: SSLv3 write certificate A [tls] >>> TLS 1.0 Handshake [length 020c], ServerKeyExchange [tls] TLS_accept: SSLv3 write key exchange A [tls] >>> TLS 1.0 Handshake [length 0093], CertificateRequest [tls] TLS_accept: SSLv3 write certificate request A [tls] TLS_accept: SSLv3 flush data [tls] TLS_accept: Need to read more data: SSLv3 read client certificate A In SSL Handshake Phase In SSL Accept mode [tls] eaptls_process returned 13 ++[eap] returns handled Sending Access-Challenge of id 2 to 10.160.4.5 port 11306 Reply-Message = "rlm_perl authorize function" EAP-Message = 0x010304000dc000000ae7160301002a02000026030107795daf3790bfb2ddc30fc03a48e82d48b477222d35ef682d0998391924b53800003900160301080a0b0008060008030003913082038d30820275a003020102020101300d06092a864886f70d0101040500307f310b30090603550406130244453110300e0603550408130748616d62757267311530130603550407130c5363687761727a656e62656b31123010060355040a13097469726920476d62483121301f06092a864886f70d0109011612636140686f7473706f742e746972692e6c693110300e0603550403130774697269204341301e170d3135303732353139313334395a170d3136 EAP-Message = 0x303732343139313334395a307c310b30090603550406130244453110300e0603550408130748616d6275726731123010060355040a13097469726920476d62483120301e0603550403131774697269205261646975732043657274696669636174653125302306092a864886f70d010901161672616469757340686f7473706f742e746972692e6c6930820122300d06092a864886f70d01010105000382010f003082010a0282010100c1d137622cec8d1f14603614804ea4cac9bde4092f508745a39ab61f7703bc2f6f97e22e59d276ec589c64abdb53302e95dd685886010b9d2fe50c47aea977dde5695375773ccccd1386a77286637e34e5bcb4 EAP-Message = 0x867fb45a59480052075c1ecaa3729784a201f755777af2687e2e968104d037a6c425f6bdf60ac8cfe12adc6d4566df042de359e2bf89a6620e151198651e0231f01acbdc4be27f7b5ff753ff00ffb0107bbeab65635170bb85683d3d0808f72da5a7d81b1ff01b3a1d0c939ab9aab4019524603a3b8c6f9bca0b8a10781369c9b509727ab93d7e327462828ec970ae02c2faec4ea31dbd0fe38fce7176219c5c5a342491cd488559654911fa8b0203010001a317301530130603551d25040c300a06082b06010505070301300d06092a864886f70d010104050003820101001349bf30e7bc3b1efca2070b746e268898bcc0735350b58f3463e4f8e7a8 EAP-Message = 0xe90998ceb0b1681c163e10742b8971b0179ee0ef7b5ca7b113743125d2653bd36700851af43ddc1fc4940ed334760f691d3ea2641155e38f7c4f5e334f76cdfe688f032dfff24af341d04c85c2abe62156003d2c44bfbe276d52504514e3843b7db0eb1c745ebedf3207ff5f7e49afeb3a8522ddc9769874b62bcef98ee674d66a3c242de9977944f70c08238666fecaecf6f2807e9e7d5df815334091fe52050502e44fe1b62c32c6704be94426285aeb09ef08936386a4e0e45f5db4d675430b3ba545b1f022b1905b36982abc0a8bf788b8e9fa95890614e251f445a44c80102d00046c3082046830820350a0030201020209009d2885275ceebbc8 EAP-Message = 0x300d06092a864886f70d0101 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x2bfd867929fe8b32b981faab4170b1d3 Finished request 2. Going to the next request Waking up in 4.9 seconds. rad_recv: Access-Request packet from host 10.160.4.5 port 11306, id=3, length=136 User-Name = "wlan_test" NAS-IP-Address = 127.0.0.1 Calling-Station-Id = "70-6F-6C-69-73-68" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 11Mbps 802.11b" EAP-Message = 0x020300060d00 State = 0x2bfd867929fe8b32b981faab4170b1d3 Message-Authenticator = 0x92f5bae48eceaa5c2ce731864502bdac # Executing section authorize from file /etc/freeradius/sites-enabled/default +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] expand: %t -> Sun Jul 26 19:12:28 2015 ++[auth_log] returns ok ++[chap] returns noop ++[mschap] returns noop ++[digest] returns noop [suffix] No '@' in User-Name = "wlan_test", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 3 length 6 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated ++[files] returns noop rlm_perl: RAD_REQUEST: EAP-Message = 0x020300060d00 rlm_perl: RAD_REQUEST: NAS-IP-Address = 127.0.0.1 rlm_perl: RAD_REQUEST: Message-Authenticator = 0x92f5bae48eceaa5c2ce731864502bdac rlm_perl: RAD_REQUEST: Framed-MTU = 1400 rlm_perl: RAD_REQUEST: Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: RAD_REQUEST: EAP-Type = EAP-TLS rlm_perl: RAD_REQUEST: User-Name = wlan_test rlm_perl: RAD_REQUEST: State = 0x2bfd867929fe8b32b981faab4170b1d3 rlm_perl: RAD_REQUEST: Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: RAD_REQUEST: NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair EAP-Message = 0x020300060d00 rlm_perl: Added pair NAS-IP-Address = 127.0.0.1 rlm_perl: Added pair Message-Authenticator = 0x92f5bae48eceaa5c2ce731864502bdac rlm_perl: Added pair Framed-MTU = 1400 rlm_perl: Added pair Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: Added pair EAP-Type = EAP-TLS rlm_perl: Added pair User-Name = wlan_test rlm_perl: Added pair State = 0x2bfd867929fe8b32b981faab4170b1d3 rlm_perl: Added pair Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: Added pair NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair Reply-Message = rlm_perl authorize function rlm_perl: Added pair Auth-Type = EAP ++[perl] returns ok ++? if (!EAP-Message) ? Evaluating !(EAP-Message) -> FALSE ++? if (!EAP-Message) -> FALSE ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns noop Found Auth-Type = EAP # Executing group from file /etc/freeradius/sites-enabled/default +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/tls [eap] processing type tls [tls] Authenticate [tls] processing EAP-TLS [tls] Received TLS ACK [tls] ACK handshake fragment handler [tls] eaptls_verify returned 1 [tls] eaptls_process returned 13 ++[eap] returns handled Sending Access-Challenge of id 3 to 10.160.4.5 port 11306 Reply-Message = "rlm_perl authorize function" EAP-Message = 0x010404000dc000000ae70b0500307f310b30090603550406130244453110300e0603550408130748616d62757267311530130603550407130c5363687761727a656e62656b31123010060355040a13097469726920476d62483121301f06092a864886f70d0109011612636140686f7473706f742e746972692e6c693110300e0603550403130774697269204341301e170d3135303732353139313334395a170d3136303732343139313334395a307f310b30090603550406130244453110300e0603550408130748616d62757267311530130603550407130c5363687761727a656e62656b31123010060355040a13097469726920476d6248312130 EAP-Message = 0x1f06092a864886f70d0109011612636140686f7473706f742e746972692e6c693110300e060355040313077469726920434130820122300d06092a864886f70d01010105000382010f003082010a028201010098727c23aded345afae75754ea9bb3a7dc7949f26b6944f98233c2e5ed1e5c720c358566aec7ccf61fc4579826efce1537a465eb8e02df124ff28140d4ad19a5573c6d0d67952f2feeccfb42232186c00eb6a0590cd0fac23c3e87351520b77c0e142e0210522a3098a503ab74660d61801d362297d8a81c56214d036d60f11d43819cfdbaa736e3b9f10e350677f5e0cf14e4856388477fa7a2ea1520b6acc495ca29de77a1a390c1ae EAP-Message = 0x0a0e5bf6c3d6f7af85603bde8a61622d3462c9c2bdba96893cfe72c3f663144458463a201f34cf6d009c03916a4799ae50048aa12039c3b814898a23c9f10537f7d8f5be505e873c3ef5a4441d08f20daf6f17ca81110203010001a381e63081e3301d0603551d0e04160414136c09d813ec30d48c30f591549d1526d14391753081b30603551d230481ab3081a88014136c09d813ec30d48c30f591549d1526d1439175a18184a48181307f310b30090603550406130244453110300e0603550408130748616d62757267311530130603550407130c5363687761727a656e62656b31123010060355040a13097469726920476d62483121301f06092a EAP-Message = 0x864886f70d0109011612636140686f7473706f742e746972692e6c693110300e06035504031307746972692043418209009d2885275ceebbc8300c0603551d13040530030101ff300d06092a864886f70d01010b05000382010100555aade04c2ef507a90f7af3483086a8142316aab27f54eb95df32eb9e0ee4fd30c2cf9e30508a85131bdaca42cb5cddcd5ff1793780cb71b9900b1de16b2b658d3933ab25aec085bfae2ced2e024a3b7465367e09af5b3fc032385351710274fe464947ab19784fec492c62ada1bfa2b745b8cbcc7d58f154af7b396f24585f80a848139ce37d3152ed3d07dca656fe9f0acb14fd4374e363da9d4da9b4dec47af9 EAP-Message = 0xef98a0f874f85879d1441db5 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x2bfd867928f98b32b981faab4170b1d3 Finished request 3. Going to the next request Waking up in 4.9 seconds. rad_recv: Access-Request packet from host 10.160.4.5 port 11306, id=4, length=136 User-Name = "wlan_test" NAS-IP-Address = 127.0.0.1 Calling-Station-Id = "70-6F-6C-69-73-68" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 11Mbps 802.11b" EAP-Message = 0x020400060d00 State = 0x2bfd867928f98b32b981faab4170b1d3 Message-Authenticator = 0x2511bcdc14925aa0901a46fd90e04e9a # Executing section authorize from file /etc/freeradius/sites-enabled/default +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] expand: %t -> Sun Jul 26 19:12:28 2015 ++[auth_log] returns ok ++[chap] returns noop ++[mschap] returns noop ++[digest] returns noop [suffix] No '@' in User-Name = "wlan_test", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 4 length 6 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated ++[files] returns noop rlm_perl: RAD_REQUEST: EAP-Message = 0x020400060d00 rlm_perl: RAD_REQUEST: NAS-IP-Address = 127.0.0.1 rlm_perl: RAD_REQUEST: Message-Authenticator = 0x2511bcdc14925aa0901a46fd90e04e9a rlm_perl: RAD_REQUEST: Framed-MTU = 1400 rlm_perl: RAD_REQUEST: Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: RAD_REQUEST: EAP-Type = EAP-TLS rlm_perl: RAD_REQUEST: User-Name = wlan_test rlm_perl: RAD_REQUEST: State = 0x2bfd867928f98b32b981faab4170b1d3 rlm_perl: RAD_REQUEST: Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: RAD_REQUEST: NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair EAP-Message = 0x020400060d00 rlm_perl: Added pair NAS-IP-Address = 127.0.0.1 rlm_perl: Added pair Message-Authenticator = 0x2511bcdc14925aa0901a46fd90e04e9a rlm_perl: Added pair Framed-MTU = 1400 rlm_perl: Added pair Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: Added pair EAP-Type = EAP-TLS rlm_perl: Added pair User-Name = wlan_test rlm_perl: Added pair State = 0x2bfd867928f98b32b981faab4170b1d3 rlm_perl: Added pair Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: Added pair NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair Reply-Message = rlm_perl authorize function rlm_perl: Added pair Auth-Type = EAP ++[perl] returns ok ++? if (!EAP-Message) ? Evaluating !(EAP-Message) -> FALSE ++? if (!EAP-Message) -> FALSE ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns noop Found Auth-Type = EAP # Executing group from file /etc/freeradius/sites-enabled/default +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/tls [eap] processing type tls [tls] Authenticate [tls] processing EAP-TLS [tls] Received TLS ACK [tls] ACK handshake fragment handler [tls] eaptls_verify returned 1 [tls] eaptls_process returned 13 ++[eap] returns handled Sending Access-Challenge of id 4 to 10.160.4.5 port 11306 Reply-Message = "rlm_perl authorize function" EAP-Message = 0x010503050d8000000ae728dd70b5677c5fb00cd4f0e60089c0d76daba78b91d9da9abc6ce42a5f1d3091291e9f7f40838cb4b64c0c868023335b65648bd62f96ce8780ad2e85716a7c51a2b546e4ba2ad7dca2fb817678c0b88c2034160301020c0c0002080080fec9bdc030018ad3d1bce0420bfec7cf29629b1be544a4404663b31cd7c175f53b8076780a983748e76b6d7d93dd225ac2a4b192dbd9bc34f3d41b7616220cfe01060ff4aef79e5780f8f29eb82c7fb33121b14a178a6bd870d63f840ffa4659220762e89ceda1eb7e3f2a28a6314875cca127fc95e93921acf72f42010727c3000102007fe19083313aa87e27c5f548275e78796295 EAP-Message = 0x82218b6712398f2f366d00b564561b774ed8db6297e2bc67a4854c4b5e5d3273b94d32dd16984ee8d06d22490b4248babd32aa3c049812ad0042b4081e3f2918f6b251f9de44565aae5fa90baef72bf84a26c42e602cce12b8893a6bf661a5e5ac9a47cc1c2ade6c4484e143cb770100b92c1329818d9a92a1f5be9ebd67a9de7a915dbf625a718e1bee20ddd499d77d504f751f6dfc46a8981451d9cd7cc4761f6908a13a70fcf21f1d571c0124fd68a44a02b0c223057d8c88b24a25afce191a91f3e0c38356c627bdc2a3fa803db3b6b606cd7868f1ff5ebedbae55f96d422a3fc2c5545e6fdaca81ed942109da75f148ba914f035771d0b63f0fcf EAP-Message = 0x0931b453007fa570e84dc5da0f9eeb435ee23c4720b7adfecaed75e70ea6bd4f4413180907172bd30162cac3b73152f3ae22bee11200adf5c16bfb8d7c2676779ebd13bbeefba870393cd8005442c2c8d766bbb5d4797e0f6291717cdbc19ff159fa1a7a0b4e423998afa3855f9a8e2875d3a416030100930d00008b05030401024000830081307f310b30090603550406130244453110300e0603550408130748616d62757267311530130603550407130c5363687761727a656e62656b31123010060355040a13097469726920476d62483121301f06092a864886f70d0109011612636140686f7473706f742e746972692e6c693110300e06035504 EAP-Message = 0x031307746972692043410e000000 Message-Authenticator = 0x00000000000000000000000000000000 State = 0x2bfd86792ff88b32b981faab4170b1d3 Finished request 4. Going to the next request Waking up in 4.9 seconds. rad_recv: Access-Request packet from host 10.160.4.5 port 11306, id=5, length=143 User-Name = "wlan_test" NAS-IP-Address = 127.0.0.1 Calling-Station-Id = "70-6F-6C-69-73-68" Framed-MTU = 1400 NAS-Port-Type = Wireless-802.11 Connect-Info = "CONNECT 11Mbps 802.11b" EAP-Message = 0x0205000d0d0015030100020233 State = 0x2bfd86792ff88b32b981faab4170b1d3 Message-Authenticator = 0x136e38a03a44e6de86bf1ec4590700dc # Executing section authorize from file /etc/freeradius/sites-enabled/default +- entering group authorize {...} ++[preprocess] returns ok [auth_log] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d -> /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] /var/log/freeradius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d expands to /var/log/freeradius/radacct/10.160.4.5/auth-detail-20150726 [auth_log] expand: %t -> Sun Jul 26 19:12:28 2015 ++[auth_log] returns ok ++[chap] returns noop ++[mschap] returns noop ++[digest] returns noop [suffix] No '@' in User-Name = "wlan_test", looking up realm NULL [suffix] No such realm "NULL" ++[suffix] returns noop [eap] EAP packet type response id 5 length 13 [eap] No EAP Start, assuming it's an on-going EAP conversation ++[eap] returns updated ++[files] returns noop rlm_perl: RAD_REQUEST: EAP-Message = 0x0205000d0d0015030100020233 rlm_perl: RAD_REQUEST: NAS-IP-Address = 127.0.0.1 rlm_perl: RAD_REQUEST: Message-Authenticator = 0x136e38a03a44e6de86bf1ec4590700dc rlm_perl: RAD_REQUEST: Framed-MTU = 1400 rlm_perl: RAD_REQUEST: Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: RAD_REQUEST: EAP-Type = EAP-TLS rlm_perl: RAD_REQUEST: User-Name = wlan_test rlm_perl: RAD_REQUEST: State = 0x2bfd86792ff88b32b981faab4170b1d3 rlm_perl: RAD_REQUEST: Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: RAD_REQUEST: NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair EAP-Message = 0x0205000d0d0015030100020233 rlm_perl: Added pair NAS-IP-Address = 127.0.0.1 rlm_perl: Added pair Message-Authenticator = 0x136e38a03a44e6de86bf1ec4590700dc rlm_perl: Added pair Framed-MTU = 1400 rlm_perl: Added pair Calling-Station-Id = 70-6F-6C-69-73-68 rlm_perl: Added pair EAP-Type = EAP-TLS rlm_perl: Added pair User-Name = wlan_test rlm_perl: Added pair State = 0x2bfd86792ff88b32b981faab4170b1d3 rlm_perl: Added pair Connect-Info = CONNECT 11Mbps 802.11b rlm_perl: Added pair NAS-Port-Type = Wireless-802.11 rlm_perl: Added pair Reply-Message = rlm_perl authorize function rlm_perl: Added pair Auth-Type = EAP ++[perl] returns ok ++? if (!EAP-Message) ? Evaluating !(EAP-Message) -> FALSE ++? if (!EAP-Message) -> FALSE ++[expiration] returns noop ++[logintime] returns noop ++[pap] returns noop Found Auth-Type = EAP # Executing group from file /etc/freeradius/sites-enabled/default +- entering group authenticate {...} [eap] Request found, released from the list [eap] EAP/tls [eap] processing type tls [tls] Authenticate [tls] processing EAP-TLS [tls] eaptls_verify returned 7 [tls] Done initial handshake [tls] <<< TLS 1.0 Alert [length 0002], fatal decrypt_error TLS Alert read:fatal:decrypt error TLS_accept: failed in SSLv3 read client certificate A rlm_eap: SSL error error:1409441B:SSL routines:SSL3_READ_BYTES:tlsv1 alert decrypt error SSL: SSL_read failed inside of TLS (-1), TLS session fails. TLS receive handshake failed during operation [tls] eaptls_process returned 4 [eap] Handler failed in EAP/tls [eap] Failed in EAP select ++[eap] returns invalid Failed to authenticate the user. Using Post-Auth-Type Reject # Executing group from file /etc/freeradius/sites-enabled/default +- entering group REJECT {...} [attr_filter.access_reject] expand: %{User-Name} -> wlan_test attr_filter: Matched entry DEFAULT at line 11 ++[attr_filter.access_reject] returns updated Delaying reject of request 5 for 1 seconds Going to the next request Waking up in 0.9 seconds. Sending delayed reject for request 5 Sending Access-Reject of id 5 to 10.160.4.5 port 11306 Reply-Message = "rlm_perl authorize function" EAP-Message = 0x04050004 Message-Authenticator = 0x00000000000000000000000000000000 Waking up in 3.9 seconds. Cleaning up request 0 ID 0 with timestamp +5 Cleaning up request 1 ID 1 with timestamp +5 Cleaning up request 2 ID 2 with timestamp +5 Cleaning up request 3 ID 3 with timestamp +5 Cleaning up request 4 ID 4 with timestamp +5 Waking up in 1.0 seconds. Cleaning up request 5 ID 5 with timestamp +5 Ready to process requests.