Google Secure LDAP

11 Jun 2019

      I'm attempting to use Google Secure LDAP solution for authentication and 
authorization. I'm not able to use this with a supplicant such as a 
laptop/phone, radtest is working fine which leads me to believe it's an 
issue of the password being hashed by mschap.

I understand from reading previous threads that I need to use 
EAP-TTLS-PAP or PEAP-GTC. How can I get freeradius to work with Google 
Secure LDAP? When freeradius does do an ldap bind which user attribute 
is it looking for? I think userPassword but in this case I don't think 
it exists.

Full debug:

FreeRADIUS Version 3.0.12
Copyright (C) 1999-2016 The FreeRADIUS server project and contributors
There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A
PARTICULAR PURPOSE
You may redistribute copies of FreeRADIUS under the terms of the
GNU General Public License
For more information about these matters, see the file named COPYRIGHT
Starting - reading configuration files ...
including dictionary file /usr/share/freeradius/dictionary
including dictionary file /usr/share/freeradius/dictionary.dhcp
including dictionary file /usr/share/freeradius/dictionary.vqp
including dictionary file /etc/freeradius/3.0/dictionary
including configuration file /etc/freeradius/3.0/radiusd.conf
including configuration file /etc/freeradius/3.0/proxy.conf
including configuration file /etc/freeradius/3.0/clients.conf
including files in directory /etc/freeradius/3.0/mods-enabled/
including configuration file /etc/freeradius/3.0/mods-enabled/cache_eap
including configuration file /etc/freeradius/3.0/mods-enabled/linelog
including configuration file /etc/freeradius/3.0/mods-enabled/sradutmp
including configuration file /etc/freeradius/3.0/mods-enabled/exec
including configuration file /etc/freeradius/3.0/mods-enabled/detail
including configuration file /etc/freeradius/3.0/mods-enabled/realm
including configuration file /etc/freeradius/3.0/mods-enabled/chap
including configuration file /etc/freeradius/3.0/mods-enabled/soh
including configuration file /etc/freeradius/3.0/mods-enabled/preprocess
including configuration file /etc/freeradius/3.0/mods-enabled/always
including configuration file /etc/freeradius/3.0/mods-enabled/digest
including configuration file 
/etc/freeradius/3.0/mods-enabled/attr_filter
including configuration file /etc/freeradius/3.0/mods-enabled/unpack
including configuration file /etc/freeradius/3.0/mods-enabled/logintime
including configuration file /etc/freeradius/3.0/mods-enabled/pap
including configuration file /etc/freeradius/3.0/mods-enabled/ldap
including configuration file /etc/freeradius/3.0/mods-enabled/ntlm_auth
including configuration file /etc/freeradius/3.0/mods-enabled/echo
including configuration file /etc/freeradius/3.0/mods-enabled/files
including configuration file /etc/freeradius/3.0/mods-enabled/unix
including configuration file /etc/freeradius/3.0/mods-enabled/expiration
including configuration file /etc/freeradius/3.0/mods-enabled/utf8
including configuration file 
/etc/freeradius/3.0/mods-enabled/dynamic_clients
including configuration file /etc/freeradius/3.0/mods-enabled/expr
including configuration file /etc/freeradius/3.0/mods-enabled/detail.log
including configuration file /etc/freeradius/3.0/mods-enabled/eap
including configuration file /etc/freeradius/3.0/mods-enabled/replicate
including configuration file /etc/freeradius/3.0/mods-enabled/mschap
including configuration file /etc/freeradius/3.0/mods-enabled/radutmp
including configuration file /etc/freeradius/3.0/mods-enabled/passwd
including files in directory /etc/freeradius/3.0/policy.d/
including configuration file 
/etc/freeradius/3.0/policy.d/moonshot-targeted-ids
including configuration file /etc/freeradius/3.0/policy.d/accounting
including configuration file /etc/freeradius/3.0/policy.d/debug
including configuration file /etc/freeradius/3.0/policy.d/cui
including configuration file 
/etc/freeradius/3.0/policy.d/canonicalization
including configuration file /etc/freeradius/3.0/policy.d/eap
including configuration file /etc/freeradius/3.0/policy.d/filter
including configuration file /etc/freeradius/3.0/policy.d/abfab-tr
including configuration file /etc/freeradius/3.0/policy.d/operator-name
including configuration file /etc/freeradius/3.0/policy.d/dhcp
including configuration file /etc/freeradius/3.0/policy.d/control
including files in directory /etc/freeradius/3.0/sites-enabled/
including configuration file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
including configuration file /etc/freeradius/3.0/sites-enabled/default
main {
  security {
  	user = "freerad"
  	group = "freerad"
  	allow_core_dumps = no
  }
	name = "freeradius"
	prefix = "/usr"
	localstatedir = "/var"
	logdir = "/var/log/freeradius"
	run_dir = "/var/run/freeradius"
}
main {
	name = "freeradius"
	prefix = "/usr"
	localstatedir = "/var"
	sbindir = "/usr/sbin"
	logdir = "/var/log/freeradius"
	run_dir = "/var/run/freeradius"
	libdir = "/usr/lib/freeradius"
	radacctdir = "/var/log/freeradius/radacct"
	hostname_lookups = no
	max_request_time = 30
	cleanup_delay = 5
	max_requests = 16384
	pidfile = "/var/run/freeradius/freeradius.pid"
	checkrad = "/usr/sbin/checkrad"
	debug_level = 0
	proxy_requests = yes
  log {
  	stripped_names = no
  	auth = no
  	auth_badpass = no
  	auth_goodpass = no
  	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 sz {
  	ipaddr = 10.0.32.55
  	require_message_authenticator = no
  	secret = <<< secret >>>
   limit {
   	max_connections = 16
   	lifetime = 0
   	idle_timeout = 30
   }
  }
  client wap1 {
  	ipaddr = 10.1.25.208
  	require_message_authenticator = no
  	secret = <<< secret >>>
  	shortname = "name"
   limit {
   	max_connections = 16
   	lifetime = 0
   	idle_timeout = 30
   }
  }
Debugger not attached
  # Creating Auth-Type = ldap
  # Creating Auth-Type = mschap
  # Creating Auth-Type = eap
  # Creating Auth-Type = PAP
  # Creating Auth-Type = CHAP
  # Creating Auth-Type = MS-CHAP
  # Creating Auth-Type = digest
radiusd: #### Instantiating modules ####
  modules {
   # Loaded module rlm_cache
   # Loading module "cache_eap" from file 
/etc/freeradius/3.0/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_linelog
   # Loading module "linelog" from file 
/etc/freeradius/3.0/mods-enabled/linelog
   linelog {
   	filename = "/var/log/freeradius/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/freeradius/3.0/mods-enabled/linelog
   linelog log_accounting {
   	filename = "/var/log/freeradius/linelog-accounting"
   	escape_filenames = no
   	syslog_severity = "info"
   	permissions = 384
   	format = ""
   	reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}"
   }
   # Loaded module rlm_radutmp
   # Loading module "sradutmp" from file 
/etc/freeradius/3.0/mods-enabled/sradutmp
   radutmp sradutmp {
   	filename = "/var/log/freeradius/sradutmp"
   	username = "%{User-Name}"
   	case_sensitive = yes
   	check_with_nas = yes
   	permissions = 420
   	caller_id = no
   }
   # Loaded module rlm_exec
   # Loading module "exec" from file 
/etc/freeradius/3.0/mods-enabled/exec
   exec {
   	wait = no
   	input_pairs = "request"
   	shell_escape = yes
   	timeout = 10
   }
   # Loaded module rlm_detail
   # Loading module "detail" from file 
/etc/freeradius/3.0/mods-enabled/detail
   detail {
   	filename = 
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d"
   	header = "%t"
   	permissions = 384
   	locking = no
   	escape_filenames = no
   	log_packet_header = no
   }
   # Loaded module rlm_realm
   # Loading module "IPASS" from file 
/etc/freeradius/3.0/mods-enabled/realm
   realm IPASS {
   	format = "prefix"
   	delimiter = "/"
   	ignore_default = no
   	ignore_null = no
   }
   # Loading module "suffix" from file 
/etc/freeradius/3.0/mods-enabled/realm
   realm suffix {
   	format = "suffix"
   	delimiter = "@"
   	ignore_default = no
   	ignore_null = no
   }
   # Loading module "realmpercent" from file 
/etc/freeradius/3.0/mods-enabled/realm
   realm realmpercent {
   	format = "suffix"
   	delimiter = "%"
   	ignore_default = no
   	ignore_null = no
   }
   # Loading module "ntdomain" from file 
/etc/freeradius/3.0/mods-enabled/realm
   realm ntdomain {
   	format = "prefix"
   	delimiter = "\\"
   	ignore_default = no
   	ignore_null = no
   }
   # Loaded module rlm_chap
   # Loading module "chap" from file 
/etc/freeradius/3.0/mods-enabled/chap
   # Loaded module rlm_soh
   # Loading module "soh" from file /etc/freeradius/3.0/mods-enabled/soh
   soh {
   	dhcp = yes
   }
   # Loaded module rlm_preprocess
   # Loading module "preprocess" from file 
/etc/freeradius/3.0/mods-enabled/preprocess
   preprocess {
   	huntgroups = "/etc/freeradius/3.0/mods-config/preprocess/huntgroups"
   	hints = "/etc/freeradius/3.0/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_always
   # Loading module "reject" from file 
/etc/freeradius/3.0/mods-enabled/always
   always reject {
   	rcode = "reject"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "fail" from file 
/etc/freeradius/3.0/mods-enabled/always
   always fail {
   	rcode = "fail"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "ok" from file 
/etc/freeradius/3.0/mods-enabled/always
   always ok {
   	rcode = "ok"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "handled" from file 
/etc/freeradius/3.0/mods-enabled/always
   always handled {
   	rcode = "handled"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "invalid" from file 
/etc/freeradius/3.0/mods-enabled/always
   always invalid {
   	rcode = "invalid"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "userlock" from file 
/etc/freeradius/3.0/mods-enabled/always
   always userlock {
   	rcode = "userlock"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "notfound" from file 
/etc/freeradius/3.0/mods-enabled/always
   always notfound {
   	rcode = "notfound"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "noop" from file 
/etc/freeradius/3.0/mods-enabled/always
   always noop {
   	rcode = "noop"
   	simulcount = 0
   	mpp = no
   }
   # Loading module "updated" from file 
/etc/freeradius/3.0/mods-enabled/always
   always updated {
   	rcode = "updated"
   	simulcount = 0
   	mpp = no
   }
   # Loaded module rlm_digest
   # Loading module "digest" from file 
/etc/freeradius/3.0/mods-enabled/digest
   # Loaded module rlm_attr_filter
   # Loading module "attr_filter.post-proxy" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
   attr_filter attr_filter.post-proxy {
   	filename = "/etc/freeradius/3.0/mods-config/attr_filter/post-proxy"
   	key = "%{Realm}"
   	relaxed = no
   }
   # Loading module "attr_filter.pre-proxy" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
   attr_filter attr_filter.pre-proxy {
   	filename = "/etc/freeradius/3.0/mods-config/attr_filter/pre-proxy"
   	key = "%{Realm}"
   	relaxed = no
   }
   # Loading module "attr_filter.access_reject" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
   attr_filter attr_filter.access_reject {
   	filename = 
"/etc/freeradius/3.0/mods-config/attr_filter/access_reject"
   	key = "%{User-Name}"
   	relaxed = no
   }
   # Loading module "attr_filter.access_challenge" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
   attr_filter attr_filter.access_challenge {
   	filename = 
"/etc/freeradius/3.0/mods-config/attr_filter/access_challenge"
   	key = "%{User-Name}"
   	relaxed = no
   }
   # Loading module "attr_filter.accounting_response" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
   attr_filter attr_filter.accounting_response {
   	filename = 
"/etc/freeradius/3.0/mods-config/attr_filter/accounting_response"
   	key = "%{User-Name}"
   	relaxed = no
   }
   # Loaded module rlm_unpack
   # Loading module "unpack" from file 
/etc/freeradius/3.0/mods-enabled/unpack
   # Loaded module rlm_logintime
   # Loading module "logintime" from file 
/etc/freeradius/3.0/mods-enabled/logintime
   logintime {
   	minimum_timeout = 60
   }
   # Loaded module rlm_pap
   # Loading module "pap" from file /etc/freeradius/3.0/mods-enabled/pap
   pap {
   	normalise = yes
   }
   # Loaded module rlm_ldap
   # Loading module "ldap" from file 
/etc/freeradius/3.0/mods-enabled/ldap
   ldap {
   	server = "ldaps://ldap.google.com:636"
   	identity = "SomethingCrazy"
   	password = <<< secret >>>
    sasl {
    }
    user {
    	scope = "sub"
    	access_positive = yes
     sasl {
     }
    }
    group {
    	filter = "(objectClass=posixGroup)"
    	scope = "sub"
    	name_attribute = "cn"
    	membership_attribute = "memberOf"
    	cacheable_name = no
    	cacheable_dn = no
    }
    client {
    	filter = "(objectClass=radiusClient)"
    	scope = "sub"
    	base_dn = "dc=burro,dc=org"
    }
    profile {
    }
    options {
    	ldap_debug = 40
    	chase_referrals = yes
    	rebind = yes
    	net_timeout = 1
    	res_timeout = 10
    	srv_timelimit = 3
    	idle = 60
    	probes = 3
    	interval = 3
    }
    tls {
    	certificate_file = "/etc/freeradius/3.0/certs/ldap-client.crt"
    	private_key_file = "/etc/freeradius/3.0/certs/ldap-client.key"
    	start_tls = no
    	require_cert = "allow"
    }
   }
Creating attribute LDAP-Group
   # Loading module "ntlm_auth" from file 
/etc/freeradius/3.0/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
   }
   # Loading module "echo" from file 
/etc/freeradius/3.0/mods-enabled/echo
   exec echo {
   	wait = yes
   	program = "/bin/echo %{User-Name}"
   	input_pairs = "request"
   	output_pairs = "reply"
   	shell_escape = yes
   }
   # Loaded module rlm_files
   # Loading module "files" from file 
/etc/freeradius/3.0/mods-enabled/files
   files {
   	filename = "/etc/freeradius/3.0/mods-config/files/authorize"
   	acctusersfile = "/etc/freeradius/3.0/mods-config/files/accounting"
   	preproxy_usersfile = 
"/etc/freeradius/3.0/mods-config/files/pre-proxy"
   }
   # Loaded module rlm_unix
   # Loading module "unix" from file 
/etc/freeradius/3.0/mods-enabled/unix
   unix {
   	radwtmp = "/var/log/freeradius/radwtmp"
   }
Creating attribute Unix-Group
   # Loaded module rlm_expiration
   # Loading module "expiration" from file 
/etc/freeradius/3.0/mods-enabled/expiration
   # Loaded module rlm_utf8
   # Loading module "utf8" from file 
/etc/freeradius/3.0/mods-enabled/utf8
   # Loaded module rlm_dynamic_clients
   # Loading module "dynamic_clients" from file 
/etc/freeradius/3.0/mods-enabled/dynamic_clients
   # Loaded module rlm_expr
   # Loading module "expr" from file 
/etc/freeradius/3.0/mods-enabled/expr
   expr {
   	safe_characters = 
"@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: 
/äéöüàâæçèéêëîïôœùûüaÿÄÉÖÜßÀÂÆÇÈÉÊËÎÏÔŒÙÛÜŸ"
   }
   # Loading module "auth_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   detail auth_log {
   	filename = 
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d"
   	header = "%t"
   	permissions = 384
   	locking = no
   	escape_filenames = no
   	log_packet_header = no
   }
   # Loading module "reply_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   detail reply_log {
   	filename = 
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/reply-detail-%Y%m%d"
   	header = "%t"
   	permissions = 384
   	locking = no
   	escape_filenames = no
   	log_packet_header = no
   }
   # Loading module "pre_proxy_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   detail pre_proxy_log {
   	filename = 
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/pre-proxy-detail-%Y%m%d"
   	header = "%t"
   	permissions = 384
   	locking = no
   	escape_filenames = no
   	log_packet_header = no
   }
   # Loading module "post_proxy_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   detail post_proxy_log {
   	filename = 
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/post-proxy-detail-%Y%m%d"
   	header = "%t"
   	permissions = 384
   	locking = no
   	escape_filenames = no
   	log_packet_header = no
   }
   # Loaded module rlm_eap
   # Loading module "eap" from file /etc/freeradius/3.0/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_replicate
   # Loading module "replicate" from file 
/etc/freeradius/3.0/mods-enabled/replicate
   # Loaded module rlm_mschap
   # Loading module "mschap" from file 
/etc/freeradius/3.0/mods-enabled/mschap
   mschap {
   	use_mppe = yes
   	require_encryption = no
   	require_strong = no
   	with_ntdomain_hack = yes
    passchange {
    }
   	allow_retry = yes
   }
   # Loading module "radutmp" from file 
/etc/freeradius/3.0/mods-enabled/radutmp
   radutmp {
   	filename = "/var/log/freeradius/radutmp"
   	username = "%{User-Name}"
   	case_sensitive = yes
   	check_with_nas = yes
   	permissions = 384
   	caller_id = yes
   }
   # Loaded module rlm_passwd
   # Loading module "etc_passwd" from file 
/etc/freeradius/3.0/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
   }
   instantiate {
   }
   # Instantiating module "cache_eap" from file 
/etc/freeradius/3.0/mods-enabled/cache_eap
rlm_cache (cache_eap): Driver rlm_cache_rbtree (module rlm_cache_rbtree) 
loaded and linked
   # Instantiating module "linelog" from file 
/etc/freeradius/3.0/mods-enabled/linelog
   # Instantiating module "log_accounting" from file 
/etc/freeradius/3.0/mods-enabled/linelog
   # Instantiating module "detail" from file 
/etc/freeradius/3.0/mods-enabled/detail
   # Instantiating module "IPASS" from file 
/etc/freeradius/3.0/mods-enabled/realm
   # Instantiating module "suffix" from file 
/etc/freeradius/3.0/mods-enabled/realm
   # Instantiating module "realmpercent" from file 
/etc/freeradius/3.0/mods-enabled/realm
   # Instantiating module "ntdomain" from file 
/etc/freeradius/3.0/mods-enabled/realm
   # Instantiating module "preprocess" from file 
/etc/freeradius/3.0/mods-enabled/preprocess
reading pairlist file 
/etc/freeradius/3.0/mods-config/preprocess/huntgroups
reading pairlist file /etc/freeradius/3.0/mods-config/preprocess/hints
   # Instantiating module "reject" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "fail" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "ok" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "handled" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "invalid" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "userlock" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "notfound" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "noop" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "updated" from file 
/etc/freeradius/3.0/mods-enabled/always
   # Instantiating module "attr_filter.post-proxy" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
reading pairlist file 
/etc/freeradius/3.0/mods-config/attr_filter/post-proxy
   # Instantiating module "attr_filter.pre-proxy" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
reading pairlist file 
/etc/freeradius/3.0/mods-config/attr_filter/pre-proxy
   # Instantiating module "attr_filter.access_reject" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
reading pairlist file 
/etc/freeradius/3.0/mods-config/attr_filter/access_reject
[/etc/freeradius/3.0/mods-config/attr_filter/access_reject]:11 Check 
item "FreeRADIUS-Response-Delay" 	found in filter list for realm 
"DEFAULT".
[/etc/freeradius/3.0/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/freeradius/3.0/mods-enabled/attr_filter
reading pairlist file 
/etc/freeradius/3.0/mods-config/attr_filter/access_challenge
   # Instantiating module "attr_filter.accounting_response" from file 
/etc/freeradius/3.0/mods-enabled/attr_filter
reading pairlist file 
/etc/freeradius/3.0/mods-config/attr_filter/accounting_response
   # Instantiating module "logintime" from file 
/etc/freeradius/3.0/mods-enabled/logintime
   # Instantiating module "pap" from file 
/etc/freeradius/3.0/mods-enabled/pap
   # Instantiating module "ldap" from file 
/etc/freeradius/3.0/mods-enabled/ldap
rlm_ldap: libldap vendor: OpenLDAP, version: 20444
    accounting {
    	reference = "%{tolower:type.%{Acct-Status-Type}}"
    }
    post-auth {
    	reference = "."
    }
rlm_ldap (ldap): Initialising connection pool
    pool {
    	start = 5
    	min = 3
    	max = 32
    	spare = 10
    	uses = 0
    	lifetime = 0
    	cleanup_interval = 30
    	idle_timeout = 60
    	retry_delay = 30
    	spread = no
    }
rlm_ldap (ldap): Opening additional connection (0), 1 of 32 pending 
slots used
rlm_ldap (ldap): Connecting to ldaps://ldap.google.com:636
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
rlm_ldap (ldap): Opening additional connection (1), 1 of 31 pending 
slots used
rlm_ldap (ldap): Connecting to ldaps://ldap.google.com:636
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
rlm_ldap (ldap): Opening additional connection (2), 1 of 30 pending 
slots used
rlm_ldap (ldap): Connecting to ldaps://ldap.google.com:636
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
rlm_ldap (ldap): Opening additional connection (3), 1 of 29 pending 
slots used
rlm_ldap (ldap): Connecting to ldaps://ldap.google.com:636
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
rlm_ldap (ldap): Opening additional connection (4), 1 of 28 pending 
slots used
rlm_ldap (ldap): Connecting to ldaps://ldap.google.com:636
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
   # Instantiating module "files" from file 
/etc/freeradius/3.0/mods-enabled/files
reading pairlist file /etc/freeradius/3.0/mods-config/files/authorize
reading pairlist file /etc/freeradius/3.0/mods-config/files/accounting
reading pairlist file /etc/freeradius/3.0/mods-config/files/pre-proxy
   # Instantiating module "expiration" from file 
/etc/freeradius/3.0/mods-enabled/expiration
   # Instantiating module "auth_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
rlm_detail (auth_log): 'User-Password' suppressed, will not appear in 
detail output
   # Instantiating module "reply_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   # Instantiating module "pre_proxy_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   # Instantiating module "post_proxy_log" from file 
/etc/freeradius/3.0/mods-enabled/detail.log
   # Instantiating module "eap" from file 
/etc/freeradius/3.0/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/freeradius/3.0/certs"
    	pem_file_type = yes
    	private_key_file = "/etc/ssl/private/ssl-cert-snakeoil.key"
    	certificate_file = "/etc/ssl/certs/ssl-cert-snakeoil.pem"
    	ca_file = "/etc/ssl/certs/ca-certificates.crt"
    	private_key_password = <<< secret >>>
    	dh_file = "/etc/freeradius/3.0/certs/dh"
    	fragment_size = 1024
    	include_length = yes
    	auto_chain = yes
    	check_crl = no
    	check_all_crl = no
    	cipher_list = "DEFAULT"
    	ecdh_curve = "prime256v1"
     cache {
     	enable = yes
     	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 "mschap" from file 
/etc/freeradius/3.0/mods-enabled/mschap
rlm_mschap (mschap): using internal authentication
   # Instantiating module "etc_passwd" from file 
/etc/freeradius/3.0/mods-enabled/passwd
rlm_passwd: nfields: 3 keyfield 0(User-Name) listable: no
  } # modules
radiusd: #### Loading Virtual Servers ####
server { # from file /etc/freeradius/3.0/radiusd.conf
} # server
server inner-tunnel { # from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
  # Loading authenticate {...}
  # Loading authorize {...}
Ignoring "sql" (see raddb/mods-available/README.rst)
  # Loading session {...}
  # Loading post-proxy {...}
  # Loading post-auth {...}
} # server inner-tunnel
server default { # from file /etc/freeradius/3.0/sites-enabled/default
  # Loading authenticate {...}
  # Loading authorize {...}
  # Loading preacct {...}
  # Loading accounting {...}
  # Loading post-proxy {...}
  # Loading post-auth {...}
} # server default
radiusd: #### Opening IP addresses and Ports ####
listen {
   	type = "auth"
   	ipaddr = 127.0.0.1
   	port = 18120
}
listen {
   	type = "auth"
   	ipaddr = *
   	port = 0
    limit {
    	max_connections = 16
    	lifetime = 0
    	idle_timeout = 30
    }
}
listen {
   	type = "acct"
   	ipaddr = *
   	port = 0
    limit {
    	max_connections = 16
    	lifetime = 0
    	idle_timeout = 30
    }
}
listen {
   	type = "auth"
   	ipv6addr = ::
   	port = 0
    limit {
    	max_connections = 16
    	lifetime = 0
    	idle_timeout = 30
    }
}
listen {
   	type = "acct"
   	ipv6addr = ::
   	port = 0
    limit {
    	max_connections = 16
    	lifetime = 0
    	idle_timeout = 30
    }
}
Listening on auth address 127.0.0.1 port 18120 bound to server 
inner-tunnel
Listening on auth address * port 1812 bound to server default
Listening on acct address * port 1813 bound to server default
Listening on auth address :: port 1812 bound to server default
Listening on acct address :: port 1813 bound to server default
Listening on proxy address * port 40729
Listening on proxy address :: port 42721
Ready to process requests
(0) Received Access-Request Id 82 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 289
(0)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(0)   User-Name = "donkey"
(0)   NAS-IP-Address = 10.1.25.208
(0)   NAS-Identifier = "18-7C-0B-59-10-6C"
(0)   NAS-Port = 1
(0)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(0)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(0)   Service-Type = Framed-User
(0)   Chargeable-User-Identity = 0x00
(0)   NAS-Port-Type = Wireless-802.11
(0)   Connect-Info = "CONNECT 802.11a/n/ac"
(0)   EAP-Message = 0x0200000f016367726f73736b6f7066
(0)   Ruckus-SSID = "STAFF1"
(0)   Ruckus-BSSID = 0x187c0b59106c
(0)   Ruckus-Wlan-Id = 5
(0)   Ruckus-VLAN-ID = 16
(0)   Ruckus-SCG-CBlade-IP = 167844299
(0)   Ruckus-Zone-Name = "MAIN"
(0)   Ruckus-Wlan-Name = "STAFF1"
(0)   Message-Authenticator = 0xabb37aec732768bf882d3b1baf6df572
(0) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(0)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(0)         if ((&User-Name =~ /@/) && (&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)  = notfound
(0)     } # policy filter_username = notfound
(0)     [preprocess] = ok
(0)     [chap] = noop
(0)     [mschap] = noop
(0)     [digest] = noop
(0) suffix: Checking for suffix after "@"
(0) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(0) suffix: No such realm "NULL"
(0)     [suffix] = noop
(0) eap: Peer sent EAP Response (code 2) ID 0 length 15
(0) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the 
rest of authorize
(0)     [eap] = ok
(0)   } # authorize = ok
(0) Found Auth-Type = eap
(0) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(0)   authenticate {
(0) eap: Peer sent packet with method EAP Identity (1)
(0) eap: Calling submodule eap_md5 to process data
(0) eap_md5: Issuing MD5 Challenge
(0) eap: Sending EAP Request (code 1) ID 1 length 22
(0) eap: EAP session adding &reply:State = 0xeb0f33f9eb0e3761
(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 
/etc/freeradius/3.0/sites-enabled/default
(0) Sent Access-Challenge Id 82 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(0)   EAP-Message = 0x010100160410b8b468348e0a4daf0ecc04e6949ae826
(0)   Message-Authenticator = 0x00000000000000000000000000000000
(0)   State = 0xeb0f33f9eb0e3761ce83e6b60363ea34
(0) Finished request
Waking up in 4.9 seconds.
(1) Received Access-Request Id 83 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 300
(1)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(1)   User-Name = "donkey"
(1)   NAS-IP-Address = 10.1.25.208
(1)   NAS-Identifier = "18-7C-0B-59-10-6C"
(1)   NAS-Port = 1
(1)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(1)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(1)   Service-Type = Framed-User
(1)   Chargeable-User-Identity = 0x00
(1)   NAS-Port-Type = Wireless-802.11
(1)   Connect-Info = "CONNECT 802.11a/n/ac"
(1)   EAP-Message = 0x020100080319152b
(1)   State = 0xeb0f33f9eb0e3761ce83e6b60363ea34
(1)   Ruckus-SSID = "STAFF1"
(1)   Ruckus-BSSID = 0x187c0b59106c
(1)   Ruckus-Wlan-Id = 5
(1)   Ruckus-VLAN-ID = 16
(1)   Ruckus-SCG-CBlade-IP = 167844299
(1)   Ruckus-Zone-Name = "MAIN"
(1)   Ruckus-Wlan-Name = "STAFF1"
(1)   Message-Authenticator = 0x0b8b5b7266ea8d8f483e6f71936f9d69
(1) session-state: No cached attributes
(1) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(1)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(1)         if ((&User-Name =~ /@/) && (&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)  = notfound
(1)     } # policy filter_username = notfound
(1)     [preprocess] = ok
(1)     [chap] = noop
(1)     [mschap] = noop
(1)     [digest] = noop
(1) suffix: Checking for suffix after "@"
(1) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(1) suffix: No such realm "NULL"
(1)     [suffix] = noop
(1) eap: Peer sent EAP Response (code 2) ID 1 length 8
(1) eap: No EAP Start, assuming it's an on-going EAP conversation
(1)     [eap] = updated
(1)     [files] = noop
rlm_ldap (ldap): Reserved connection (0)
(1) ldap: EXPAND (uid=%{%{Stripped-User-Name}:-%{User-Name}})
(1) ldap:    --> (uid=donkey)
(1) ldap: Performing search in "dc=burro,dc=org" with filter 
"(uid=donkey)", scope "sub"
(1) ldap: Waiting for search result...
(1) ldap: User object found at DN 
"uid=donkey,ou=Animals,ou=Users,dc=burro,dc=org"
(1) ldap: Processing user attributes
(1) ldap: WARNING: No "known good" password added. Ensure the admin user 
has permission to read the password attribute
(1) ldap: WARNING: PAP authentication will *NOT* work with Active 
Directory (if that is what you were trying to configure)
rlm_ldap (ldap): Released connection (0)
rlm_ldap (ldap): Need 5 more connections to reach 10 spares
rlm_ldap (ldap): Opening additional connection (5), 1 of 27 pending 
slots used
rlm_ldap (ldap): Connecting to ldaps://ldap.google.com:636
rlm_ldap (ldap): Waiting for bind result...
rlm_ldap (ldap): Bind successful
(1)     [ldap] = ok
(1)     [expiration] = noop
(1)     [logintime] = noop
(1) pap: WARNING: No "known good" password found for the user.  Not 
setting Auth-Type
(1) pap: WARNING: Authentication will fail unless a "known good" 
password is available
(1)     [pap] = noop
(1)     if (User-Password) {
(1)     if (User-Password)  -> FALSE
(1)   } # authorize = updated
(1) Found Auth-Type = eap
(1) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(1)   authenticate {
(1) eap: Expiring EAP session with state 0xeb0f33f9eb0e3761
(1) eap: Finished EAP session with state 0xeb0f33f9eb0e3761
(1) eap: Previous EAP request found for state 0xeb0f33f9eb0e3761, 
released from the list
(1) eap: Peer sent packet with method EAP NAK (3)
(1) eap: Found mutually acceptable type PEAP (25)
(1) eap: Calling submodule eap_peap to process data
(1) eap_peap: Initiating new EAP-TLS session
(1) eap_peap: [eaptls start] = request
(1) eap: Sending EAP Request (code 1) ID 2 length 6
(1) eap: EAP session adding &reply:State = 0xeb0f33f9ea0d2a61
(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 
/etc/freeradius/3.0/sites-enabled/default
(1) Sent Access-Challenge Id 83 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(1)   EAP-Message = 0x010200061920
(1)   Message-Authenticator = 0x00000000000000000000000000000000
(1)   State = 0xeb0f33f9ea0d2a61ce83e6b60363ea34
(1) Finished request
Waking up in 4.1 seconds.
(2) Received Access-Request Id 84 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 453
(2)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(2)   User-Name = "donkey"
(2)   NAS-IP-Address = 10.1.25.208
(2)   NAS-Identifier = "18-7C-0B-59-10-6C"
(2)   NAS-Port = 1
(2)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(2)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(2)   Service-Type = Framed-User
(2)   Chargeable-User-Identity = 0x00
(2)   NAS-Port-Type = Wireless-802.11
(2)   Connect-Info = "CONNECT 802.11a/n/ac"
(2)   EAP-Message = 
0x020200a119800000009716030100920100008e03035cfede6254095d49bd63bd295e703470aa11619b0acf539a1e28ac5cc475f25100002c00ffc02cc02bc024c023c00ac009c008c030c02fc028c027c014c013c012009d009c003d003c0035002f000a01000039000a000
(2)   State = 0xeb0f33f9ea0d2a61ce83e6b60363ea34
(2)   Ruckus-SSID = "STAFF1"
(2)   Ruckus-BSSID = 0x187c0b59106c
(2)   Ruckus-Wlan-Id = 5
(2)   Ruckus-VLAN-ID = 16
(2)   Ruckus-SCG-CBlade-IP = 167844299
(2)   Ruckus-Zone-Name = "MAIN"
(2)   Ruckus-Wlan-Name = "STAFF1"
(2)   Message-Authenticator = 0xd60bcb324cd87ecd8dfec4a8e4a58544
(2) session-state: No cached attributes
(2) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(2)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(2)         if ((&User-Name =~ /@/) && (&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)  = notfound
(2)     } # policy filter_username = notfound
(2)     [preprocess] = ok
(2)     [chap] = noop
(2)     [mschap] = noop
(2)     [digest] = noop
(2) suffix: Checking for suffix after "@"
(2) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(2) suffix: No such realm "NULL"
(2)     [suffix] = noop
(2) eap: Peer sent EAP Response (code 2) ID 2 length 161
(2) eap: Continuing tunnel setup
(2)     [eap] = ok
(2)   } # authorize = ok
(2) Found Auth-Type = eap
(2) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(2)   authenticate {
(2) eap: Expiring EAP session with state 0xeb0f33f9ea0d2a61
(2) eap: Finished EAP session with state 0xeb0f33f9ea0d2a61
(2) eap: Previous EAP request found for state 0xeb0f33f9ea0d2a61, 
released from the list
(2) eap: Peer sent packet with method EAP PEAP (25)
(2) eap: Calling submodule eap_peap to process data
(2) eap_peap: Continuing EAP-TLS
(2) eap_peap: Peer indicated complete TLS record size will be 151 bytes
(2) eap_peap: Got complete TLS record (151 bytes)
(2) eap_peap: [eaptls verify] = length included
(2) eap_peap: (other): before SSL initialization
(2) eap_peap: TLS_accept: before SSL initialization
(2) eap_peap: TLS_accept: before SSL initialization
(2) eap_peap: <<< recv TLS 1.2  [length 0092]
(2) eap_peap: TLS_accept: SSLv3/TLS read client hello
(2) eap_peap: >>> send TLS 1.2  [length 003d]
(2) eap_peap: TLS_accept: SSLv3/TLS write server hello
(2) eap_peap: >>> send TLS 1.2  [length 02f1]
(2) eap_peap: TLS_accept: SSLv3/TLS write certificate
(2) eap_peap: >>> send TLS 1.2  [length 014d]
(2) eap_peap: TLS_accept: SSLv3/TLS write key exchange
(2) eap_peap: >>> send TLS 1.2  [length 0004]
(2) eap_peap: TLS_accept: SSLv3/TLS write server done
(2) eap_peap: TLS_accept: Need to read more data: SSLv3/TLS write server 
done
(2) eap_peap: In SSL Handshake Phase
(2) eap_peap: In SSL Accept mode
(2) eap_peap: [eaptls process] = handled
(2) eap: Sending EAP Request (code 1) ID 3 length 1004
(2) eap: EAP session adding &reply:State = 0xeb0f33f9e90c2a61
(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 
/etc/freeradius/3.0/sites-enabled/default
(2) Sent Access-Challenge Id 84 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(2)   EAP-Message = 
0x010303ec19c000000493160303003d020000390303ec4487452b5f1fb5ba794059ea0d6d5b877ae2e899921074222b5d1f847af2d600c030000011ff01000100000b0004030001020017000016030302f10b0002ed0002ea0002e7308202e3308201cba0030201020209009
(2)   Message-Authenticator = 0x00000000000000000000000000000000
(2)   State = 0xeb0f33f9e90c2a61ce83e6b60363ea34
(2) Finished request
Waking up in 4.1 seconds.
(3) Received Access-Request Id 85 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 298
(3)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(3)   User-Name = "donkey"
(3)   NAS-IP-Address = 10.1.25.208
(3)   NAS-Identifier = "18-7C-0B-59-10-6C"
(3)   NAS-Port = 1
(3)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(3)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(3)   Service-Type = Framed-User
(3)   Chargeable-User-Identity = 0x00
(3)   NAS-Port-Type = Wireless-802.11
(3)   Connect-Info = "CONNECT 802.11a/n/ac"
(3)   EAP-Message = 0x020300061900
(3)   State = 0xeb0f33f9e90c2a61ce83e6b60363ea34
(3)   Ruckus-SSID = "STAFF1"
(3)   Ruckus-BSSID = 0x187c0b59106c
(3)   Ruckus-Wlan-Id = 5
(3)   Ruckus-VLAN-ID = 16
(3)   Ruckus-SCG-CBlade-IP = 167844299
(3)   Ruckus-Zone-Name = "MAIN"
(3)   Ruckus-Wlan-Name = "STAFF1"
(3)   Message-Authenticator = 0x00bfef65f6da6de45b7e7c344ca914fd
(3) session-state: No cached attributes
(3) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(3)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(3)         if ((&User-Name =~ /@/) && (&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)  = notfound
(3)     } # policy filter_username = notfound
(3)     [preprocess] = ok
(3)     [chap] = noop
(3)     [mschap] = noop
(3)     [digest] = noop
(3) suffix: Checking for suffix after "@"
(3) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(3) suffix: No such realm "NULL"
(3)     [suffix] = noop
(3) eap: Peer sent EAP Response (code 2) ID 3 length 6
(3) eap: Continuing tunnel setup
(3)     [eap] = ok
(3)   } # authorize = ok
(3) Found Auth-Type = eap
(3) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(3)   authenticate {
(3) eap: Expiring EAP session with state 0xeb0f33f9e90c2a61
(3) eap: Finished EAP session with state 0xeb0f33f9e90c2a61
(3) eap: Previous EAP request found for state 0xeb0f33f9e90c2a61, 
released from the list
(3) eap: Peer sent packet with method EAP PEAP (25)
(3) eap: Calling submodule eap_peap to process data
(3) eap_peap: Continuing EAP-TLS
(3) eap_peap: Peer ACKed our handshake fragment
(3) eap_peap: [eaptls verify] = request
(3) eap_peap: [eaptls process] = handled
(3) eap: Sending EAP Request (code 1) ID 4 length 183
(3) eap: EAP session adding &reply:State = 0xeb0f33f9e80b2a61
(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 
/etc/freeradius/3.0/sites-enabled/default
(3) Sent Access-Challenge Id 85 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(3)   EAP-Message = 
0x010400b71900a1a29b66f95de8004c8245181cbf9f23b4a7d479292bfa74962a915dd8774a2523676d92f7dfa80932789370c76b891e274a0344206e5d5072ada0c21a8921e6b74fcf47341dc2c57863a6c600eba45681356a575c5953296da0275684325a4ac411b224b64
(3)   Message-Authenticator = 0x00000000000000000000000000000000
(3)   State = 0xeb0f33f9e80b2a61ce83e6b60363ea34
(3) Finished request
Waking up in 4.1 seconds.
(4) Received Access-Request Id 86 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 428
(4)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(4)   User-Name = "donkey"
(4)   NAS-IP-Address = 10.1.25.208
(4)   NAS-Identifier = "18-7C-0B-59-10-6C"
(4)   NAS-Port = 1
(4)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(4)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(4)   Service-Type = Framed-User
(4)   Chargeable-User-Identity = 0x00
(4)   NAS-Port-Type = Wireless-802.11
(4)   Connect-Info = "CONNECT 802.11a/n/ac"
(4)   EAP-Message = 
0x0204008819800000007e16030300461000004241046a8ce96dd2e79dcf4274695af82e3429db8cf218baea8842e877d8e53d5af5ad90d0ca34a7bedd750d51282438e22b40376bb2c7658ea62e5e44a9a0b364d1611403030001011603030028ac32e57bfad56383076dd17
(4)   State = 0xeb0f33f9e80b2a61ce83e6b60363ea34
(4)   Ruckus-SSID = "STAFF1"
(4)   Ruckus-BSSID = 0x187c0b59106c
(4)   Ruckus-Wlan-Id = 5
(4)   Ruckus-VLAN-ID = 16
(4)   Ruckus-SCG-CBlade-IP = 167844299
(4)   Ruckus-Zone-Name = "MAIN"
(4)   Ruckus-Wlan-Name = "STAFF1"
(4)   Message-Authenticator = 0x91fe336e00013ce58b87218e146eb362
(4) session-state: No cached attributes
(4) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(4)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(4)         if ((&User-Name =~ /@/) && (&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)  = notfound
(4)     } # policy filter_username = notfound
(4)     [preprocess] = ok
(4)     [chap] = noop
(4)     [mschap] = noop
(4)     [digest] = noop
(4) suffix: Checking for suffix after "@"
(4) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(4) suffix: No such realm "NULL"
(4)     [suffix] = noop
(4) eap: Peer sent EAP Response (code 2) ID 4 length 136
(4) eap: Continuing tunnel setup
(4)     [eap] = ok
(4)   } # authorize = ok
(4) Found Auth-Type = eap
(4) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(4)   authenticate {
(4) eap: Expiring EAP session with state 0xeb0f33f9e80b2a61
(4) eap: Finished EAP session with state 0xeb0f33f9e80b2a61
(4) eap: Previous EAP request found for state 0xeb0f33f9e80b2a61, 
released from the list
(4) eap: Peer sent packet with method EAP PEAP (25)
(4) eap: Calling submodule eap_peap to process data
(4) eap_peap: Continuing EAP-TLS
(4) eap_peap: Peer indicated complete TLS record size will be 126 bytes
(4) eap_peap: Got complete TLS record (126 bytes)
(4) eap_peap: [eaptls verify] = length included
(4) eap_peap: TLS_accept: SSLv3/TLS write server done
(4) eap_peap: <<< recv TLS 1.2  [length 0046]
(4) eap_peap: TLS_accept: SSLv3/TLS read client key exchange
(4) eap_peap: TLS_accept: SSLv3/TLS read change cipher spec
(4) eap_peap: <<< recv TLS 1.2  [length 0010]
(4) eap_peap: TLS_accept: SSLv3/TLS read finished
(4) eap_peap: >>> send TLS 1.2  [length 0001]
(4) eap_peap: TLS_accept: SSLv3/TLS write change cipher spec
(4) eap_peap: >>> send TLS 1.2  [length 0010]
(4) eap_peap: TLS_accept: SSLv3/TLS write finished
(4) eap_peap: (other): SSL negotiation finished successfully
(4) eap_peap: SSL Connection Established
(4) eap_peap: [eaptls process] = handled
(4) eap: Sending EAP Request (code 1) ID 5 length 57
(4) eap: EAP session adding &reply:State = 0xeb0f33f9ef0a2a61
(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 
/etc/freeradius/3.0/sites-enabled/default
(4) Sent Access-Challenge Id 86 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(4)   EAP-Message = 
0x01050039190014030300010116030300280b2330975c35e8e635f254e800229cae0fe90eb8b7fe5ddccc04fa2a79902a3a72ee710e8af88deb
(4)   Message-Authenticator = 0x00000000000000000000000000000000
(4)   State = 0xeb0f33f9ef0a2a61ce83e6b60363ea34
(4) Finished request
Waking up in 4.1 seconds.
(5) Received Access-Request Id 87 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 298
(5)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(5)   User-Name = "donkey"
(5)   NAS-IP-Address = 10.1.25.208
(5)   NAS-Identifier = "18-7C-0B-59-10-6C"
(5)   NAS-Port = 1
(5)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(5)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(5)   Service-Type = Framed-User
(5)   Chargeable-User-Identity = 0x00
(5)   NAS-Port-Type = Wireless-802.11
(5)   Connect-Info = "CONNECT 802.11a/n/ac"
(5)   EAP-Message = 0x020500061900
(5)   State = 0xeb0f33f9ef0a2a61ce83e6b60363ea34
(5)   Ruckus-SSID = "STAFF1"
(5)   Ruckus-BSSID = 0x187c0b59106c
(5)   Ruckus-Wlan-Id = 5
(5)   Ruckus-VLAN-ID = 16
(5)   Ruckus-SCG-CBlade-IP = 167844299
(5)   Ruckus-Zone-Name = "MAIN"
(5)   Ruckus-Wlan-Name = "STAFF1"
(5)   Message-Authenticator = 0x482575750aa8d6d755fec98b2f0e9b5c
(5) session-state: No cached attributes
(5) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(5)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(5)         if ((&User-Name =~ /@/) && (&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)  = notfound
(5)     } # policy filter_username = notfound
(5)     [preprocess] = ok
(5)     [chap] = noop
(5)     [mschap] = noop
(5)     [digest] = noop
(5) suffix: Checking for suffix after "@"
(5) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(5) suffix: No such realm "NULL"
(5)     [suffix] = noop
(5) eap: Peer sent EAP Response (code 2) ID 5 length 6
(5) eap: Continuing tunnel setup
(5)     [eap] = ok
(5)   } # authorize = ok
(5) Found Auth-Type = eap
(5) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(5)   authenticate {
(5) eap: Expiring EAP session with state 0xeb0f33f9ef0a2a61
(5) eap: Finished EAP session with state 0xeb0f33f9ef0a2a61
(5) eap: Previous EAP request found for state 0xeb0f33f9ef0a2a61, 
released from the list
(5) eap: Peer sent packet with method EAP PEAP (25)
(5) eap: Calling submodule eap_peap to process data
(5) eap_peap: Continuing EAP-TLS
(5) eap_peap: Peer ACKed our handshake fragment.  handshake is finished
(5) eap_peap: [eaptls verify] = success
(5) eap_peap: [eaptls process] = success
(5) eap_peap: Session established.  Decoding tunneled attributes
(5) eap_peap: PEAP state TUNNEL ESTABLISHED
(5) eap: Sending EAP Request (code 1) ID 6 length 40
(5) eap: EAP session adding &reply:State = 0xeb0f33f9ee092a61
(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 
/etc/freeradius/3.0/sites-enabled/default
(5) Sent Access-Challenge Id 87 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(5)   EAP-Message = 
0x010600281900170303001d0b2330975c35e8e771c29d08efbd904f285fc7913a39771a0666079800
(5)   Message-Authenticator = 0x00000000000000000000000000000000
(5)   State = 0xeb0f33f9ee092a61ce83e6b60363ea34
(5) Finished request
Waking up in 4.1 seconds.
(6) Received Access-Request Id 88 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 338
(6)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(6)   User-Name = "donkey"
(6)   NAS-IP-Address = 10.1.25.208
(6)   NAS-Identifier = "18-7C-0B-59-10-6C"
(6)   NAS-Port = 1
(6)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(6)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(6)   Service-Type = Framed-User
(6)   Chargeable-User-Identity = 0x00
(6)   NAS-Port-Type = Wireless-802.11
(6)   Connect-Info = "CONNECT 802.11a/n/ac"
(6)   EAP-Message = 
0x0206002e19001703030023ac32e57bfad5638438fe9d07fadaa4d125b8ba070d562d74853d930c154f60657b8f76
(6)   State = 0xeb0f33f9ee092a61ce83e6b60363ea34
(6)   Ruckus-SSID = "STAFF1"
(6)   Ruckus-BSSID = 0x187c0b59106c
(6)   Ruckus-Wlan-Id = 5
(6)   Ruckus-VLAN-ID = 16
(6)   Ruckus-SCG-CBlade-IP = 167844299
(6)   Ruckus-Zone-Name = "MAIN"
(6)   Ruckus-Wlan-Name = "STAFF1"
(6)   Message-Authenticator = 0x6f6fa288d194d0df748524c52c8d175a
(6) session-state: No cached attributes
(6) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(6)   authorize {
(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 !~ /@(.+)\.(.+)$/))  
{
(6)         if ((&User-Name =~ /@/) && (&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)  = notfound
(6)     } # policy filter_username = notfound
(6)     [preprocess] = ok
(6)     [chap] = noop
(6)     [mschap] = noop
(6)     [digest] = noop
(6) suffix: Checking for suffix after "@"
(6) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(6) suffix: No such realm "NULL"
(6)     [suffix] = noop
(6) eap: Peer sent EAP Response (code 2) ID 6 length 46
(6) eap: Continuing tunnel setup
(6)     [eap] = ok
(6)   } # authorize = ok
(6) Found Auth-Type = eap
(6) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(6)   authenticate {
(6) eap: Expiring EAP session with state 0xeb0f33f9ee092a61
(6) eap: Finished EAP session with state 0xeb0f33f9ee092a61
(6) eap: Previous EAP request found for state 0xeb0f33f9ee092a61, 
released from the list
(6) eap: Peer sent packet with method EAP PEAP (25)
(6) eap: Calling submodule eap_peap to process data
(6) eap_peap: Continuing EAP-TLS
(6) eap_peap: [eaptls verify] = ok
(6) eap_peap: Done initial handshake
(6) eap_peap: [eaptls process] = ok
(6) eap_peap: Session established.  Decoding tunneled attributes
(6) eap_peap: PEAP state WAITING FOR INNER IDENTITY
(6) eap_peap: Identity - donkey
(6) eap_peap: Got inner identity 'donkey'
(6) eap_peap: Setting default EAP type for tunneled EAP session
(6) eap_peap: Got tunneled request
(6) eap_peap:   EAP-Message = 0x0206000f016367726f73736b6f7066
(6) eap_peap: Setting User-Name to donkey
(6) eap_peap: Sending tunneled request to inner-tunnel
(6) eap_peap:   EAP-Message = 0x0206000f016367726f73736b6f7066
(6) eap_peap:   FreeRADIUS-Proxied-To = 127.0.0.1
(6) eap_peap:   User-Name = "donkey"
(6) Virtual server inner-tunnel received request
(6)   EAP-Message = 0x0206000f016367726f73736b6f7066
(6)   FreeRADIUS-Proxied-To = 127.0.0.1
(6)   User-Name = "donkey"
(6) WARNING: Outer and inner identities are the same.  User privacy is 
compromised.
(6) server inner-tunnel {
(6)   # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
(6)     authorize {
(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 !~ /@(.+)\.(.+)$/)) 
  {
(6)           if ((&User-Name =~ /@/) && (&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)  = notfound
(6)       } # policy filter_username = notfound
(6) suffix: Checking for suffix after "@"
(6) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(6) suffix: No such realm "NULL"
(6)       [suffix] = noop
(6)       update control {
(6)         &Proxy-To-Realm := LOCAL
(6)       } # update control = noop
(6) eap: Peer sent EAP Response (code 2) ID 6 length 15
(6) eap: EAP-Identity reply, returning 'ok' so we can short-circuit the 
rest of authorize
(6)       [eap] = ok
(6)     } # authorize = ok
(6)   Found Auth-Type = eap
(6)   # Executing group from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
(6)     authenticate {
(6) eap: Peer sent packet with method EAP Identity (1)
(6) eap: Calling submodule eap_mschapv2 to process data
(6) eap_mschapv2: Issuing Challenge
(6) eap: Sending EAP Request (code 1) ID 7 length 43
(6) eap: EAP session adding &reply:State = 0x51e14a5951e65099
(6)       [eap] = handled
(6)     } # authenticate = handled
(6) } # server inner-tunnel
(6) Virtual server sending reply
(6)   EAP-Message = 
0x0107002b1a0107002610f20e6c7657e18ddf266e1644efa62536667265657261646975732d332e302e3132
(6)   Message-Authenticator = 0x00000000000000000000000000000000
(6)   State = 0x51e14a5951e650990b18921f653a810f
(6) eap_peap: Got tunneled reply code 11
(6) eap_peap:   EAP-Message = 
0x0107002b1a0107002610f20e6c7657e18ddf266e1644efa62536667265657261646975732d332e302e3132
(6) eap_peap:   Message-Authenticator = 
0x00000000000000000000000000000000
(6) eap_peap:   State = 0x51e14a5951e650990b18921f653a810f
(6) eap_peap: Got tunneled reply RADIUS code 11
(6) eap_peap:   EAP-Message = 
0x0107002b1a0107002610f20e6c7657e18ddf266e1644efa62536667265657261646975732d332e302e3132
(6) eap_peap:   Message-Authenticator = 
0x00000000000000000000000000000000
(6) eap_peap:   State = 0x51e14a5951e650990b18921f653a810f
(6) eap_peap: Got tunneled Access-Challenge
(6) eap: Sending EAP Request (code 1) ID 7 length 74
(6) eap: EAP session adding &reply:State = 0xeb0f33f9ed082a61
(6)     [eap] = handled
(6)   } # authenticate = handled
(6) Using Post-Auth-Type Challenge
(6) Post-Auth-Type sub-section not found.  Ignoring.
(6) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(6) Sent Access-Challenge Id 88 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(6)   EAP-Message = 
0x0107004a1900170303003f0b2330975c35e8e8b2276f20245b6124662b9bd8da19f4c47411a4d7d0d6e10d45ba35319ae5c54e0246619deb19b66b16242f32cd16f225578e40dc8a3e98
(6)   Message-Authenticator = 0x00000000000000000000000000000000
(6)   State = 0xeb0f33f9ed082a61ce83e6b60363ea34
(6) Finished request
Waking up in 4.1 seconds.
(7) Received Access-Request Id 89 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 392
(7)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(7)   User-Name = "donkey"
(7)   NAS-IP-Address = 10.1.25.208
(7)   NAS-Identifier = "18-7C-0B-59-10-6C"
(7)   NAS-Port = 1
(7)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(7)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(7)   Service-Type = Framed-User
(7)   Chargeable-User-Identity = 0x00
(7)   NAS-Port-Type = Wireless-802.11
(7)   Connect-Info = "CONNECT 802.11a/n/ac"
(7)   EAP-Message = 
0x0207006419001703030059ac32e57bfad563851bc9fd7df25ee6a60f93167a11020bd796065bbd01c5b3b3ee291d68be4e15fc291bb850fd90b90f39b0f7b13da7ea3ab0474b00e2d57f275110390d0cc8e1f1ee29a05a06fa88a88c8a785e6bb8d34bad
(7)   State = 0xeb0f33f9ed082a61ce83e6b60363ea34
(7)   Ruckus-SSID = "STAFF1"
(7)   Ruckus-BSSID = 0x187c0b59106c
(7)   Ruckus-Wlan-Id = 5
(7)   Ruckus-VLAN-ID = 16
(7)   Ruckus-SCG-CBlade-IP = 167844299
(7)   Ruckus-Zone-Name = "MAIN"
(7)   Ruckus-Wlan-Name = "STAFF1"
(7)   Message-Authenticator = 0xdf8fc6ae10cd2b42cd387a757861c295
(7) session-state: No cached attributes
(7) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(7)   authorize {
(7)     policy filter_username {
(7)       if (&User-Name) {
(7)       if (&User-Name)  -> TRUE
(7)       if (&User-Name)  {
(7)         if (&User-Name =~ / /) {
(7)         if (&User-Name =~ / /)  -> FALSE
(7)         if (&User-Name =~ /@[^@]*@/ ) {
(7)         if (&User-Name =~ /@[^@]*@/ )  -> FALSE
(7)         if (&User-Name =~ /\.\./ ) {
(7)         if (&User-Name =~ /\.\./ )  -> FALSE
(7)         if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/))  
{
(7)         if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/))   
-> FALSE
(7)         if (&User-Name =~ /\.$/)  {
(7)         if (&User-Name =~ /\.$/)   -> FALSE
(7)         if (&User-Name =~ /@\./)  {
(7)         if (&User-Name =~ /@\./)   -> FALSE
(7)       } # if (&User-Name)  = notfound
(7)     } # policy filter_username = notfound
(7)     [preprocess] = ok
(7)     [chap] = noop
(7)     [mschap] = noop
(7)     [digest] = noop
(7) suffix: Checking for suffix after "@"
(7) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(7) suffix: No such realm "NULL"
(7)     [suffix] = noop
(7) eap: Peer sent EAP Response (code 2) ID 7 length 100
(7) eap: Continuing tunnel setup
(7)     [eap] = ok
(7)   } # authorize = ok
(7) Found Auth-Type = eap
(7) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(7)   authenticate {
(7) eap: Expiring EAP session with state 0x51e14a5951e65099
(7) eap: Finished EAP session with state 0xeb0f33f9ed082a61
(7) eap: Previous EAP request found for state 0xeb0f33f9ed082a61, 
released from the list
(7) eap: Peer sent packet with method EAP PEAP (25)
(7) eap: Calling submodule eap_peap to process data
(7) eap_peap: Continuing EAP-TLS
(7) eap_peap: [eaptls verify] = ok
(7) eap_peap: Done initial handshake
(7) eap_peap: [eaptls process] = ok
(7) eap_peap: Session established.  Decoding tunneled attributes
(7) eap_peap: PEAP state phase2
(7) eap_peap: EAP method MSCHAPv2 (26)
(7) eap_peap: Got tunneled request
(7) eap_peap:   EAP-Message = 
0x020700451a02070040317e26162a2707abeccaa28862ac0e39fa0000000000000000012a7f3c674b2789fe5f5cbc6218f4bb866415ba3d123f94006367726f73736b6f7066
(7) eap_peap: Setting User-Name to donkey
(7) eap_peap: Sending tunneled request to inner-tunnel
(7) eap_peap:   EAP-Message = 
0x020700451a02070040317e26162a2707abeccaa28862ac0e39fa0000000000000000012a7f3c674b2789fe5f5cbc6218f4bb866415ba3d123f94006367726f73736b6f7066
(7) eap_peap:   FreeRADIUS-Proxied-To = 127.0.0.1
(7) eap_peap:   User-Name = "donkey"
(7) eap_peap:   State = 0x51e14a5951e650990b18921f653a810f
(7) Virtual server inner-tunnel received request
(7)   EAP-Message = 
0x020700451a02070040317e26162a2707abeccaa28862ac0e39fa0000000000000000012a7f3c674b2789fe5f5cbc6218f4bb866415ba3d123f94006367726f73736b6f7066
(7)   FreeRADIUS-Proxied-To = 127.0.0.1
(7)   User-Name = "donkey"
(7)   State = 0x51e14a5951e650990b18921f653a810f
(7) WARNING: Outer and inner identities are the same.  User privacy is 
compromised.
(7) server inner-tunnel {
(7)   session-state: No cached attributes
(7)   # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
(7)     authorize {
(7)       policy filter_username {
(7)         if (&User-Name) {
(7)         if (&User-Name)  -> TRUE
(7)         if (&User-Name)  {
(7)           if (&User-Name =~ / /) {
(7)           if (&User-Name =~ / /)  -> FALSE
(7)           if (&User-Name =~ /@[^@]*@/ ) {
(7)           if (&User-Name =~ /@[^@]*@/ )  -> FALSE
(7)           if (&User-Name =~ /\.\./ ) {
(7)           if (&User-Name =~ /\.\./ )  -> FALSE
(7)           if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) 
  {
(7)           if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/)) 
   -> FALSE
(7)           if (&User-Name =~ /\.$/)  {
(7)           if (&User-Name =~ /\.$/)   -> FALSE
(7)           if (&User-Name =~ /@\./)  {
(7)           if (&User-Name =~ /@\./)   -> FALSE
(7)         } # if (&User-Name)  = notfound
(7)       } # policy filter_username = notfound
(7) suffix: Checking for suffix after "@"
(7) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(7) suffix: No such realm "NULL"
(7)       [suffix] = noop
(7)       update control {
(7)         &Proxy-To-Realm := LOCAL
(7)       } # update control = noop
(7) eap: Peer sent EAP Response (code 2) ID 7 length 69
(7) eap: No EAP Start, assuming it's an on-going EAP conversation
(7)       [eap] = updated
(7)       [files] = noop
rlm_ldap (ldap): Reserved connection (1)
(7) ldap: EXPAND (uid=%{%{Stripped-User-Name}:-%{User-Name}})
(7) ldap:    --> (uid=donkey)
(7) ldap: Performing search in "dc=burro,dc=org" with filter 
"(uid=donkey)", scope "sub"
(7) ldap: Waiting for search result...
(7) ldap: User object found at DN 
"uid=donkey,ou=Animals,ou=Users,dc=burro,dc=org"
(7) ldap: Processing user attributes
(7) ldap: WARNING: No "known good" password added. Ensure the admin user 
has permission to read the password attribute
(7) ldap: WARNING: PAP authentication will *NOT* work with Active 
Directory (if that is what you were trying to configure)
rlm_ldap (ldap): Released connection (1)
(7)       [ldap] = ok
(7)       [expiration] = noop
(7)       [logintime] = noop
(7)       [pap] = noop
(7)       if (User-Password) {
(7)       if (User-Password)  -> FALSE
(7)       [mschap] = noop
(7)     } # authorize = updated
(7)   Found Auth-Type = eap
(7)   # Executing group from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
(7)     authenticate {
(7) eap: Expiring EAP session with state 0x51e14a5951e65099
(7) eap: Finished EAP session with state 0x51e14a5951e65099
(7) eap: Previous EAP request found for state 0x51e14a5951e65099, 
released from the list
(7) eap: Peer sent packet with method EAP MSCHAPv2 (26)
(7) eap: Calling submodule eap_mschapv2 to process data
(7) eap_mschapv2: # Executing group from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
(7) eap_mschapv2:   authenticate {
(7) mschap: WARNING: No Cleartext-Password configured.  Cannot create 
NT-Password
(7) mschap: WARNING: No Cleartext-Password configured.  Cannot create 
LM-Password
(7) mschap: Creating challenge hash with username: donkey
(7) mschap: Client is using MS-CHAPv2
(7) mschap: ERROR: FAILED: No NT/LM-Password.  Cannot perform 
authentication
(7) mschap: ERROR: MS-CHAP2-Response is incorrect
(7)     [mschap] = reject
(7)   } # authenticate = reject
(7) eap: Sending EAP Failure (code 4) ID 7 length 4
(7) eap: Freeing handler
(7)       [eap] = reject
(7)     } # authenticate = reject
(7)   Failed to authenticate the user
(7)   Using Post-Auth-Type Reject
(7)   # Executing group from file 
/etc/freeradius/3.0/sites-enabled/inner-tunnel
(7)     Post-Auth-Type REJECT {
(7) attr_filter.access_reject: EXPAND %{User-Name}
(7) attr_filter.access_reject:    --> donkey
(7) attr_filter.access_reject: Matched entry DEFAULT at line 11
(7)       [attr_filter.access_reject] = updated
(7)       update outer.session-state {
(7)         &Module-Failure-Message := &request:Module-Failure-Message 
-> 'mschap: FAILED: No NT/LM-Password.  Cannot perform authentication'
(7)       } # update outer.session-state = noop
(7)     } # Post-Auth-Type REJECT = updated
(7) } # server inner-tunnel
(7) Virtual server sending reply
(7)   MS-CHAP-Error = "\007E=691 R=1 C=5655d99e064e2256aa10e59df3860df7 
V=3 M=Authentication failed"
(7)   EAP-Message = 0x04070004
(7)   Message-Authenticator = 0x00000000000000000000000000000000
(7) eap_peap: Got tunneled reply code 3
(7) eap_peap:   MS-CHAP-Error = "\007E=691 R=1 
C=5655d99e064e2256aa10e59df3860df7 V=3 M=Authentication failed"
(7) eap_peap:   EAP-Message = 0x04070004
(7) eap_peap:   Message-Authenticator = 
0x00000000000000000000000000000000
(7) eap_peap: Got tunneled reply RADIUS code 3
(7) eap_peap:   MS-CHAP-Error = "\007E=691 R=1 
C=5655d99e064e2256aa10e59df3860df7 V=3 M=Authentication failed"
(7) eap_peap:   EAP-Message = 0x04070004
(7) eap_peap:   Message-Authenticator = 
0x00000000000000000000000000000000
(7) eap_peap: Tunneled authentication was rejected
(7) eap_peap: FAILURE
(7) eap: Sending EAP Request (code 1) ID 8 length 46
(7) eap: EAP session adding &reply:State = 0xeb0f33f9ec072a61
(7)     [eap] = handled
(7)   } # authenticate = handled
(7) Using Post-Auth-Type Challenge
(7) Post-Auth-Type sub-section not found.  Ignoring.
(7) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(7) session-state: Saving cached attributes
(7)   Module-Failure-Message := "mschap: FAILED: No NT/LM-Password.  
Cannot perform authentication"
(7) Sent Access-Challenge Id 89 from 10.251.16.50:1812 to 
10.1.25.208:58067 length 0
(7)   EAP-Message = 
0x0108002e190017030300230b2330975c35e8e9ddf79f42ef6e7756557b1d7292d8d6a7939dba671186bc3157b4e5
(7)   Message-Authenticator = 0x00000000000000000000000000000000
(7)   State = 0xeb0f33f9ec072a61ce83e6b60363ea34
(7) Finished request
Waking up in 3.8 seconds.
(8) Received Access-Request Id 90 from 10.1.25.208:58067 to 
10.251.16.50:1812 length 338
(8)   Acct-Session-Id = "5CFEDE60-1B69AD04"
(8)   User-Name = "donkey"
(8)   NAS-IP-Address = 10.1.25.208
(8)   NAS-Identifier = "18-7C-0B-59-10-6C"
(8)   NAS-Port = 1
(8)   Called-Station-Id = "18-7C-0B-59-10-6C:STAFF1"
(8)   Calling-Station-Id = "28-F0-76-1A-05-C6"
(8)   Service-Type = Framed-User
(8)   Chargeable-User-Identity = 0x00
(8)   NAS-Port-Type = Wireless-802.11
(8)   Connect-Info = "CONNECT 802.11a/n/ac"
(8)   EAP-Message = 
0x0208002e19001703030023ac32e57bfad5638652a9471fbb614c7521ccdcdcf2cb7b6bb38d0350bcc3f6c0bc0c64
(8)   State = 0xeb0f33f9ec072a61ce83e6b60363ea34
(8)   Ruckus-SSID = "STAFF1"
(8)   Ruckus-BSSID = 0x187c0b59106c
(8)   Ruckus-Wlan-Id = 5
(8)   Ruckus-VLAN-ID = 16
(8)   Ruckus-SCG-CBlade-IP = 167844299
(8)   Ruckus-Zone-Name = "MAIN"
(8)   Ruckus-Wlan-Name = "STAFF1"
(8)   Message-Authenticator = 0x3103c46759b6d6f8e2b7b6241363c9cc
(8) Restoring &session-state
(8)   &session-state:Module-Failure-Message := "mschap: FAILED: No 
NT/LM-Password.  Cannot perform authentication"
(8) # Executing section authorize from file 
/etc/freeradius/3.0/sites-enabled/default
(8)   authorize {
(8)     policy filter_username {
(8)       if (&User-Name) {
(8)       if (&User-Name)  -> TRUE
(8)       if (&User-Name)  {
(8)         if (&User-Name =~ / /) {
(8)         if (&User-Name =~ / /)  -> FALSE
(8)         if (&User-Name =~ /@[^@]*@/ ) {
(8)         if (&User-Name =~ /@[^@]*@/ )  -> FALSE
(8)         if (&User-Name =~ /\.\./ ) {
(8)         if (&User-Name =~ /\.\./ )  -> FALSE
(8)         if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/))  
{
(8)         if ((&User-Name =~ /@/) && (&User-Name !~ /@(.+)\.(.+)$/))   
-> FALSE
(8)         if (&User-Name =~ /\.$/)  {
(8)         if (&User-Name =~ /\.$/)   -> FALSE
(8)         if (&User-Name =~ /@\./)  {
(8)         if (&User-Name =~ /@\./)   -> FALSE
(8)       } # if (&User-Name)  = notfound
(8)     } # policy filter_username = notfound
(8)     [preprocess] = ok
(8)     [chap] = noop
(8)     [mschap] = noop
(8)     [digest] = noop
(8) suffix: Checking for suffix after "@"
(8) suffix: No '@' in User-Name = "donkey", looking up realm NULL
(8) suffix: No such realm "NULL"
(8)     [suffix] = noop
(8) eap: Peer sent EAP Response (code 2) ID 8 length 46
(8) eap: Continuing tunnel setup
(8)     [eap] = ok
(8)   } # authorize = ok
(8) Found Auth-Type = eap
(8) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(8)   authenticate {
(8) eap: Expiring EAP session with state 0xeb0f33f9ec072a61
(8) eap: Finished EAP session with state 0xeb0f33f9ec072a61
(8) eap: Previous EAP request found for state 0xeb0f33f9ec072a61, 
released from the list
(8) eap: Peer sent packet with method EAP PEAP (25)
(8) eap: Calling submodule eap_peap to process data
(8) eap_peap: Continuing EAP-TLS
(8) eap_peap: [eaptls verify] = ok
(8) eap_peap: Done initial handshake
(8) eap_peap: [eaptls process] = ok
(8) eap_peap: Session established.  Decoding tunneled attributes
(8) eap_peap: PEAP state send tlv failure
(8) eap_peap: Received EAP-TLV response
(8) eap_peap:   The users session was previously rejected: returning 
reject (again.)
(8) eap_peap:   This means you need to read the PREVIOUS messages in the 
debug output
(8) eap_peap:   to find out the reason why the user was rejected
(8) eap_peap:   Look for "reject" or "fail".  Those earlier messages 
will tell you
(8) eap_peap:   what went wrong, and how to fix the problem
(8) eap: ERROR: Failed continuing EAP PEAP (25) session.  EAP sub-module 
failed
(8) eap: Sending EAP Failure (code 4) ID 8 length 4
(8) eap: Failed in EAP select
(8)     [eap] = invalid
(8)   } # authenticate = invalid
(8) Failed to authenticate the user
(8) Using Post-Auth-Type Reject
(8) # Executing group from file 
/etc/freeradius/3.0/sites-enabled/default
(8)   Post-Auth-Type REJECT {
(8) attr_filter.access_reject: EXPAND %{User-Name}
(8) attr_filter.access_reject:    --> donkey
(8) attr_filter.access_reject: Matched entry DEFAULT at line 11
(8)     [attr_filter.access_reject] = updated
(8)     [eap] = noop
(8)     policy remove_reply_message_if_eap {
(8)       if (&reply:EAP-Message && &reply:Reply-Message) {
(8)       if (&reply:EAP-Message && &reply:Reply-Message)  -> FALSE
(8)       else {
(8)         [noop] = noop
(8)       } # else = noop
(8)     } # policy remove_reply_message_if_eap = noop
(8)   } # Post-Auth-Type REJECT = updated
(8) Delaying response for 1.000000 seconds
Waking up in 0.3 seconds.
Waking up in 0.6 seconds.
(8) Sending delayed response
(8) Sent Access-Reject Id 90 from 10.251.16.50:1812 to 10.1.25.208:58067 
length 44
(8)   EAP-Message = 0x04080004
(8)   Message-Authenticator = 0x00000000000000000000000000000000
Waking up in 2.8 seconds.
(0) Cleaning up request packet ID 82 with timestamp +11
Waking up in 0.8 seconds.
(1) Cleaning up request packet ID 83 with timestamp +11
(2) Cleaning up request packet ID 84 with timestamp +12
(3) Cleaning up request packet ID 85 with timestamp +12
(4) Cleaning up request packet ID 86 with timestamp +12
(5) Cleaning up request packet ID 87 with timestamp +12
(6) Cleaning up request packet ID 88 with timestamp +12
Waking up in 0.2 seconds.
(7) Cleaning up request packet ID 89 with timestamp +12
(8) Cleaning up request packet ID 90 with timestamp +12
Ready to process requests

Google Secure LDAP

eko＠flyingtongue.io