March 2015 - Freeradius-Users - lists.freeradius.org

Best practices for logging in production environment?
by Mohamed Lrhazi 27 Mar '15

27 Mar '15

Deployed 3.x in production the morning... and all went fine.. Thank you guys! I guess being worried of performance issues, I enabled very little logging..., just linelog, with the following config: messages { default = "Unknown packet type %{Packet-Type}" Access-Request = "%S: %{reply:Packet-Type}: u=%{User-Name} cis=%{Calling-Station-Id} cds=%{Called-Station-Id} pip=%{Packet-Src-IP-Address} nip=%{NAS-IP-Address} n=%{NAS-Identifier}" #Access-Challenge = "Sent challenge: u=%{User-Name} s=%{%{request:Calling-Station-Id}:-UnknownCSID}" } Of course, when a user is rejected, all I have is some data about where they came from, but no hints as to why we rejected them.... How do you guys log in production settings? any examples highly appreciated. Thanks a lot, Mohamed.

3 7

WPA Enterprise/EAP
by Marcin 27 Mar '15

27 Mar '15

Hi, I'm trying to configure freeradius with wireles eap. It works, but in debug mode there are some warnings. #v+ root@radius01:/etc/freeradius# freeradius -X Copyright (C) 1999-2015 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 For more information about these matters, see the file named COPYRIGHT Starting - reading configuration files ... including dictionary file /usr/share/freeradius/dictionary including dictionary file /usr/share/freeradius/dictionary.dhcp including dictionary file /usr/share/freeradius/dictionary.vqp including dictionary file /etc/freeradius/dictionary including configuration file /etc/freeradius/radiusd.conf including configuration file /etc/freeradius/clients.conf including files in directory /etc/freeradius/mods-enabled/ including configuration file /etc/freeradius/mods-enabled/dynamic_clients including configuration file /etc/freeradius/mods-enabled/soh including configuration file /etc/freeradius/mods-enabled/passwd including configuration file /etc/freeradius/mods-enabled/detail including configuration file /etc/freeradius/mods-enabled/cache_eap including configuration file /etc/freeradius/mods-enabled/expiration including configuration file /etc/freeradius/mods-enabled/files including configuration file /etc/freeradius/mods-enabled/pap including configuration file /etc/freeradius/mods-enabled/expr including configuration file /etc/freeradius/mods-enabled/attr_filter including configuration file /etc/freeradius/mods-enabled/detail.log including configuration file /etc/freeradius/mods-enabled/radutmp including configuration file /etc/freeradius/mods-enabled/dhcp including configuration file /etc/freeradius/mods-enabled/exec including configuration file /etc/freeradius/mods-enabled/linelog including configuration file /etc/freeradius/mods-enabled/unpack including configuration file /etc/freeradius/mods-enabled/eap including configuration file /etc/freeradius/mods-enabled/ntlm_auth including configuration file /etc/freeradius/mods-enabled/echo including configuration file /etc/freeradius/mods-enabled/utf8 including configuration file /etc/freeradius/mods-enabled/unix including configuration file /etc/freeradius/mods-enabled/mschap including configuration file /etc/freeradius/mods-enabled/digest including configuration file /etc/freeradius/mods-enabled/sradutmp including configuration file /etc/freeradius/mods-enabled/preprocess including configuration file /etc/freeradius/mods-enabled/realm including configuration file /etc/freeradius/mods-enabled/chap including configuration file /etc/freeradius/mods-enabled/always including configuration file /etc/freeradius/mods-enabled/replicate including configuration file /etc/freeradius/mods-enabled/logintime including files in directory /etc/freeradius/policy.d/ including configuration file /etc/freeradius/policy.d/filter including configuration file /etc/freeradius/policy.d/control including configuration file /etc/freeradius/policy.d/dhcp including configuration file /etc/freeradius/policy.d/canonicalization including configuration file /etc/freeradius/policy.d/eap including configuration file /etc/freeradius/policy.d/operator-name including configuration file /etc/freeradius/policy.d/cui including configuration file /etc/freeradius/policy.d/debug including configuration file /etc/freeradius/policy.d/accounting including configuration file /etc/freeradius/policy.d/abfab-tr including files in directory /etc/freeradius/sites-enabled/ including configuration file /etc/freeradius/sites-enabled/inner-tunnel including configuration file /etc/freeradius/sites-enabled/default main { security { user = "freerad" group = "freerad" allow_core_dumps = no } } 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 = no log { stripped_names = no auth = no auth_badpass = no auth_goodpass = no colourise = yes msg_denied = "You are already logged in - access denied" } resources { } security { max_attributes = 200 reject_delay = 1.000000 status_server = yes } } radiusd: #### Loading Realms and Home Servers #### radiusd: #### Loading Clients #### client localhost { ipaddr = 127.0.0.1 require_message_authenticator = no secret = <<< secret >>> nas_type = "other" proto = "*" limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } client localhost_ipv6 { ipv6addr = ::1 require_message_authenticator = no secret = <<< secret >>> limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } client MGMT_network { ipaddr = 172.28.0.0/16 require_message_authenticator = no secret = <<< secret >>> nas_type = "other" limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } client testNetwork { ipaddr = 172.21.7.0/24 require_message_authenticator = no secret = <<< secret >>> nas_type = "other" limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } Debugger not attached # Creating Auth-Type = digest radiusd: #### Instantiating modules #### instantiate { } modules { # Loaded module rlm_dynamic_clients # Instantiating module "dynamic_clients" from file /etc/freeradius/mods-enabled/dynamic_clients # Loaded module rlm_soh # Instantiating module "soh" from file /etc/freeradius/mods-enabled/soh soh { dhcp = yes } # Loaded module rlm_passwd # Instantiating module "etc_passwd" from file /etc/freeradius/mods-enabled/passwd passwd etc_passwd { filename = "/etc/passwd" format = "*User-Name:Crypt-Password:" delimiter = ":" ignore_nislike = no ignore_empty = yes allow_multiple_keys = no hash_size = 100 } rlm_passwd: nfields: 3 keyfield 0(User-Name) listable: no # Loaded module rlm_detail # Instantiating module "detail" from file /etc/freeradius/mods-enabled/detail detail { filename = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d" header = "%t" permissions = 384 locking = no escape_filenames = no log_packet_header = no } # Loaded module rlm_cache # Instantiating module "cache_eap" from file /etc/freeradius/mods-enabled/cache_eap cache cache_eap { driver = "rlm_cache_rbtree" key = "%{%{control:State}:-%{%{reply:State}:-%{State}}}" ttl = 15 max_entries = 0 epoch = 0 add_stats = no } rlm_cache (cache_eap): Driver rlm_cache_rbtree (module rlm_cache_rbtree) loaded and linked # Loaded module rlm_expiration # Instantiating module "expiration" from file /etc/freeradius/mods-enabled/expiration # Loaded module rlm_files # Instantiating module "files" from file /etc/freeradius/mods-enabled/files files { filename = "/etc/freeradius/mods-config/files/authorize" usersfile = "/etc/freeradius/mods-config/files/authorize" acctusersfile = "/etc/freeradius/mods-config/files/accounting" preproxy_usersfile = "/etc/freeradius/mods-config/files/pre-proxy" compat = "cistron" } reading pairlist file /etc/freeradius/mods-config/files/authorize [/etc/freeradius/mods-config/files/authorize]:56 Cistron compatibility checks for entry bob ... [/etc/freeradius/mods-config/files/authorize]:187 Cistron compatibility checks for entry DEFAULT ... [/etc/freeradius/mods-config/files/authorize]:194 Cistron compatibility checks for entry DEFAULT ... [/etc/freeradius/mods-config/files/authorize]:200 Cistron compatibility checks for entry DEFAULT ... reading pairlist file /etc/freeradius/mods-config/files/authorize [/etc/freeradius/mods-config/files/authorize]:56 Cistron compatibility checks for entry bob ... [/etc/freeradius/mods-config/files/authorize]:187 Cistron compatibility checks for entry DEFAULT ... [/etc/freeradius/mods-config/files/authorize]:194 Cistron compatibility checks for entry DEFAULT ... [/etc/freeradius/mods-config/files/authorize]:200 Cistron compatibility checks for entry DEFAULT ... reading pairlist file /etc/freeradius/mods-config/files/accounting reading pairlist file /etc/freeradius/mods-config/files/pre-proxy # Loaded module rlm_pap # Instantiating module "pap" from file /etc/freeradius/mods-enabled/pap pap { normalise = yes } # Loaded module rlm_expr # Instantiating module "expr" from file /etc/freeradius/mods-enabled/expr expr { safe_characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /äéöüàâæçèéêëîïôœùûüaÿÄÉÖÜßÀÂÆÇÈÉÊËÎÏÔŒÙÛÜŸ" } # Loaded module rlm_attr_filter # Instantiating module "attr_filter.post-proxy" from file /etc/freeradius/mods-enabled/attr_filter attr_filter attr_filter.post-proxy { filename = "/etc/freeradius/mods-config/attr_filter/post-proxy" key = "%{Realm}" relaxed = no } reading pairlist file /etc/freeradius/mods-config/attr_filter/post-proxy # Instantiating module "attr_filter.pre-proxy" from file /etc/freeradius/mods-enabled/attr_filter attr_filter attr_filter.pre-proxy { filename = "/etc/freeradius/mods-config/attr_filter/pre-proxy" key = "%{Realm}" relaxed = no } reading pairlist file /etc/freeradius/mods-config/attr_filter/pre-proxy # Instantiating module "attr_filter.access_reject" from file /etc/freeradius/mods-enabled/attr_filter attr_filter attr_filter.access_reject { filename = "/etc/freeradius/mods-config/attr_filter/access_reject" key = "%{User-Name}" relaxed = no } reading pairlist file /etc/freeradius/mods-config/attr_filter/access_reject # Instantiating module "attr_filter.access_challenge" from file /etc/freeradius/mods-enabled/attr_filter attr_filter attr_filter.access_challenge { filename = "/etc/freeradius/mods-config/attr_filter/access_challenge" key = "%{User-Name}" relaxed = no } reading pairlist file /etc/freeradius/mods-config/attr_filter/access_challenge # Instantiating module "attr_filter.accounting_response" from file /etc/freeradius/mods-enabled/attr_filter attr_filter attr_filter.accounting_response { filename = "/etc/freeradius/mods-config/attr_filter/accounting_response" key = "%{User-Name}" relaxed = no } reading pairlist file /etc/freeradius/mods-config/attr_filter/accounting_response # Instantiating module "auth_log" from file /etc/freeradius/mods-enabled/detail.log detail auth_log { filename = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d" header = "%t" permissions = 384 locking = no escape_filenames = no log_packet_header = no } rlm_detail (auth_log): 'User-Password' suppressed, will not appear in detail output # Instantiating module "reply_log" from file /etc/freeradius/mods-enabled/detail.log detail reply_log { filename = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/reply-detail-%Y%m%d" header = "%t" permissions = 384 locking = no escape_filenames = no log_packet_header = no } # Instantiating module "pre_proxy_log" from file /etc/freeradius/mods-enabled/detail.log detail pre_proxy_log { filename = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/pre-proxy-detail-%Y%m%d" header = "%t" permissions = 384 locking = no escape_filenames = no log_packet_header = no } # Instantiating module "post_proxy_log" from file /etc/freeradius/mods-enabled/detail.log detail post_proxy_log { filename = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/post-proxy-detail-%Y%m%d" header = "%t" permissions = 384 locking = no escape_filenames = no log_packet_header = no } # Loaded module rlm_radutmp # Instantiating module "radutmp" from file /etc/freeradius/mods-enabled/radutmp radutmp { filename = "/var/log/freeradius/radutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes permissions = 384 caller_id = yes } # Loaded module rlm_dhcp # Instantiating module "dhcp" from file /etc/freeradius/mods-enabled/dhcp # Loaded module rlm_exec # Instantiating module "exec" from file /etc/freeradius/mods-enabled/exec exec { wait = no input_pairs = "request" shell_escape = yes timeout = 10 } # Loaded module rlm_linelog # Instantiating module "linelog" from file /etc/freeradius/mods-enabled/linelog linelog { filename = "/var/log/freeradius/linelog" permissions = 384 format = "This is a log message for %{User-Name}" reference = "messages.%{%{Packet-Type}:-default}" } # Instantiating module "log_accounting" from file /etc/freeradius/mods-enabled/linelog linelog log_accounting { filename = "/var/log/freeradius/linelog-accounting" permissions = 384 format = "" reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}" } # Loaded module rlm_unpack # Instantiating module "unpack" from file /etc/freeradius/mods-enabled/unpack # Loaded module rlm_eap # Instantiating module "eap" from file /etc/freeradius/mods-enabled/eap eap { default_eap_type = "peap" timer_expire = 60 ignore_unknown_eap_types = no mod_accounting_username_bug = no max_sessions = 1024 } # Linked to sub-module rlm_eap_md5 # Linked to sub-module rlm_eap_leap # Linked to sub-module rlm_eap_gtc gtc { challenge = "Password: " auth_type = "PAP" } # Linked to sub-module rlm_eap_tls tls { tls = "tls-common" } tls-config tls-common { 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.pem" certificate_file = "/etc/freeradius/certs/server.pem" ca_file = "/etc/freeradius/certs/ca.pem" private_key_password = <<< secret >>> dh_file = "/etc/freeradius/certs/dh" fragment_size = 1024 include_length = yes check_crl = no cipher_list = "DEFAULT" ecdh_curve = "prime256v1" cache { enable = yes lifetime = 24 max_entries = 255 } verify { } ocsp { enable = no override_cert_url = yes url = "http://127.0.0.1/ocsp/" use_nonce = yes timeout = 0 softfail = no } } # Linked to sub-module rlm_eap_ttls ttls { tls = "tls-common" default_eap_type = "md5" copy_request_to_tunnel = yes use_tunneled_reply = no virtual_server = "inner-tunnel" include_length = yes require_client_cert = no } Using cached TLS configuration from previous invocation # Linked to sub-module rlm_eap_peap peap { tls = "tls-common" default_method = "mschapv2" copy_request_to_tunnel = no use_tunneled_reply = no proxy_tunneled_request_as_eap = yes virtual_server = "inner-tunnel" soh = no require_client_cert = no } Using cached TLS configuration from previous invocation # Linked to sub-module rlm_eap_mschapv2 mschapv2 { with_ntdomain_hack = no send_error = no } # Instantiating module "ntlm_auth" from file /etc/freeradius/mods-enabled/ntlm_auth exec ntlm_auth { wait = yes program = "/path/to/ntlm_auth --request-nt-key --domain=MYDOMAIN --username=%{mschap:User-Name} --password=%{User-Password}" shell_escape = yes } # Instantiating module "echo" from file /etc/freeradius/mods-enabled/echo exec echo { wait = yes program = "/bin/echo %{User-Name}" input_pairs = "request" output_pairs = "reply" shell_escape = yes } # Loaded module rlm_utf8 # Instantiating module "utf8" from file /etc/freeradius/mods-enabled/utf8 # Loaded module rlm_unix # Instantiating module "unix" from file /etc/freeradius/mods-enabled/unix unix { radwtmp = "/var/log/freeradius/radwtmp" } # Loaded module rlm_mschap # Instantiating module "mschap" from file /etc/freeradius/mods-enabled/mschap mschap { use_mppe = yes require_encryption = no require_strong = no with_ntdomain_hack = yes passchange { } allow_retry = yes } # Loaded module rlm_digest # Instantiating module "digest" from file /etc/freeradius/mods-enabled/digest # Instantiating module "sradutmp" from file /etc/freeradius/mods-enabled/sradutmp radutmp sradutmp { filename = "/var/log/freeradius/sradutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes permissions = 420 caller_id = no } # Loaded module rlm_preprocess # Instantiating module "preprocess" from file /etc/freeradius/mods-enabled/preprocess preprocess { huntgroups = "/etc/freeradius/mods-config/preprocess/huntgroups" hints = "/etc/freeradius/mods-config/preprocess/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 } reading pairlist file /etc/freeradius/mods-config/preprocess/huntgroups reading pairlist file /etc/freeradius/mods-config/preprocess/hints # Loaded module rlm_realm # Instantiating module "IPASS" from file /etc/freeradius/mods-enabled/realm realm IPASS { format = "prefix" delimiter = "/" ignore_default = no ignore_null = no } # Instantiating module "suffix" from file /etc/freeradius/mods-enabled/realm realm suffix { format = "suffix" delimiter = "@" ignore_default = no ignore_null = no } # Instantiating module "realmpercent" from file /etc/freeradius/mods-enabled/realm realm realmpercent { format = "suffix" delimiter = "%" ignore_default = no ignore_null = no } # Instantiating module "ntdomain" from file /etc/freeradius/mods-enabled/realm realm ntdomain { format = "prefix" delimiter = "\\" ignore_default = no ignore_null = no } # Loaded module rlm_chap # Instantiating module "chap" from file /etc/freeradius/mods-enabled/chap # Loaded module rlm_always # Instantiating module "reject" from file /etc/freeradius/mods-enabled/always always reject { rcode = "reject" simulcount = 0 mpp = no } # Instantiating module "fail" from file /etc/freeradius/mods-enabled/always always fail { rcode = "fail" simulcount = 0 mpp = no } # Instantiating module "ok" from file /etc/freeradius/mods-enabled/always always ok { rcode = "ok" simulcount = 0 mpp = no } # Instantiating module "handled" from file /etc/freeradius/mods-enabled/always always handled { rcode = "handled" simulcount = 0 mpp = no } # Instantiating module "invalid" from file /etc/freeradius/mods-enabled/always always invalid { rcode = "invalid" simulcount = 0 mpp = no } # Instantiating module "userlock" from file /etc/freeradius/mods-enabled/always always userlock { rcode = "userlock" simulcount = 0 mpp = no } # Instantiating module "notfound" from file /etc/freeradius/mods-enabled/always always notfound { rcode = "notfound" simulcount = 0 mpp = no } # Instantiating module "noop" from file /etc/freeradius/mods-enabled/always always noop { rcode = "noop" simulcount = 0 mpp = no } # Instantiating module "updated" from file /etc/freeradius/mods-enabled/always always updated { rcode = "updated" simulcount = 0 mpp = no } # Loaded module rlm_replicate # Instantiating module "replicate" from file /etc/freeradius/mods-enabled/replicate # Loaded module rlm_logintime # Instantiating module "logintime" from file /etc/freeradius/mods-enabled/logintime logintime { minimum_timeout = 60 } } # modules radiusd: #### Loading Virtual Servers #### server { # from file /etc/freeradius/radiusd.conf } # server server inner-tunnel { # from file /etc/freeradius/sites-enabled/inner-tunnel # Loading authenticate {...} # Loading authorize {...} Ignoring "sql" (see raddb/mods-available/README.rst) Ignoring "ldap" (see raddb/mods-available/README.rst) # Loading session {...} # Loading post-auth {...} } # server inner-tunnel server default { # from file /etc/freeradius/sites-enabled/default # Loading authenticate {...} # Loading authorize {...} # Loading preacct {...} # Loading accounting {...} # Loading post-auth {...} } # server default radiusd: #### Opening IP addresses and Ports #### listen { type = "auth" ipaddr = 127.0.0.1 port = 18120 } listen { type = "auth" ipaddr = * port = 0 limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } listen { type = "acct" ipaddr = * port = 0 limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } listen { type = "auth" ipv6addr = :: port = 0 limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } listen { type = "acct" ipv6addr = :: port = 0 limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } Listening on auth address 127.0.0.1 port 18120 bound to server inner-tunnel Listening on auth address * port 1812 bound to server default Listening on acct address * port 1813 bound to server default Listening on auth address :: port 1812 bound to server default Listening on acct address :: port 1813 bound to server default Ready to process requests (0) Received Access-Request Id 48 from 172.21.7.176:55431 to 172.21.7.175:1812 length 212 (0) Service-Type = Framed-User (0) Framed-MTU = 1400 (0) User-Name = 'bob' (0) NAS-Port-Id = 'wlan1' (0) NAS-Port-Type = Wireless-802.11 (0) Acct-Session-Id = '82000006' (0) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (0) Calling-Station-Id = '44-74-6C-CB-FE-1E' (0) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (0) EAP-Message = 0x0200000801626f62 (0) Message-Authenticator = 0xf11fbb978dd91276979ee0a70e494997 (0) NAS-Identifier = 'TestowyMT' (0) NAS-IP-Address = 172.21.7.176 (0) # Executing section authorize from file /etc/freeradius/sites-enabled/default (0) authorize { (0) policy filter_username { (0) if (!&User-Name) { (0) if (!&User-Name) -> FALSE (0) if (&User-Name =~ / /) { (0) if (&User-Name =~ / /) -> FALSE (0) if (&User-Name =~ /@.*@/ ) { (0) if (&User-Name =~ /@.*@/ ) -> FALSE (0) if (&User-Name =~ /\.\./ ) { (0) if (&User-Name =~ /\.\./ ) -> FALSE (0) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (0) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (0) if (&User-Name =~ /\.$/) { (0) if (&User-Name =~ /\.$/) -> FALSE (0) if (&User-Name =~ /(a)\./) { (0) if (&User-Name =~ /(a)\./) -> FALSE (0) } # policy filter_username = notfound (0) [preprocess] = ok (0) [chap] = noop (0) [mschap] = noop (0) [digest] = noop (0) suffix: Checking for suffix after "@" (0) suffix: No '@' in User-Name = "bob", looking up realm NULL (0) suffix: No such realm "NULL" (0) [suffix] = noop (0) eap: Peer sent code Response (2) ID 0 length 8 (0) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the rest of authorize (0) [eap] = ok (0) } # authorize = ok (0) Found Auth-Type = EAP (0) # Executing group from file /etc/freeradius/sites-enabled/default (0) authenticate { (0) eap: Peer sent method Identity (1) (0) eap: Calling eap_peap to process EAP data (0) eap_peap: Flushing SSL sessions (of #0) (0) eap_peap: Initiate (0) eap_peap: Start returned 1 (0) eap: EAP session adding &reply:State = 0xc4f3e4bfc4f2fded (0) [eap] = handled (0) } # authenticate = handled (0) Using Post-Auth-Type Challenge (0) # Executing group from file /etc/freeradius/sites-enabled/default (0) Sent Access-Challenge Id 48 from 172.21.7.175:1812 to 172.21.7.176:55431 length 64 (0) EAP-Message = 0x010100061920 (0) Message-Authenticator = 0x00000000000000000000000000000000 (0) State = 0xc4f3e4bfc4f2fdedb35262d2c5aab0d9 (0) Finished request Waking up in 0.6 seconds. (1) Received Access-Request Id 49 from 172.21.7.176:36135 to 172.21.7.175:1812 length 430 (1) Service-Type = Framed-User (1) Framed-MTU = 1400 (1) User-Name = 'bob' (1) State = 0xc4f3e4bfc4f2fdedb35262d2c5aab0d9 (1) NAS-Port-Id = 'wlan1' (1) NAS-Port-Type = Wireless-802.11 (1) Acct-Session-Id = '82000006' (1) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (1) Calling-Station-Id = '44-74-6C-CB-FE-1E' (1) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (1) EAP-Message = 0x020100d01980000000c616030100c1010000bd030155151cf5b9600d759333eba3c89a2d098d1bad383b549a05d00f18b2f2a6374f000054c014c00ac022c02100390038c00fc0050035c012c008c01cc01b00160013c00dc003000ac013c009c01fc01e00330032c00ec004002fc011c007c00cc00200 (1) Message-Authenticator = 0xbbc81b6fb14e1ec3cb4e810ff7892db8 (1) NAS-Identifier = 'TestowyMT' (1) NAS-IP-Address = 172.21.7.176 (1) session-state: No cached attributes (1) # Executing section authorize from file /etc/freeradius/sites-enabled/default (1) authorize { (1) policy filter_username { (1) if (!&User-Name) { (1) if (!&User-Name) -> FALSE (1) if (&User-Name =~ / /) { (1) if (&User-Name =~ / /) -> FALSE (1) if (&User-Name =~ /@.*@/ ) { (1) if (&User-Name =~ /@.*@/ ) -> FALSE (1) if (&User-Name =~ /\.\./ ) { (1) if (&User-Name =~ /\.\./ ) -> FALSE (1) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (1) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (1) if (&User-Name =~ /\.$/) { (1) if (&User-Name =~ /\.$/) -> FALSE (1) if (&User-Name =~ /(a)\./) { (1) if (&User-Name =~ /(a)\./) -> FALSE (1) } # policy filter_username = notfound (1) [preprocess] = ok (1) [chap] = noop (1) [mschap] = noop (1) [digest] = noop (1) suffix: Checking for suffix after "@" (1) suffix: No '@' in User-Name = "bob", looking up realm NULL (1) suffix: No such realm "NULL" (1) [suffix] = noop (1) eap: Peer sent code Response (2) ID 1 length 208 (1) eap: Continuing tunnel setup (1) [eap] = ok (1) } # authorize = ok (1) Found Auth-Type = EAP (1) # Executing group from file /etc/freeradius/sites-enabled/default (1) authenticate { (1) eap: Expiring EAP session with state 0xc4f3e4bfc4f2fded (1) eap: Finished EAP session with state 0xc4f3e4bfc4f2fded (1) eap: Previous EAP request found for state 0xc4f3e4bfc4f2fded, released from the list (1) eap: Peer sent method PEAP (25) (1) eap: EAP PEAP (25) (1) eap: Calling eap_peap to process EAP data (1) eap_peap: processing EAP-TLS (1) eap_peap: TLS Length 198 (1) eap_peap: Length Included (1) eap_peap: eaptls_verify returned 11 (1) eap_peap: (other): before/accept initialization (1) eap_peap: TLS_accept: before/accept initialization (1) eap_peap: <<< TLS 1.0 Handshake [length 00c1], ClientHello (1) eap_peap: TLS_accept: SSLv3 read client hello A (1) eap_peap: >>> TLS 1.0 Handshake [length 0059], ServerHello (1) eap_peap: TLS_accept: SSLv3 write server hello A (1) eap_peap: >>> TLS 1.0 Handshake [length 08d0], Certificate (1) eap_peap: TLS_accept: SSLv3 write certificate A (1) eap_peap: >>> TLS 1.0 Handshake [length 014b], ServerKeyExchange (1) eap_peap: TLS_accept: SSLv3 write key exchange A (1) eap_peap: >>> TLS 1.0 Handshake [length 0004], ServerHelloDone (1) eap_peap: TLS_accept: SSLv3 write server done A (1) eap_peap: TLS_accept: SSLv3 flush data (1) eap_peap: TLS_accept: Need to read more data: SSLv3 read client certificate A (1) eap_peap: TLS_accept: Need to read more data: SSLv3 read client certificate A In SSL Handshake Phase In SSL Accept mode (1) eap_peap: eaptls_process returned 13 (1) eap_peap: FR_TLS_HANDLED (1) eap: EAP session adding &reply:State = 0xc4f3e4bfc5f1fded (1) [eap] = handled (1) } # authenticate = handled (1) Using Post-Auth-Type Challenge (1) # Executing group from file /etc/freeradius/sites-enabled/default (1) Sent Access-Challenge Id 49 from 172.21.7.175:1812 to 172.21.7.176:36135 length 1068 (1) EAP-Message = 0x010203ec19c000000a8c160301005902000055030155151cebf6ba12c24349fa22bd93cb3f3ab5f534a518ea798eb10bc68520f85e2088047a7836777c91caec026c2987818176f396d62108680d7be0ec280ce6a955c01400000dff01000100000b00040300010216030108d00b0008cc0008c90003de (1) Message-Authenticator = 0x00000000000000000000000000000000 (1) State = 0xc4f3e4bfc5f1fdedb35262d2c5aab0d9 (1) Finished request Waking up in 0.6 seconds. (2) Received Access-Request Id 50 from 172.21.7.176:51966 to 172.21.7.175:1812 length 228 (2) Service-Type = Framed-User (2) Framed-MTU = 1400 (2) User-Name = 'bob' (2) State = 0xc4f3e4bfc5f1fdedb35262d2c5aab0d9 (2) NAS-Port-Id = 'wlan1' (2) NAS-Port-Type = Wireless-802.11 (2) Acct-Session-Id = '82000006' (2) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (2) Calling-Station-Id = '44-74-6C-CB-FE-1E' (2) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (2) EAP-Message = 0x020200061900 (2) Message-Authenticator = 0x65c387e65b9cad3f43afd6b4c2cf3c5c (2) NAS-Identifier = 'TestowyMT' (2) NAS-IP-Address = 172.21.7.176 (2) session-state: No cached attributes (2) # Executing section authorize from file /etc/freeradius/sites-enabled/default (2) authorize { (2) policy filter_username { (2) if (!&User-Name) { (2) if (!&User-Name) -> FALSE (2) if (&User-Name =~ / /) { (2) if (&User-Name =~ / /) -> FALSE (2) if (&User-Name =~ /@.*@/ ) { (2) if (&User-Name =~ /@.*@/ ) -> FALSE (2) if (&User-Name =~ /\.\./ ) { (2) if (&User-Name =~ /\.\./ ) -> FALSE (2) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (2) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (2) if (&User-Name =~ /\.$/) { (2) if (&User-Name =~ /\.$/) -> FALSE (2) if (&User-Name =~ /(a)\./) { (2) if (&User-Name =~ /(a)\./) -> FALSE (2) } # policy filter_username = notfound (2) [preprocess] = ok (2) [chap] = noop (2) [mschap] = noop (2) [digest] = noop (2) suffix: Checking for suffix after "@" (2) suffix: No '@' in User-Name = "bob", looking up realm NULL (2) suffix: No such realm "NULL" (2) [suffix] = noop (2) eap: Peer sent code Response (2) ID 2 length 6 (2) eap: Continuing tunnel setup (2) [eap] = ok (2) } # authorize = ok (2) Found Auth-Type = EAP (2) # Executing group from file /etc/freeradius/sites-enabled/default (2) authenticate { (2) eap: Expiring EAP session with state 0xc4f3e4bfc5f1fded (2) eap: Finished EAP session with state 0xc4f3e4bfc5f1fded (2) eap: Previous EAP request found for state 0xc4f3e4bfc5f1fded, released from the list (2) eap: Peer sent method PEAP (25) (2) eap: EAP PEAP (25) (2) eap: Calling eap_peap to process EAP data (2) eap_peap: processing EAP-TLS (2) eap_peap: Received TLS ACK (2) eap_peap: Received TLS ACK (2) eap_peap: ACK handshake fragment handler (2) eap_peap: eaptls_verify returned 1 (2) eap_peap: eaptls_process returned 13 (2) eap_peap: FR_TLS_HANDLED (2) eap: EAP session adding &reply:State = 0xc4f3e4bfc6f0fded (2) [eap] = handled (2) } # authenticate = handled (2) Using Post-Auth-Type Challenge (2) # Executing group from file /etc/freeradius/sites-enabled/default (2) Sent Access-Challenge Id 50 from 172.21.7.175:1812 to 172.21.7.176:51966 length 1064 (2) EAP-Message = 0x010303e81940ea52ccfd63018f5baeca18786b3111106d5c3d807a09c17d63a23a5b576f5b0825c80faf7ae59a57fcf595b9880bd17efdb9433f832cf521828d0161b1d1493fbaeb0adc8779aca5e8e0b7819b66665d626978e5e075e9dccbb3f767e05fabc5d635e333b48233b1e40004e5308204e130 (2) Message-Authenticator = 0x00000000000000000000000000000000 (2) State = 0xc4f3e4bfc6f0fdedb35262d2c5aab0d9 (2) Finished request Waking up in 0.6 seconds. (3) Received Access-Request Id 51 from 172.21.7.176:44159 to 172.21.7.175:1812 length 228 (3) Service-Type = Framed-User (3) Framed-MTU = 1400 (3) User-Name = 'bob' (3) State = 0xc4f3e4bfc6f0fdedb35262d2c5aab0d9 (3) NAS-Port-Id = 'wlan1' (3) NAS-Port-Type = Wireless-802.11 (3) Acct-Session-Id = '82000006' (3) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (3) Calling-Station-Id = '44-74-6C-CB-FE-1E' (3) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (3) EAP-Message = 0x020300061900 (3) Message-Authenticator = 0x48978be4e626a71976b9195dcb93e3ed (3) NAS-Identifier = 'TestowyMT' (3) NAS-IP-Address = 172.21.7.176 (3) session-state: No cached attributes (3) # Executing section authorize from file /etc/freeradius/sites-enabled/default (3) authorize { (3) policy filter_username { (3) if (!&User-Name) { (3) if (!&User-Name) -> FALSE (3) if (&User-Name =~ / /) { (3) if (&User-Name =~ / /) -> FALSE (3) if (&User-Name =~ /@.*@/ ) { (3) if (&User-Name =~ /@.*@/ ) -> FALSE (3) if (&User-Name =~ /\.\./ ) { (3) if (&User-Name =~ /\.\./ ) -> FALSE (3) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (3) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (3) if (&User-Name =~ /\.$/) { (3) if (&User-Name =~ /\.$/) -> FALSE (3) if (&User-Name =~ /(a)\./) { (3) if (&User-Name =~ /(a)\./) -> FALSE (3) } # policy filter_username = notfound (3) [preprocess] = ok (3) [chap] = noop (3) [mschap] = noop (3) [digest] = noop (3) suffix: Checking for suffix after "@" (3) suffix: No '@' in User-Name = "bob", looking up realm NULL (3) suffix: No such realm "NULL" (3) [suffix] = noop (3) eap: Peer sent code Response (2) ID 3 length 6 (3) eap: Continuing tunnel setup (3) [eap] = ok (3) } # authorize = ok (3) Found Auth-Type = EAP (3) # Executing group from file /etc/freeradius/sites-enabled/default (3) authenticate { (3) eap: Expiring EAP session with state 0xc4f3e4bfc6f0fded (3) eap: Finished EAP session with state 0xc4f3e4bfc6f0fded (3) eap: Previous EAP request found for state 0xc4f3e4bfc6f0fded, released from the list (3) eap: Peer sent method PEAP (25) (3) eap: EAP PEAP (25) (3) eap: Calling eap_peap to process EAP data (3) eap_peap: processing EAP-TLS (3) eap_peap: Received TLS ACK (3) eap_peap: Received TLS ACK (3) eap_peap: ACK handshake fragment handler (3) eap_peap: eaptls_verify returned 1 (3) eap_peap: eaptls_process returned 13 (3) eap_peap: FR_TLS_HANDLED (3) eap: EAP session adding &reply:State = 0xc4f3e4bfc7f7fded (3) [eap] = handled (3) } # authenticate = handled (3) Using Post-Auth-Type Challenge (3) # Executing group from file /etc/freeradius/sites-enabled/default (3) Sent Access-Challenge Id 51 from 172.21.7.175:1812 to 172.21.7.176:44159 length 780 (3) EAP-Message = 0x010402ce190020417574686f7269747982090093d70bc70119a89b300c0603551d13040530030101ff30360603551d1f042f302d302ba029a0278625687474703a2f2f7777772e6578616d706c652e636f6d2f6578616d706c655f63612e63726c300d06092a864886f70d0101050500038201010076b7 (3) Message-Authenticator = 0x00000000000000000000000000000000 (3) State = 0xc4f3e4bfc7f7fdedb35262d2c5aab0d9 (3) Finished request Waking up in 0.5 seconds. (4) Received Access-Request Id 52 from 172.21.7.176:42871 to 172.21.7.175:1812 length 366 (4) Service-Type = Framed-User (4) Framed-MTU = 1400 (4) User-Name = 'bob' (4) State = 0xc4f3e4bfc7f7fdedb35262d2c5aab0d9 (4) NAS-Port-Id = 'wlan1' (4) NAS-Port-Type = Wireless-802.11 (4) Acct-Session-Id = '82000006' (4) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (4) Calling-Station-Id = '44-74-6C-CB-FE-1E' (4) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (4) EAP-Message = 0x020400901980000000861603010046100000424104eda1e096f754c51f491c67cce1d3501b9dec09a17ad4dd3df167dedea74e7da886fa0701ad6fdc3c1a5e9110939d32abd189b3e9c20551fbef7dc1ac889e81a9140301000101160301003063ee38bed2c1fd1ac035ff6af8b278ef434ed12a9e0d94 (4) Message-Authenticator = 0xb99839c1aa5b29d7788c79853bc608e9 (4) NAS-Identifier = 'TestowyMT' (4) NAS-IP-Address = 172.21.7.176 (4) session-state: No cached attributes (4) # Executing section authorize from file /etc/freeradius/sites-enabled/default (4) authorize { (4) policy filter_username { (4) if (!&User-Name) { (4) if (!&User-Name) -> FALSE (4) if (&User-Name =~ / /) { (4) if (&User-Name =~ / /) -> FALSE (4) if (&User-Name =~ /@.*@/ ) { (4) if (&User-Name =~ /@.*@/ ) -> FALSE (4) if (&User-Name =~ /\.\./ ) { (4) if (&User-Name =~ /\.\./ ) -> FALSE (4) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (4) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (4) if (&User-Name =~ /\.$/) { (4) if (&User-Name =~ /\.$/) -> FALSE (4) if (&User-Name =~ /(a)\./) { (4) if (&User-Name =~ /(a)\./) -> FALSE (4) } # policy filter_username = notfound (4) [preprocess] = ok (4) [chap] = noop (4) [mschap] = noop (4) [digest] = noop (4) suffix: Checking for suffix after "@" (4) suffix: No '@' in User-Name = "bob", looking up realm NULL (4) suffix: No such realm "NULL" (4) [suffix] = noop (4) eap: Peer sent code Response (2) ID 4 length 144 (4) eap: Continuing tunnel setup (4) [eap] = ok (4) } # authorize = ok (4) Found Auth-Type = EAP (4) # Executing group from file /etc/freeradius/sites-enabled/default (4) authenticate { (4) eap: Expiring EAP session with state 0xc4f3e4bfc7f7fded (4) eap: Finished EAP session with state 0xc4f3e4bfc7f7fded (4) eap: Previous EAP request found for state 0xc4f3e4bfc7f7fded, released from the list (4) eap: Peer sent method PEAP (25) (4) eap: EAP PEAP (25) (4) eap: Calling eap_peap to process EAP data (4) eap_peap: processing EAP-TLS (4) eap_peap: TLS Length 134 (4) eap_peap: Length Included (4) eap_peap: eaptls_verify returned 11 (4) eap_peap: <<< TLS 1.0 Handshake [length 0046], ClientKeyExchange (4) eap_peap: TLS_accept: SSLv3 read client key exchange A (4) eap_peap: <<< TLS 1.0 ChangeCipherSpec [length 0001] (4) eap_peap: <<< TLS 1.0 Handshake [length 0010], Finished (4) eap_peap: TLS_accept: SSLv3 read finished A (4) eap_peap: >>> TLS 1.0 ChangeCipherSpec [length 0001] (4) eap_peap: TLS_accept: SSLv3 write change cipher spec A (4) eap_peap: >>> TLS 1.0 Handshake [length 0010], Finished (4) eap_peap: TLS_accept: SSLv3 write finished A (4) eap_peap: TLS_accept: SSLv3 flush data SSL: adding session 88047a7836777c91caec026c2987818176f396d62108680d7be0ec280ce6a955 to cache (4) eap_peap: (other): SSL negotiation finished successfully SSL Connection Established (4) eap_peap: eaptls_process returned 13 (4) eap_peap: FR_TLS_HANDLED (4) eap: EAP session adding &reply:State = 0xc4f3e4bfc0f6fded (4) [eap] = handled (4) } # authenticate = handled (4) Using Post-Auth-Type Challenge (4) # Executing group from file /etc/freeradius/sites-enabled/default (4) Sent Access-Challenge Id 52 from 172.21.7.175:1812 to 172.21.7.176:42871 length 123 (4) EAP-Message = 0x01050041190014030100010116030100309f50896699f8ca775023b9ca2f51332ce352d1681fbb18dcc703a8dc155ce7d78238d5df2ba4e5a3d3f41d3f167f39cc (4) Message-Authenticator = 0x00000000000000000000000000000000 (4) State = 0xc4f3e4bfc0f6fdedb35262d2c5aab0d9 (4) Finished request Waking up in 0.5 seconds. (5) Received Access-Request Id 53 from 172.21.7.176:49148 to 172.21.7.175:1812 length 228 (5) Service-Type = Framed-User (5) Framed-MTU = 1400 (5) User-Name = 'bob' (5) State = 0xc4f3e4bfc0f6fdedb35262d2c5aab0d9 (5) NAS-Port-Id = 'wlan1' (5) NAS-Port-Type = Wireless-802.11 (5) Acct-Session-Id = '82000006' (5) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (5) Calling-Station-Id = '44-74-6C-CB-FE-1E' (5) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (5) EAP-Message = 0x020500061900 (5) Message-Authenticator = 0xcdc4f70353c04e75481bef2a720e9a63 (5) NAS-Identifier = 'TestowyMT' (5) NAS-IP-Address = 172.21.7.176 (5) session-state: No cached attributes (5) # Executing section authorize from file /etc/freeradius/sites-enabled/default (5) authorize { (5) policy filter_username { (5) if (!&User-Name) { (5) if (!&User-Name) -> FALSE (5) if (&User-Name =~ / /) { (5) if (&User-Name =~ / /) -> FALSE (5) if (&User-Name =~ /@.*@/ ) { (5) if (&User-Name =~ /@.*@/ ) -> FALSE (5) if (&User-Name =~ /\.\./ ) { (5) if (&User-Name =~ /\.\./ ) -> FALSE (5) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (5) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (5) if (&User-Name =~ /\.$/) { (5) if (&User-Name =~ /\.$/) -> FALSE (5) if (&User-Name =~ /(a)\./) { (5) if (&User-Name =~ /(a)\./) -> FALSE (5) } # policy filter_username = notfound (5) [preprocess] = ok (5) [chap] = noop (5) [mschap] = noop (5) [digest] = noop (5) suffix: Checking for suffix after "@" (5) suffix: No '@' in User-Name = "bob", looking up realm NULL (5) suffix: No such realm "NULL" (5) [suffix] = noop (5) eap: Peer sent code Response (2) ID 5 length 6 (5) eap: Continuing tunnel setup (5) [eap] = ok (5) } # authorize = ok (5) Found Auth-Type = EAP (5) # Executing group from file /etc/freeradius/sites-enabled/default (5) authenticate { (5) eap: Expiring EAP session with state 0xc4f3e4bfc0f6fded (5) eap: Finished EAP session with state 0xc4f3e4bfc0f6fded (5) eap: Previous EAP request found for state 0xc4f3e4bfc0f6fded, released from the list (5) eap: Peer sent method PEAP (25) (5) eap: EAP PEAP (25) (5) eap: Calling eap_peap to process EAP data (5) eap_peap: processing EAP-TLS (5) eap_peap: Received TLS ACK (5) eap_peap: Received TLS ACK (5) eap_peap: ACK handshake is finished (5) eap_peap: eaptls_verify returned 3 (5) eap_peap: eaptls_process returned 3 (5) eap_peap: FR_TLS_SUCCESS (5) eap_peap: Session established. Decoding tunneled attributes (5) eap_peap: PEAP state TUNNEL ESTABLISHED (5) eap: EAP session adding &reply:State = 0xc4f3e4bfc1f5fded (5) [eap] = handled (5) } # authenticate = handled (5) Using Post-Auth-Type Challenge (5) # Executing group from file /etc/freeradius/sites-enabled/default (5) Sent Access-Challenge Id 53 from 172.21.7.175:1812 to 172.21.7.176:49148 length 101 (5) EAP-Message = 0x0106002b19001703010020450aabab255e3952dd3e248e84d684492b174c26a1ec2906b22a8ad21795f58a (5) Message-Authenticator = 0x00000000000000000000000000000000 (5) State = 0xc4f3e4bfc1f5fdedb35262d2c5aab0d9 (5) Finished request Waking up in 0.4 seconds. (6) Received Access-Request Id 54 from 172.21.7.176:48068 to 172.21.7.175:1812 length 302 (6) Service-Type = Framed-User (6) Framed-MTU = 1400 (6) User-Name = 'bob' (6) State = 0xc4f3e4bfc1f5fdedb35262d2c5aab0d9 (6) NAS-Port-Id = 'wlan1' (6) NAS-Port-Type = Wireless-802.11 (6) Acct-Session-Id = '82000006' (6) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (6) Calling-Station-Id = '44-74-6C-CB-FE-1E' (6) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (6) EAP-Message = 0x0206005019001703010020bbf49c5de60dbc5f4d92bf760437c00ec320fada6d06f831c1e20622b8a28e921703010020c3afda2de7ccafce02b9ae264b0f9e878a476f1235b0310d7c65edf07294ea6e (6) Message-Authenticator = 0x8f4b8abc01340495ad3b75e2d7314ef5 (6) NAS-Identifier = 'TestowyMT' (6) NAS-IP-Address = 172.21.7.176 (6) session-state: No cached attributes (6) # Executing section authorize from file /etc/freeradius/sites-enabled/default (6) authorize { (6) policy filter_username { (6) if (!&User-Name) { (6) if (!&User-Name) -> FALSE (6) if (&User-Name =~ / /) { (6) if (&User-Name =~ / /) -> FALSE (6) if (&User-Name =~ /@.*@/ ) { (6) if (&User-Name =~ /@.*@/ ) -> FALSE (6) if (&User-Name =~ /\.\./ ) { (6) if (&User-Name =~ /\.\./ ) -> FALSE (6) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (6) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (6) if (&User-Name =~ /\.$/) { (6) if (&User-Name =~ /\.$/) -> FALSE (6) if (&User-Name =~ /(a)\./) { (6) if (&User-Name =~ /(a)\./) -> FALSE (6) } # policy filter_username = notfound (6) [preprocess] = ok (6) [chap] = noop (6) [mschap] = noop (6) [digest] = noop (6) suffix: Checking for suffix after "@" (6) suffix: No '@' in User-Name = "bob", looking up realm NULL (6) suffix: No such realm "NULL" (6) [suffix] = noop (6) eap: Peer sent code Response (2) ID 6 length 80 (6) eap: Continuing tunnel setup (6) [eap] = ok (6) } # authorize = ok (6) Found Auth-Type = EAP (6) # Executing group from file /etc/freeradius/sites-enabled/default (6) authenticate { (6) eap: Expiring EAP session with state 0xc4f3e4bfc1f5fded (6) eap: Finished EAP session with state 0xc4f3e4bfc1f5fded (6) eap: Previous EAP request found for state 0xc4f3e4bfc1f5fded, released from the list (6) eap: Peer sent method PEAP (25) (6) eap: EAP PEAP (25) (6) eap: Calling eap_peap to process EAP data (6) eap_peap: processing EAP-TLS (6) eap_peap: eaptls_verify returned 7 (6) eap_peap: Done initial handshake (6) eap_peap: eaptls_process returned 7 (6) eap_peap: FR_TLS_OK (6) eap_peap: Session established. Decoding tunneled attributes (6) eap_peap: PEAP state WAITING FOR INNER IDENTITY (6) eap_peap: Identity - bob (6) eap_peap: Got inner identity 'bob' (6) eap_peap: Setting default EAP type for tunneled EAP session (6) eap_peap: Got tunneled request (6) eap_peap: EAP-Message = 0x0206000801626f62 (6) eap_peap: Setting User-Name to bob (6) eap_peap: Sending tunneled request to inner-tunnel (6) eap_peap: EAP-Message = 0x0206000801626f62 (6) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1 (6) eap_peap: User-Name = 'bob' (6) Virtual server received request (6) EAP-Message = 0x0206000801626f62 (6) FreeRADIUS-Proxied-To = 127.0.0.1 (6) User-Name = 'bob' (6) server inner-tunnel { (6) # Executing section authorize from file /etc/freeradius/sites-enabled/inner-tunnel (6) authorize { (6) [chap] = noop (6) [mschap] = noop (6) suffix: Checking for suffix after "@" (6) suffix: No '@' in User-Name = "bob", looking up realm NULL (6) suffix: No such realm "NULL" (6) [suffix] = noop (6) update control { (6) &Proxy-To-Realm := 'LOCAL' (6) } # update control = noop (6) eap: Peer sent code Response (2) ID 6 length 8 (6) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the rest of authorize (6) [eap] = ok (6) } # authorize = ok (6) WARNING: You set Proxy-To-Realm = LOCAL, but the realm does not exist! Cancelling invalid proxy request. (6) Found Auth-Type = EAP (6) # Executing group from file /etc/freeradius/sites-enabled/inner-tunnel (6) authenticate { (6) eap: Peer sent method Identity (1) (6) eap: Calling eap_mschapv2 to process EAP data (6) eap_mschapv2: Issuing Challenge (6) eap: EAP session adding &reply:State = 0x417a42e3417d5897 (6) [eap] = handled (6) } # authenticate = handled (6) } # server inner-tunnel (6) Virtual server sending reply (6) EAP-Message = 0x0107001d1a01070018105c69173875a6dce386f9f3f2a3eb73cb626f62 (6) Message-Authenticator = 0x00000000000000000000000000000000 (6) State = 0x417a42e3417d589754fee2901ab0a5ab (6) eap_peap: Got tunneled reply code 11 (6) eap_peap: EAP-Message = 0x0107001d1a01070018105c69173875a6dce386f9f3f2a3eb73cb626f62 (6) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000 (6) eap_peap: State = 0x417a42e3417d589754fee2901ab0a5ab (6) eap_peap: Got tunneled reply RADIUS code 11 (6) eap_peap: EAP-Message = 0x0107001d1a01070018105c69173875a6dce386f9f3f2a3eb73cb626f62 (6) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000 (6) eap_peap: State = 0x417a42e3417d589754fee2901ab0a5ab (6) eap_peap: Got tunneled Access-Challenge (6) eap: EAP session adding &reply:State = 0xc4f3e4bfc2f4fded (6) [eap] = handled (6) } # authenticate = handled (6) Using Post-Auth-Type Challenge (6) # Executing group from file /etc/freeradius/sites-enabled/default (6) Sent Access-Challenge Id 54 from 172.21.7.175:1812 to 172.21.7.176:48068 length 117 (6) EAP-Message = 0x0107003b19001703010030a33322042f0e83c5d91044bb52646dbee22caff2c1df9738aecdd3e7f2daa98e935cd79459e3136f92ed86c4c19fe675 (6) Message-Authenticator = 0x00000000000000000000000000000000 (6) State = 0xc4f3e4bfc2f4fdedb35262d2c5aab0d9 (6) Finished request Waking up in 0.4 seconds. (7) Received Access-Request Id 55 from 172.21.7.176:39389 to 172.21.7.175:1812 length 350 (7) Service-Type = Framed-User (7) Framed-MTU = 1400 (7) User-Name = 'bob' (7) State = 0xc4f3e4bfc2f4fdedb35262d2c5aab0d9 (7) NAS-Port-Id = 'wlan1' (7) NAS-Port-Type = Wireless-802.11 (7) Acct-Session-Id = '82000006' (7) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (7) Calling-Station-Id = '44-74-6C-CB-FE-1E' (7) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (7) EAP-Message = 0x0207008019001703010020acb0654a85d5f4c4a61c8ce00c007ea6a4cc953d1409392cb02d5b5c81ea65ca1703010050180dc887c8fa3458b796c66b229642e9a5618e3752ff36ee9a3839b1a419a8ea1b1ca1f06a33b61b06570ab0c3c94cba939f8ce4ff0f686943ad1cbfe84aee5f35abef58c6b8b6 (7) Message-Authenticator = 0x19444e36c349d1b30ba89b5791633082 (7) NAS-Identifier = 'TestowyMT' (7) NAS-IP-Address = 172.21.7.176 (7) session-state: No cached attributes (7) # Executing section authorize from file /etc/freeradius/sites-enabled/default (7) authorize { (7) policy filter_username { (7) if (!&User-Name) { (7) if (!&User-Name) -> FALSE (7) if (&User-Name =~ / /) { (7) if (&User-Name =~ / /) -> FALSE (7) if (&User-Name =~ /@.*@/ ) { (7) if (&User-Name =~ /@.*@/ ) -> FALSE (7) if (&User-Name =~ /\.\./ ) { (7) if (&User-Name =~ /\.\./ ) -> FALSE (7) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (7) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (7) if (&User-Name =~ /\.$/) { (7) if (&User-Name =~ /\.$/) -> FALSE (7) if (&User-Name =~ /(a)\./) { (7) if (&User-Name =~ /(a)\./) -> FALSE (7) } # policy filter_username = notfound (7) [preprocess] = ok (7) [chap] = noop (7) [mschap] = noop (7) [digest] = noop (7) suffix: Checking for suffix after "@" (7) suffix: No '@' in User-Name = "bob", looking up realm NULL (7) suffix: No such realm "NULL" (7) [suffix] = noop (7) eap: Peer sent code Response (2) ID 7 length 128 (7) eap: Continuing tunnel setup (7) [eap] = ok (7) } # authorize = ok (7) Found Auth-Type = EAP (7) # Executing group from file /etc/freeradius/sites-enabled/default (7) authenticate { (7) eap: Expiring EAP session with state 0x417a42e3417d5897 (7) eap: Finished EAP session with state 0xc4f3e4bfc2f4fded (7) eap: Previous EAP request found for state 0xc4f3e4bfc2f4fded, released from the list (7) eap: Peer sent method PEAP (25) (7) eap: EAP PEAP (25) (7) eap: Calling eap_peap to process EAP data (7) eap_peap: processing EAP-TLS (7) eap_peap: eaptls_verify returned 7 (7) eap_peap: Done initial handshake (7) eap_peap: eaptls_process returned 7 (7) eap_peap: FR_TLS_OK (7) eap_peap: Session established. Decoding tunneled attributes (7) eap_peap: PEAP state phase2 (7) eap_peap: EAP type MSCHAPv2 (26) (7) eap_peap: Got tunneled request (7) eap_peap: EAP-Message = 0x0207003e1a02070039315849184725258ed58c5f89c92b357e100000000000000000130908b4d20b9dd367f1ccdaf95ed8bd97269b2d794fff0e00626f62 (7) eap_peap: Setting User-Name to bob (7) eap_peap: Sending tunneled request to inner-tunnel (7) eap_peap: EAP-Message = 0x0207003e1a02070039315849184725258ed58c5f89c92b357e100000000000000000130908b4d20b9dd367f1ccdaf95ed8bd97269b2d794fff0e00626f62 (7) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1 (7) eap_peap: User-Name = 'bob' (7) eap_peap: State = 0x417a42e3417d589754fee2901ab0a5ab (7) Virtual server received request (7) EAP-Message = 0x0207003e1a02070039315849184725258ed58c5f89c92b357e100000000000000000130908b4d20b9dd367f1ccdaf95ed8bd97269b2d794fff0e00626f62 (7) FreeRADIUS-Proxied-To = 127.0.0.1 (7) User-Name = 'bob' (7) State = 0x417a42e3417d589754fee2901ab0a5ab (7) server inner-tunnel { (7) session-state: No cached attributes (7) # Executing section authorize from file /etc/freeradius/sites-enabled/inner-tunnel (7) authorize { (7) [chap] = noop (7) [mschap] = noop (7) suffix: Checking for suffix after "@" (7) suffix: No '@' in User-Name = "bob", looking up realm NULL (7) suffix: No such realm "NULL" (7) [suffix] = noop (7) update control { (7) &Proxy-To-Realm := 'LOCAL' (7) } # update control = noop (7) eap: Peer sent code Response (2) ID 7 length 62 (7) eap: No EAP Start, assuming it's an on-going EAP conversation (7) [eap] = updated (7) files: users: Matched entry bob at line 56 (7) [files] = ok (7) [expiration] = noop (7) [logintime] = noop (7) pap: WARNING: Auth-Type already set. Not setting to PAP (7) [pap] = noop (7) } # authorize = updated (7) WARNING: You set Proxy-To-Realm = LOCAL, but the realm does not exist! Cancelling invalid proxy request. (7) Found Auth-Type = EAP (7) # Executing group from file /etc/freeradius/sites-enabled/inner-tunnel (7) authenticate { (7) eap: Expiring EAP session with state 0x417a42e3417d5897 (7) eap: Finished EAP session with state 0x417a42e3417d5897 (7) eap: Previous EAP request found for state 0x417a42e3417d5897, released from the list (7) eap: Peer sent method MSCHAPv2 (26) (7) eap: EAP MSCHAPv2 (26) (7) eap: Calling eap_mschapv2 to process EAP data (7) eap_mschapv2: # Executing group from file /etc/freeradius/sites-enabled/inner-tunnel (7) eap_mschapv2: Auth-Type MS-CHAP { (7) mschap: Found Cleartext-Password, hashing to create NT-Password (7) mschap: Found Cleartext-Password, hashing to create LM-Password (7) mschap: Creating challenge hash with username: bob (7) mschap: Client is using MS-CHAPv2 (7) mschap: Adding MS-CHAPv2 MPPE keys (7) [mschap] = ok (7) } # Auth-Type MS-CHAP = ok (7) MSCHAP Success (7) eap: EAP session adding &reply:State = 0x417a42e340725897 (7) [eap] = handled (7) } # authenticate = handled (7) } # server inner-tunnel (7) Virtual server sending reply (7) Reply-Message = 'Hello bob' (7) EAP-Message = 0x010800331a0307002e533d33424641324344374138453246393746383631334334363638364344383043353243313241314333 (7) Message-Authenticator = 0x00000000000000000000000000000000 (7) State = 0x417a42e34072589754fee2901ab0a5ab (7) eap_peap: Got tunneled reply code 11 (7) eap_peap: Reply-Message = 'Hello bob' (7) eap_peap: EAP-Message = 0x010800331a0307002e533d33424641324344374138453246393746383631334334363638364344383043353243313241314333 (7) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000 (7) eap_peap: State = 0x417a42e34072589754fee2901ab0a5ab (7) eap_peap: Got tunneled reply RADIUS code 11 (7) eap_peap: Reply-Message = 'Hello bob' (7) eap_peap: EAP-Message = 0x010800331a0307002e533d33424641324344374138453246393746383631334334363638364344383043353243313241314333 (7) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000 (7) eap_peap: State = 0x417a42e34072589754fee2901ab0a5ab (7) eap_peap: Got tunneled Access-Challenge (7) eap: EAP session adding &reply:State = 0xc4f3e4bfc3fbfded (7) [eap] = handled (7) } # authenticate = handled (7) Using Post-Auth-Type Challenge (7) # Executing group from file /etc/freeradius/sites-enabled/default (7) Sent Access-Challenge Id 55 from 172.21.7.175:1812 to 172.21.7.176:39389 length 149 (7) EAP-Message = 0x0108005b190017030100503fb24196a0b42341de69299e7ac47b885bd0d7a431cd227123005474b159fbed71797a5e932c2e6e359defd31dfae6ef02cf0ea1f22e2db4cc2fd26227421d32fb609c96af02056d68eb80abcc5e4322 (7) Message-Authenticator = 0x00000000000000000000000000000000 (7) State = 0xc4f3e4bfc3fbfdedb35262d2c5aab0d9 (7) Finished request Waking up in 0.4 seconds. (8) Received Access-Request Id 56 from 172.21.7.176:46845 to 172.21.7.175:1812 length 302 (8) Service-Type = Framed-User (8) Framed-MTU = 1400 (8) User-Name = 'bob' (8) State = 0xc4f3e4bfc3fbfdedb35262d2c5aab0d9 (8) NAS-Port-Id = 'wlan1' (8) NAS-Port-Type = Wireless-802.11 (8) Acct-Session-Id = '82000006' (8) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (8) Calling-Station-Id = '44-74-6C-CB-FE-1E' (8) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (8) EAP-Message = 0x020800501900170301002060eeb413ee721ea5802a17086ba98ce55bb9a97a4f18bd7382b78a43fa150579170301002090a2768752fb9c65a7067db34cda739259a4d91cd2565822b5064b8271673350 (8) Message-Authenticator = 0xecff140a8c31166a095b9055dc689b3e (8) NAS-Identifier = 'TestowyMT' (8) NAS-IP-Address = 172.21.7.176 (8) session-state: No cached attributes (8) # Executing section authorize from file /etc/freeradius/sites-enabled/default (8) authorize { (8) policy filter_username { (8) if (!&User-Name) { (8) if (!&User-Name) -> FALSE (8) if (&User-Name =~ / /) { (8) if (&User-Name =~ / /) -> FALSE (8) if (&User-Name =~ /@.*@/ ) { (8) if (&User-Name =~ /@.*@/ ) -> FALSE (8) if (&User-Name =~ /\.\./ ) { (8) if (&User-Name =~ /\.\./ ) -> FALSE (8) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (8) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (8) if (&User-Name =~ /\.$/) { (8) if (&User-Name =~ /\.$/) -> FALSE (8) if (&User-Name =~ /(a)\./) { (8) if (&User-Name =~ /(a)\./) -> FALSE (8) } # policy filter_username = notfound (8) [preprocess] = ok (8) [chap] = noop (8) [mschap] = noop (8) [digest] = noop (8) suffix: Checking for suffix after "@" (8) suffix: No '@' in User-Name = "bob", looking up realm NULL (8) suffix: No such realm "NULL" (8) [suffix] = noop (8) eap: Peer sent code Response (2) ID 8 length 80 (8) eap: Continuing tunnel setup (8) [eap] = ok (8) } # authorize = ok (8) Found Auth-Type = EAP (8) # Executing group from file /etc/freeradius/sites-enabled/default (8) authenticate { (8) eap: Expiring EAP session with state 0x417a42e340725897 (8) eap: Finished EAP session with state 0xc4f3e4bfc3fbfded (8) eap: Previous EAP request found for state 0xc4f3e4bfc3fbfded, released from the list (8) eap: Peer sent method PEAP (25) (8) eap: EAP PEAP (25) (8) eap: Calling eap_peap to process EAP data (8) eap_peap: processing EAP-TLS (8) eap_peap: eaptls_verify returned 7 (8) eap_peap: Done initial handshake (8) eap_peap: eaptls_process returned 7 (8) eap_peap: FR_TLS_OK (8) eap_peap: Session established. Decoding tunneled attributes (8) eap_peap: PEAP state phase2 (8) eap_peap: EAP type MSCHAPv2 (26) (8) eap_peap: Got tunneled request (8) eap_peap: EAP-Message = 0x020800061a03 (8) eap_peap: Setting User-Name to bob (8) eap_peap: Sending tunneled request to inner-tunnel (8) eap_peap: EAP-Message = 0x020800061a03 (8) eap_peap: FreeRADIUS-Proxied-To = 127.0.0.1 (8) eap_peap: User-Name = 'bob' (8) eap_peap: State = 0x417a42e34072589754fee2901ab0a5ab (8) Virtual server received request (8) EAP-Message = 0x020800061a03 (8) FreeRADIUS-Proxied-To = 127.0.0.1 (8) User-Name = 'bob' (8) State = 0x417a42e34072589754fee2901ab0a5ab (8) server inner-tunnel { (8) session-state: No cached attributes (8) # Executing section authorize from file /etc/freeradius/sites-enabled/inner-tunnel (8) authorize { (8) [chap] = noop (8) [mschap] = noop (8) suffix: Checking for suffix after "@" (8) suffix: No '@' in User-Name = "bob", looking up realm NULL (8) suffix: No such realm "NULL" (8) [suffix] = noop (8) update control { (8) &Proxy-To-Realm := 'LOCAL' (8) } # update control = noop (8) eap: Peer sent code Response (2) ID 8 length 6 (8) eap: No EAP Start, assuming it's an on-going EAP conversation (8) [eap] = updated (8) files: users: Matched entry bob at line 56 (8) [files] = ok (8) [expiration] = noop (8) [logintime] = noop (8) pap: WARNING: Auth-Type already set. Not setting to PAP (8) [pap] = noop (8) } # authorize = updated (8) WARNING: You set Proxy-To-Realm = LOCAL, but the realm does not exist! Cancelling invalid proxy request. (8) Found Auth-Type = EAP (8) # Executing group from file /etc/freeradius/sites-enabled/inner-tunnel (8) authenticate { (8) eap: Expiring EAP session with state 0x417a42e340725897 (8) eap: Finished EAP session with state 0x417a42e340725897 (8) eap: Previous EAP request found for state 0x417a42e340725897, released from the list (8) eap: Peer sent method MSCHAPv2 (26) (8) eap: EAP MSCHAPv2 (26) (8) eap: Calling eap_mschapv2 to process EAP data (8) eap: Freeing handler (8) [eap] = ok (8) } # authenticate = ok (8) # Executing section post-auth from file /etc/freeradius/sites-enabled/inner-tunnel (8) post-auth { ... } # empty sub-section is ignored (8) } # server inner-tunnel (8) Virtual server sending reply (8) Reply-Message = 'Hello bob' (8) MS-MPPE-Encryption-Policy = Encryption-Allowed (8) MS-MPPE-Encryption-Types = RC4-40or128-bit-Allowed (8) MS-MPPE-Send-Key = 0x392845732ba58bc020b95f449b8a46b3 (8) MS-MPPE-Recv-Key = 0x746cab3622d7cd113228b9062486e26d (8) EAP-Message = 0x03080004 (8) Message-Authenticator = 0x00000000000000000000000000000000 (8) User-Name = 'bob' (8) eap_peap: Got tunneled reply code 2 (8) eap_peap: Reply-Message = 'Hello bob' (8) eap_peap: MS-MPPE-Encryption-Policy = Encryption-Allowed (8) eap_peap: MS-MPPE-Encryption-Types = RC4-40or128-bit-Allowed (8) eap_peap: MS-MPPE-Send-Key = 0x392845732ba58bc020b95f449b8a46b3 (8) eap_peap: MS-MPPE-Recv-Key = 0x746cab3622d7cd113228b9062486e26d (8) eap_peap: EAP-Message = 0x03080004 (8) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000 (8) eap_peap: User-Name = 'bob' (8) eap_peap: Got tunneled reply RADIUS code 2 (8) eap_peap: Reply-Message = 'Hello bob' (8) eap_peap: MS-MPPE-Encryption-Policy = Encryption-Allowed (8) eap_peap: MS-MPPE-Encryption-Types = RC4-40or128-bit-Allowed (8) eap_peap: MS-MPPE-Send-Key = 0x392845732ba58bc020b95f449b8a46b3 (8) eap_peap: MS-MPPE-Recv-Key = 0x746cab3622d7cd113228b9062486e26d (8) eap_peap: EAP-Message = 0x03080004 (8) eap_peap: Message-Authenticator = 0x00000000000000000000000000000000 (8) eap_peap: User-Name = 'bob' (8) eap_peap: Tunneled authentication was successful (8) eap_peap: SUCCESS (8) eap: EAP session adding &reply:State = 0xc4f3e4bfccfafded (8) [eap] = handled (8) } # authenticate = handled (8) Using Post-Auth-Type Challenge (8) # Executing group from file /etc/freeradius/sites-enabled/default (8) Sent Access-Challenge Id 56 from 172.21.7.175:1812 to 172.21.7.176:46845 length 101 (8) EAP-Message = 0x0109002b19001703010020ed0b59fd029f430c0cc5c027a628ab6684e1de0b3b45c022d7e0cfc6af831626 (8) Message-Authenticator = 0x00000000000000000000000000000000 (8) State = 0xc4f3e4bfccfafdedb35262d2c5aab0d9 (8) Finished request Waking up in 0.4 seconds. (9) Received Access-Request Id 57 from 172.21.7.176:60330 to 172.21.7.175:1812 length 302 (9) Service-Type = Framed-User (9) Framed-MTU = 1400 (9) User-Name = 'bob' (9) State = 0xc4f3e4bfccfafdedb35262d2c5aab0d9 (9) NAS-Port-Id = 'wlan1' (9) NAS-Port-Type = Wireless-802.11 (9) Acct-Session-Id = '82000006' (9) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (9) Calling-Station-Id = '44-74-6C-CB-FE-1E' (9) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (9) EAP-Message = 0x0209005019001703010020278cd1d8ac7bf5750cd93ddd81d3d056797dd3b238067805a259804788144bba1703010020c054d0df79af2d6e999abb6b54b5257643676501fbe27e88a53ab6cc420b2a55 (9) Message-Authenticator = 0xce89d4ac76e87606f41cc2cbea3be379 (9) NAS-Identifier = 'TestowyMT' (9) NAS-IP-Address = 172.21.7.176 (9) session-state: No cached attributes (9) # Executing section authorize from file /etc/freeradius/sites-enabled/default (9) authorize { (9) policy filter_username { (9) if (!&User-Name) { (9) if (!&User-Name) -> FALSE (9) if (&User-Name =~ / /) { (9) if (&User-Name =~ / /) -> FALSE (9) if (&User-Name =~ /@.*@/ ) { (9) if (&User-Name =~ /@.*@/ ) -> FALSE (9) if (&User-Name =~ /\.\./ ) { (9) if (&User-Name =~ /\.\./ ) -> FALSE (9) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) { (9) if ((&User-Name =~ /@/) && (&User-Name !~ /(a)(.+)\.(.+)$/)) -> FALSE (9) if (&User-Name =~ /\.$/) { (9) if (&User-Name =~ /\.$/) -> FALSE (9) if (&User-Name =~ /(a)\./) { (9) if (&User-Name =~ /(a)\./) -> FALSE (9) } # policy filter_username = notfound (9) [preprocess] = ok (9) [chap] = noop (9) [mschap] = noop (9) [digest] = noop (9) suffix: Checking for suffix after "@" (9) suffix: No '@' in User-Name = "bob", looking up realm NULL (9) suffix: No such realm "NULL" (9) [suffix] = noop (9) eap: Peer sent code Response (2) ID 9 length 80 (9) eap: Continuing tunnel setup (9) [eap] = ok (9) } # authorize = ok (9) Found Auth-Type = EAP (9) # Executing group from file /etc/freeradius/sites-enabled/default (9) authenticate { (9) eap: Expiring EAP session with state 0xc4f3e4bfccfafded (9) eap: Finished EAP session with state 0xc4f3e4bfccfafded (9) eap: Previous EAP request found for state 0xc4f3e4bfccfafded, released from the list (9) eap: Peer sent method PEAP (25) (9) eap: EAP PEAP (25) (9) eap: Calling eap_peap to process EAP data (9) eap_peap: processing EAP-TLS (9) eap_peap: eaptls_verify returned 7 (9) eap_peap: Done initial handshake (9) eap_peap: eaptls_process returned 7 (9) eap_peap: FR_TLS_OK (9) eap_peap: Session established. Decoding tunneled attributes (9) eap_peap: PEAP state send tlv success (9) eap_peap: Received EAP-TLV response (9) eap_peap: Success (9) eap_peap: No information to cache: session caching will be disabled for session 88047a7836777c91caec026c2987818176f396d62108680d7be0ec280ce6a955 SSL: Removing session 88047a7836777c91caec026c2987818176f396d62108680d7be0ec280ce6a955 from the cache (9) eap: Freeing handler (9) [eap] = ok (9) } # authenticate = ok (9) # Executing section post-auth from file /etc/freeradius/sites-enabled/default (9) post-auth { (9) update { (9) No attributes updated (9) } # update = noop (9) [exec] = noop (9) policy remove_reply_message_if_eap { (9) if (&reply:EAP-Message && &reply:Reply-Message) { (9) if (&reply:EAP-Message && &reply:Reply-Message) -> FALSE (9) else { (9) [noop] = noop (9) } # else = noop (9) } # policy remove_reply_message_if_eap = noop (9) } # post-auth = noop (9) Sent Access-Accept Id 57 from 172.21.7.175:1812 to 172.21.7.176:60330 length 165 (9) MS-MPPE-Recv-Key = 0xb9a80a16e33bfa56255cc45926a3afb71049b04b65612db3dc81b228fc2d8caf (9) MS-MPPE-Send-Key = 0x5d015cad6056016965c40b04d7ea49dfbab33b9c481022b6c9192cdb87c50a71 (9) EAP-Message = 0x03090004 (9) Message-Authenticator = 0x00000000000000000000000000000000 (9) User-Name = 'bob' (9) Finished request Waking up in 0.4 seconds. (10) Received Accounting-Request Id 58 from 172.21.7.176:57439 to 172.21.7.175:1813 length 196 (10) Service-Type = Framed-User (10) NAS-Port-Id = 'wlan1' (10) NAS-Port-Type = Wireless-802.11 (10) User-Name = 'bob' (10) Acct-Session-Id = '82000006' (10) Acct-Multi-Session-Id = '00-02-6F-46-BD-CE-44-74-6C-CB-FE-1E-82-00-00-00-00-00-00-03' (10) Calling-Station-Id = '44-74-6C-CB-FE-1E' (10) Called-Station-Id = '00-02-6F-46-BD-CE:Tescior' (10) Acct-Authentic = RADIUS (10) Acct-Status-Type = Start (10) NAS-Identifier = 'TestowyMT' (10) Acct-Delay-Time = 0 (10) NAS-IP-Address = 172.21.7.176 (10) # Executing section preacct from file /etc/freeradius/sites-enabled/default (10) preacct { (10) [preprocess] = ok (10) policy acct_unique { (10) if ("%{string:Class}" =~ /ai:([0-9a-f]{32})/i) { (10) EXPAND %{string:Class} (10) --> (10) if ("%{string:Class}" =~ /ai:([0-9a-f]{32})/i) -> FALSE (10) else { (10) update request { (10) EXPAND %{md5:%{User-Name},%{Acct-Session-ID},%{%{NAS-IPv6-Address}:-%{NAS-IP-Address}},%{NAS-Identifier},%{NAS-Port-ID},%{NAS-Port}} (10) --> be69e6f225273d282cbd87711747ad0d (10) &Acct-Unique-Session-Id := "be69e6f225273d282cbd87711747ad0d" (10) } # update request = noop (10) } # else = noop (10) } # policy acct_unique = noop (10) suffix: Checking for suffix after "@" (10) suffix: No '@' in User-Name = "bob", looking up realm NULL (10) suffix: No such realm "NULL" (10) [suffix] = noop (10) [files] = noop (10) } # preacct = ok (10) # Executing section accounting from file /etc/freeradius/sites-enabled/default (10) accounting { (10) detail: EXPAND /var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d (10) detail: --> /var/log/freeradius/radacct/172.21.7.176/detail-20150327 (10) detail: /var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/freeradius/radacct/172.21.7.176/detail-20150327 (10) detail: EXPAND %t (10) detail: --> Fri Mar 27 10:03:40 2015 (10) [detail] = ok (10) [unix] = ok (10) [exec] = noop (10) attr_filter.accounting_response: EXPAND %{User-Name} (10) attr_filter.accounting_response: --> bob (10) attr_filter.accounting_response: Matched entry DEFAULT at line 15 (10) [attr_filter.accounting_response] = updated (10) } # accounting = updated (10) Sent Accounting-Response Id 58 from 172.21.7.175:1813 to 172.21.7.176:57439 length 20 (10) Finished request Waking up in 0.4 seconds. (10) <done>: Cleaning up request packet ID 58 with timestamp +31 Waking up in 4.0 seconds. (0) <done>: Cleaning up request packet ID 48 with timestamp +30 (1) <done>: Cleaning up request packet ID 49 with timestamp +30 (2) <done>: Cleaning up request packet ID 50 with timestamp +31 (3) <done>: Cleaning up request packet ID 51 with timestamp +31 (4) <done>: Cleaning up request packet ID 52 with timestamp +31 (5) <done>: Cleaning up request packet ID 53 with timestamp +31 (6) <done>: Cleaning up request packet ID 54 with timestamp +31 (7) <done>: Cleaning up request packet ID 55 with timestamp +31 (8) <done>: Cleaning up request packet ID 56 with timestamp +31 (9) <done>: Cleaning up request packet ID 57 with timestamp +31 Ready to process requests #v- Warnings: (6) WARNING: You set Proxy-To-Realm = LOCAL, but the realm does not exist! Cancelling invalid proxy request. (8) pap: WARNING: Auth-Type already set. Not setting to PAP (8) WARNING: You set Proxy-To-Realm = LOCAL, but the realm does not exist! Cancelling invalid proxy request. Should I worry about it? Freeradius config is defalult, like OutOfBox -- Best Regards Nicram

2 5

synchronize accounting
by Marcin 27 Mar '15

27 Mar '15

Hi, I'm testing freeradius 2.1 from debian stable. I'd like to set two independent serwer with the same configuration but the problem is with synchronize active sessions radutmp. I use simultaneous-use = 1. So if first server is broken client won't be able to authorise :/ How can I achieve synchronized two servers with active sessions? I don't want to using sql database to avoind problems with other servers, daemons. -- Pozdrawiam Marcin / nicraM

4 12

How to use rewrite.called_station_id IN dynamic clients authorize section
by James Wood 26 Mar '15

26 Mar '15

Hi, We use dynamic clients + sql for our authentication of NAS devices. We also use rlm_raw because we cannot auth on the IP Address (because of not knowing all the dynamic IP's clients are coming from), so we auth on the Called-Station-Id value. In normal circumstances this works beautifully, but when we have a NAS that sends the Called-Station-Id value as AABBCCDDEEFF with no colon or hyphen, auth fails, because in our SQL database we store the MAC like AA-BB-CC-DD-EE-FF. I already use SQL to replace colon with hyphen, but I am struggling with if it has no delimiter at all. For this particular NAS client, there is no way to change the format of the Called-Station-Id value it is sending so I need something on the FreeRadius side. I tried using the rewrite.called_station_id module from policy.conf and whilst it does not error it doesn't rewrite the incoming Called-Station-Id to the format I require. Here is my dynamic clients file: client dymamic { ... } server dynamic_client_server { authorize { #Test to see if our required raw attribute exists if("%{raw:Called-Station-Id}"){ rewrite.called_station_id #Test to see if it is in the DB if ("%{sql: select count(*) from nas where community=REPLACE(SUBSTRING(\"%{Called-Station-Id}\",1,17),\":\",\"-\")}" == 1) { update control { ... } ok } } } } I suspect it's a problem because we are using raw:Called-Station-Id because before auth Called-Station-Id itself is not accessible. Is it possible to just have a rewrite block in the authorize section of dynamic clients so it can rewrite the raw value there? Thank you, James

7 20

Help PLease
by Adam Schappell 26 Mar '15

26 Mar '15

I need some help getting my freeradius server up and running. For some reason all the tests pass but when I login to wifi I get invalid credentials. Im stuck! Thanks, Adam Schappell System Administrator II Clearedge IT Solutions, LLC 10620 Guilford Road Jessup, MD 20794 Office:443-212-4712 Fax:443-212-4809 www.ClearEdgeIT.com <http://www.clearedgeit.com/>

5 17

Performance Problems ntlm_auth <-> Active Directory under heavy load
by tom greisch 26 Mar '15

26 Mar '15

Hi together, Yesterday i have compiled Freeradius 2.2.6 and configured for ntlm_auth against an Active Directory. Everything seems ok. After testing i have redirected our WLAN Controller (with thousands of Clients) to the new Radius Server and the Server was overloaded immediately. (By the way our old Microsoft NPS Server had no Problem with the Load!). So i activated the Logging for Samba an i got this: ---------------------------------------------------- [2015/03/18 16:59:50.848834, 0] ../source3/lib/util.c:896(log_stack_trace) BACKTRACE: 21 stack frames: #0 /usr/lib/x86_64-linux-gnu/libsmbconf.so.0(log_stack_trace+0x1a) [0x7f60a79bb2ca] #1 /usr/lib/x86_64-linux-gnu/libsmbconf.so.0(smb_panic_s3+0x20) [0x7f60a79bb3b0] #2 /usr/lib/x86_64-linux-gnu/libsamba-util.so.0(smb_panic+0x2f) [0x7f60abce5caf] #3 /usr/lib/x86_64-linux-gnu/libsamba-util.so.0(+0x1cecf) [0x7f60abce5ecf] #4 /lib/x86_64-linux-gnu/libpthread.so.0(+0xf8d0) [0x7f60ac1158d0] #5 /usr/lib/x86_64-linux-gnu/samba/liblibcli_netlogon3.so.0(rpccli_netlogon_sam_network_logon+0x154) [0x7f60a99c52a4] #6 /usr/sbin/winbindd(+0x48fd3) [0x7f60ac58efd3] #7 /usr/sbin/winbindd(winbindd_dual_pam_auth_crap+0x2d8) [0x7f60ac592938] #8 /usr/sbin/winbindd(+0x5fd5c) [0x7f60ac5a5d5c] #9 /usr/lib/x86_64-linux-gnu/libtevent.so.0(+0x92cb) [0x7f60a5a162cb] #10 /usr/lib/x86_64-linux-gnu/libtevent.so.0(+0x7797) [0x7f60a5a14797] #11 /usr/lib/x86_64-linux-gnu/libtevent.so.0(_tevent_loop_once+0x8d) [0x7f60a5a10f9d] #12 /usr/sbin/winbindd(+0x620d8) [0x7f60ac5a80d8] #13 /usr/sbin/winbindd(+0x627d5) [0x7f60ac5a87d5] #14 /usr/lib/x86_64-linux-gnu/libtevent.so.0(tevent_common_loop_immediate+0xd4) [0x7f60a5a117c4] #15 /usr/lib/x86_64-linux-gnu/libtevent.so.0(+0x908e) [0x7f60a5a1608e] #16 /usr/lib/x86_64-linux-gnu/libtevent.so.0(+0x7797) [0x7f60a5a14797] #17 /usr/lib/x86_64-linux-gnu/libtevent.so.0(_tevent_loop_once+0x8d) [0x7f60a5a10f9d] #18 /usr/sbin/winbindd(main+0xad4) [0x7f60ac56b024] #19 /lib/x86_64-linux-gnu/libc.so.6(__libc_start_main+0xf5) [0x7f60a5685b45] #20 /usr/sbin/winbindd(+0x25699) [0x7f60ac56b699] [2015/03/18 16:59:50.853758, 0] ../source3/lib/util.c:797(smb_panic_s3) smb_panic(): calling panic action [/usr/share/samba/panic-action 4754] [2015/03/18 16:59:50.859870, 0] ../source3/lib/util.c:805(smb_panic_s3) smb_panic(): action returned status 0 [2015/03/18 16:59:50.860457, 0] ../source3/lib/dumpcore.c:317(dump_core) dumping core in /var/log/samba/cores/winbindd--------------------------------------------------------------------------------- At this Point its clear, that it is not a Freeradius Problem. Its a Samba Problem! I am lucky because i found a BUG Report at the Samba Site released onyl few Days ago (2015-03-10). The Problem persists for more than one Year. The BUG is: https://bugzilla.samba.org/show_bug.cgi?id=11149 The Bug Report says that you have to start Freeradius with the "-t" Option to disable Threads because Samba 4.1.X is not able to handle threads. So we have to hope that samba 4.2 will fix the Problem. Until that, i decided to clone the Radius Server twice , start with "-t" Flag and set a "Freeradius Loadbalancer" bevor the "Worker Radius Server". Now i can handle the Load ! I think more people will have the same Problem as me... So i decided to write here... System Info: ----------------------------- Debian 8 (Jessie) Samba version 4.1.17-Debian Freeradius Version 2.2.6 -----------------------------

6 9

Any precedence in proxy.conf?
by Stefan Paetow 26 Mar '15

26 Mar '15

Hi Alan et al, Just a quick question: Is there a precedence in realm lookups between dynamic and static realms? I'm happy to experiment, just thought I'd ask. Stefan Paetow Moonshot Industry & Research Liaison Coordinator t: +44 (0)1235 822 125 gpg: 0x3FCE5142 xmpp: stefanp(a)jabber.dev.ja.net skype: stefan.paetow.janet jisc.ac.uk Jisc is a registered charity (number 1149740) and a company limited by guarantee which is registered in England under Company No. 5747339, VAT No. GB 197 0632 86. Jisc¹s registered office is: One Castlepark, Tower Hill, Bristol, BS2 0JA. T 0203 697 5800. Jisc Collections and Janet Ltd. is a wholly owned Jisc subsidiary and a company limited by guarantee which is registered in England under Company No. number 2881024, VAT No. GB 197 0632 86. The registered office is: Lumen House, Library Avenue, Harwell, Didcot, Oxfordshire, OX11 0SG. T 01235 822200.

4 6

How to use reference instead of printing attribute
by Castel, Nicolas 26 Mar '15

26 Mar '15

Hi, We currently use 3.0.x version of freeRADIUS. I try to follow recommendations found in unlang man concerning use of attribute references. Extract from man: "We recommend using attribute references instead of printing attributes to a string, e.g. (User-Name == "%{Filter-Id}"). Attribute references will be faster and more efficient." It seems not to work correctly with my configuration. An example of debug which works with printing of attribute: (2) } # if ("%{proxy-reply:Packet-Type}" == "Access-Accept") = ok (2) if ("%{proxy-reply:Packet-Type}" == "Access-Challenge") { (2) EXPAND %{proxy-reply:Packet-Type} (2) --> Access-Accept (2) if ("%{proxy-reply:Packet-Type}" == "Access-Challenge") -> FALSE (2) } # post-proxy = ok Corresponding configuration: if ("%{proxy-reply:Packet-Type}" == "Access-Challenge") { The same example using reference which do not work: (2) } # if ("%{proxy-reply:Packet-Type}" == "Access-Accept") = ok (2) if (&proxy-reply:Packet-Type == "Access-Challenge") { (2) ERROR: Failed retrieving values required to evaluate condition (2) } # post-proxy = ok Corresponding configuration: if (&proxy-reply:Packet-Type == "Access-Challenge") { Another test using directly integer value (2) } # if ("%{proxy-reply:Packet-Type}" == "Access-Accept") = ok (2) if (&proxy-reply:Packet-Type == 11) { (2) ERROR: Failed retrieving values required to evaluate condition (2) } # post-proxy = ok Corresponding configuration: if (&proxy-reply:Packet-Type == 11) { Same thing using following configuration: (2) if (&proxy-reply:Packet-Type == Access-Challenge) { (2) ERROR: Failed retrieving values required to evaluate condition Is there some limitations using references ? Weird thing is that reference works with Auth-Type attribute used in another place in my configuration: (6) if (&control:Auth-Type == WIFI-GW-Auth) { (6) if (&control:Auth-Type == WIFI-GW-Auth) -> TRUE Corresponding configuration: if (&control:Auth-Type == WIFI-GW-Auth) { Thanks for help. Nicolas Castel This message contains information that may be privileged or confidential and is the property of the Capgemini Group. It is intended only for the person to whom it is addressed. If you are not the intended recipient, you are not authorized to read, print, retain, copy, disseminate, distribute, or use this message or any part thereof. If you receive this message in error, please notify the sender immediately and delete all copies of this message.

3 3

testing tools
by Marcin 25 Mar '15

25 Mar '15

Hi, what are the possibilities to test radius without proper equipment (switch)? I'd like to use freeradius for Dell switches to authorise (802.1x) clients with their mac. radtest can't send eap messages. Is there any programs to test it? -- Pozdrawiam Marcin / nicraM

5 9

rlm_python and threading
by Andrew Parisio 25 Mar '15

25 Mar '15

I'm working with rlm_python in FreeRadius 2.2.6 and with 20 simultaneous eapol_test threads running I was only getting 5-6 requests/second. This got me wondering how FreeRadius and rlm_python handle threading. So to make sure it wasn't related to my database calls or anything else I wrote a simple radiusd_module.py with no external dependencies/calls that instantly returned OK and it was handling 275 requests/second. Now I'm doubting my requests are being processed in parallel so I modified my radiusd_module.py to have a 1 second sleep between starting to process a request and returning OK. The module looks something like this: import radiusd import time def instantiate(p): # do something return 0 def array_to_dict(array): my_dict = {} for t in array: # strip any quotes off of the beginning & end my_dict[t[0]] = t[1].lstrip('"').rstrip('"') return my_dict def post_auth(p): my_dict = array_to_dict(p) print "***** Start %s" % my_dict['NAS-Port-Id'] time.sleep(1) print "***** End %s" % my_dict['NAS-Port-Id'] return radiusd.RLM_MODULE_OK Then I set two copies of eapol_test in an infinite loop sending NAS-Port-Id's of 1 and 2 so I could see what radius.log looked like. The hypothesis being if it's properly threaded I should get this: ***** Start 1 ***** Start 2 ==== Pause 1 second ***** End 1 ***** End 2 ... repeat I ran the the two eapol_test threads against radius and the output looks like this: tail radius.log -f | grep "\*\*\*\*\*" ***** Start 1 ==== Pause 1 second <-- not output, just a literal 1 second wait from time.sleep() ***** End 1 ***** Start 2 ==== Pause 1 second <-- not output, just a literal 1 second wait from time.sleep() ***** End 2 .... and so on, >From this I can see that requests handled by rlm_python are being served by a single thread rather than multiple/parallel threads. Does anybody have any experience with rlm_python.py and/or know what I might be doing wrong? Thanks! Andrew P.S. Latency from my development machine at my desk to Dynamodb in AWS is ~80ms, **which won't be the case for prod**, which is why I was only getting 5-6 requests/second. but I'd still like to be able to handle hundreds of requests/s per production host (obviously the hosts will need to be sized appropriately).

3 2