- Freeradius-Users - lists.freeradius.org

FreeRadius v3.0.25 Radsec
by Emile Swarts 17 Mar '22

17 Mar '22

Hi, We've upgraded FreeRadius from version 3.0.10 to 3.0.25 and this has broken Radsec (but not EAP-TLS). The error message from the server is: (0) (TLS) OpenSSL says that the TLS session is still negotiating, but there's no more data to send! Did a packet capture to try and spot the differences and can see that the server is sending RST packets to the client after Server Hello Done. Previously this would proceed to the handshake phase. The new version of openssl is: OpenSSL 1.1.1n 15 Mar 2022 (Library: OpenSSL 1.1.1l 24 Aug 2021) Any advice on how to debug this would be appreciated. FreeRADIUS Version 3.0.25 Copyright (C) 1999-2021 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/raddb/dictionary including configuration file /etc/raddb/radiusd.conf including files in directory /etc/raddb/mods-enabled/ including configuration file /etc/raddb/mods-enabled/soh including configuration file /etc/raddb/mods-enabled/ntlm_auth including configuration file /etc/raddb/mods-enabled/cache_eap including configuration file /etc/raddb/mods-enabled/always including configuration file /etc/raddb/mods-enabled/python3 including configuration file /etc/raddb/mods-enabled/mschap including configuration file /etc/raddb/mods-enabled/echo including configuration file /etc/raddb/mods-enabled/passwd including configuration file /etc/raddb/mods-enabled/files including configuration file /etc/raddb/mods-enabled/utf8 including configuration file /etc/raddb/mods-enabled/pap including configuration file /etc/raddb/mods-enabled/radutmp including configuration file /etc/raddb/mods-enabled/realm including configuration file /etc/raddb/mods-enabled/date including configuration file /etc/raddb/mods-enabled/expiration including configuration file /etc/raddb/mods-enabled/unix including configuration file /etc/raddb/mods-enabled/unpack including configuration file /etc/raddb/mods-enabled/logintime including configuration file /etc/raddb/mods-enabled/attr_filter including configuration file /etc/raddb/mods-enabled/eap including configuration file /etc/raddb/mods-enabled/detail including configuration file /etc/raddb/mods-enabled/dynamic_clients including configuration file /etc/raddb/mods-enabled/digest including configuration file /etc/raddb/mods-enabled/detail.log including configuration file /etc/raddb/mods-enabled/expr including configuration file /etc/raddb/mods-enabled/replicate including configuration file /etc/raddb/mods-enabled/chap including configuration file /etc/raddb/mods-enabled/preprocess including configuration file /etc/raddb/mods-enabled/sradutmp including configuration file /etc/raddb/mods-enabled/linelog including configuration file /etc/raddb/mods-enabled/totp including configuration file /etc/raddb/mods-enabled/exec including files in directory /etc/raddb/policy.d/ including configuration file /etc/raddb/policy.d/cui including configuration file /etc/raddb/policy.d/rfc7542 including configuration file /etc/raddb/policy.d/dhcp including configuration file /etc/raddb/policy.d/control including configuration file /etc/raddb/policy.d/filter including configuration file /etc/raddb/policy.d/accounting including configuration file /etc/raddb/policy.d/eap including configuration file /etc/raddb/policy.d/operator-name including configuration file /etc/raddb/policy.d/debug including configuration file /etc/raddb/policy.d/abfab-tr including configuration file /etc/raddb/policy.d/canonicalization including configuration file /etc/raddb/policy.d/moonshot-targeted-ids including files in directory /etc/raddb/sites-enabled/ including configuration file /etc/raddb/sites-enabled/default including configuration file /etc/raddb/sites-enabled/radsec including configuration file /etc/raddb/clients.conf main { security { allow_core_dumps = no } name = "radiusd" prefix = "/usr" localstatedir = "/var" logdir = "/var/log/radius" run_dir = "/var/run/radiusd" } main { name = "radiusd" prefix = "/usr" localstatedir = "/var" sbindir = "/usr/sbin" logdir = "/var/log/radius" run_dir = "/var/run/radiusd" libdir = "/usr/lib/freeradius" radacctdir = "/var/log/radius/radacct" hostname_lookups = no max_request_time = 30 cleanup_delay = 5 max_requests = 204800 postauth_client_lost = no pidfile = "/var/run/radiusd/radiusd.pid" checkrad = "/usr/sbin/checkrad" debug_level = 0 proxy_requests = no log { stripped_names = no auth = no auth_badpass = no auth_goodpass = no msg_denied = "You are already logged in - access denied" } resources { } security { max_attributes = 200 reject_delay = 1.000000 status_server = yes allow_vulnerable_openssl = "no" } } radiusd: #### Loading Realms and Home Servers #### radiusd: #### Loading Clients #### client test_client { ipaddr = 10.5.0.6 require_message_authenticator = no secret = <<< secret >>> shortname = "test_client" limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } Found debugger attached # Creating Auth-Type = eap radiusd: #### Instantiating modules #### modules { # Loaded module rlm_soh # Loading module "soh" from file /etc/raddb/mods-enabled/soh soh { dhcp = yes } # Loaded module rlm_exec # Loading module "ntlm_auth" from file /etc/raddb/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 } # Loaded module rlm_cache # Loading module "cache_eap" from file /etc/raddb/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 } # Loaded module rlm_always # Loading module "reject" from file /etc/raddb/mods-enabled/always always reject { rcode = "reject" simulcount = 0 mpp = no } # Loading module "fail" from file /etc/raddb/mods-enabled/always always fail { rcode = "fail" simulcount = 0 mpp = no } # Loading module "ok" from file /etc/raddb/mods-enabled/always always ok { rcode = "ok" simulcount = 0 mpp = no } # Loading module "handled" from file /etc/raddb/mods-enabled/always always handled { rcode = "handled" simulcount = 0 mpp = no } # Loading module "invalid" from file /etc/raddb/mods-enabled/always always invalid { rcode = "invalid" simulcount = 0 mpp = no } # Loading module "userlock" from file /etc/raddb/mods-enabled/always always userlock { rcode = "userlock" simulcount = 0 mpp = no } # Loading module "notfound" from file /etc/raddb/mods-enabled/always always notfound { rcode = "notfound" simulcount = 0 mpp = no } # Loading module "noop" from file /etc/raddb/mods-enabled/always always noop { rcode = "noop" simulcount = 0 mpp = no } # Loading module "updated" from file /etc/raddb/mods-enabled/always always updated { rcode = "updated" simulcount = 0 mpp = no } # Loaded module rlm_python3 # Loading module "python3" from file /etc/raddb/mods-enabled/python3 python3 { mod_post_auth = "policyengine" func_post_auth = "post_auth" python_path = "/etc/raddb/mods-config/python3" cext_compat = yes pass_all_vps = no pass_all_vps_dict = no } # Loaded module rlm_mschap # Loading module "mschap" from file /etc/raddb/mods-enabled/mschap mschap { use_mppe = yes require_encryption = no require_strong = no with_ntdomain_hack = yes passchange { } allow_retry = yes winbind_retry_with_normalised_username = no } # Loading module "echo" from file /etc/raddb/mods-enabled/echo exec echo { wait = yes program = "/bin/echo %{User-Name}" input_pairs = "request" output_pairs = "reply" shell_escape = yes } # Loaded module rlm_passwd # Loading module "etc_passwd" from file /etc/raddb/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 } # Loaded module rlm_files # Loading module "authorized_macs" from file /etc/raddb/mods-enabled/files files authorized_macs { usersfile = "/etc/raddb/authorised_macs" key = "%{Calling-Station-ID}" } # Loaded module rlm_utf8 # Loading module "utf8" from file /etc/raddb/mods-enabled/utf8 # Loaded module rlm_pap # Loading module "pap" from file /etc/raddb/mods-enabled/pap pap { normalise = yes } # Loaded module rlm_radutmp # Loading module "radutmp" from file /etc/raddb/mods-enabled/radutmp radutmp { filename = "/var/log/radius/radutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes permissions = 384 caller_id = yes } # Loaded module rlm_realm # Loading module "IPASS" from file /etc/raddb/mods-enabled/realm realm IPASS { format = "prefix" delimiter = "/" ignore_default = no ignore_null = no } # Loading module "suffix" from file /etc/raddb/mods-enabled/realm realm suffix { format = "suffix" delimiter = "@" ignore_default = no ignore_null = no } # Loading module "bangpath" from file /etc/raddb/mods-enabled/realm realm bangpath { format = "prefix" delimiter = "!" ignore_default = no ignore_null = no } # Loading module "realmpercent" from file /etc/raddb/mods-enabled/realm realm realmpercent { format = "suffix" delimiter = "%" ignore_default = no ignore_null = no } # Loading module "ntdomain" from file /etc/raddb/mods-enabled/realm realm ntdomain { format = "prefix" delimiter = "\\" ignore_default = no ignore_null = no } # Loaded module rlm_date # Loading module "date" from file /etc/raddb/mods-enabled/date date { format = "%b %e %Y %H:%M:%S %Z" utc = no } # Loading module "wispr2date" from file /etc/raddb/mods-enabled/date date wispr2date { format = "%Y-%m-%dT%H:%M:%S" utc = no } # Loaded module rlm_expiration # Loading module "expiration" from file /etc/raddb/mods-enabled/expiration # Loaded module rlm_unix # Loading module "unix" from file /etc/raddb/mods-enabled/unix unix { radwtmp = "/var/log/radius/radwtmp" } Creating attribute Unix-Group # Loaded module rlm_unpack # Loading module "unpack" from file /etc/raddb/mods-enabled/unpack # Loaded module rlm_logintime # Loading module "logintime" from file /etc/raddb/mods-enabled/logintime logintime { minimum_timeout = 60 } # Loaded module rlm_attr_filter # Loading module "attr_filter.post-proxy" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.post-proxy { filename = "/etc/raddb/mods-config/attr_filter/post-proxy" key = "%{Realm}" relaxed = no } # Loading module "attr_filter.pre-proxy" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.pre-proxy { filename = "/etc/raddb/mods-config/attr_filter/pre-proxy" key = "%{Realm}" relaxed = no } # Loading module "attr_filter.access_reject" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.access_reject { filename = "/etc/raddb/mods-config/attr_filter/access_reject" key = "%{User-Name}" relaxed = no } # Loading module "attr_filter.access_challenge" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.access_challenge { filename = "/etc/raddb/mods-config/attr_filter/access_challenge" key = "%{User-Name}" relaxed = no } # Loading module "attr_filter.accounting_response" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.accounting_response { filename = "/etc/raddb/mods-config/attr_filter/accounting_response" key = "%{User-Name}" relaxed = no } # Loading module "attr_filter.coa" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.coa { filename = "/etc/raddb/mods-config/attr_filter/coa" key = "%{User-Name}" relaxed = no } # Loaded module rlm_eap # Loading module "eap" from file /etc/raddb/mods-enabled/eap eap eap { default_eap_type = "ttls" timer_expire = 60 ignore_unknown_eap_types = yes cisco_accounting_username_bug = no max_sessions = 204800 } # Loaded module rlm_detail # Loading module "detail" from file /etc/raddb/mods-enabled/detail detail { filename = "/var/log/radius/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_dynamic_clients # Loading module "dynamic_clients" from file /etc/raddb/mods-enabled/dynamic_clients # Loaded module rlm_digest # Loading module "digest" from file /etc/raddb/mods-enabled/digest # Loading module "auth_log" from file /etc/raddb/mods-enabled/detail.log detail auth_log { filename = "/var/log/radius/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 } # Loading module "reply_log" from file /etc/raddb/mods-enabled/detail.log detail reply_log { filename = "/var/log/radius/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 } # Loading module "pre_proxy_log" from file /etc/raddb/mods-enabled/detail.log detail pre_proxy_log { filename = "/var/log/radius/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 } # Loading module "post_proxy_log" from file /etc/raddb/mods-enabled/detail.log detail post_proxy_log { filename = "/var/log/radius/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_expr # Loading module "expr" from file /etc/raddb/mods-enabled/expr expr { safe_characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /äéöüàâæçèéêëîïôœùûüaÿÄÉÖÜßÀÂÆÇÈÉÊËÎÏÔŒÙÛÜŸ" } # Loaded module rlm_replicate # Loading module "replicate" from file /etc/raddb/mods-enabled/replicate # Loaded module rlm_chap # Loading module "chap" from file /etc/raddb/mods-enabled/chap # Loaded module rlm_preprocess # Loading module "preprocess" from file /etc/raddb/mods-enabled/preprocess preprocess { huntgroups = "/etc/raddb/mods-config/preprocess/huntgroups" hints = "/etc/raddb/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 } # Loading module "sradutmp" from file /etc/raddb/mods-enabled/sradutmp radutmp sradutmp { filename = "/var/log/radius/sradutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes permissions = 420 caller_id = no } # Loaded module rlm_linelog # Loading module "linelog" from file /etc/raddb/mods-enabled/linelog linelog { filename = "/var/log/radius/linelog" escape_filenames = no syslog_severity = "info" permissions = 384 format = "This is a log message for %{User-Name}" reference = "messages.%{%{reply:Packet-Type}:-default}" } # Loading module "log_accounting" from file /etc/raddb/mods-enabled/linelog linelog log_accounting { filename = "/var/log/radius/linelog-accounting" escape_filenames = no syslog_severity = "info" permissions = 384 format = "" reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}" } # Loaded module rlm_totp # Loading module "totp" from file /etc/raddb/mods-enabled/totp # Loading module "exec" from file /etc/raddb/mods-enabled/exec exec { wait = no input_pairs = "request" shell_escape = yes timeout = 10 } # Instantiating module "cache_eap" from file /etc/raddb/mods-enabled/cache_eap rlm_cache (cache_eap): Driver rlm_cache_rbtree (module rlm_cache_rbtree) loaded and linked # Instantiating module "reject" from file /etc/raddb/mods-enabled/always # Instantiating module "fail" from file /etc/raddb/mods-enabled/always # Instantiating module "ok" from file /etc/raddb/mods-enabled/always # Instantiating module "handled" from file /etc/raddb/mods-enabled/always # Instantiating module "invalid" from file /etc/raddb/mods-enabled/always # Instantiating module "userlock" from file /etc/raddb/mods-enabled/always # Instantiating module "notfound" from file /etc/raddb/mods-enabled/always # Instantiating module "noop" from file /etc/raddb/mods-enabled/always # Instantiating module "updated" from file /etc/raddb/mods-enabled/always # Instantiating module "python3" from file /etc/raddb/mods-enabled/python3 Python version: 3.9.7 (default, Nov 24 2021, 21:15:59) [GCC 10.3.1 20211027] # Instantiating module "mschap" from file /etc/raddb/mods-enabled/mschap rlm_mschap (mschap): using internal authentication # Instantiating module "etc_passwd" from file /etc/raddb/mods-enabled/passwd rlm_passwd: nfields: 3 keyfield 0(User-Name) listable: no # Instantiating module "authorized_macs" from file /etc/raddb/mods-enabled/files reading pairlist file /etc/raddb/authorised_macs # Instantiating module "pap" from file /etc/raddb/mods-enabled/pap # Instantiating module "IPASS" from file /etc/raddb/mods-enabled/realm # Instantiating module "suffix" from file /etc/raddb/mods-enabled/realm # Instantiating module "bangpath" from file /etc/raddb/mods-enabled/realm # Instantiating module "realmpercent" from file /etc/raddb/mods-enabled/realm # Instantiating module "ntdomain" from file /etc/raddb/mods-enabled/realm # Instantiating module "expiration" from file /etc/raddb/mods-enabled/expiration # Instantiating module "logintime" from file /etc/raddb/mods-enabled/logintime # Instantiating module "attr_filter.post-proxy" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/post-proxy # Instantiating module "attr_filter.pre-proxy" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/pre-proxy # Instantiating module "attr_filter.access_reject" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/access_reject # Instantiating module "attr_filter.access_challenge" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/access_challenge # Instantiating module "attr_filter.accounting_response" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/accounting_response # Instantiating module "attr_filter.coa" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/coa # Instantiating module "eap" from file /etc/raddb/mods-enabled/eap # Linked to sub-module rlm_eap_tls tls { } TLS section "tls" missing, trying to use legacy configuration tls { verify_depth = 0 ca_path = "/etc/raddb/certs" pem_file_type = yes private_key_file = "/etc/raddb/certs/server.pem" certificate_file = "/etc/raddb/certs/server.pem" private_key_password = <<< secret >>> dh_file = "/etc/raddb/certs/dh" random_file = "/dev/random" fragment_size = 1024 include_length = yes auto_chain = no check_crl = no check_all_crl = no ca_path_reload_interval = 0 cipher_list = "HIGH" require_client_cert = yes reject_unknown_intermediate_ca = no ecdh_curve = "prime256v1" tls_max_version = "1.2" tls_min_version = "1.2" cache { enable = no lifetime = 24 max_entries = 255 } verify { skip_if_ocsp_ok = no tmpdir = "/tmp/radiusd" client = "/usr/bin/openssl verify -verbose -CApath /etc/raddb/certs %{TLS-Client-Cert-Filename}" } ocsp { enable = yes override_cert_url = yes url = "http://www.example.com:80" use_nonce = yes timeout = 0 softfail = no } } # Linked to sub-module rlm_eap_ttls ttls { default_eap_type = "tls" copy_request_to_tunnel = yes use_tunneled_reply = yes virtual_server = "default" include_length = yes require_client_cert = no } TLS section "tls" missing, trying to use legacy configuration tls: Using cached TLS configuration from previous invocation # Linked to sub-module rlm_eap_md5 # Instantiating module "detail" from file /etc/raddb/mods-enabled/detail # Instantiating module "auth_log" from file /etc/raddb/mods-enabled/detail.log rlm_detail (auth_log): 'User-Password' suppressed, will not appear in detail output # Instantiating module "reply_log" from file /etc/raddb/mods-enabled/detail.log # Instantiating module "pre_proxy_log" from file /etc/raddb/mods-enabled/detail.log # Instantiating module "post_proxy_log" from file /etc/raddb/mods-enabled/detail.log # Instantiating module "preprocess" from file /etc/raddb/mods-enabled/preprocess reading pairlist file /etc/raddb/mods-config/preprocess/huntgroups reading pairlist file /etc/raddb/mods-config/preprocess/hints # Instantiating module "linelog" from file /etc/raddb/mods-enabled/linelog # Instantiating module "log_accounting" from file /etc/raddb/mods-enabled/linelog } # modules radiusd: #### Loading Virtual Servers #### server { # from file /etc/raddb/radiusd.conf } # server server default { # from file /etc/raddb/sites-enabled/default # Loading authenticate {...} # Loading authorize {...} # Loading post-auth {...} } # server default server radsec { # from file /etc/raddb/sites-enabled/radsec # Loading authenticate {...} # Loading authorize {...} # Loading post-auth {...} } # server radsec thread pool { start_servers = 5 max_servers = 32 min_spare_servers = 3 max_spare_servers = 10 max_requests_per_server = 0 cleanup_delay = 5 max_queue_size = 65536 } Thread spawned new child 1. Total threads in pool: 1 Thread 1 waiting to be assigned a request Thread spawned new child 2. Total threads in pool: 2 Thread 2 waiting to be assigned a request Thread 3 waiting to be assigned a request Thread spawned new child 3. Total threads in pool: 3 Thread spawned new child 4. Total threads in pool: 4 Thread spawned new child 5. Total threads in pool: 5 Thread pool initialized radiusd: #### Opening IP addresses and Ports #### Thread 5 waiting to be assigned a request Thread 4 waiting to be assigned a request listen { type = "auth" ipaddr = * port = 1812 limit { max_connections = 64 lifetime = 10 idle_timeout = 30 } Setting idle_timeout to 0 } listen { type = "auth" ipaddr = * port = 2083 proto = "tcp" tls { verify_depth = 0 ca_path = "/etc/raddb/certs/radsec" pem_file_type = yes private_key_file = "/etc/raddb/certs/radsec/server.pem" certificate_file = "/etc/raddb/certs/radsec/server.pem" private_key_password = <<< secret >>> dh_file = "/etc/raddb/certs/dh" random_file = "/dev/random" fragment_size = 1024 include_length = yes auto_chain = yes check_crl = no check_all_crl = no ca_path_reload_interval = 0 cipher_list = "DEFAULT@SECLEVEL=1" require_client_cert = yes reject_unknown_intermediate_ca = no ecdh_curve = "prime256v1" tls_max_version = "1.3" tls_min_version = "1.2" cache { enable = no lifetime = 24 max_entries = 255 } verify { skip_if_ocsp_ok = no tmpdir = "/tmp/radiusd" client = "/usr/bin/openssl verify -verbose -CApath /etc/raddb/certs/radsec %{TLS-Client-Cert-Filename}" } ocsp { enable = no override_cert_url = no use_nonce = yes timeout = 0 softfail = no } } check_client_connections = no limit { max_connections = 16 lifetime = 0 idle_timeout = 180 } clients = "radsec" client radsecproxy { ipaddr = 10.5.0.8 netmask = 32 require_message_authenticator = no secret = <<< secret >>> shortname = "radsec_server" proto = "tls" limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } } Regards, Emile

2 1

copy accounting packet to multiple servers
by gaurav p 17 Mar '22

17 Mar '22

Hi Everyone Hope all is well! I am trying to copy the accounting packet to multiple servers. I am able to copy on two servers but when I use the 3rd server then it is inconsistent. time sends packets on two servers some time only on one server. i am Configuration Listening on detail file /opt/aaa3/var/log/radius/radacct/detail* as server copy-acct-to-home-server Listening on detail file /opt/aaa3/var/log/radius/radacct/detail* as server copy-acct-to-home-server3 Listening on detail file /opt/aaa3/var/log/radius/radacct/detail* as server copy-acct-to-home-server2 update control { #Home-Server-Name := "radius2" (It is also not working) Proxy-To-Realm := example.com } i have added above config in all copy-acct-to-home-server with different realm name 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 = 172.16.1.121 port = 1813 type = "acct" secret = <<< secret >>> response_window = 20.000000 response_timeouts = 1 max_outstanding = 65536 zombie_period = 40 status_check = "status-server" ping_interval = 30 check_interval = 30 check_timeout = 4 num_answers_to_alive = 3 revive_interval = 120 username = "bob" password = "bob" limit { max_connections = 16 max_requests = 0 lifetime = 0 idle_timeout = 0 } coa { irt = 2 mrt = 16 mrc = 5 mrd = 30 } } home_server secondserver { ipaddr = 172.16.1.121 port = 1818 type = "acct" secret = <<< secret >>> response_window = 20.000000 response_timeouts = 1 max_outstanding = 65536 zombie_period = 40 status_check = "status-server" ping_interval = 30 check_interval = 30 check_timeout = 4 num_answers_to_alive = 3 revive_interval = 120 limit { max_connections = 16 max_requests = 0 lifetime = 0 idle_timeout = 0 } coa { irt = 2 mrt = 16 mrc = 5 mrd = 30 } } home_server thirdserver { ipaddr = 172.16.1.121 port = 1815 type = "acct" secret = <<< secret >>> response_window = 20.000000 response_timeouts = 1 max_outstanding = 65536 zombie_period = 40 status_check = "status-server" ping_interval = 30 check_interval = 30 check_timeout = 4 num_answers_to_alive = 3 revive_interval = 120 limit { max_connections = 16 max_requests = 0 lifetime = 0 idle_timeout = 0 } coa { irt = 2 mrt = 16 mrc = 5 mrd = 30 } } home_server_pool secondserver_pool { type = fail-over home_server = secondserver } realm second.com { acct_pool = secondserver_pool } home_server_pool thirdserver_pool { type = fail-over home_server = thirdserver } realm third.com { acct_pool = thirdserver_pool } home_server_pool my_auth_failover { type = fail-over home_server = localhost } realm example.com { acct_pool = my_auth_failover } Output logs detail (/opt/aaa3/var/log/radius/radacct/detail): Detail listener state unopened waiting 1.028538 sec (12) Received Accounting-Request Id 23 from 127.0.0.1:60425 to 127.0.0.1:1816 length 191 (12) Filter-Id = "plan" (12) User-Name = "testing" (12) Acct-Session-Id = "259" (12) Service-Type = Login-User (12) Calling-Station-Id = "00:0c:29:e0:85:43" (12) Acct-Input-Gigawords = 0 (12) Acct-Output-Gigawords = 0 (12) Acct-Input-Octets = 0 (12) Acct-Output-Octets = 0 (12) Acct-Session-Time = 19 (12) NAS-Port-Id = "cpeth1" (12) NAS-Port = 1 (12) Acct-Authentic = RADIUS (12) NAS-Port-Type = 50 (12) Called-Station-Id = "00:0c:29:53:fb:2c" (12) Acct-Terminate-Cause = User-Request (12) Event-Timestamp = "Mar 6 2022 11:46:51 IST" (12) NAS-Identifier = "radiustest" (12) NAS-IP-Address = 172.16.1.87 (12) Calling-Station-Id = "testing" (12) Framed-IP-Address = 10.100.100.2 (12) Acct-Status-Type = Stop (12) # Executing section preacct from file /opt/aaa3/etc/raddb/sites-enabled/default (12) preacct { (12) [preprocess] = ok (12) policy acct_unique { (12) update request { (12) &Tmp-String-9 := "ai:" (12) } # update request = noop (12) if (("%{hex:&Class}" =~ /^%{hex:&Tmp-String-9}/) && ("%{string:&Class}" =~ /^ai:([0-9a-f]{32})/i)) { (12) EXPAND %{hex:&Class} (12) --> (12) EXPAND ^%{hex:&Tmp-String-9} (12) --> ^61693a (12) if (("%{hex:&Class}" =~ /^%{hex:&Tmp-String-9}/) && ("%{string:&Class}" =~ /^ai:([0-9a-f]{32})/i)) -> FALSE (12) else { (12) update request { (12) EXPAND %{md5:%{User-Name},%{Acct-Session-ID},%{%{NAS-IPv6-Address}:-%{NAS-IP-Address}},%{NAS-Identifier},%{NAS-Port-ID},%{NAS-Port}} (12) --> 5bd47cbf1411cd31bd1e801d746e319e (12) &Acct-Unique-Session-Id := 5bd47cbf1411cd31bd1e801d746e319e (12) } # update request = noop (12) } # else = noop (12) } # policy acct_unique = noop (12) suffix: Checking for suffix after "@" (12) suffix: No '@' in User-Name = "testing", looking up realm NULL (12) suffix: No such realm "NULL" (12) [suffix] = noop (12) [files] = noop (12) } # preacct = ok (12) # Executing section accounting from file /opt/aaa3/etc/raddb/sites-enabled/default (12) accounting { (12) detail: EXPAND /opt/aaa3/var/log/radius/radacct/detail (12) detail: --> /opt/aaa3/var/log/radius/radacct/detail (12) detail: /opt/aaa3/var/log/radius/radacct/detail expands to /opt/aaa3/var/log/radius/radacct/detail (12) detail: EXPAND %t (12) detail: --> Sun Mar 6 11:46:55 2022 (12) [detail] = ok (12) [unix] = ok (12) [exec] = noop (12) attr_filter.accounting_response: EXPAND %{User-Name} (12) attr_filter.accounting_response: --> testing (12) attr_filter.accounting_response: Matched entry DEFAULT at line 12 (12) [attr_filter.accounting_response] = updated (12) } # accounting = updated (12) Sent Accounting-Response Id 23 from 127.0.0.1:1816 to 127.0.0.1:60425 length 0 (12) Finished request (12) Cleaning up request packet ID 23 with timestamp +490 Ready to process requests detail (/opt/aaa3/var/log/radius/radacct/detail): Polling for detail file detail (/opt/aaa3/var/log/radius/radacct/detail): Renaming /opt/aaa3/var/log/radius/radacct/detail -> /opt/aaa3/var/log/radius/radacct/ detail.work detail (/opt/aaa3/var/log/radius/radacct/detail): Read packet from /opt/aaa3/var/log/radius/radacct/detail.work Filter-Id = "plan" User-Name = "testing" Acct-Session-Id = "259" Service-Type = Login-User Calling-Station-Id = "00:0c:29:e0:85:43" Acct-Input-Gigawords = 0 Acct-Output-Gigawords = 0 Acct-Input-Octets = 0 Acct-Output-Octets = 0 Acct-Session-Time = 19 NAS-Port-Id = "cpeth1" NAS-Port = 1 Acct-Authentic = RADIUS NAS-Port-Type = 50 Called-Station-Id = "00:0c:29:53:fb:2c" Acct-Terminate-Cause = User-Request Event-Timestamp = "Mar 6 2022 11:46:51 IST" NAS-Identifier = "radiustest" NAS-IP-Address = 172.16.1.87 Calling-Station-Id = "testing" Framed-IP-Address = 10.100.100.2 Acct-Status-Type = Stop Tmp-String-9 = "ai:" Acct-Unique-Session-Id = "5bd47cbf1411cd31bd1e801d746e319e" Packet-Original-Timestamp = "Mar 6 2022 11:46:55 IST" Acct-Delay-Time = 5 Packet-Transmit-Counter = 1 (13) # Executing section preacct from file /opt/aaa3/etc/raddb/sites-enabled/copy-acct-to-home-server3 (13) preacct { (13) [preprocess] = ok (13) update control { (13) Proxy-To-Realm := third.com (13) } # update control = noop (13) [files] = noop (13) } # preacct = ok (13) # Executing section accounting from file /opt/aaa3/etc/raddb/sites-enabled/copy-acct-to-home-server3 (13) accounting { (13) [ok] = ok (13) } # accounting = ok (13) Starting proxy to home server 172.16.1.121 port 1815 (13) server copy-acct-to-home-server3 { (13) } (13) Proxying request to home server 172.16.1.121 port 1815 timeout 20.000000 Waking up in 0.3 seconds. (13) Clearing existing &reply: attributes (13) server copy-acct-to-home-server3 { (13) } (13) detail (/opt/aaa3/var/log/radius/radacct/detail): Done Accounting-Request packet. (13) Finished request (13) Cleaning up request packet ID 2 with timestamp +491 Ready to process requests detail (/opt/aaa3/var/log/radius/radacct/detail): Read packet from /opt/aaa3/var/log/radius/radacct/detail.work Filter-Id = "PlanAg" User-Name = "testing" Acct-Session-Id = "259" Service-Type = Login-User Calling-Station-Id = "00:0c:29:e0:85:43" Acct-Input-Gigawords = 0 Acct-Output-Gigawords = 0 Acct-Input-Octets = 0 Acct-Output-Octets = 0 Acct-Session-Time = 19 NAS-Port-Id = "cpeth1" NAS-Port = 1 Acct-Authentic = RADIUS NAS-Port-Type = 50 Called-Station-Id = "00:0c:29:53:fb:2c" Acct-Terminate-Cause = User-Request Event-Timestamp = "Mar 6 2022 11:46:51 IST" NAS-Identifier = "radiustest" NAS-IP-Address = 172.16.1.87 Calling-Station-Id = "testing" Framed-IP-Address = 10.100.100.2 Acct-Status-Type = Stop Tmp-String-9 = "ai:" Acct-Unique-Session-Id = "5bd47cbf1411cd31bd1e801d746e319e" Packet-Original-Timestamp = "Mar 6 2022 11:46:55 IST" Acct-Delay-Time = 5 Packet-Transmit-Counter = 1 (14) # Executing section preacct from file /opt/aaa3/etc/raddb/sites-enabled/copy-acct-to-home-server (14) preacct { (14) [preprocess] = ok (14) update control { (14) Proxy-To-Realm := example.com (14) } # update control = noop (14) [files] = noop (14) } # preacct = ok (14) # Executing section accounting from file /opt/aaa3/etc/raddb/sites-enabled/copy-acct-to-home-server (14) accounting { (14) [ok] = ok (14) } # accounting = ok (14) Starting proxy to home server 172.16.1.121 port 1813 (14) server copy-acct-to-home-server { (14) } (14) Proxying request to home server 172.16.1.121 port 1813 timeout 20.000000 Waking up in 0.3 seconds. (14) Clearing existing &reply: attributes (14) server copy-acct-to-home-server { (14) } (14) detail (/opt/aaa3/var/log/radius/radacct/detail): Done Accounting-Request packet. (14) Finished request (14) Cleaning up request packet ID 3 with timestamp +491 Ready to process requests Can anyone please help thanks & regards gaurav

2 3

Suggestion for error message verbosity improvement
by Stefan Winter 16 Mar '22

16 Mar '22

Hello, Regarding this message in radius.log: Info: Dropping packet without response because of error: Received packet from A.B.C.D with invalid Message-Authenticator! (Shared secret is incorrect.) I would like to suggest to include the name of the client stanza that received the packet. This makes it easier to identify the source in some scenarios. In my case, on a server that has many virtual servers, each listening on individual ports, with overlapping client subnet definitions (i.e. the server's port number that was contacted is important to identify the listen config; something which the client name would give away). Alternatively, adding just the port number that the packet was received on would also be sufficient. I suggest the client name by preference because that makes the reporting in line with other errors (e.g. "Login incorrect (Home Server failed to respond): [abc] (from client CLIENTS_61783_5-20..." IOW, it would be nice if the error message above could read Info: Dropping packet without response because of error: Received packet from A.B.C.D with invalid Message-Authenticator! *(from client CLIENTS_61783_5-20)* (Shared secret is incorrect.) or Info: Dropping packet without response because of error: Received packet from A.B.C.D *on port 61783* with invalid Message-Authenticator! (Shared secret is incorrect.) Greetings, Stefan Winter -- This email may contain information for limited distribution only, please treat accordingly. Fondation Restena, Stefan WINTER Chief Technology Officer 2, avenue de l'Université L-4365 Esch-sur-Alzette

2 1

FreeRADIUS (packetfence) - Azure AD - Authentication - Regarding
by P.Thirunavukkarasu 16 Mar '22

16 Mar '22

Hi all, I learned a lot with the support of the users mailing list My environment is FreeRADIUS (Packetfence) running with the Azure AD Configured the Azure AD for the application packetfence. This is the O/P of the the FreeRADIUS server --------------------- } # policy rewrite_called_station_id = updated (0) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (0) EXPAND %{client:shortname} (0) --> 172.16.20.210/32 (0) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (0) policy filter_username { (0) if (&User-Name) { (0) if (&User-Name) -> TRUE (0) if (&User-Name) { (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) } # if (&User-Name) = updated (0) } # policy filter_username = updated (0) policy filter_password { (0) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (0) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (0) } # policy filter_password = updated (0) [preprocess] = ok (0) [mschap] = noop (0) suffix: Checking for suffix after "@" (0) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (0) suffix: Found realm "tanuvas.edu.in" (0) suffix: Adding Stripped-User-Name = "" (0) suffix: Adding Realm = "tanuvas.edu.in" (0) suffix: Authentication realm is LOCAL (0) [suffix] = ok (0) ntdomain: Request already has destination realm set. Ignoring (0) [ntdomain] = noop (0) eap: Peer sent EAP Response (code 2) ID 2 length 20 (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 /usr/local/pf/raddb/sites-enabled/packetfence (0) authenticate { (0) eap: Peer sent packet with method EAP Identity (1) (0) eap: Calling submodule eap_peap to process data (0) eap_peap: (TLS) Initiating new session (0) eap: Sending EAP Request (code 1) ID 3 length 6 (0) eap: EAP session adding &reply:State = 0xc7239dc8c720845a (0) [eap] = handled (0) } # authenticate = handled (0) Using Post-Auth-Type Challenge (0) Post-Auth-Type sub-section not found. Ignoring. (0) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (0) session-state: Saving cached attributes (0) Framed-MTU = 994 (0) Sent Access-Challenge Id 61 from 172.16.11.10:1812 to 172.16.20.210:57049 length 64 (0) EAP-Message = 0x010300061920 (0) Message-Authenticator = 0x00000000000000000000000000000000 (0) State = 0xc7239dc8c720845ac7ab04a38861e476 (0) Finished request Thread 1 waiting to be assigned a request Threads: total/active/spare threads = 3/0/3 Waking up in 0.3 seconds. Thread 2 got semaphore Thread 2 handling request 1, (1 handled so far) (1) Received Access-Request Id 62 from 172.16.20.210:57049 to 172.16.11.10:1812 length 221 (1) User-Name = "@tanuvas.edu.in" (1) NAS-IP-Address = 172.16.20.210 (1) NAS-Port = 0 (1) NAS-Identifier = "172.16.20.101" (1) NAS-Port-Type = Wireless-802.11 (1) Calling-Station-Id = "706655fca6f1" (1) Called-Station-Id = "b83a5ac71008" (1) Service-Type = Framed-User (1) Framed-MTU = 1100 (1) EAP-Message = 0x020300060315 (1) State = 0xc7239dc8c720845ac7ab04a38861e476 (1) Aruba-Essid-Name = "TANUVAS" (1) Aruba-Location-Id = "CECONDS" (1) Aruba-AP-Group = "MVC_AcademicAP_VC" (1) Aruba-Device-Type = "NOFP" (1) Message-Authenticator = 0xbcc9ecdc45d8912c7c26adf13026d1c9 (1) Restoring &session-state (1) &session-state:Framed-MTU = 994 (1) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence (1) authorize { (1) policy packetfence-nas-ip-address { (1) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (1) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (1) } # policy packetfence-nas-ip-address = notfound (1) update { (1) EXPAND %{Packet-Src-IP-Address} (1) --> 172.16.20.210 (1) &request:FreeRADIUS-Client-IP-Address := 172.16.20.210 (1) EXPAND %{Packet-Dst-IP-Address} (1) --> 172.16.11.10 (1) &request:PacketFence-Radius-Ip := 172.16.11.10 (1) &control:PacketFence-RPC-Server = 127.0.0.1 (1) &control:PacketFence-RPC-Port = 7070 (1) &control:PacketFence-RPC-User = (1) &control:PacketFence-RPC-Pass = '' (1) &control:PacketFence-RPC-Proto = http (1) EXPAND %l (1) --> 1647449682 (1) &control:Tmp-Integer-0 := 1647449682 (1) &control:PacketFence-Request-Time := 0 (1) } # update = noop (1) policy packetfence-set-realm-if-machine { (1) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (1) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (1) } # policy packetfence-set-realm-if-machine = noop (1) policy packetfence-balanced-key-policy { (1) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) { (1) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) -> FALSE (1) else { (1) update { (1) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (1) --> 676ae0f0be13d41f008250df0c25be53 (1) &request:PacketFence-KeyBalanced := 676ae0f0be13d41f008250df0c25be53 (1) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (1) --> 676ae0f0be13d41f008250df0c25be53 (1) &control:Load-Balance-Key := 676ae0f0be13d41f008250df0c25be53 (1) } # update = noop (1) } # else = noop (1) } # policy packetfence-balanced-key-policy = noop (1) policy packetfence-set-tenant-id { (1) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (1) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (1) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (1) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (1) --> 0 (1) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (1) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (1) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (1) EXPAND %{request:Called-Station-Id} (1) --> b83a5ac71008 (1) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (1) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (1) update control { rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (1) EXPAND %{User-Name} (1) --> @tanuvas.edu.in (1) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (1) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (1) (1) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (1) --> 0 (1) &PacketFence-Tenant-Id = 0 (1) } # update control = noop (1) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (1) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (1) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (1) --> 0 (1) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (1) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (1) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) (1) EXPAND %{User-Name} (1) --> @tanuvas.edu.in (1) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (1) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (2) (1) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (1) --> 1 (1) &PacketFence-Tenant-Id = 1 (1) } # update control = noop (1) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (1) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (1) if ( &control:PacketFence-Tenant-Id == 0 ) { (1) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (1) if ( &control:PacketFence-Tenant-Id == 0 ) { (1) update control { rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) (1) EXPAND %{User-Name} (1) --> @tanuvas.edu.in (1) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (1) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (2) (1) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (1) --> 1 (1) &PacketFence-Tenant-Id := 1 (1) } # update control = noop (1) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (1) } # policy packetfence-set-tenant-id = noop (1) policy rewrite_calling_station_id { (1) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (1) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> TRUE (1) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (1) update request { (1) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (1) --> 70:66:55:fc:a6:f1 (1) &Calling-Station-Id := 70:66:55:fc:a6:f1 (1) } # update request = noop (1) [updated] = updated (1) } # if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) = updated (1) ... skipping else: Preceding "if" was taken (1) } # policy rewrite_calling_station_id = updated (1) policy rewrite_called_station_id { (1) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (1) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (1) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (1) update request { (1) &Called-Station-Id !* ANY (1) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (1) --> b8:3a:5a:c7:10:08 (1) &Called-Station-Id := b8:3a:5a:c7:10:08 (1) } # update request = noop (1) if ("%{8}") { (1) EXPAND %{8} (1) --> (1) if ("%{8}") -> FALSE (1) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (1) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (1) elsif (Aruba-Essid-Name) { (1) elsif (Aruba-Essid-Name) -> TRUE (1) elsif (Aruba-Essid-Name) { (1) update request { (1) EXPAND %{Aruba-Essid-Name} (1) --> TANUVAS (1) &Called-Station-SSID := TANUVAS (1) } # update request = noop (1) } # elsif (Aruba-Essid-Name) = noop (1) ... skipping elsif: Preceding "if" was taken (1) [updated] = updated (1) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (1) ... skipping else: Preceding "if" was taken (1) } # policy rewrite_called_station_id = updated (1) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (1) EXPAND %{client:shortname} (1) --> 172.16.20.210/32 (1) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (1) policy filter_username { (1) if (&User-Name) { (1) if (&User-Name) -> TRUE (1) if (&User-Name) { (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) } # if (&User-Name) = updated (1) } # policy filter_username = updated (1) policy filter_password { (1) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (1) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (1) } # policy filter_password = updated (1) [preprocess] = ok (1) [mschap] = noop (1) suffix: Checking for suffix after "@" (1) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (1) suffix: Found realm "tanuvas.edu.in" (1) suffix: Adding Stripped-User-Name = "" (1) suffix: Adding Realm = "tanuvas.edu.in" (1) suffix: Authentication realm is LOCAL (1) [suffix] = ok (1) ntdomain: Request already has destination realm set. Ignoring (1) [ntdomain] = noop (1) eap: Peer sent EAP Response (code 2) ID 3 length 6 (1) eap: No EAP Start, assuming it's an on-going EAP conversation (1) [eap] = updated (1) if ( !EAP-Message && "%{%{Control:Auth-type}:-No-MS_CHAP}" != "MS-CHAP") { (1) if ( !EAP-Message && "%{%{Control:Auth-type}:-No-MS_CHAP}" != "MS-CHAP") -> FALSE (1) if ("%{%{Control:Auth-type}:-No-MS_CHAP}" == "MS-CHAP") { (1) EXPAND %{%{Control:Auth-type}:-No-MS_CHAP} (1) --> eap (1) if ("%{%{Control:Auth-type}:-No-MS_CHAP}" == "MS-CHAP") -> FALSE (1) policy packetfence-eap-mac-policy { (1) if ( &EAP-Type ) { (1) if ( &EAP-Type ) -> TRUE (1) if ( &EAP-Type ) { (1) if (&User-Name && (&User-Name =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (1) if (&User-Name && (&User-Name =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> FALSE (1) } # if ( &EAP-Type ) = updated (1) [noop] = noop (1) } # policy packetfence-eap-mac-policy = updated (1) * pap: WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!(1) pap: WARNING: !!! Ignoring control:User-Password. Update your !!!(1) pap: WARNING: !!! configuration so that the "known good" clear text !!!(1) pap: WARNING: !!! password is in Cleartext-Password and NOT in !!!(1) pap: WARNING: !!! User-Password. !!!(1) pap: WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!* Not doing PAP as Auth-Type is already set. (1) [pap] = noop (1) } # authorize = updated (1) Found Auth-Type = eap (1) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (1) authenticate { (1) eap: Expiring EAP session with state 0xc7239dc8c720845a (1) eap: Finished EAP session with state 0xc7239dc8c720845a (1) eap: Previous EAP request found for state 0xc7239dc8c720845a, released from the list (1) eap: Peer sent packet with method EAP NAK (3) (1) eap: Found mutually acceptable type TTLS (21) (1) eap: Calling submodule eap_ttls to process data (1) eap_ttls: (TLS) Initiating new session (1) eap: Sending EAP Request (code 1) ID 4 length 6 (1) eap: EAP session adding &reply:State = 0xc7239dc8c627885a (1) [eap] = handled (1) } # authenticate = handled (1) Using Post-Auth-Type Challenge (1) Post-Auth-Type sub-section not found. Ignoring. (1) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (1) session-state: Saving cached attributes (1) Framed-MTU = 994 (1) Sent Access-Challenge Id 62 from 172.16.11.10:1812 to 172.16.20.210:57049 length 64 (1) EAP-Message = 0x010400061520 (1) Message-Authenticator = 0x00000000000000000000000000000000 (1) State = 0xc7239dc8c627885ac7ab04a38861e476 (1) Finished request Thread 2 waiting to be assigned a request Waking up in 0.2 seconds. Thread 3 got semaphore Thread 3 handling request 2, (1 handled so far) (2) Received Access-Request Id 63 from 172.16.20.210:57049 to 172.16.11.10:1812 length 387 (2) User-Name = "@tanuvas.edu.in" (2) NAS-IP-Address = 172.16.20.210 (2) NAS-Port = 0 (2) NAS-Identifier = "172.16.20.101" (2) NAS-Port-Type = Wireless-802.11 (2) Calling-Station-Id = "706655fca6f1" (2) Called-Station-Id = "b83a5ac71008" (2) Service-Type = Framed-User (2) Framed-MTU = 1100 (2) EAP-Message = 0x020400ac1580000000a2160303009d0100009903036231ca9a72f5c07f0ade35438b2f397936b99ab972e37955c1a24cfce5ae3ef900002ac02cc02bc030c02f009f009ec024c023c028c027c00ac009c014c013009d009c003d003c0035002f000a01000046000500050100000000000a00080006001d00170018000b00020100000d001a00180804080508060401050102010403050302030202060106030023000000170000ff01000100 (2) State = 0xc7239dc8c627885ac7ab04a38861e476 (2) Aruba-Essid-Name = "TANUVAS" (2) Aruba-Location-Id = "CECONDS" (2) Aruba-AP-Group = "MVC_AcademicAP_VC" (2) Aruba-Device-Type = "NOFP" (2) Message-Authenticator = 0x145b706d2f82d33aabdf94b983a619bf (2) Restoring &session-state (2) &session-state:Framed-MTU = 994 (2) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence (2) authorize { (2) policy packetfence-nas-ip-address { (2) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (2) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (2) } # policy packetfence-nas-ip-address = notfound (2) update { (2) EXPAND %{Packet-Src-IP-Address} (2) --> 172.16.20.210 (2) &request:FreeRADIUS-Client-IP-Address := 172.16.20.210 (2) EXPAND %{Packet-Dst-IP-Address} (2) --> 172.16.11.10 (2) &request:PacketFence-Radius-Ip := 172.16.11.10 (2) &control:PacketFence-RPC-Server = 127.0.0.1 (2) &control:PacketFence-RPC-Port = 7070 (2) &control:PacketFence-RPC-User = (2) &control:PacketFence-RPC-Pass = '' (2) &control:PacketFence-RPC-Proto = http (2) EXPAND %l (2) --> 1647449682 (2) &control:Tmp-Integer-0 := 1647449682 (2) &control:PacketFence-Request-Time := 0 (2) } # update = noop (2) policy packetfence-set-realm-if-machine { (2) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (2) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (2) } # policy packetfence-set-realm-if-machine = noop (2) policy packetfence-balanced-key-policy { (2) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) { (2) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) -> FALSE (2) else { (2) update { (2) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (2) --> 676ae0f0be13d41f008250df0c25be53 (2) &request:PacketFence-KeyBalanced := 676ae0f0be13d41f008250df0c25be53 (2) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (2) --> 676ae0f0be13d41f008250df0c25be53 (2) &control:Load-Balance-Key := 676ae0f0be13d41f008250df0c25be53 (2) } # update = noop (2) } # else = noop (2) } # policy packetfence-balanced-key-policy = noop (2) policy packetfence-set-tenant-id { (2) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (2) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (2) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (2) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (2) --> 0 (2) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (2) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (2) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (2) EXPAND %{request:Called-Station-Id} (2) --> b83a5ac71008 (2) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (2) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (2) update control { rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) (2) EXPAND %{User-Name} (2) --> @tanuvas.edu.in (2) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (0) (2) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (0) (2) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (2) --> 0 (2) &PacketFence-Tenant-Id = 0 (2) } # update control = noop (2) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (2) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (2) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (2) --> 0 (2) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (2) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (2) update control { rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (2) EXPAND %{User-Name} (2) --> @tanuvas.edu.in (2) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (2) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (1) (2) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (2) --> 1 (2) &PacketFence-Tenant-Id = 1 (2) } # update control = noop (2) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (2) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (2) if ( &control:PacketFence-Tenant-Id == 0 ) { (2) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (2) if ( &control:PacketFence-Tenant-Id == 0 ) { (2) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (2) EXPAND %{User-Name} (2) --> @tanuvas.edu.in (2) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (2) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (1) (2) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (2) --> 1 (2) &PacketFence-Tenant-Id := 1 (2) } # update control = noop (2) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (2) } # policy packetfence-set-tenant-id = noop (2) policy rewrite_calling_station_id { (2) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (2) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> TRUE (2) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (2) update request { (2) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (2) --> 70:66:55:fc:a6:f1 (2) &Calling-Station-Id := 70:66:55:fc:a6:f1 (2) } # update request = noop (2) [updated] = updated (2) } # if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) = updated (2) ... skipping else: Preceding "if" was taken (2) } # policy rewrite_calling_station_id = updated (2) policy rewrite_called_station_id { (2) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (2) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (2) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (2) update request { (2) &Called-Station-Id !* ANY (2) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (2) --> b8:3a:5a:c7:10:08 (2) &Called-Station-Id := b8:3a:5a:c7:10:08 (2) } # update request = noop (2) if ("%{8}") { (2) EXPAND %{8} (2) --> (2) if ("%{8}") -> FALSE (2) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (2) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (2) elsif (Aruba-Essid-Name) { (2) elsif (Aruba-Essid-Name) -> TRUE (2) elsif (Aruba-Essid-Name) { (2) update request { (2) EXPAND %{Aruba-Essid-Name} (2) --> TANUVAS (2) &Called-Station-SSID := TANUVAS (2) } # update request = noop (2) } # elsif (Aruba-Essid-Name) = noop (2) ... skipping elsif: Preceding "if" was taken (2) [updated] = updated (2) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (2) ... skipping else: Preceding "if" was taken (2) } # policy rewrite_called_station_id = updated (2) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (2) EXPAND %{client:shortname} (2) --> 172.16.20.210/32 (2) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (2) policy filter_username { (2) if (&User-Name) { (2) if (&User-Name) -> TRUE (2) if (&User-Name) { (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) } # if (&User-Name) = updated (2) } # policy filter_username = updated (2) policy filter_password { (2) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (2) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (2) } # policy filter_password = updated (2) [preprocess] = ok (2) [mschap] = noop (2) suffix: Checking for suffix after "@" (2) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (2) suffix: Found realm "tanuvas.edu.in" (2) suffix: Adding Stripped-User-Name = "" (2) suffix: Adding Realm = "tanuvas.edu.in" (2) suffix: Authentication realm is LOCAL (2) [suffix] = ok (2) ntdomain: Request already has destination realm set. Ignoring (2) [ntdomain] = noop (2) eap: Peer sent EAP Response (code 2) ID 4 length 172 (2) eap: Continuing tunnel setup (2) [eap] = ok (2) } # authorize = ok (2) Found Auth-Type = eap (2) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (2) authenticate { (2) eap: Expiring EAP session with state 0xc7239dc8c627885a (2) eap: Finished EAP session with state 0xc7239dc8c627885a (2) eap: Previous EAP request found for state 0xc7239dc8c627885a, released from the list (2) eap: Peer sent packet with method EAP TTLS (21) (2) eap: Calling submodule eap_ttls to process data (2) eap_ttls: Authenticate (2) eap_ttls: (TLS) EAP Peer says that the final record size will be 162 bytes (2) eap_ttls: (TLS) EAP Got all data (162 bytes) (2) eap_ttls: (TLS) Handshake state - before SSL initialization (2) eap_ttls: (TLS) Handshake state - Server before SSL initialization (2) eap_ttls: (TLS) Handshake state - Server before SSL initialization (2) eap_ttls: (TLS) recv TLS 1.3 Handshake, ClientHello (2) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS read client hello (2) eap_ttls: (TLS) send TLS 1.2 Handshake, ServerHello (2) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write server hello (2) eap_ttls: (TLS) send TLS 1.2 Handshake, Certificate (2) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write certificate (2) eap_ttls: (TLS) send TLS 1.2 Handshake, ServerKeyExchange (2) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write key exchange (2) eap_ttls: (TLS) send TLS 1.2 Handshake, ServerHelloDone (2) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write server done (2) eap_ttls: (TLS) Server : Need to read more data: SSLv3/TLS write server done (2) eap_ttls: (TLS) In Handshake Phase (2) eap: Sending EAP Request (code 1) ID 5 length 1004 (2) eap: EAP session adding &reply:State = 0xc7239dc8c526885a (2) [eap] = handled (2) } # authenticate = handled (2) Using Post-Auth-Type Challenge (2) Post-Auth-Type sub-section not found. Ignoring. (2) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (2) session-state: Saving cached attributes (2) Framed-MTU = 994 (2) TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (2) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (2) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (2) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (2) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (2) Sent Access-Challenge Id 63 from 172.16.11.10:1812 to 172.16.20.210:57049 length 1068 (2) EAP-Message = 0x010503ec15c000000a8b160303003d0200003903032841295d51eab237d088feb0035e05f9749f13ac3d96eec57b778e02ccbb95d100c030000011ff01000100000b0004030001020017000016030308e90b0008e50008e20003de308203da308202c2a003020102020101300d06092a864886f70d01010b0500308193310b3009060355040613024652310f300d06035504080c065261646975733112301006035504070c09536f6d65776865726531153013060355040a0c0c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e6f72673126302406035504030c1d4578616d706c6520436572746966696361746520417574686f72697479301e170d3232303232333135343635315a170d3237303232323135343635315a307c310b3009060355040613024652310f300d06035504080c0652616469757331153013060355040a0c0c4578616d706c6520496e632e3123302106035504030c1a4578616d70 (2) Message-Authenticator = 0x00000000000000000000000000000000 (2) State = 0xc7239dc8c526885ac7ab04a38861e476 (2) Finished request Thread 3 waiting to be assigned a request Waking up in 0.2 seconds. Thread 1 got semaphore Thread 1 handling request 3, (2 handled so far) (3) Received Access-Request Id 64 from 172.16.20.210:57049 to 172.16.11.10:1812 length 221 (3) User-Name = "@tanuvas.edu.in" (3) NAS-IP-Address = 172.16.20.210 (3) NAS-Port = 0 (3) NAS-Identifier = "172.16.20.101" (3) NAS-Port-Type = Wireless-802.11 (3) Calling-Station-Id = "706655fca6f1" (3) Called-Station-Id = "b83a5ac71008" (3) Service-Type = Framed-User (3) Framed-MTU = 1100 (3) EAP-Message = 0x020500061500 (3) State = 0xc7239dc8c526885ac7ab04a38861e476 (3) Aruba-Essid-Name = "TANUVAS" (3) Aruba-Location-Id = "CECONDS" (3) Aruba-AP-Group = "MVC_AcademicAP_VC" (3) Aruba-Device-Type = "NOFP" (3) Message-Authenticator = 0x43eb1f46e1ff7c7eae412bd848fe45e6 (3) Restoring &session-state (3) &session-state:Framed-MTU = 994 (3) &session-state:TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (3) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (3) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (3) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (3) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (3) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence (3) authorize { (3) policy packetfence-nas-ip-address { (3) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (3) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (3) } # policy packetfence-nas-ip-address = notfound (3) update { (3) EXPAND %{Packet-Src-IP-Address} (3) --> 172.16.20.210 (3) &request:FreeRADIUS-Client-IP-Address := 172.16.20.210 (3) EXPAND %{Packet-Dst-IP-Address} (3) --> 172.16.11.10 (3) &request:PacketFence-Radius-Ip := 172.16.11.10 (3) &control:PacketFence-RPC-Server = 127.0.0.1 (3) &control:PacketFence-RPC-Port = 7070 (3) &control:PacketFence-RPC-User = (3) &control:PacketFence-RPC-Pass = '' (3) &control:PacketFence-RPC-Proto = http (3) EXPAND %l (3) --> 1647449682 (3) &control:Tmp-Integer-0 := 1647449682 (3) &control:PacketFence-Request-Time := 0 (3) } # update = noop (3) policy packetfence-set-realm-if-machine { (3) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (3) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (3) } # policy packetfence-set-realm-if-machine = noop (3) policy packetfence-balanced-key-policy { (3) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) { (3) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) -> FALSE (3) else { (3) update { (3) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (3) --> 676ae0f0be13d41f008250df0c25be53 (3) &request:PacketFence-KeyBalanced := 676ae0f0be13d41f008250df0c25be53 (3) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (3) --> 676ae0f0be13d41f008250df0c25be53 (3) &control:Load-Balance-Key := 676ae0f0be13d41f008250df0c25be53 (3) } # update = noop (3) } # else = noop (3) } # policy packetfence-balanced-key-policy = noop (3) policy packetfence-set-tenant-id { (3) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (3) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (3) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (3) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (3) --> 0 (3) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (3) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (3) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (3) EXPAND %{request:Called-Station-Id} (3) --> b83a5ac71008 (3) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (3) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (3) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) (3) EXPAND %{User-Name} (3) --> @tanuvas.edu.in (3) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (3) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (2) (3) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (3) --> 0 (3) &PacketFence-Tenant-Id = 0 (3) } # update control = noop (3) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (3) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (3) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (3) --> 0 (3) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (3) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (3) update control { rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) (3) EXPAND %{User-Name} (3) --> @tanuvas.edu.in (3) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (0) (3) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (0) (3) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (3) --> 1 (3) &PacketFence-Tenant-Id = 1 (3) } # update control = noop (3) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (3) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (3) if ( &control:PacketFence-Tenant-Id == 0 ) { (3) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (3) if ( &control:PacketFence-Tenant-Id == 0 ) { (3) update control { rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) (3) EXPAND %{User-Name} (3) --> @tanuvas.edu.in (3) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (0) (3) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (0) (3) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (3) --> 1 (3) &PacketFence-Tenant-Id := 1 (3) } # update control = noop (3) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (3) } # policy packetfence-set-tenant-id = noop (3) policy rewrite_calling_station_id { (3) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (3) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> TRUE (3) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (3) update request { (3) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (3) --> 70:66:55:fc:a6:f1 (3) &Calling-Station-Id := 70:66:55:fc:a6:f1 (3) } # update request = noop (3) [updated] = updated (3) } # if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) = updated (3) ... skipping else: Preceding "if" was taken (3) } # policy rewrite_calling_station_id = updated (3) policy rewrite_called_station_id { (3) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (3) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (3) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (3) update request { (3) &Called-Station-Id !* ANY (3) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (3) --> b8:3a:5a:c7:10:08 (3) &Called-Station-Id := b8:3a:5a:c7:10:08 (3) } # update request = noop (3) if ("%{8}") { (3) EXPAND %{8} (3) --> (3) if ("%{8}") -> FALSE (3) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (3) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (3) elsif (Aruba-Essid-Name) { (3) elsif (Aruba-Essid-Name) -> TRUE (3) elsif (Aruba-Essid-Name) { (3) update request { (3) EXPAND %{Aruba-Essid-Name} (3) --> TANUVAS (3) &Called-Station-SSID := TANUVAS (3) } # update request = noop (3) } # elsif (Aruba-Essid-Name) = noop (3) ... skipping elsif: Preceding "if" was taken (3) [updated] = updated (3) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (3) ... skipping else: Preceding "if" was taken (3) } # policy rewrite_called_station_id = updated (3) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (3) EXPAND %{client:shortname} (3) --> 172.16.20.210/32 (3) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (3) policy filter_username { (3) if (&User-Name) { (3) if (&User-Name) -> TRUE (3) if (&User-Name) { (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) } # if (&User-Name) = updated (3) } # policy filter_username = updated (3) policy filter_password { (3) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (3) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (3) } # policy filter_password = updated (3) [preprocess] = ok (3) [mschap] = noop (3) suffix: Checking for suffix after "@" (3) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (3) suffix: Found realm "tanuvas.edu.in" (3) suffix: Adding Stripped-User-Name = "" (3) suffix: Adding Realm = "tanuvas.edu.in" (3) suffix: Authentication realm is LOCAL (3) [suffix] = ok (3) ntdomain: Request already has destination realm set. Ignoring (3) [ntdomain] = noop (3) eap: Peer sent EAP Response (code 2) ID 5 length 6 (3) eap: Continuing tunnel setup (3) [eap] = ok (3) } # authorize = ok (3) Found Auth-Type = eap (3) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (3) authenticate { (3) eap: Expiring EAP session with state 0xc7239dc8c526885a (3) eap: Finished EAP session with state 0xc7239dc8c526885a (3) eap: Previous EAP request found for state 0xc7239dc8c526885a, released from the list (3) eap: Peer sent packet with method EAP TTLS (21) (3) eap: Calling submodule eap_ttls to process data (3) eap_ttls: Authenticate (3) eap_ttls: (TLS) Peer ACKed our handshake fragment (3) eap: Sending EAP Request (code 1) ID 6 length 1004 (3) eap: EAP session adding &reply:State = 0xc7239dc8c425885a (3) [eap] = handled (3) } # authenticate = handled (3) Using Post-Auth-Type Challenge (3) Post-Auth-Type sub-section not found. Ignoring. (3) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (3) session-state: Saving cached attributes (3) Framed-MTU = 994 (3) TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (3) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (3) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (3) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (3) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (3) Sent Access-Challenge Id 64 from 172.16.11.10:1812 to 172.16.20.210:57049 length 1068 (3) EAP-Message = 0x010603ec15c000000a8bc6c0465e8b9b1914ddac5ac4ae059c4943885a50b9993dd88a9b4f3086b66218cf8cf569d65fa4c6450c031c9cbc745dcdf3d766f8dc6d0e6b64439afa773b334255c4009f6591d212b3e222e50004fe308204fa308203e2a00302010202140141a16ddfd9fce3a7d1f13ab4552f2136efcca6300d06092a864886f70d01010b0500308193310b3009060355040613024652310f300d06035504080c065261646975733112301006035504070c09536f6d65776865726531153013060355040a0c0c4578616d706c6520496e632e3120301e06092a864886f70d010901161161646d696e406578616d706c652e6f72673126302406035504030c1d4578616d706c6520436572746966696361746520417574686f72697479301e170d3232303232333135343635315a170d3237303232323135343635315a308193310b3009060355040613024652310f300d06035504080c065261646975733112301006035504070c09536f6d657768657265 (3) Message-Authenticator = 0x00000000000000000000000000000000 (3) State = 0xc7239dc8c425885ac7ab04a38861e476 (3) Finished request Thread 1 waiting to be assigned a request Waking up in 0.1 seconds. Thread 2 got semaphore Thread 2 handling request 4, (2 handled so far) (4) Received Access-Request Id 65 from 172.16.20.210:57049 to 172.16.11.10:1812 length 221 (4) User-Name = "@tanuvas.edu.in" (4) NAS-IP-Address = 172.16.20.210 (4) NAS-Port = 0 (4) NAS-Identifier = "172.16.20.101" (4) NAS-Port-Type = Wireless-802.11 (4) Calling-Station-Id = "706655fca6f1" (4) Called-Station-Id = "b83a5ac71008" (4) Service-Type = Framed-User (4) Framed-MTU = 1100 (4) EAP-Message = 0x020600061500 (4) State = 0xc7239dc8c425885ac7ab04a38861e476 (4) Aruba-Essid-Name = "TANUVAS" (4) Aruba-Location-Id = "CECONDS" (4) Aruba-AP-Group = "MVC_AcademicAP_VC" (4) Aruba-Device-Type = "NOFP" (4) Message-Authenticator = 0xead7c4879b2f4265eda427f33bc83889 (4) Restoring &session-state (4) &session-state:Framed-MTU = 994 (4) &session-state:TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (4) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (4) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (4) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (4) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (4) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence (4) authorize { (4) policy packetfence-nas-ip-address { (4) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (4) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (4) } # policy packetfence-nas-ip-address = notfound (4) update { (4) EXPAND %{Packet-Src-IP-Address} (4) --> 172.16.20.210 (4) &request:FreeRADIUS-Client-IP-Address := 172.16.20.210 (4) EXPAND %{Packet-Dst-IP-Address} (4) --> 172.16.11.10 (4) &request:PacketFence-Radius-Ip := 172.16.11.10 (4) &control:PacketFence-RPC-Server = 127.0.0.1 (4) &control:PacketFence-RPC-Port = 7070 (4) &control:PacketFence-RPC-User = (4) &control:PacketFence-RPC-Pass = '' (4) &control:PacketFence-RPC-Proto = http (4) EXPAND %l (4) --> 1647449682 (4) &control:Tmp-Integer-0 := 1647449682 (4) &control:PacketFence-Request-Time := 0 (4) } # update = noop (4) policy packetfence-set-realm-if-machine { (4) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (4) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (4) } # policy packetfence-set-realm-if-machine = noop (4) policy packetfence-balanced-key-policy { (4) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) { (4) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) -> FALSE (4) else { (4) update { (4) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (4) --> 676ae0f0be13d41f008250df0c25be53 (4) &request:PacketFence-KeyBalanced := 676ae0f0be13d41f008250df0c25be53 (4) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (4) --> 676ae0f0be13d41f008250df0c25be53 (4) &control:Load-Balance-Key := 676ae0f0be13d41f008250df0c25be53 (4) } # update = noop (4) } # else = noop (4) } # policy packetfence-balanced-key-policy = noop (4) policy packetfence-set-tenant-id { (4) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (4) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (4) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (4) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (4) --> 0 (4) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (4) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (4) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (4) EXPAND %{request:Called-Station-Id} (4) --> b83a5ac71008 (4) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (4) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (4) update control { rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (4) EXPAND %{User-Name} (4) --> @tanuvas.edu.in (4) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (4) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (1) (4) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (4) --> 0 (4) &PacketFence-Tenant-Id = 0 (4) } # update control = noop (4) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (4) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (4) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (4) --> 0 (4) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (4) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (4) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) (4) EXPAND %{User-Name} (4) --> @tanuvas.edu.in (4) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (4) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (2) (4) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (4) --> 1 (4) &PacketFence-Tenant-Id = 1 (4) } # update control = noop (4) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (4) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (4) if ( &control:PacketFence-Tenant-Id == 0 ) { (4) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (4) if ( &control:PacketFence-Tenant-Id == 0 ) { (4) update control { rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) (4) EXPAND %{User-Name} (4) --> @tanuvas.edu.in (4) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (4) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (2) (4) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (4) --> 1 (4) &PacketFence-Tenant-Id := 1 (4) } # update control = noop (4) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (4) } # policy packetfence-set-tenant-id = noop (4) policy rewrite_calling_station_id { (4) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (4) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> TRUE (4) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (4) update request { (4) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (4) --> 70:66:55:fc:a6:f1 (4) &Calling-Station-Id := 70:66:55:fc:a6:f1 (4) } # update request = noop (4) [updated] = updated (4) } # if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) = updated (4) ... skipping else: Preceding "if" was taken (4) } # policy rewrite_calling_station_id = updated (4) policy rewrite_called_station_id { (4) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (4) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (4) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (4) update request { (4) &Called-Station-Id !* ANY (4) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (4) --> b8:3a:5a:c7:10:08 (4) &Called-Station-Id := b8:3a:5a:c7:10:08 (4) } # update request = noop (4) if ("%{8}") { (4) EXPAND %{8} (4) --> (4) if ("%{8}") -> FALSE (4) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (4) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (4) elsif (Aruba-Essid-Name) { (4) elsif (Aruba-Essid-Name) -> TRUE (4) elsif (Aruba-Essid-Name) { (4) update request { (4) EXPAND %{Aruba-Essid-Name} (4) --> TANUVAS (4) &Called-Station-SSID := TANUVAS (4) } # update request = noop (4) } # elsif (Aruba-Essid-Name) = noop (4) ... skipping elsif: Preceding "if" was taken (4) [updated] = updated (4) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (4) ... skipping else: Preceding "if" was taken (4) } # policy rewrite_called_station_id = updated (4) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (4) EXPAND %{client:shortname} (4) --> 172.16.20.210/32 (4) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (4) policy filter_username { (4) if (&User-Name) { (4) if (&User-Name) -> TRUE (4) if (&User-Name) { (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) } # if (&User-Name) = updated (4) } # policy filter_username = updated (4) policy filter_password { (4) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (4) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (4) } # policy filter_password = updated (4) [preprocess] = ok (4) [mschap] = noop (4) suffix: Checking for suffix after "@" (4) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (4) suffix: Found realm "tanuvas.edu.in" (4) suffix: Adding Stripped-User-Name = "" (4) suffix: Adding Realm = "tanuvas.edu.in" (4) suffix: Authentication realm is LOCAL (4) [suffix] = ok (4) ntdomain: Request already has destination realm set. Ignoring (4) [ntdomain] = noop (4) eap: Peer sent EAP Response (code 2) ID 6 length 6 (4) eap: Continuing tunnel setup (4) [eap] = ok (4) } # authorize = ok (4) Found Auth-Type = eap (4) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (4) authenticate { (4) eap: Expiring EAP session with state 0xc7239dc8c425885a (4) eap: Finished EAP session with state 0xc7239dc8c425885a (4) eap: Previous EAP request found for state 0xc7239dc8c425885a, released from the list (4) eap: Peer sent packet with method EAP TTLS (21) (4) eap: Calling submodule eap_ttls to process data (4) eap_ttls: Authenticate (4) eap_ttls: (TLS) Peer ACKed our handshake fragment (4) eap: Sending EAP Request (code 1) ID 7 length 721 (4) eap: EAP session adding &reply:State = 0xc7239dc8c324885a (4) [eap] = handled (4) } # authenticate = handled (4) Using Post-Auth-Type Challenge (4) Post-Auth-Type sub-section not found. Ignoring. (4) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (4) session-state: Saving cached attributes (4) Framed-MTU = 994 (4) TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (4) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (4) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (4) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (4) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (4) Sent Access-Challenge Id 65 from 172.16.11.10:1812 to 172.16.20.210:57049 length 783 (4) EAP-Message = 0x010702d1158000000a8bd9fce3a7d1f13ab4552f2136efcca6300f0603551d130101ff040530030101ff30360603551d1f042f302d302ba029a0278625687474703a2f2f7777772e6578616d706c652e6f72672f6578616d706c655f63612e63726c300d06092a864886f70d01010b050003820101007d3559bea4e88af5447e8015ba0c5dd35f625272cbcf8fe8ceb746a6a64f4d54c4314cefa8222f53e87356da0cf679f75a8ce780c6d6b77fbc9b8cbfb6634f29020ae42a235f229e90d9fdaae0a84effd08a6be10b5c1b48460c855dae766dfb6ca602c579acd5e2c335b18117745367df7ce9be5297e53881ae94f3bb926dca3c3b041264187636d2097562a5b60adc05e759bbe0caad844f3aeb2e2ee543273b2d4e9b3e27625441d77d8f77ac8d787551311a1e692c63ceee11a0087d4c416ef248147201980b214b85ec85bc74c5b000a748231281f8c06806b42a2d46b13e7a8265fa75f36eb36e18353ca442a0e0f8d2500e327aa2490114142f1f310716 (4) Message-Authenticator = 0x00000000000000000000000000000000 (4) State = 0xc7239dc8c324885ac7ab04a38861e476 (4) Finished request Thread 2 waiting to be assigned a request Waking up in 0.1 seconds. Thread 3 got semaphore Thread 3 handling request 5, (2 handled so far) (5) Received Access-Request Id 66 from 172.16.20.210:57049 to 172.16.11.10:1812 length 351 (5) User-Name = "@tanuvas.edu.in" (5) NAS-IP-Address = 172.16.20.210 (5) NAS-Port = 0 (5) NAS-Identifier = "172.16.20.101" (5) NAS-Port-Type = Wireless-802.11 (5) Calling-Station-Id = "706655fca6f1" (5) Called-Station-Id = "b83a5ac71008" (5) Service-Type = Framed-User (5) Framed-MTU = 1100 (5) EAP-Message = 0x0207008815800000007e1603030046100000424104c4dd5151d2477fc7b889af09a48bc315a77aee2bc39f8058883c0d7dad0f9935eb1bc5ca46dd3b93f80ad04cae257662de9c199d16ce622e7880007f6dc6d138140303000101160303002800000000000000001e22c3cf379434e69dd52d8f6a8ea0c084f0b6f35efcb916f01b52d96bf8246c (5) State = 0xc7239dc8c324885ac7ab04a38861e476 (5) Aruba-Essid-Name = "TANUVAS" (5) Aruba-Location-Id = "CECONDS" (5) Aruba-AP-Group = "MVC_AcademicAP_VC" (5) Aruba-Device-Type = "NOFP" (5) Message-Authenticator = 0xb275fc254168c0bf148aaafcb1979511 (5) Restoring &session-state (5) &session-state:Framed-MTU = 994 (5) &session-state:TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (5) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (5) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (5) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (5) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (5) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence (5) authorize { (5) policy packetfence-nas-ip-address { (5) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (5) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (5) } # policy packetfence-nas-ip-address = notfound (5) update { (5) EXPAND %{Packet-Src-IP-Address} (5) --> 172.16.20.210 (5) &request:FreeRADIUS-Client-IP-Address := 172.16.20.210 (5) EXPAND %{Packet-Dst-IP-Address} (5) --> 172.16.11.10 (5) &request:PacketFence-Radius-Ip := 172.16.11.10 (5) &control:PacketFence-RPC-Server = 127.0.0.1 (5) &control:PacketFence-RPC-Port = 7070 (5) &control:PacketFence-RPC-User = (5) &control:PacketFence-RPC-Pass = '' (5) &control:PacketFence-RPC-Proto = http (5) EXPAND %l (5) --> 1647449682 (5) &control:Tmp-Integer-0 := 1647449682 (5) &control:PacketFence-Request-Time := 0 (5) } # update = noop (5) policy packetfence-set-realm-if-machine { (5) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (5) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (5) } # policy packetfence-set-realm-if-machine = noop (5) policy packetfence-balanced-key-policy { (5) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) { (5) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) -> FALSE (5) else { (5) update { (5) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (5) --> 676ae0f0be13d41f008250df0c25be53 (5) &request:PacketFence-KeyBalanced := 676ae0f0be13d41f008250df0c25be53 (5) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (5) --> 676ae0f0be13d41f008250df0c25be53 (5) &control:Load-Balance-Key := 676ae0f0be13d41f008250df0c25be53 (5) } # update = noop (5) } # else = noop (5) } # policy packetfence-balanced-key-policy = noop (5) policy packetfence-set-tenant-id { (5) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (5) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (5) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (5) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (5) --> 0 (5) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (5) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (5) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (5) EXPAND %{request:Called-Station-Id} (5) --> b83a5ac71008 (5) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (5) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (5) update control { rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) (5) EXPAND %{User-Name} (5) --> @tanuvas.edu.in (5) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (0) (5) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (0) (5) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (5) --> 0 (5) &PacketFence-Tenant-Id = 0 (5) } # update control = noop (5) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (5) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (5) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (5) --> 0 (5) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (5) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (5) update control { rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (5) EXPAND %{User-Name} (5) --> @tanuvas.edu.in (5) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (5) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (1) (5) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (5) --> 1 (5) &PacketFence-Tenant-Id = 1 (5) } # update control = noop (5) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (5) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (5) if ( &control:PacketFence-Tenant-Id == 0 ) { (5) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (5) if ( &control:PacketFence-Tenant-Id == 0 ) { (5) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (5) EXPAND %{User-Name} (5) --> @tanuvas.edu.in (5) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (5) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (1) (5) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (5) --> 1 (5) &PacketFence-Tenant-Id := 1 (5) } # update control = noop (5) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (5) } # policy packetfence-set-tenant-id = noop (5) policy rewrite_calling_station_id { (5) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (5) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> TRUE (5) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (5) update request { (5) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (5) --> 70:66:55:fc:a6:f1 (5) &Calling-Station-Id := 70:66:55:fc:a6:f1 (5) } # update request = noop (5) [updated] = updated (5) } # if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) = updated (5) ... skipping else: Preceding "if" was taken (5) } # policy rewrite_calling_station_id = updated (5) policy rewrite_called_station_id { (5) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (5) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (5) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (5) update request { (5) &Called-Station-Id !* ANY (5) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (5) --> b8:3a:5a:c7:10:08 (5) &Called-Station-Id := b8:3a:5a:c7:10:08 (5) } # update request = noop (5) if ("%{8}") { (5) EXPAND %{8} (5) --> (5) if ("%{8}") -> FALSE (5) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (5) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (5) elsif (Aruba-Essid-Name) { (5) elsif (Aruba-Essid-Name) -> TRUE (5) elsif (Aruba-Essid-Name) { (5) update request { (5) EXPAND %{Aruba-Essid-Name} (5) --> TANUVAS (5) &Called-Station-SSID := TANUVAS (5) } # update request = noop (5) } # elsif (Aruba-Essid-Name) = noop (5) ... skipping elsif: Preceding "if" was taken (5) [updated] = updated (5) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (5) ... skipping else: Preceding "if" was taken (5) } # policy rewrite_called_station_id = updated (5) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (5) EXPAND %{client:shortname} (5) --> 172.16.20.210/32 (5) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (5) policy filter_username { (5) if (&User-Name) { (5) if (&User-Name) -> TRUE (5) if (&User-Name) { (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) } # if (&User-Name) = updated (5) } # policy filter_username = updated (5) policy filter_password { (5) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (5) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (5) } # policy filter_password = updated (5) [preprocess] = ok (5) [mschap] = noop (5) suffix: Checking for suffix after "@" (5) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (5) suffix: Found realm "tanuvas.edu.in" (5) suffix: Adding Stripped-User-Name = "" (5) suffix: Adding Realm = "tanuvas.edu.in" (5) suffix: Authentication realm is LOCAL (5) [suffix] = ok (5) ntdomain: Request already has destination realm set. Ignoring (5) [ntdomain] = noop (5) eap: Peer sent EAP Response (code 2) ID 7 length 136 (5) eap: Continuing tunnel setup (5) [eap] = ok (5) } # authorize = ok (5) Found Auth-Type = eap (5) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (5) authenticate { (5) eap: Expiring EAP session with state 0xc7239dc8c324885a (5) eap: Finished EAP session with state 0xc7239dc8c324885a (5) eap: Previous EAP request found for state 0xc7239dc8c324885a, released from the list (5) eap: Peer sent packet with method EAP TTLS (21) (5) eap: Calling submodule eap_ttls to process data (5) eap_ttls: Authenticate (5) eap_ttls: (TLS) EAP Peer says that the final record size will be 126 bytes (5) eap_ttls: (TLS) EAP Got all data (126 bytes) (5) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write server done (5) eap_ttls: (TLS) recv TLS 1.2 Handshake, ClientKeyExchange (5) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS read client key exchange (5) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS read change cipher spec (5) eap_ttls: (TLS) recv TLS 1.2 Handshake, Finished (5) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS read finished (5) eap_ttls: (TLS) send TLS 1.2 ChangeCipherSpec (5) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write change cipher spec (5) eap_ttls: (TLS) send TLS 1.2 Handshake, Finished (5) eap_ttls: (TLS) Handshake state - Server SSLv3/TLS write finished (5) eap_ttls: (TLS) Handshake state - SSL negotiation finished successfully (5) eap_ttls: (TLS) Connection Established (5) eap_ttls: TLS-Session-Cipher-Suite = "ECDHE-RSA-AES256-GCM-SHA384" (5) eap_ttls: TLS-Session-Version = "TLS 1.2" (5) eap: Sending EAP Request (code 1) ID 8 length 61 (5) eap: EAP session adding &reply:State = 0xc7239dc8c22b885a (5) [eap] = handled (5) } # authenticate = handled (5) Using Post-Auth-Type Challenge (5) Post-Auth-Type sub-section not found. Ignoring. (5) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (5) session-state: Saving cached attributes (5) Framed-MTU = 994 (5) TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (5) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (5) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (5) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (5) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (5) TLS-Session-Information = "(TLS) recv TLS 1.2 Handshake, ClientKeyExchange" (5) TLS-Session-Information = "(TLS) recv TLS 1.2 Handshake, Finished" (5) TLS-Session-Information = "(TLS) send TLS 1.2 ChangeCipherSpec" (5) TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Finished" (5) TLS-Session-Cipher-Suite = "ECDHE-RSA-AES256-GCM-SHA384" (5) TLS-Session-Version = "TLS 1.2" (5) Sent Access-Challenge Id 66 from 172.16.11.10:1812 to 172.16.20.210:57049 length 119 (5) EAP-Message = 0x0108003d15800000003314030300010116030300283855ef975928a19d03d3a260ac0e925065588253e7a88e732f42724b673faa0f609197353425f0e6 (5) Message-Authenticator = 0x00000000000000000000000000000000 (5) State = 0xc7239dc8c22b885ac7ab04a38861e476 (5) Finished request Thread 3 waiting to be assigned a request Waking up in 4.4 seconds. Waking up in 0.3 seconds. Thread 1 got semaphore Thread 1 handling request 6, (3 handled so far) (6) Received Access-Request Id 67 from 172.16.20.210:57049 to 172.16.11.10:1812 length 306 (6) User-Name = "@tanuvas.edu.in" (6) NAS-IP-Address = 172.16.20.210 (6) NAS-Port = 0 (6) NAS-Identifier = "172.16.20.101" (6) NAS-Port-Type = Wireless-802.11 (6) Calling-Station-Id = "706655fca6f1" (6) Called-Station-Id = "b83a5ac71008" (6) Service-Type = Framed-User (6) Framed-MTU = 1100 (6) EAP-Message = 0x0208005b158000000051170303004c000000000000000140aaec26e769e54b6155a3c1048c4ff2b9398f03fb1076c83982c34bbfeca12cb54843909f0c70fb51b301cd4542c5b6911ffb2e17d33c910e9e4fe6caf1b8fe03d93321 (6) State = 0xc7239dc8c22b885ac7ab04a38861e476 (6) Aruba-Essid-Name = "TANUVAS" (6) Aruba-Location-Id = "CECONDS" (6) Aruba-AP-Group = "MVC_AcademicAP_VC" (6) Aruba-Device-Type = "NOFP" (6) Message-Authenticator = 0x169466c3949f358044792e7fbf909c5c (6) Restoring &session-state (6) &session-state:Framed-MTU = 994 (6) &session-state:TLS-Session-Information = "(TLS) recv TLS 1.3 Handshake, ClientHello" (6) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHello" (6) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Certificate" (6) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerKeyExchange" (6) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, ServerHelloDone" (6) &session-state:TLS-Session-Information = "(TLS) recv TLS 1.2 Handshake, ClientKeyExchange" (6) &session-state:TLS-Session-Information = "(TLS) recv TLS 1.2 Handshake, Finished" (6) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 ChangeCipherSpec" (6) &session-state:TLS-Session-Information = "(TLS) send TLS 1.2 Handshake, Finished" (6) &session-state:TLS-Session-Cipher-Suite = "ECDHE-RSA-AES256-GCM-SHA384" (6) &session-state:TLS-Session-Version = "TLS 1.2" (6) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence (6) authorize { (6) policy packetfence-nas-ip-address { (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (6) } # policy packetfence-nas-ip-address = notfound (6) update { (6) EXPAND %{Packet-Src-IP-Address} (6) --> 172.16.20.210 (6) &request:FreeRADIUS-Client-IP-Address := 172.16.20.210 (6) EXPAND %{Packet-Dst-IP-Address} (6) --> 172.16.11.10 (6) &request:PacketFence-Radius-Ip := 172.16.11.10 (6) &control:PacketFence-RPC-Server = 127.0.0.1 (6) &control:PacketFence-RPC-Port = 7070 (6) &control:PacketFence-RPC-User = (6) &control:PacketFence-RPC-Pass = '' (6) &control:PacketFence-RPC-Proto = http (6) EXPAND %l (6) --> 1647449684 (6) &control:Tmp-Integer-0 := 1647449684 (6) &control:PacketFence-Request-Time := 0 (6) } # update = noop (6) policy packetfence-set-realm-if-machine { (6) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (6) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (6) } # policy packetfence-set-realm-if-machine = noop (6) policy packetfence-balanced-key-policy { (6) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) { (6) if (&PacketFence-KeyBalanced && (&PacketFence-KeyBalanced =~ /^(.*)(.)$/i)) -> FALSE (6) else { (6) update { (6) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (6) --> 676ae0f0be13d41f008250df0c25be53 (6) &request:PacketFence-KeyBalanced := 676ae0f0be13d41f008250df0c25be53 (6) EXPAND %{md5:%{Calling-Station-Id}%{User-Name}} (6) --> 676ae0f0be13d41f008250df0c25be53 (6) &control:Load-Balance-Key := 676ae0f0be13d41f008250df0c25be53 (6) } # update = noop (6) } # else = noop (6) } # policy packetfence-balanced-key-policy = noop (6) policy packetfence-set-tenant-id { (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (6) --> 0 (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (6) EXPAND %{request:Called-Station-Id} (6) --> b83a5ac71008 (6) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (6) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (6) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) Need more connections to reach 10 spares rlm_sql (sql): Opening additional connection (3), 1 of 61 pending slots used rlm_sql_mysql: Starting connect to MySQL server rlm_sql_mysql: Connected to database 'pf' on Localhost via UNIX socket, server version 10.5.15-MariaDB-1:10.5.15+maria~bullseye, protocol version 10 (6) EXPAND %{User-Name} (6) --> @tanuvas.edu.in (6) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (6) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (2) (6) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (6) --> 0 (6) &PacketFence-Tenant-Id = 0 (6) } # update control = noop (6) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (6) --> 0 (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) update control { rlm_sql (sql): Reserved connection (1) rlm_sql (sql): Released connection (1) (6) EXPAND %{User-Name} (6) --> @tanuvas.edu.in (6) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (0) (6) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (0) (6) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (6) --> 1 (6) &PacketFence-Tenant-Id = 1 (6) } # update control = noop (6) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (6) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (6) if ( &control:PacketFence-Tenant-Id == 0 ) { (6) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (6) if ( &control:PacketFence-Tenant-Id == 0 ) { (6) update control { rlm_sql (sql): Reserved connection (3) rlm_sql (sql): Released connection (3) rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (6) EXPAND %{User-Name} (6) --> @tanuvas.edu.in (6) SQL-User-Name set to '@tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (6) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (1) (6) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (6) --> 1 (6) &PacketFence-Tenant-Id := 1 (6) } # update control = noop (6) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (6) } # policy packetfence-set-tenant-id = noop (6) policy rewrite_calling_station_id { (6) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (6) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) -> TRUE (6) if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) { (6) update request { (6) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (6) --> 70:66:55:fc:a6:f1 (6) &Calling-Station-Id := 70:66:55:fc:a6:f1 (6) } # update request = noop (6) [updated] = updated (6) } # if (&Calling-Station-Id && (&Calling-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})$/i)) = updated (6) ... skipping else: Preceding "if" was taken (6) } # policy rewrite_calling_station_id = updated (6) policy rewrite_called_station_id { (6) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (6) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (6) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (6) update request { (6) &Called-Station-Id !* ANY (6) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (6) --> b8:3a:5a:c7:10:08 (6) &Called-Station-Id := b8:3a:5a:c7:10:08 (6) } # update request = noop (6) if ("%{8}") { (6) EXPAND %{8} (6) --> (6) if ("%{8}") -> FALSE (6) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (6) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (6) elsif (Aruba-Essid-Name) { (6) elsif (Aruba-Essid-Name) -> TRUE (6) elsif (Aruba-Essid-Name) { (6) update request { (6) EXPAND %{Aruba-Essid-Name} (6) --> TANUVAS (6) &Called-Station-SSID := TANUVAS (6) } # update request = noop (6) } # elsif (Aruba-Essid-Name) = noop (6) ... skipping elsif: Preceding "if" was taken (6) [updated] = updated (6) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (6) ... skipping else: Preceding "if" was taken (6) } # policy rewrite_called_station_id = updated (6) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) { (6) EXPAND %{client:shortname} (6) --> 172.16.20.210/32 (6) if ( "%{client:shortname}" =~ /eduroam_tlrs/ ) -> FALSE (6) policy filter_username { (6) if (&User-Name) { (6) if (&User-Name) -> TRUE (6) if (&User-Name) { (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) } # if (&User-Name) = updated (6) } # policy filter_username = updated (6) policy filter_password { (6) if (&User-Password && (&User-Password != "%{string:User-Password}")) { (6) if (&User-Password && (&User-Password != "%{string:User-Password}")) -> FALSE (6) } # policy filter_password = updated (6) [preprocess] = ok (6) [mschap] = noop (6) suffix: Checking for suffix after "@" (6) suffix: Looking up realm "tanuvas.edu.in" for User-Name = "@ tanuvas.edu.in" (6) suffix: Found realm "tanuvas.edu.in" (6) suffix: Adding Stripped-User-Name = "" (6) suffix: Adding Realm = "tanuvas.edu.in" (6) suffix: Authentication realm is LOCAL (6) [suffix] = ok (6) ntdomain: Request already has destination realm set. Ignoring (6) [ntdomain] = noop (6) eap: Peer sent EAP Response (code 2) ID 8 length 91 (6) eap: Continuing tunnel setup (6) [eap] = ok (6) } # authorize = ok (6) Found Auth-Type = eap (6) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (6) authenticate { (6) eap: Expiring EAP session with state 0xc7239dc8c22b885a (6) eap: Finished EAP session with state 0xc7239dc8c22b885a (6) eap: Previous EAP request found for state 0xc7239dc8c22b885a, released from the list (6) eap: Peer sent packet with method EAP TTLS (21) (6) eap: Calling submodule eap_ttls to process data (6) eap_ttls: Authenticate (6) eap_ttls: (TLS) EAP Peer says that the final record size will be 81 bytes (6) eap_ttls: (TLS) EAP Got all data (81 bytes) (6) eap_ttls: Session established. Proceeding to decode tunneled attributes (6) eap_ttls: Got tunneled request (6) eap_ttls: User-Name = "MTP19003(a)tanuvas.edu.in" (6) eap_ttls: User-Password = "Tanuvas@2020" (6) eap_ttls: FreeRADIUS-Proxied-To = 127.0.0.1 (6) eap_ttls: Sending tunneled request (6) Virtual server packetfence-tunnel received request (6) User-Name = "MTP19003(a)tanuvas.edu.in" (6) User-Password = "Tanuvas@2020" (6) FreeRADIUS-Proxied-To = 127.0.0.1 (6) NAS-IP-Address = 172.16.20.210 (6) NAS-Port = 0 (6) NAS-Identifier = "172.16.20.101" (6) NAS-Port-Type = Wireless-802.11 (6) Calling-Station-Id := "70:66:55:fc:a6:f1" (6) Service-Type = Framed-User (6) Framed-MTU = 1100 (6) Aruba-Essid-Name = "TANUVAS" (6) Aruba-Location-Id = "CECONDS" (6) Aruba-AP-Group = "MVC_AcademicAP_VC" (6) Aruba-Device-Type = "NOFP" (6) PacketFence-Radius-Ip := "172.16.11.10" (6) PacketFence-KeyBalanced := "676ae0f0be13d41f008250df0c25be53" (6) Called-Station-Id := "b8:3a:5a:c7:10:08" (6) Event-Timestamp = "Mar 16 2022 22:24:44 IST" (6) server packetfence-tunnel { (6) # Executing section authorize from file /usr/local/pf/raddb/sites-enabled/packetfence-tunnel (6) authorize { (6) if ( outer.EAP-Type == TTLS) { (6) if ( outer.EAP-Type == TTLS) -> TRUE (6) if ( outer.EAP-Type == TTLS) { (6) update request { (6) &EAP-Type := TTLS (6) } # update request = noop (6) } # if ( outer.EAP-Type == TTLS) = noop (6) policy packetfence-set-realm-if-machine { (6) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) { (6) if (User-Name =~ /host\/([a-z0-9_-]*)[\.](.*)/i) -> FALSE (6) } # policy packetfence-set-realm-if-machine = noop (6) policy packetfence-set-tenant-id { (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (6) --> 0 (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (6) EXPAND %{request:Called-Station-Id} (6) --> b8:3a:5a:c7:10:08 (6) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) -> TRUE (6) if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) { (6) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) (6) EXPAND %{User-Name} (6) --> MTP19003(a)tanuvas.edu.in (6) SQL-User-Name set to 'MTP19003(a)tanuvas.edu.in' rlm_sql (sql): Reserved connection (3) (6) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = 'b8:3a:5a:c7:10:08'), 0) rlm_sql (sql): Released connection (3) (6) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}}'), 0)} (6) --> 0 (6) &PacketFence-Tenant-Id = 0 (6) } # update control = noop (6) } # if ("%{request:Called-Station-Id}" =~ /^([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})/i) = noop (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (6) --> 0 (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> TRUE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) update control { rlm_sql (sql): Reserved connection (2) rlm_sql (sql): Released connection (2) (6) EXPAND %{User-Name} (6) --> MTP19003(a)tanuvas.edu.in (6) SQL-User-Name set to 'MTP19003(a)tanuvas.edu.in' rlm_sql (sql): Reserved connection (1) (6) Executing select query: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '172.16.20.210'), 0) rlm_sql (sql): Released connection (1) (6) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id FROM radius_nas WHERE nasname = '%{NAS-IP-Address}'), 0)} (6) --> 1 (6) &PacketFence-Tenant-Id = 1 (6) } # update control = noop (6) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (6) } # if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") = noop (6) if ( &control:PacketFence-Tenant-Id == 0 ) { (6) if ( &control:PacketFence-Tenant-Id == 0 ) -> TRUE (6) if ( &control:PacketFence-Tenant-Id == 0 ) { (6) update control { rlm_sql (sql): Reserved connection (0) rlm_sql (sql): Released connection (0) rlm_sql (sql): Reserved connection (3) rlm_sql (sql): Released connection (3) (6) EXPAND %{User-Name} (6) --> MTP19003(a)tanuvas.edu.in (6) SQL-User-Name set to 'MTP19003(a)tanuvas.edu.in' rlm_sql (sql): Reserved connection (2) (6) Executing select query: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('172.16.20.210') and INET_ATON('172.16.20.210') <= end_ip order by range_length limit 1), 1) rlm_sql (sql): Released connection (2) (6) EXPAND %{sql: SELECT IFNULL((SELECT tenant_id from radius_nas WHERE start_ip <= INET_ATON('%{NAS-IP-Address}') and INET_ATON('%{NAS-IP-Address}') <= end_ip order by range_length limit 1), 1)} (6) --> 1 (6) &PacketFence-Tenant-Id := 1 (6) } # update control = noop (6) } # if ( &control:PacketFence-Tenant-Id == 0 ) = noop (6) } # policy packetfence-set-tenant-id = noop (6) policy filter_username { (6) if (&User-Name) { (6) if (&User-Name) -> TRUE (6) if (&User-Name) { (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) } # if (&User-Name) = noop (6) } # policy filter_username = noop (6) update { (6) EXPAND %{outer.request:User-Name} (6) --> @tanuvas.edu.in (6) &request:PacketFence-Outer-User := @tanuvas.edu.in (6) } # update = noop (6) [mschap] = noop (6) suffix: Checking for suffix after "@" (6) suffix: Looking up realm "tanuvas.edu.in" for User-Name = " MTP19003(a)tanuvas.edu.in" (6) suffix: Found realm "tanuvas.edu.in" (6) suffix: Adding Stripped-User-Name = "MTP19003" (6) suffix: Adding Realm = "tanuvas.edu.in" (6) suffix: Authentication realm is LOCAL (6) [suffix] = ok (6) ntdomain: Request already has destination realm set. Ignoring (6) [ntdomain] = noop (6) update control { (6) &Proxy-To-Realm := LOCAL (6) } # update control = noop (6) eap: No EAP-Message, not doing EAP (6) [eap] = noop (6) if (Realm =~ /^tanuvas.org.in$/) { (6) if (Realm =~ /^tanuvas.org.in$/) -> FALSE (6) if (Realm =~ /^tanuvas.edu.in$/) { (6) if (Realm =~ /^tanuvas.edu.in$/) -> TRUE (6) if (Realm =~ /^tanuvas.edu.in$/) { (6) policy oauth2.authorize { (6) if (&Realm && &User-Password && "%{config:realm[%{Realm}].oauth2.discovery}") { (6) EXPAND realm[tanuvas.edu.in].oauth2.discovery (6) --> realm[tanuvas.edu.in].oauth2.discovery (6) EXPAND %{config:realm[%{Realm}].oauth2.discovery} (6) --> https://login.microsoftonline.com/%{Realm}/v2.0 (6) if (&Realm && &User-Password && "%{config:realm[%{Realm}].oauth2.discovery}") -> TRUE (6) if (&Realm && &User-Password && "%{config:realm[%{Realm}].oauth2.discovery}") { (6) oauth2_perl: $RAD_REQUEST{'User-Name'} = &request:User-Name -> ' MTP19003(a)tanuvas.edu.in' (6) oauth2_perl: $RAD_REQUEST{'User-Password'} = &request:User-Password -> 'Tanuvas@2020' (6) oauth2_perl: $RAD_REQUEST{'NAS-IP-Address'} = &request:NAS-IP-Address -> '172.16.20.210' (6) oauth2_perl: $RAD_REQUEST{'NAS-Port'} = &request:NAS-Port -> '0' (6) oauth2_perl: $RAD_REQUEST{'Service-Type'} = &request:Service-Type -> 'Framed-User' (6) oauth2_perl: $RAD_REQUEST{'Framed-MTU'} = &request:Framed-MTU -> '1100' (6) oauth2_perl: $RAD_REQUEST{'Called-Station-Id'} = &request:Called-Station-Id -> 'b8:3a:5a:c7:10:08' (6) oauth2_perl: $RAD_REQUEST{'Calling-Station-Id'} = &request:Calling-Station-Id -> '70:66:55:fc:a6:f1' (6) oauth2_perl: $RAD_REQUEST{'NAS-Identifier'} = &request:NAS-Identifier -> '172.16.20.101' (6) oauth2_perl: $RAD_REQUEST{'NAS-Port-Type'} = &request:NAS-Port-Type -> 'Wireless-802.11' (6) oauth2_perl: $RAD_REQUEST{'Event-Timestamp'} = &request:Event-Timestamp -> 'Mar 16 2022 22:24:44 IST' (6) oauth2_perl: $RAD_REQUEST{'Aruba-Essid-Name'} = &request:Aruba-Essid-Name -> 'TANUVAS' (6) oauth2_perl: $RAD_REQUEST{'Aruba-Location-Id'} = &request:Aruba-Location-Id -> 'CECONDS' (6) oauth2_perl: $RAD_REQUEST{'Aruba-AP-Group'} = &request:Aruba-AP-Group -> 'MVC_AcademicAP_VC' (6) oauth2_perl: $RAD_REQUEST{'Aruba-Device-Type'} = &request:Aruba-Device-Type -> 'NOFP' (6) oauth2_perl: $RAD_REQUEST{'FreeRADIUS-Proxied-To'} = &request:FreeRADIUS-Proxied-To -> '127.0.0.1' (6) oauth2_perl: $RAD_REQUEST{'EAP-Type'} = &request:EAP-Type -> 'TTLS' (6) oauth2_perl: $RAD_REQUEST{'Stripped-User-Name'} = &request:Stripped-User-Name -> 'MTP19003' (6) oauth2_perl: $RAD_REQUEST{'Realm'} = &request:Realm -> 'tanuvas.edu.in ' (6) oauth2_perl: $RAD_REQUEST{'SQL-User-Name'} = &request:SQL-User-Name -> 'MTP19003(a)tanuvas.edu.in' (6) oauth2_perl: $RAD_REQUEST{'PacketFence-KeyBalanced'} = &request:PacketFence-KeyBalanced -> '676ae0f0be13d41f008250df0c25be53' (6) oauth2_perl: $RAD_REQUEST{'PacketFence-Radius-Ip'} = &request:PacketFence-Radius-Ip -> '172.16.11.10' (6) oauth2_perl: $RAD_REQUEST{'PacketFence-Outer-User'} = &request:PacketFence-Outer-User -> '@tanuvas.edu.in' (6) oauth2_perl: $RAD_CHECK{'Proxy-To-Realm'} = &control:Proxy-To-Realm -> 'LOCAL' (6) oauth2_perl: $RAD_CHECK{'PacketFence-Tenant-Id'} = &control:PacketFence-Tenant-Id -> '1' (6) oauth2_perl: $RAD_CONFIG{'Proxy-To-Realm'} = &control:Proxy-To-Realm -> 'LOCAL' (6) oauth2_perl: $RAD_CONFIG{'PacketFence-Tenant-Id'} = &control:PacketFence-Tenant-Id -> '1' rlm_perl: oauth2 authorize (6) oauth2_perl: EXPAND realm[tanuvas.edu.in].oauth2.discovery (6) oauth2_perl: --> realm[tanuvas.edu.in].oauth2.discovery (6) oauth2_perl: EXPAND %{config:realm[tanuvas.edu.in].oauth2.discovery} (6) oauth2_perl: --> https://login.microsoftonline.com/%{Realm}/v2.0 (6) oauth2_perl: EXPAND https://login.microsoftonline.com/%{Realm}/v2.0 (6) oauth2_perl: --> https://login.microsoftonline.com/tanuvas.edu.in/v2.0 (6) oauth2_perl: EXPAND realm[tanuvas.edu.in].oauth2.client_id (6) oauth2_perl: --> realm[tanuvas.edu.in].oauth2.client_id (6) oauth2_perl: EXPAND %{config:realm[tanuvas.edu.in].oauth2.client_id} (6) oauth2_perl: --> 06f29276-f381-4e8b-8618-e62e701ec2a7 (6) oauth2_perl: EXPAND realm[tanuvas.edu.in].oauth2.client_secret (6) oauth2_perl: --> realm[tanuvas.edu.in].oauth2.client_secret (6) oauth2_perl: EXPAND %{config:realm[tanuvas.edu.in].oauth2.client_secret} (6) oauth2_perl: --> b43401d0-0a12-42fd-a27d-32437248d01b rlm_perl: oauth2 worker (tanuvas.edu.in): supervisor started (tid=1) rlm_perl: oauth2 worker (tanuvas.edu.in): fetching discovery document Waking up in 0.4 seconds. rlm_perl: oauth2 worker (tanuvas.edu.in): started (tid=2) rlm_perl: oauth2 worker (tanuvas.edu.in): sync rlm_perl: oauth2 worker (tanuvas.edu.in): sync users rlm_perl: oauth2 worker (tanuvas.edu.in): users page rlm_perl: oauth2 worker (tanuvas.edu.in): fetching token rlm_perl: oauth2 worker (tanuvas.edu.in): token failed: 401 Unauthorized Waking up in 0.7 seconds. Use of uninitialized value $v in concatenation (.) or string at /usr/local/pf/lib_perl/lib/perl5/Net/HTTP/Methods.pm line 167. rlm_perl: oauth2 worker (tanuvas.edu.in): users failed: 400 Bad Request rlm_perl: oauth2 worker (tanuvas.edu.in): sync groups rlm_perl: oauth2 worker (tanuvas.edu.in): groups page rlm_perl: oauth2 worker (tanuvas.edu.in): fetching token rlm_perl: oauth2 worker (tanuvas.edu.in): token failed: 401 Unauthorized rlm_perl: oauth2 worker (tanuvas.edu.in): groups failed: 500 Can't connect to graph.microsoft.com:443 (SSL connect attempt failed error:27069065:OCSP routines:OCSP_basic_verify:certificate verify error) Thread 2 terminated abnormally: token (tanuvas.edu.in): 500 Can't connect to graph.microsoft.com:443 (SSL connect attempt failed error:27069065:OCSP routines:OCSP_basic_verify:certificate verify error) at /usr/local/pf/raddb/mods-config/perl/oauth2.pm line 191. rlm_perl: oauth2 worker (tanuvas.edu.in): died, sleeping for 0 seconds rlm_perl: oauth2 worker (tanuvas.edu.in): started (tid=3) rlm_perl: oauth2 worker (tanuvas.edu.in): sync rlm_perl: oauth2 worker (tanuvas.edu.in): sync users rlm_perl: oauth2 worker (tanuvas.edu.in): users page rlm_perl: oauth2 worker (tanuvas.edu.in): fetching token Waking up in 1.1 seconds. rlm_perl: oauth2 worker (tanuvas.edu.in): token failed: 401 Unauthorized Use of uninitialized value $v in concatenation (.) or string at /usr/local/pf/lib_perl/lib/perl5/Net/HTTP/Methods.pm line 167. rlm_perl: oauth2 worker (tanuvas.edu.in): users failed: 400 Bad Request rlm_perl: oauth2 worker (tanuvas.edu.in): sync groups rlm_perl: oauth2 worker (tanuvas.edu.in): groups page rlm_perl: oauth2 worker (tanuvas.edu.in): fetching token rlm_perl: oauth2 worker (tanuvas.edu.in): token failed: 401 Unauthorized Use of uninitialized value $v in concatenation (.) or string at /usr/local/pf/lib_perl/lib/perl5/Net/HTTP/Methods.pm line 167. rlm_perl: oauth2 worker (tanuvas.edu.in): groups failed: 400 Bad Request rlm_perl: oauth2 worker (tanuvas.edu.in): apply (6) oauth2_perl: &request:Stripped-User-Name = $RAD_REQUEST{'Stripped-User-Name'} -> 'MTP19003' (6) oauth2_perl: &request:Calling-Station-Id = $RAD_REQUEST{'Calling-Station-Id'} -> '70:66:55:fc:a6:f1' (6) oauth2_perl: &request:Framed-MTU = $RAD_REQUEST{'Framed-MTU'} -> '1100' (6) oauth2_perl: &request:NAS-Identifier = $RAD_REQUEST{'NAS-Identifier'} -> '172.16.20.101' (6) oauth2_perl: &request:User-Name = $RAD_REQUEST{'User-Name'} -> ' MTP19003(a)tanuvas.edu.in' (6) oauth2_perl: &request:Service-Type = $RAD_REQUEST{'Service-Type'} -> 'Framed-User' (6) oauth2_perl: &request:EAP-Type = $RAD_REQUEST{'EAP-Type'} -> 'TTLS' (6) oauth2_perl: &request:Called-Station-Id = $RAD_REQUEST{'Called-Station-Id'} -> 'b8:3a:5a:c7:10:08' (6) oauth2_perl: &request:SQL-User-Name = $RAD_REQUEST{'SQL-User-Name'} -> ' MTP19003(a)tanuvas.edu.in' (6) oauth2_perl: &request:PacketFence-Outer-User = $RAD_REQUEST{'PacketFence-Outer-User'} -> '@tanuvas.edu.in' (6) oauth2_perl: &request:Aruba-Device-Type = $RAD_REQUEST{'Aruba-Device-Type'} -> 'NOFP' (6) oauth2_perl: &request:NAS-Port-Type = $RAD_REQUEST{'NAS-Port-Type'} -> 'Wireless-802.11' (6) oauth2_perl: &request:FreeRADIUS-Proxied-To = $RAD_REQUEST{'FreeRADIUS-Proxied-To'} -> '127.0.0.1' (6) oauth2_perl: &request:Event-Timestamp = $RAD_REQUEST{'Event-Timestamp'} -> 'Mar 16 2022 22:24:44 IST' (6) oauth2_perl: &request:NAS-Port = $RAD_REQUEST{'NAS-Port'} -> '0' (6) oauth2_perl: &request:PacketFence-Radius-Ip = $RAD_REQUEST{'PacketFence-Radius-Ip'} -> '172.16.11.10' (6) oauth2_perl: &request:PacketFence-KeyBalanced = $RAD_REQUEST{'PacketFence-KeyBalanced'} -> '676ae0f0be13d41f008250df0c25be53' (6) oauth2_perl: &request:NAS-IP-Address = $RAD_REQUEST{'NAS-IP-Address'} -> '172.16.20.210' (6) oauth2_perl: &request:Aruba-Location-Id = $RAD_REQUEST{'Aruba-Location-Id'} -> 'CECONDS' (6) oauth2_perl: &request:Aruba-AP-Group = $RAD_REQUEST{'Aruba-AP-Group'} -> 'MVC_AcademicAP_VC' (6) oauth2_perl: &request:User-Password = $RAD_REQUEST{'User-Password'} -> 'Tanuvas@2020' (6) oauth2_perl: &request:Realm = $RAD_REQUEST{'Realm'} -> 'tanuvas.edu.in' (6) oauth2_perl: &request:Aruba-Essid-Name = $RAD_REQUEST{'Aruba-Essid-Name'} -> 'TANUVAS' (6) oauth2_perl: &control:PacketFence-Tenant-Id = $RAD_CHECK{'PacketFence-Tenant-Id'} -> '1' (6) oauth2_perl: &control:Proxy-To-Realm = $RAD_CHECK{'Proxy-To-Realm'} -> 'LOCAL' (6) [oauth2_perl] = notfound (6) if (updated && "%{config:realm[%{Realm}].oauth2.cache_password}" =~ /^(yes)?$/i) { (6) if (updated && "%{config:realm[%{Realm}].oauth2.cache_password}" =~ /^(yes)?$/i) -> FALSE (6) } # if (&Realm && &User-Password && "%{config:realm[%{Realm}].oauth2.discovery}") = notfound (6) ... skipping else: Preceding "if" was taken (6) } # policy oauth2.authorize = notfound (6) } # if (Realm =~ /^tanuvas.edu.in$/) = notfound (6) policy rewrite_called_station_id { (6) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (6) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) -> TRUE (6) if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) { (6) update request { (6) &Called-Station-Id !* ANY (6) EXPAND %{tolower:%{1}:%{2}:%{3}:%{4}:%{5}:%{6}} (6) --> b8:3a:5a:c7:10:08 (6) &Called-Station-Id := b8:3a:5a:c7:10:08 (6) } # update request = noop (6) if ("%{8}") { (6) EXPAND %{8} (6) --> (6) if ("%{8}") -> FALSE (6) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) { (6) elsif ( (Colubris-AVPair) && "%{Colubris-AVPair}" =~ /^ssid=(.*)$/i) -> FALSE (6) elsif (Aruba-Essid-Name) { (6) elsif (Aruba-Essid-Name) -> TRUE (6) elsif (Aruba-Essid-Name) { (6) update request { (6) EXPAND %{Aruba-Essid-Name} (6) --> TANUVAS (6) &Called-Station-SSID := TANUVAS (6) } # update request = noop (6) } # elsif (Aruba-Essid-Name) = noop (6) ... skipping elsif: Preceding "if" was taken (6) [updated] = updated (6) } # if ((&Called-Station-Id) && (&Called-Station-Id =~ /^1?:?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})[^0-9a-f]?([0-9a-f]{2})(:(.+))?$/i)) = updated (6) ... skipping else: Preceding "if" was taken (6) } # policy rewrite_called_station_id = updated (6) [pap] = noop (6) } # authorize = updated (6) WARNING: You set Proxy-To-Realm = local, but it is a LOCAL realm! Cancelling proxy request. (6) ERROR: No Auth-Type found: rejecting the user via Post-Auth-Type = Reject (6) Failed to authenticate the user (6) Using Post-Auth-Type Reject (6) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence-tunnel (6) Post-Auth-Type REJECT { (6) policy packetfence-set-tenant-id { (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (6) --> 1 (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> FALSE (6) if ( &control:PacketFence-Tenant-Id == 0 ) { (6) if ( &control:PacketFence-Tenant-Id == 0 ) -> FALSE (6) } # policy packetfence-set-tenant-id = noop (6) update { (6) &request:User-Password := "******" (6) } # update = noop (6) policy packetfence-audit-log-reject { (6) if (&User-Name && (&User-Name == "dummy")) { (6) if (&User-Name && (&User-Name == "dummy")) -> FALSE (6) else { (6) policy request-timing { (6) if ("%{%{control:PacketFence-Request-Time}:-0}" != 0) { (6) EXPAND %{%{control:PacketFence-Request-Time}:-0} (6) --> 0 (6) if ("%{%{control:PacketFence-Request-Time}:-0}" != 0) -> FALSE (6) } # policy request-timing = noop (6) sql_reject: EXPAND type.reject.query (6) sql_reject: --> type.reject.query (6) sql_reject: Using query template 'query' rlm_sql (sql): Reserved connection (1) (6) sql_reject: EXPAND %{User-Name} (6) sql_reject: --> MTP19003(a)tanuvas.edu.in (6) sql_reject: SQL-User-Name set to 'MTP19003(a)tanuvas.edu.in' (6) sql_reject: EXPAND INSERT INTO radius_audit_log ( mac, ip, computer_name, user_name, stripped_user_name, realm, event_type, switch_id, switch_mac, switch_ip_address, radius_source_ip_address, called_station_id, calling_station_id, nas_port_type, ssid, nas_port_id, ifindex, nas_port, connection_type, nas_ip_address, nas_identifier, auth_status, reason, auth_type, eap_type, role, node_status, profile, source, auto_reg, is_phone, pf_domain, uuid, radius_request, radius_reply, request_time, tenant_id, radius_ip) VALUES ( '%{request:Calling-Station-Id}', '%{request:Framed-IP-Address}', '%{%{control:PacketFence-Computer-Name}:-N/A}', '%{request:User-Name}', '%{request:Stripped-User-Name}', '%{request:Realm}', 'Radius-Access-Request', '%{%{control:PacketFence-Switch-Id}:-N/A}', '%{%{control:PacketFence-Switch-Mac}:-N/A}', '%{%{control:PacketFence-Switch-Ip-Address}:-N/A}', '%{Packet-Src-IP-Address}', '%{request:Called-Station-Id}', '%{request:Calling-Station-Id}', '%{request:NAS-Port-Type}', '%{request:Called-Station-SSID}', '%{request:NAS-Port-Id}', '%{%{control:PacketFence-IfIndex}:-N/A}', '%{request:NAS-Port}', '%{%{control:PacketFence-Connection-Type}:-N/A}', '%{request:NAS-IP-Address}', '%{request:NAS-Identifier}', 'Reject', '%{request:Module-Failure-Message}', '%{control:Auth-Type}', '%{request:EAP-Type}', '%{%{control:PacketFence-Role}:-N/A}', '%{%{control:PacketFence-Status}:-N/A}', '%{%{control:PacketFence-Profile}:-N/A}', '%{%{control:PacketFence-Source}:-N/A}', '%{%{control:PacketFence-AutoReg}:-0}', '%{%{control:PacketFence-IsPhone}:-0}', '%{request:PacketFence-Domain}', '', '%{pairs:&request:[*]}','%{pairs:&reply:[*]}', '%{%{control:PacketFence-Request-Time}:-0}', '%{control:PacketFence-Tenant-Id}', '%{request:PacketFence-Radius-Ip}') rlm_perl: oauth2 worker (tanuvas.edu.in): syncing in 27 seconds (6) sql_reject: --> INSERT INTO radius_audit_log ( mac, ip, computer_name, user_name, stripped_user_name, realm, event_type, switch_id, switch_mac, switch_ip_address, radius_source_ip_address, called_station_id, calling_station_id, nas_port_type, ssid, nas_port_id, ifindex, nas_port, connection_type, nas_ip_address, nas_identifier, auth_status, reason, auth_type, eap_type, role, node_status, profile, source, auto_reg, is_phone, pf_domain, uuid, radius_request, radius_reply, request_time, tenant_id, radius_ip) VALUES ( '70:66:55:fc:a6:f1', '', 'N/A', 'MTP19003(a)tanuvas.edu.in', 'MTP19003', 'tanuvas.edu.in', 'Radius-Access-Request', 'N/A', 'N/A', 'N/A', '172.16.20.210', 'b8:3a:5a:c7:10:08', '70:66:55:fc:a6:f1', 'Wireless-802.11', 'TANUVAS', '', 'N/A', '0', 'N/A', '172.16.20.210', '172.16.20.101', 'Reject', 'No Auth-Type found: rejecting the user via Post-Auth-Type =3D Reject', '', 'TTLS', 'N/A', 'N/A', 'N/A', 'N/A', '0', '0', '', '', 'Stripped-User-Name =3D =22MTP19003=22, Calling-Station-Id =3D =2270:66:55:fc:a6:f1=22, Framed-MTU =3D 1100, NAS-Identifier =3D =22172.16.20.101=22, User-Name =3D =22MTP19003(a)tanuvas.edu.in=22, Service-Type =3D Framed-User, EAP-Type =3D TTLS, PacketFence-Outer-User =3D =22(a)tanuvas.edu.in=22, Aruba-Device-Type =3D =22NOFP=22, NAS-Port-Type =3D Wireless-802.11, FreeRADIUS-Proxied-To =3D 127.0.0.1, Event-Timestamp =3D =22Mar 16 2022 22:24:44 IST=22, NAS-Port =3D 0, PacketFence-Radius-Ip =3D =22172.16.11.10=22, PacketFence-KeyBalanced =3D =22676ae0f0be13d41f008250df0c25be53=22, NAS-IP-Address =3D 172.16.20.210, Aruba-Location-Id =3D =22CECONDS=22, Aruba-AP-Group =3D =22MVC_AcademicAP_VC=22, User-Password =3D =22=2A=2A=2A=2A=2A=2A=22, Realm =3D =22tanuvas.edu.in=22, Aruba-Essid-Name =3D =22TANUVAS=22, Called-Station-Id =3D =22b8:3a:5a:c7:10:08=22, Called-Station-SSID =3D =22TANUVAS=22, Module-Failure-Message =3D =22No Auth-Type found: rejecting the user via Post-Auth-Type =3D Reject=22, SQL-User-Name =3D = 22MTP19003(a)tanuvas.edu.in=22','', '0', '1', '172.16.11.10') (6) sql_reject: Executing query: INSERT INTO radius_audit_log ( mac, ip, computer_name, user_name, stripped_user_name, realm, event_type, switch_id, switch_mac, switch_ip_address, radius_source_ip_address, called_station_id, calling_station_id, nas_port_type, ssid, nas_port_id, ifindex, nas_port, connection_type, nas_ip_address, nas_identifier, auth_status, reason, auth_type, eap_type, role, node_status, profile, source, auto_reg, is_phone, pf_domain, uuid, radius_request, radius_reply, request_time, tenant_id, radius_ip) VALUES ( '70:66:55:fc:a6:f1', '', 'N/A', 'MTP19003(a)tanuvas.edu.in', 'MTP19003', 'tanuvas.edu.in', 'Radius-Access-Request', 'N/A', 'N/A', 'N/A', '172.16.20.210', 'b8:3a:5a:c7:10:08', '70:66:55:fc:a6:f1', 'Wireless-802.11', 'TANUVAS', '', 'N/A', '0', 'N/A', '172.16.20.210', '172.16.20.101', 'Reject', 'No Auth-Type found: rejecting the user via Post-Auth-Type =3D Reject', '', 'TTLS', 'N/A', 'N/A', 'N/A', 'N/A', '0', '0', '', '', 'Stripped-User-Name =3D =22MTP19003=22, Calling-Station-Id =3D =2270:66:55:fc:a6:f1=22, Framed-MTU =3D 1100, NAS-Identifier =3D =22172.16.20.101=22, User-Name =3D = 22MTP19003(a)tanuvas.edu.in=22, Service-Type =3D Framed-User, EAP-Type =3D TTLS, PacketFence-Outer-User =3D =22(a)tanuvas.edu.in=22, Aruba-Device-Type =3D =22NOFP=22, NAS-Port-Type =3D Wireless-802.11, FreeRADIUS-Proxied-To =3D 127.0.0.1, Event-Timestamp =3D =22Mar 16 2022 22:24:44 IST=22, NAS-Port =3D 0, PacketFence-Radius-Ip =3D =22172.16.11.10=22, PacketFence-KeyBalanced =3D =22676ae0f0be13d41f008250df0c25be53=22, NAS-IP-Address =3D 172.16.20.210, Aruba-Location-Id =3D =22CECONDS=22, Aruba-AP-Group =3D =22MVC_AcademicAP_VC=22, User-Password =3D =22=2A=2A=2A=2A=2A=2A=22, Realm =3D =22tanuvas.edu.in=22, Aruba-Essid-Name =3D =22TANUVAS=22, Called-Station-Id =3D =22b8:3a:5a:c7:10:08=22, Called-Station-SSID =3D =22TANUVAS=22, Module-Failure-Message =3D =22No Auth-Type found: rejecting the user via Post-Auth-Type =3D Reject=22, SQL-User-Name =3D =22MTP19003(a)tanuvas.edu.in=22','', '0', '1', '172.16.11.10') (6) sql_reject: SQL query returned: success (6) sql_reject: 1 record(s) updated rlm_sql (sql): Released connection (1) Need more connections to reach 10 spares rlm_sql (sql): Opening additional connection (4), 1 of 60 pending slots used rlm_sql_mysql: Starting connect to MySQL server rlm_sql_mysql: Connected to database 'pf' on Localhost via UNIX socket, server version 10.5.15-MariaDB-1:10.5.15+maria~bullseye, protocol version 10 (6) [sql_reject] = ok (6) } # else = ok (6) } # policy packetfence-audit-log-reject = ok (6) attr_filter.access_reject: EXPAND %{User-Name} (6) attr_filter.access_reject: --> MTP19003(a)tanuvas.edu.in (6) attr_filter.access_reject: Matched entry DEFAULT at line 11 (6) [attr_filter.access_reject] = updated (6) update outer.session-state { (6) *&Module-Failure-Message := &request:Module-Failure-Message -> 'No Auth-Type found: rejecting the user via Post-Auth-Type = Reject'* (6) } # update outer.session-state = noop (6) } # Post-Auth-Type REJECT = updated (6) *Login incorrect (No Auth-Type found: rejecting the user via Post-Auth-Type = Reject): [MTP19003(a)tanuvas.edu.in <MTP19003(a)tanuvas.edu.in>] (from client 172.16.20.210/32 <http://172.16.20.210/32> port 0 cli 70:66:55:fc:a6:f1 via TLS tunnel)* (6) } # server packetfence-tunnel (6) Virtual server sending reply (6) eap_ttls: Got tunneled Access-Reject (6) eap: ERROR: Failed continuing EAP TTLS (21) session. EAP sub-module failed (6) eap: Sending EAP Failure (code 4) ID 8 length 4 (6) eap: Failed in EAP select (6) [eap] = invalid (6) } # authenticate = invalid (6) Failed to authenticate the user (6) Using Post-Auth-Type Reject (6) # Executing group from file /usr/local/pf/raddb/sites-enabled/packetfence (6) Post-Auth-Type REJECT { (6) policy packetfence-set-tenant-id { (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0"){ (6) if (!NAS-IP-Address || NAS-IP-Address == "0.0.0.0") -> FALSE (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") { (6) EXPAND %{%{control:PacketFence-Tenant-Id}:-0} (6) --> 1 (6) if ( "%{%{control:PacketFence-Tenant-Id}:-0}" == "0") -> FALSE (6) if ( &control:PacketFence-Tenant-Id == 0 ) { (6) if ( &control:PacketFence-Tenant-Id == 0 ) -> FALSE (6) } # policy packetfence-set-tenant-id = noop (6) update { (6) &request:User-Password := "******" (6) } # update = noop (6) if (! EAP-Type || (EAP-Type != TTLS && EAP-Type != PEAP) ) { (6) if (! EAP-Type || (EAP-Type != TTLS && EAP-Type != PEAP) ) -> FALSE (6) if ("%{%{control:PacketFence-Proxied-From}:-False}" == "True") { (6) EXPAND %{%{control:PacketFence-Proxied-From}:-False} (6) --> False (6) if ("%{%{control:PacketFence-Proxied-From}:-False}" == "True") -> FALSE (6) attr_filter.access_reject: EXPAND %{User-Name} (6) attr_filter.access_reject: --> @tanuvas.edu.in (6) attr_filter.access_reject: Matched entry DEFAULT at line 11 (6) [attr_filter.access_reject] = updated (6) attr_filter.packetfence_post_auth: EXPAND %{User-Name} (6) attr_filter.packetfence_post_auth: --> @tanuvas.edu.in (6) attr_filter.packetfence_post_auth: Matched entry DEFAULT at line 10 (6) [attr_filter.packetfence_post_auth] = updated (6) [eap] = noop (6) policy remove_reply_message_if_eap { (6) if (&reply:EAP-Message && &reply:Reply-Message) { (6) if (&reply:EAP-Message && &reply:Reply-Message) -> FALSE (6) else { (6) [noop] = noop (6) } # else = noop (6) } # policy remove_reply_message_if_eap = noop (6) linelog: EXPAND messages.%{%{reply:Packet-Type}:-default} (6) linelog: --> messages.Access-Reject (6) linelog: EXPAND [mac:%{Calling-Station-Id}] Rejected user: %{User-Name} (6) linelog: --> [mac:70:66:55:fc:a6:f1] Rejected user: @tanuvas.edu.in (6) [linelog] = ok (6) } # Post-Auth-Type REJECT = updated (6) *Login incorrect (eap: Failed continuing EAP TTLS (21) session. EAP sub-module failed): [@tanuvas.edu.in <http://tanuvas.edu.in>] (from client 172.16.20.210/32 <http://172.16.20.210/32> port 0 cli 70:66:55:fc:a6:f1)* (6) Delaying response for 1.000000 seconds Thread 1 waiting to be assigned a request (0) Cleaning up request packet ID 61 with timestamp +42 (1) Cleaning up request packet ID 62 with timestamp +42 (2) Cleaning up request packet ID 63 with timestamp +42 (3) Cleaning up request packet ID 64 with timestamp +42 (4) Cleaning up request packet ID 65 with timestamp +42 (5) Cleaning up request packet ID 66 with timestamp +42 Waking up in 0.5 seconds. (6) Sending delayed response (6) Sent Access-Reject Id 67 from 172.16.11.10:1812 to 172.16.20.210:57049 length 44 (6) EAP-Message = 0x04080004 (6) Message-Authenticator = 0x00000000000000000000000000000000 Waking up in 3.9 seconds. (6) Cleaning up request packet ID 67 with timestamp +44 Ready to process requests The user could not connect with his Azure AD credentials Can anyone help me to resovle the issue? Regards, Thirunavukkarasu

1 0

Issue with OpenSSL
by Alan DeKok 16 Mar '22

16 Mar '22

If you have EAP-TLS or RadSec configured, you probably want to update OpenSSL: https://www.openssl.org/news/secadv/20220315.txt This isn't an issue in FreeRADIUS but a malicious person can use WiFi + EAP-TLS to "lock up" the RADIUS server. The only fix is to either disable the use of client certificates, or to upgrade OpenSSL. Alan DeKok.

1 0

Triggers in freeradius.
by Julio Edel Salas Díaz 15 Mar '22

15 Mar '22

Hi, I have configured a old freeradius server where every day execute a code to verify active users but not remember now. The freeradius server use postgresql database.

2 1

sqlippool log messages to stdout
by Matteo Sgalaberni 14 Mar '22

14 Mar '22

Hi, I'm struggling by configuring the accounting for logs of module sqlippool (messages exists/success/clear/failed/nopool) (freeradius 3.x). I would like to have these logs directed to my stdout as I'm using freeradius into a docker container and also the main logs of freeradius are directed to stdout. I found a way to log them via linelog but I need the logs to be directed to stdout. The module linelog does not support it ;( Is there a way to log the attribute %{control:Module-Success-Message} that contain these information to the standard radius log module? In that way I will find sqlippool logs "mixed" with the other freeradius logs (as was in the 2.x freeradius release). Probably the right way it's via the update/control directive but I didn't got lucky by reading the docs and experimenting... Can a freeradius expert point me to the right direction? Thanks! Matteo

3 6

Calling-Station-Id Issue
by Ammad Ali 11 Mar '22

11 Mar '22

Hi Guys, We are currently using FR 3.0.4 on CentOS7 with SQL backend. Now we are planning to migrate it to 3.0.25 installed from https://networkradius.com/packages/#:~:text=number%20of%20platforms-,UBUNTU, -Add%20the%20APT Currently the authentication is getting failed with below logs. Thu Mar 10 13:47:43 2022 : Debug: rlm_sql (sql): Reserved connection (0) Thu Mar 10 13:47:43 2022 : Debug: SELECT id, username, attribute, value, op FROM radcheck WHERE username = BINARY '%{SQL-User-Name}' ORDER BY id Thu Mar 10 13:47:43 2022 : Debug: Parsed xlat tree: Thu Mar 10 13:47:43 2022 : Debug: literal --> SELECT id, username, attribute, value, op FROM radcheck WHERE username = BINARY ' Thu Mar 10 13:47:43 2022 : Debug: attribute --> SQL-User-Name Thu Mar 10 13:47:43 2022 : Debug: literal --> ' ORDER BY id Thu Mar 10 13:47:43 2022 : Debug: (0) sql: EXPAND SELECT id, username, attribute, value, op FROM radcheck WHERE username = BINARY '%{SQL-User-Name}' ORDER BY id Thu Mar 10 13:47:43 2022 : Debug: (0) sql: --> SELECT id, username, attribute, value, op FROM radcheck WHERE username = BINARY 'noctest' ORDER BY id Thu Mar 10 13:47:43 2022 : Debug: (0) sql: Executing select query: SELECT id, username, attribute, value, op FROM radcheck WHERE username = BINARY 'noctest' ORDER BY id Thu Mar 10 13:47:43 2022 : Debug: (0) sql: User found in radcheck table Thu Mar 10 13:47:43 2022 : ERROR: (0) sql: Thu Mar 10 13:47:43 2022 : ERROR: (0) sql: ^ Empty expression Thu Mar 10 13:47:43 2022 : WARNING: (0) sql: check items do not match. Thu Mar 10 13:47:43 2022 : Debug: (0) sql: ... falling-through to group processing Thu Mar 10 13:47:43 2022 : Debug: SELECT groupname FROM radusergroup WHERE username = BINARY '%{SQL-User-Name}' ORDER BY priority Thu Mar 10 13:47:43 2022 : Debug: Parsed xlat tree: Thu Mar 10 13:47:43 2022 : Debug: literal --> SELECT groupname FROM radusergroup WHERE username = BINARY ' ... Thu Mar 10 13:47:43 2022 : Debug: rlm_sql_mysql: Socket destructor called, closing socket Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: returned from sql (rlm_sql) Thu Mar 10 13:47:43 2022 : Debug: (0) [sql] = ok Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: calling expiration (rlm_expiration) Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: returned from expiration (rlm_expiration) Thu Mar 10 13:47:43 2022 : Debug: (0) [expiration] = noop Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: calling logintime (rlm_logintime) Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: returned from logintime (rlm_logintime) Thu Mar 10 13:47:43 2022 : Debug: (0) [logintime] = noop Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: calling pap (rlm_pap) Thu Mar 10 13:47:43 2022 : WARNING: (0) pap: No "known good" password found for the user. Not setting Auth-Type Thu Mar 10 13:47:43 2022 : WARNING: (0) pap: Authentication will fail unless a "known good" password is available Thu Mar 10 13:47:43 2022 : Debug: (0) modsingle[authorize]: returned from pap (rlm_pap) Thu Mar 10 13:47:43 2022 : Debug: (0) [pap] = noop Thu Mar 10 13:47:43 2022 : Debug: (0) } # authorize = ok Thu Mar 10 13:47:43 2022 : ERROR: (0) No Auth-Type found: rejecting the user via Post-Auth-Type = Reject Thu Mar 10 13:47:43 2022 : Debug: (0) Failed to authenticate the user The full logs are here. https://pastebin.com/r1b2nZRc I am using below values in radcheck table for user. I am using Calling-Station-Id to restrict MAC as well. mysql> SELECT id, username, attribute, value, op FROM radcheck WHERE username = 'noctest' ORDER BY id -> ; +---------+----------+--------------------+---------+----+ | id | username | attribute | value | op | +---------+----------+--------------------+---------+----+ | 2882016 | noctest | Cleartext-Password | noctest | := | | 2882017 | noctest | Calling-Station-Id | | =~ | +---------+----------+--------------------+---------+----+ I have tested by removing the Calling-Station-Id ROW from radcheck table. The authentication goes successful Thu Mar 10 18:04:04 2022 : Debug: Parsed xlat tree: Thu Mar 10 18:04:04 2022 : Debug: literal --> SELECT id, username, attribute, value, op FROM radcheck WHERE username = ' Thu Mar 10 18:04:04 2022 : Debug: attribute --> SQL-User-Name Thu Mar 10 18:04:04 2022 : Debug: literal --> ' ORDER BY id Thu Mar 10 18:04:04 2022 : Debug: (3) sql: EXPAND SELECT id, username, attribute, value, op FROM radcheck WHERE username = '%{SQL-User-Name}' ORDER BY id Thu Mar 10 18:04:04 2022 : Debug: (3) sql: --> SELECT id, username, attribute, value, op FROM radcheck WHERE username = 'noctest' ORDER BY id Thu Mar 10 18:04:04 2022 : Debug: (3) sql: Executing select query: SELECT id, username, attribute, value, op FROM radcheck WHERE username = 'noctest' ORDER BY id Thu Mar 10 18:04:04 2022 : Debug: (3) sql: User found in radcheck table Thu Mar 10 18:04:04 2022 : Debug: (3) sql: Conditional check items matched, merging assignment check items Thu Mar 10 18:04:04 2022 : Debug: (3) sql: Cleartext-Password := "noctest" Thu Mar 10 18:04:04 2022 : Debug: (3) sql: ::: FROM 1 TO 0 MAX 1 Thu Mar 10 18:04:04 2022 : Debug: (3) sql: ::: Examining Cleartext-Password Thu Mar 10 18:04:04 2022 : Debug: (3) sql: ::: APPENDING Cleartext-Password FROM 0 TO 0 Thu Mar 10 18:04:04 2022 : Debug: (3) sql: ::: TO in 0 out 0 Thu Mar 10 18:04:04 2022 : Debug: SELECT id, username, attribute, value, op FROM radreply WHERE username = '%{SQL-User-Name}' ORDER BY id Thu Mar 10 18:04:04 2022 : Debug: Parsed xlat tree: .. Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: returned from sql (rlm_sql) Thu Mar 10 18:04:04 2022 : Debug: (3) [sql] = ok Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: calling expiration (rlm_expiration) Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: returned from expiration (rlm_expiration) Thu Mar 10 18:04:04 2022 : Debug: (3) [expiration] = noop Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: calling logintime (rlm_logintime) Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: returned from logintime (rlm_logintime) Thu Mar 10 18:04:04 2022 : Debug: (3) [logintime] = noop Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: calling pap (rlm_pap) Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authorize]: returned from pap (rlm_pap) Thu Mar 10 18:04:04 2022 : Debug: (3) [pap] = updated Thu Mar 10 18:04:04 2022 : Debug: (3) } # authorize = updated Thu Mar 10 18:04:04 2022 : Debug: (3) Found Auth-Type = PAP Thu Mar 10 18:04:04 2022 : Debug: (3) # Executing group from file /etc/freeradius/sites-enabled/default Thu Mar 10 18:04:04 2022 : Debug: (3) Auth-Type PAP { Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authenticate]: calling pap (rlm_pap) Thu Mar 10 18:04:04 2022 : Debug: (3) pap: Login attempt with password "noctest" (7) Thu Mar 10 18:04:04 2022 : Debug: (3) pap: Comparing with "known good" Cleartext-Password "noctest" (7) Thu Mar 10 18:04:04 2022 : Debug: (3) pap: User authenticated successfully Thu Mar 10 18:04:04 2022 : Debug: (3) modsingle[authenticate]: returned from pap (rlm_pap) Thu Mar 10 18:04:04 2022 : Debug: (3) [pap] = ok Thu Mar 10 18:04:04 2022 : Debug: (3) } # Auth-Type PAP = ok Thu Mar 10 18:04:04 2022 : Debug: (3) # Executing section session from file /etc/freeradius/sites-enabled/default Thu Mar 10 18:04:04 2022 : Debug: (3) session { Full logs are here. https://pastebin.com/7xvgukiq With my current production setup I am using Calling-Station-Id to restrict MAC for authentication and I want to use the same with 3.0.25. How to achieve this ? Ammad

3 4

Vlan Assignement depending on Ip source adress
by Benoit RAYNIER 10 Mar '22

10 Mar '22

Hello, I have configured a freeradius V3 with automatic VLAN assignement, all work fine. I want to know how it is possible to assign a VLAN depending on the IP source Adress. For Exemple : If user A connect freeradius from 18.18.18.18 (public ip) ==> Assign VLAN 1 If user A connect freeradius from 22.22.22.22 (public ip) ==> Assign VLAN 3 If user A connect freeradius from 34.34.32.12 (public ip) ==> Assign VLAN 22 Thanks for your help. Ben

5 7

FreeRadius not responding to requests from external host
by Darren Share 09 Mar '22

09 Mar '22

Hi, Hope someone can tell me where I’m going wrong here, because I’m stumped. CentOS 7, with pretty much a default installation of FreeRadius. Client config: client localhost { ipaddr = 127.0.0.1 proto = * secret = testing123 require_message_authenticator = no limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } client localhost_ipv6 { ipv6addr = ::1 secret = testing123 } client private-network-1 { ipaddr = 172.31.0.0/16 secret = password } FR server is on 172.31.2.11. Firewalld turned off. FR responds perfectly to requests from an application running locally on the same server. A copy of the same application on a server with IP 172.31.1.36 is not getting any response. The output of radiusd -X shows nothing, as if it didn’t receive a request, yet packets are arriving as per tcpdump: 14:55:13.682482 IP (tos 0x0, ttl 64, id 60077, offset 0, flags [DF], proto UDP (17), length 93) 172.31.1.36.58188 > 172.31.2.11.1812: RADIUS, length: 65 Access-Request (1), id: 0x0c, Authenticator: 563b39fc146c0193e012f3787be53c16 User-Name Attribute (1), length: 8, Value: darren CHAP-Password Attribute (3), length: 19, Value: CHAP-Challenge Attribute (60), length: 18, Value: ......#5|:O..... [root@tp11 raddb]# firewall-cmd --list-all FirewallD is not running [root@tp11 raddb]# iptables -L -n -v Chain INPUT (policy ACCEPT 992 packets, 240K bytes) pkts bytes target prot opt in out source destination Chain FORWARD (policy ACCEPT 0 packets, 0 bytes) pkts bytes target prot opt in out source destination Chain OUTPUT (policy ACCEPT 835 packets, 229K bytes) pkts bytes target prot opt in out source destination I can see radiusd listening as expected: [root@tp11 raddb]# netstat -apn | grep radiusd udp 0 0 0.0.0.0:34270 0.0.0.0:* 43979/radiusd udp 0 0 127.0.0.1:18120 0.0.0.0:* 43979/radiusd udp 0 0 0.0.0.0:1812 0.0.0.0:* 43979/radiusd udp 0 0 0.0.0.0:1813 0.0.0.0:* 43979/radiusd udp6 0 0 :::56652 :::* 43979/radiusd udp6 0 0 :::1812 :::* 43979/radiusd udp6 0 0 :::1813 :::* 43979/radiusd Complete output of radiusd -X: FreeRADIUS Version 3.0.13 Copyright (C) 1999-2017 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/raddb/dictionary including configuration file /etc/raddb/radiusd.conf including configuration file /etc/raddb/proxy.conf including configuration file /etc/raddb/clients.conf including files in directory /etc/raddb/mods-enabled/ including configuration file /etc/raddb/mods-enabled/always including configuration file /etc/raddb/mods-enabled/attr_filter including configuration file /etc/raddb/mods-enabled/cache_eap including configuration file /etc/raddb/mods-enabled/chap including configuration file /etc/raddb/mods-enabled/date including configuration file /etc/raddb/mods-enabled/detail including configuration file /etc/raddb/mods-enabled/detail.log including configuration file /etc/raddb/mods-enabled/dhcp including configuration file /etc/raddb/mods-enabled/digest including configuration file /etc/raddb/mods-enabled/dynamic_clients including configuration file /etc/raddb/mods-enabled/eap including configuration file /etc/raddb/mods-enabled/echo including configuration file /etc/raddb/mods-enabled/exec including configuration file /etc/raddb/mods-enabled/expiration including configuration file /etc/raddb/mods-enabled/expr including configuration file /etc/raddb/mods-enabled/files including configuration file /etc/raddb/mods-enabled/linelog including configuration file /etc/raddb/mods-enabled/logintime including configuration file /etc/raddb/mods-enabled/mschap including configuration file /etc/raddb/mods-enabled/ntlm_auth including configuration file /etc/raddb/mods-enabled/pap including configuration file /etc/raddb/mods-enabled/passwd including configuration file /etc/raddb/mods-enabled/preprocess including configuration file /etc/raddb/mods-enabled/radutmp including configuration file /etc/raddb/mods-enabled/realm including configuration file /etc/raddb/mods-enabled/replicate including configuration file /etc/raddb/mods-enabled/soh including configuration file /etc/raddb/mods-enabled/sradutmp including configuration file /etc/raddb/mods-enabled/unix including configuration file /etc/raddb/mods-enabled/unpack including configuration file /etc/raddb/mods-enabled/utf8 including files in directory /etc/raddb/policy.d/ including configuration file /etc/raddb/policy.d/accounting including configuration file /etc/raddb/policy.d/canonicalization including configuration file /etc/raddb/policy.d/control including configuration file /etc/raddb/policy.d/cui including configuration file /etc/raddb/policy.d/debug including configuration file /etc/raddb/policy.d/dhcp including configuration file /etc/raddb/policy.d/eap including configuration file /etc/raddb/policy.d/filter including configuration file /etc/raddb/policy.d/operator-name including files in directory /etc/raddb/sites-enabled/ including configuration file /etc/raddb/sites-enabled/default including configuration file /etc/raddb/sites-enabled/inner-tunnel main { security { user = "radiusd" group = "radiusd" allow_core_dumps = no } name = "radiusd" prefix = "/usr" localstatedir = "/var" logdir = "/var/log/radius" run_dir = "/var/run/radiusd" } main { name = "radiusd" prefix = "/usr" localstatedir = "/var" sbindir = "/usr/sbin" logdir = "/var/log/radius" run_dir = "/var/run/radiusd" libdir = "/usr/lib64/freeradius" radacctdir = "/var/log/radius/radacct" hostname_lookups = no max_request_time = 30 cleanup_delay = 5 max_requests = 16384 pidfile = "/var/run/radiusd/radiusd.pid" checkrad = "/usr/sbin/checkrad" debug_level = 0 proxy_requests = yes 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 #### 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 = <<< secret >>> response_window = 20.000000 response_timeouts = 1 max_outstanding = 65536 zombie_period = 40 status_check = "status-server" ping_interval = 30 check_interval = 30 check_timeout = 4 num_answers_to_alive = 3 revive_interval = 120 limit { max_connections = 16 max_requests = 0 lifetime = 0 idle_timeout = 0 } 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 = <<< 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 private-network-1 { ipaddr = 172.31.0.0/16 require_message_authenticator = no secret = <<< secret >>> limit { max_connections = 16 lifetime = 0 idle_timeout = 30 } } Debugger not attached # Creating Auth-Type = mschap # Creating Auth-Type = digest # Creating Auth-Type = eap # Creating Auth-Type = PAP # Creating Auth-Type = CHAP # Creating Auth-Type = MS-CHAP radiusd: #### Instantiating modules #### modules { # Loaded module rlm_always # Loading module "reject" from file /etc/raddb/mods-enabled/always always reject { rcode = "reject" simulcount = 0 mpp = no } # Loading module "fail" from file /etc/raddb/mods-enabled/always always fail { rcode = "fail" simulcount = 0 mpp = no } # Loading module "ok" from file /etc/raddb/mods-enabled/always always ok { rcode = "ok" simulcount = 0 mpp = no } # Loading module "handled" from file /etc/raddb/mods-enabled/always always handled { rcode = "handled" simulcount = 0 mpp = no } # Loading module "invalid" from file /etc/raddb/mods-enabled/always always invalid { rcode = "invalid" simulcount = 0 mpp = no } # Loading module "userlock" from file /etc/raddb/mods-enabled/always always userlock { rcode = "userlock" simulcount = 0 mpp = no } # Loading module "notfound" from file /etc/raddb/mods-enabled/always always notfound { rcode = "notfound" simulcount = 0 mpp = no } # Loading module "noop" from file /etc/raddb/mods-enabled/always always noop { rcode = "noop" simulcount = 0 mpp = no } # Loading module "updated" from file /etc/raddb/mods-enabled/always always updated { rcode = "updated" simulcount = 0 mpp = no } # Loaded module rlm_attr_filter # Loading module "attr_filter.post-proxy" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.post-proxy { filename = "/etc/raddb/mods-config/attr_filter/post-proxy" key = "%{Realm}" relaxed = no } # Loading module "attr_filter.pre-proxy" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.pre-proxy { filename = "/etc/raddb/mods-config/attr_filter/pre-proxy" key = "%{Realm}" relaxed = no } # Loading module "attr_filter.access_reject" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.access_reject { filename = "/etc/raddb/mods-config/attr_filter/access_reject" key = "%{User-Name}" relaxed = no } # Loading module "attr_filter.access_challenge" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.access_challenge { filename = "/etc/raddb/mods-config/attr_filter/access_challenge" key = "%{User-Name}" relaxed = no } # Loading module "attr_filter.accounting_response" from file /etc/raddb/mods-enabled/attr_filter attr_filter attr_filter.accounting_response { filename = "/etc/raddb/mods-config/attr_filter/accounting_response" key = "%{User-Name}" relaxed = no } # Loaded module rlm_cache # Loading module "cache_eap" from file /etc/raddb/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 } # Loaded module rlm_chap # Loading module "chap" from file /etc/raddb/mods-enabled/chap # Loaded module rlm_date # Loading module "date" from file /etc/raddb/mods-enabled/date date { format = "%b %e %Y %H:%M:%S %Z" } # Loaded module rlm_detail # Loading module "detail" from file /etc/raddb/mods-enabled/detail detail { filename = "/var/log/radius/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 } # Loading module "auth_log" from file /etc/raddb/mods-enabled/detail.log detail auth_log { filename = "/var/log/radius/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 } # Loading module "reply_log" from file /etc/raddb/mods-enabled/detail.log detail reply_log { filename = "/var/log/radius/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 } # Loading module "pre_proxy_log" from file /etc/raddb/mods-enabled/detail.log detail pre_proxy_log { filename = "/var/log/radius/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 } # Loading module "post_proxy_log" from file /etc/raddb/mods-enabled/detail.log detail post_proxy_log { filename = "/var/log/radius/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_dhcp # Loading module "dhcp" from file /etc/raddb/mods-enabled/dhcp # Loaded module rlm_digest # Loading module "digest" from file /etc/raddb/mods-enabled/digest # Loaded module rlm_dynamic_clients # Loading module "dynamic_clients" from file /etc/raddb/mods-enabled/dynamic_clients # Loaded module rlm_eap # Loading module "eap" from file /etc/raddb/mods-enabled/eap eap { default_eap_type = "md5" timer_expire = 60 ignore_unknown_eap_types = no cisco_accounting_username_bug = no max_sessions = 16384 } # Loaded module rlm_exec # Loading module "echo" from file /etc/raddb/mods-enabled/echo exec echo { wait = yes program = "/bin/echo %{User-Name}" input_pairs = "request" output_pairs = "reply" shell_escape = yes } # Loading module "exec" from file /etc/raddb/mods-enabled/exec exec { wait = no input_pairs = "request" shell_escape = yes timeout = 10 } # Loaded module rlm_expiration # Loading module "expiration" from file /etc/raddb/mods-enabled/expiration # Loaded module rlm_expr # Loading module "expr" from file /etc/raddb/mods-enabled/expr expr { safe_characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /äéöüàâæçèéêëîïôœùûüaÿÄÉÖÜßÀÂÆÇÈÉÊËÎÏÔŒÙÛÜŸ" } # Loaded module rlm_files # Loading module "files" from file /etc/raddb/mods-enabled/files files { filename = "/etc/raddb/mods-config/files/authorize" acctusersfile = "/etc/raddb/mods-config/files/accounting" preproxy_usersfile = "/etc/raddb/mods-config/files/pre-proxy" } # Loaded module rlm_linelog # Loading module "linelog" from file /etc/raddb/mods-enabled/linelog linelog { filename = "/var/log/radius/linelog" escape_filenames = no syslog_severity = "info" permissions = 384 format = "This is a log message for %{User-Name}" reference = "messages.%{%{reply:Packet-Type}:-default}" } # Loading module "log_accounting" from file /etc/raddb/mods-enabled/linelog linelog log_accounting { filename = "/var/log/radius/linelog-accounting" escape_filenames = no syslog_severity = "info" permissions = 384 format = "" reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}" } # Loaded module rlm_logintime # Loading module "logintime" from file /etc/raddb/mods-enabled/logintime logintime { minimum_timeout = 60 } # Loaded module rlm_mschap # Loading module "mschap" from file /etc/raddb/mods-enabled/mschap mschap { use_mppe = yes require_encryption = no require_strong = no with_ntdomain_hack = yes passchange { } allow_retry = yes winbind_retry_with_normalised_username = no } # Loading module "ntlm_auth" from file /etc/raddb/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 } # Loaded module rlm_pap # Loading module "pap" from file /etc/raddb/mods-enabled/pap pap { normalise = yes } # Loaded module rlm_passwd # Loading module "etc_passwd" from file /etc/raddb/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 } # Loaded module rlm_preprocess # Loading module "preprocess" from file /etc/raddb/mods-enabled/preprocess preprocess { huntgroups = "/etc/raddb/mods-config/preprocess/huntgroups" hints = "/etc/raddb/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 } # Loaded module rlm_radutmp # Loading module "radutmp" from file /etc/raddb/mods-enabled/radutmp radutmp { filename = "/var/log/radius/radutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes permissions = 384 caller_id = yes } # Loaded module rlm_realm # Loading module "IPASS" from file /etc/raddb/mods-enabled/realm realm IPASS { format = "prefix" delimiter = "/" ignore_default = no ignore_null = no } # Loading module "suffix" from file /etc/raddb/mods-enabled/realm realm suffix { format = "suffix" delimiter = "@" ignore_default = no ignore_null = no } # Loading module "realmpercent" from file /etc/raddb/mods-enabled/realm realm realmpercent { format = "suffix" delimiter = "%" ignore_default = no ignore_null = no } # Loading module "ntdomain" from file /etc/raddb/mods-enabled/realm realm ntdomain { format = "prefix" delimiter = "\\" ignore_default = no ignore_null = no } # Loaded module rlm_replicate # Loading module "replicate" from file /etc/raddb/mods-enabled/replicate # Loaded module rlm_soh # Loading module "soh" from file /etc/raddb/mods-enabled/soh soh { dhcp = yes } # Loading module "sradutmp" from file /etc/raddb/mods-enabled/sradutmp radutmp sradutmp { filename = "/var/log/radius/sradutmp" username = "%{User-Name}" case_sensitive = yes check_with_nas = yes permissions = 420 caller_id = no } # Loaded module rlm_unix # Loading module "unix" from file /etc/raddb/mods-enabled/unix unix { radwtmp = "/var/log/radius/radwtmp" } Creating attribute Unix-Group # Loaded module rlm_unpack # Loading module "unpack" from file /etc/raddb/mods-enabled/unpack # Loaded module rlm_utf8 # Loading module "utf8" from file /etc/raddb/mods-enabled/utf8 instantiate { } # Instantiating module "reject" from file /etc/raddb/mods-enabled/always # Instantiating module "fail" from file /etc/raddb/mods-enabled/always # Instantiating module "ok" from file /etc/raddb/mods-enabled/always # Instantiating module "handled" from file /etc/raddb/mods-enabled/always # Instantiating module "invalid" from file /etc/raddb/mods-enabled/always # Instantiating module "userlock" from file /etc/raddb/mods-enabled/always # Instantiating module "notfound" from file /etc/raddb/mods-enabled/always # Instantiating module "noop" from file /etc/raddb/mods-enabled/always # Instantiating module "updated" from file /etc/raddb/mods-enabled/always # Instantiating module "attr_filter.post-proxy" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/post-proxy # Instantiating module "attr_filter.pre-proxy" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/pre-proxy # Instantiating module "attr_filter.access_reject" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/access_reject [/etc/raddb/mods-config/attr_filter/access_reject]:11 Check item "FreeRADIUS-Response-Delay" found in filter list for realm "DEFAULT". [/etc/raddb/mods-config/attr_filter/access_reject]:11 Check item "FreeRADIUS-Response-Delay-USec" found in filter list for realm "DEFAULT". # Instantiating module "attr_filter.access_challenge" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/access_challenge # Instantiating module "attr_filter.accounting_response" from file /etc/raddb/mods-enabled/attr_filter reading pairlist file /etc/raddb/mods-config/attr_filter/accounting_response # Instantiating module "cache_eap" from file /etc/raddb/mods-enabled/cache_eap rlm_cache (cache_eap): Driver rlm_cache_rbtree (module rlm_cache_rbtree) loaded and linked # Instantiating module "detail" from file /etc/raddb/mods-enabled/detail # Instantiating module "auth_log" from file /etc/raddb/mods-enabled/detail.log rlm_detail (auth_log): 'User-Password' suppressed, will not appear in detail output # Instantiating module "reply_log" from file /etc/raddb/mods-enabled/detail.log # Instantiating module "pre_proxy_log" from file /etc/raddb/mods-enabled/detail.log # Instantiating module "post_proxy_log" from file /etc/raddb/mods-enabled/detail.log # Instantiating module "eap" from file /etc/raddb/mods-enabled/eap # 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 { verify_depth = 0 ca_path = "/etc/raddb/certs" pem_file_type = yes private_key_file = "/etc/raddb/certs/server.pem" certificate_file = "/etc/raddb/certs/server.pem" ca_file = "/etc/raddb/certs/ca.pem" private_key_password = <<< secret >>> dh_file = "/etc/raddb/certs/dh" fragment_size = 1024 include_length = yes auto_chain = yes check_crl = no check_all_crl = no cipher_list = "DEFAULT" cipher_server_preference = no ecdh_curve = "prime256v1" cache { enable = no lifetime = 24 max_entries = 255 } verify { skip_if_ocsp_ok = no } 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 = no use_tunneled_reply = no virtual_server = "inner-tunnel" include_length = yes require_client_cert = no } tls: Using cached TLS configuration from previous invocation # Linked to sub-module rlm_eap_peap peap { tls = "tls-common" default_eap_type = "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 } tls: Using cached TLS configuration from previous invocation # Linked to sub-module rlm_eap_mschapv2 mschapv2 { with_ntdomain_hack = no send_error = no } # Instantiating module "expiration" from file /etc/raddb/mods-enabled/expiration # Instantiating module "files" from file /etc/raddb/mods-enabled/files reading pairlist file /etc/raddb/mods-config/files/authorize reading pairlist file /etc/raddb/mods-config/files/accounting reading pairlist file /etc/raddb/mods-config/files/pre-proxy # Instantiating module "linelog" from file /etc/raddb/mods-enabled/linelog # Instantiating module "log_accounting" from file /etc/raddb/mods-enabled/linelog # Instantiating module "logintime" from file /etc/raddb/mods-enabled/logintime # Instantiating module "mschap" from file /etc/raddb/mods-enabled/mschap rlm_mschap (mschap): using internal authentication # Instantiating module "pap" from file /etc/raddb/mods-enabled/pap # Instantiating module "etc_passwd" from file /etc/raddb/mods-enabled/passwd rlm_passwd: nfields: 3 keyfield 0(User-Name) listable: no # Instantiating module "preprocess" from file /etc/raddb/mods-enabled/preprocess reading pairlist file /etc/raddb/mods-config/preprocess/huntgroups reading pairlist file /etc/raddb/mods-config/preprocess/hints # Instantiating module "IPASS" from file /etc/raddb/mods-enabled/realm # Instantiating module "suffix" from file /etc/raddb/mods-enabled/realm # Instantiating module "realmpercent" from file /etc/raddb/mods-enabled/realm # Instantiating module "ntdomain" from file /etc/raddb/mods-enabled/realm } # modules radiusd: #### Loading Virtual Servers #### server { # from file /etc/raddb/radiusd.conf } # server server default { # from file /etc/raddb/sites-enabled/default # Loading authenticate {...} # Loading authorize {...} Ignoring "sql" (see raddb/mods-available/README.rst) Ignoring "ldap" (see raddb/mods-available/README.rst) # Loading preacct {...} # Loading accounting {...} # Loading post-proxy {...} # Loading post-auth {...} } # server default server inner-tunnel { # from file /etc/raddb/sites-enabled/inner-tunnel # Loading authenticate {...} # Loading authorize {...} # Loading session {...} # Loading post-proxy {...} # Loading post-auth {...} # Skipping contents of 'if' as it is always 'false' -- /etc/raddb/sites-enabled/inner-tunnel:330 } # server inner-tunnel radiusd: #### Opening IP addresses and Ports #### 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 } } listen { type = "auth" ipaddr = 127.0.0.1 port = 18120 } 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 Listening on auth address 127.0.0.1 port 18120 bound to server inner-tunnel Listening on proxy address * port 34270 Listening on proxy address :: port 56652 Ready to process requests Thanks in advance. Darren.

4 5