Re: Empty authorize section. Using default return values. error in 3.0.9

I have not edited anything , just added users records thats all and my client The output was in the message thread But here it is again [linux ~]# radiusd -i 50.50.1.1 -p 1812 -xX Mon Jul 20 09:46:41 2015 : Debug: Server was built with: Mon Jul 20 09:46:41 2015 : Debug: accounting : yes Mon Jul 20 09:46:41 2015 : Debug: authentication : yes Mon Jul 20 09:46:41 2015 : Debug: ascend-binary-attributes : yes Mon Jul 20 09:46:41 2015 : Debug: coa : yes Mon Jul 20 09:46:41 2015 : Debug: control-socket : yes Mon Jul 20 09:46:41 2015 : Debug: detail : yes Mon Jul 20 09:46:41 2015 : Debug: dhcp : yes Mon Jul 20 09:46:41 2015 : Debug: dynamic-clients : yes Mon Jul 20 09:46:41 2015 : Debug: osfc2 : no Mon Jul 20 09:46:41 2015 : Debug: proxy : yes Mon Jul 20 09:46:41 2015 : Debug: regex-pcre : no Mon Jul 20 09:46:41 2015 : Debug: regex-posix : yes Mon Jul 20 09:46:41 2015 : Debug: regex-posix-extended : yes Mon Jul 20 09:46:41 2015 : Debug: session-management : yes Mon Jul 20 09:46:41 2015 : Debug: stats : yes Mon Jul 20 09:46:41 2015 : Debug: tcp : yes Mon Jul 20 09:46:41 2015 : Debug: threads : yes Mon Jul 20 09:46:41 2015 : Debug: tls : yes Mon Jul 20 09:46:41 2015 : Debug: unlang : yes Mon Jul 20 09:46:41 2015 : Debug: vmps : yes Mon Jul 20 09:46:41 2015 : Debug: developer : no Mon Jul 20 09:46:41 2015 : Debug: Server core libs: Mon Jul 20 09:46:41 2015 : Debug: freeradius-server : 3.0.9 Mon Jul 20 09:46:41 2015 : Debug: talloc : 2.0.* Mon Jul 20 09:46:41 2015 : Debug: ssl : 1.0.2d release Mon Jul 20 09:46:41 2015 : Debug: Endianess: Mon Jul 20 09:46:41 2015 : Debug: little Mon Jul 20 09:46:41 2015 : Debug: Compilation flags: Mon Jul 20 09:46:41 2015 : Info: Copyright (C) 1999-2015 The FreeRADIUS server project and contributors Mon Jul 20 09:46:41 2015 : Info: There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A Mon Jul 20 09:46:41 2015 : Info: PARTICULAR PURPOSE Mon Jul 20 09:46:41 2015 : Info: You may redistribute copies of FreeRADIUS under the terms of the Mon Jul 20 09:46:41 2015 : Info: GNU General Public License Mon Jul 20 09:46:41 2015 : Info: For more information about these matters, see the file named COPYRIGHT Mon Jul 20 09:46:41 2015 : Info: Starting - reading configuration files ... Mon Jul 20 09:46:41 2015 : Debug: including dictionary file /usr/local/share/freeradius/dictionary Mon Jul 20 09:46:41 2015 : Debug: including dictionary file /usr/local/share/freeradius/dictionary.dhcp Mon Jul 20 09:46:41 2015 : Debug: including dictionary file /usr/local/share/freeradius/dictionary.vqp Mon Jul 20 09:46:41 2015 : Debug: including dictionary file /usr/local/etc/raddb/dictionary Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/radiusd.conf Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/proxy.conf Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/clients.conf Mon Jul 20 09:46:41 2015 : Debug: including files in directory /usr/local/etc/raddb/mods-enabled/ Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/unpack Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/pap Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/sradutmp Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/eap Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/digest Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/utf8 Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/expr Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/detail Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/replicate Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/cache_eap Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/radutmp Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/soh Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/dhcp Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/files Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/unix Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/mschap Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/logintime Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/chap Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/exec Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/echo Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/passwd Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/ntlm_auth Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/expiration Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/linelog Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/dynamic_clients Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/mods-enabled/preprocess Mon Jul 20 09:46:41 2015 : Debug: including files in directory /usr/local/etc/raddb/policy.d/ Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/operator-name Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/eap Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/canonicalization Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/control Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/abfab-tr Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/cui Mon Jul 20 09:46:41 2015 : Debug: OPTIMIZING (${policy.cui_require_operator_name} == yes) --> FALSE Mon Jul 20 09:46:41 2015 : Debug: OPTIMIZING (no == yes) --> FALSE Mon Jul 20 09:46:41 2015 : Debug: OPTIMIZING (${policy.cui_require_operator_name} == yes) --> FALSE Mon Jul 20 09:46:41 2015 : Debug: OPTIMIZING (no == yes) --> FALSE Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/debug Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/dhcp Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/filter Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/policy.d/accounting Mon Jul 20 09:46:41 2015 : Debug: including files in directory /usr/local/etc/raddb/sites-enabled/ Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/sites-enabled/default Mon Jul 20 09:46:41 2015 : Debug: including configuration file /usr/local/etc/raddb/sites-enabled/inner-tunnel Mon Jul 20 09:46:41 2015 : Debug: main { Mon Jul 20 09:46:41 2015 : Debug: security { Mon Jul 20 09:46:41 2015 : Debug: allow_core_dumps = no Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[462]: The item 'max_attributes' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[480]: The item 'reject_delay' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[500]: The item 'status_server' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[510]: The item 'allow_vulnerable_openssl' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: name = "radiusd" Mon Jul 20 09:46:41 2015 : Debug: prefix = "/usr/local" Mon Jul 20 09:46:41 2015 : Debug: localstatedir = "/usr/local/var" Mon Jul 20 09:46:41 2015 : Debug: logdir = "/usr/local/var/log/radius" Mon Jul 20 09:46:41 2015 : Debug: run_dir = "/usr/local/var/run/radiusd" Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[67]: The item 'confdir' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[74]: The item 'db_dir' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[108]: The item 'libdir' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[119]: The item 'pidfile' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[140]: The item 'correct_escapes' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[194]: The item 'max_request_time' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[213]: The item 'cleanup_delay' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[250]: The item 'hostname_lookups' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[372]: The item 'checkrad' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[529]: The item 'proxy_requests' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: main { Mon Jul 20 09:46:41 2015 : Debug: name = "radiusd" Mon Jul 20 09:46:41 2015 : Debug: prefix = "/usr/local" Mon Jul 20 09:46:41 2015 : Debug: localstatedir = "/usr/local/var" Mon Jul 20 09:46:41 2015 : Debug: sbindir = "/usr/local/sbin" Mon Jul 20 09:46:41 2015 : Debug: logdir = "/usr/local/var/log/radius" Mon Jul 20 09:46:41 2015 : Debug: run_dir = "/usr/local/var/run/radiusd" Mon Jul 20 09:46:41 2015 : Debug: libdir = "/usr/local/lib" Mon Jul 20 09:46:41 2015 : Debug: radacctdir = "/usr/local/var/log/radius/radacct" Mon Jul 20 09:46:41 2015 : Debug: hostname_lookups = no Mon Jul 20 09:46:41 2015 : Debug: max_request_time = 30 Mon Jul 20 09:46:41 2015 : Debug: cleanup_delay = 5 Mon Jul 20 09:46:41 2015 : Debug: max_requests = 16384 Mon Jul 20 09:46:41 2015 : Debug: pidfile = "/usr/local/var/run/radiusd/radiusd.pid" Mon Jul 20 09:46:41 2015 : Debug: checkrad = "/usr/local/sbin/checkrad" Mon Jul 20 09:46:41 2015 : Debug: debug_level = 0 Mon Jul 20 09:46:41 2015 : Debug: proxy_requests = yes Mon Jul 20 09:46:41 2015 : Debug: log { Mon Jul 20 09:46:41 2015 : Debug: stripped_names = no Mon Jul 20 09:46:41 2015 : Debug: auth = no Mon Jul 20 09:46:41 2015 : Debug: auth_badpass = no Mon Jul 20 09:46:41 2015 : Debug: auth_goodpass = no Mon Jul 20 09:46:41 2015 : Debug: colourise = yes Mon Jul 20 09:46:41 2015 : Debug: msg_denied = "You are already logged in - access denied" Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[268]: The item 'destination' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[285]: The item 'file' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[331]: The item 'syslog_facility' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: resources { Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: security { Mon Jul 20 09:46:41 2015 : Debug: max_attributes = 200 Mon Jul 20 09:46:41 2015 : Debug: reject_delay = 1.000000 Mon Jul 20 09:46:41 2015 : Debug: status_server = yes Mon Jul 20 09:46:41 2015 : Debug: allow_vulnerable_openssl = "no" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[67]: The item 'confdir' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[74]: The item 'db_dir' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Warning: /usr/local/etc/raddb/radiusd.conf[140]: The item 'correct_escapes' is defined, but is unused by the configuration Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: radiusd: #### Loading Realms and Home Servers #### Mon Jul 20 09:46:41 2015 : Debug: proxy server { Mon Jul 20 09:46:41 2015 : Debug: retry_delay = 5 Mon Jul 20 09:46:41 2015 : Debug: retry_count = 3 Mon Jul 20 09:46:41 2015 : Debug: default_fallback = no Mon Jul 20 09:46:41 2015 : Debug: dead_time = 120 Mon Jul 20 09:46:41 2015 : Debug: wake_all_if_all_dead = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: home_server localhost { Mon Jul 20 09:46:41 2015 : Debug: ipaddr = 127.0.0.1 Mon Jul 20 09:46:41 2015 : Debug: port = 1812 Mon Jul 20 09:46:41 2015 : Debug: type = "auth" Mon Jul 20 09:46:41 2015 : Debug: secret = "testing123" Mon Jul 20 09:46:41 2015 : Debug: response_window = 20.000000 Mon Jul 20 09:46:41 2015 : Debug: response_timeouts = 1 Mon Jul 20 09:46:41 2015 : Debug: max_outstanding = 65536 Mon Jul 20 09:46:41 2015 : Debug: zombie_period = 40 Mon Jul 20 09:46:41 2015 : Debug: status_check = "status-server" Mon Jul 20 09:46:41 2015 : Debug: ping_interval = 30 Mon Jul 20 09:46:41 2015 : Debug: check_interval = 30 Mon Jul 20 09:46:41 2015 : Debug: check_timeout = 4 Mon Jul 20 09:46:41 2015 : Debug: num_answers_to_alive = 3 Mon Jul 20 09:46:41 2015 : Debug: revive_interval = 120 Mon Jul 20 09:46:41 2015 : Debug: limit { Mon Jul 20 09:46:41 2015 : Debug: max_connections = 16 Mon Jul 20 09:46:41 2015 : Debug: max_requests = 0 Mon Jul 20 09:46:41 2015 : Debug: lifetime = 0 Mon Jul 20 09:46:41 2015 : Debug: idle_timeout = 0 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: coa { Mon Jul 20 09:46:41 2015 : Debug: irt = 2 Mon Jul 20 09:46:41 2015 : Debug: mrt = 16 Mon Jul 20 09:46:41 2015 : Debug: mrc = 5 Mon Jul 20 09:46:41 2015 : Debug: mrd = 30 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: home_server_pool my_auth_failover { Mon Jul 20 09:46:41 2015 : Debug: type = fail-over Mon Jul 20 09:46:41 2015 : Debug: home_server = localhost Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: realm example.com { Mon Jul 20 09:46:41 2015 : Debug: auth_pool = my_auth_failover Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: realm LOCAL { Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: radiusd: #### Loading Clients #### Mon Jul 20 09:46:41 2015 : Debug: client localhost { Mon Jul 20 09:46:41 2015 : Debug: ipaddr = 127.0.0.1 Mon Jul 20 09:46:41 2015 : Debug: require_message_authenticator = no Mon Jul 20 09:46:41 2015 : Debug: secret = "testing123" Mon Jul 20 09:46:41 2015 : Debug: nas_type = "other" Mon Jul 20 09:46:41 2015 : Debug: proto = "*" Mon Jul 20 09:46:41 2015 : Debug: limit { Mon Jul 20 09:46:41 2015 : Debug: max_connections = 16 Mon Jul 20 09:46:41 2015 : Debug: lifetime = 0 Mon Jul 20 09:46:41 2015 : Debug: idle_timeout = 30 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Adding client 127.0.0.1/32 (127.0.0.1) to prefix tree 32 Mon Jul 20 09:46:41 2015 : Debug: client localhost_ipv6 { Mon Jul 20 09:46:41 2015 : Debug: ipv6addr = ::1 Mon Jul 20 09:46:41 2015 : Debug: require_message_authenticator = no Mon Jul 20 09:46:41 2015 : Debug: secret = "testing123" Mon Jul 20 09:46:41 2015 : Debug: limit { Mon Jul 20 09:46:41 2015 : Debug: max_connections = 16 Mon Jul 20 09:46:41 2015 : Debug: lifetime = 0 Mon Jul 20 09:46:41 2015 : Debug: idle_timeout = 30 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Adding client ::1/128 (::1) to prefix tree 128 Mon Jul 20 09:46:41 2015 : Debug: client 50.50.1.2/32 { Mon Jul 20 09:46:41 2015 : Debug: ipaddr = 50.50.1.2 Mon Jul 20 09:46:41 2015 : Debug: require_message_authenticator = no Mon Jul 20 09:46:41 2015 : Debug: secret = "redback" Mon Jul 20 09:46:41 2015 : Debug: shortname = "st-bng-uc2-ssr1" Mon Jul 20 09:46:41 2015 : Debug: limit { Mon Jul 20 09:46:41 2015 : Debug: max_connections = 16 Mon Jul 20 09:46:41 2015 : Debug: lifetime = 0 Mon Jul 20 09:46:41 2015 : Debug: idle_timeout = 30 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Adding client 50.50.1.2/32 (50.50.1.2) to prefix tree 32 Mon Jul 20 09:46:41 2015 : Info: Debugger not attached Mon Jul 20 09:46:41 2015 : Debug: # Creating Auth-Type = digest Mon Jul 20 09:46:41 2015 : Debug: radiusd: #### Instantiating modules #### Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_unpack, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_unpack Mon Jul 20 09:46:41 2015 : Debug: # Loading module "unpack" from file /usr/local/etc/raddb/mods-enabled/unpack Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_pap, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_pap Mon Jul 20 09:46:41 2015 : Debug: # Loading module "pap" from file /usr/local/etc/raddb/mods-enabled/pap Mon Jul 20 09:46:41 2015 : Debug: pap { Mon Jul 20 09:46:41 2015 : Debug: normalise = yes Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_radutmp, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_radutmp Mon Jul 20 09:46:41 2015 : Debug: # Loading module "sradutmp" from file /usr/local/etc/raddb/mods-enabled/sradutmp Mon Jul 20 09:46:41 2015 : Debug: radutmp sradutmp { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/sradutmp" Mon Jul 20 09:46:41 2015 : Debug: username = "%{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: case_sensitive = yes Mon Jul 20 09:46:41 2015 : Debug: check_with_nas = yes Mon Jul 20 09:46:41 2015 : Debug: permissions = 420 Mon Jul 20 09:46:41 2015 : Debug: caller_id = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_eap, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_eap Mon Jul 20 09:46:41 2015 : Debug: # Loading module "eap" from file /usr/local/etc/raddb/mods-enabled/eap Mon Jul 20 09:46:41 2015 : Debug: eap { Mon Jul 20 09:46:41 2015 : Debug: default_eap_type = "md5" Mon Jul 20 09:46:41 2015 : Debug: timer_expire = 60 Mon Jul 20 09:46:41 2015 : Debug: ignore_unknown_eap_types = no Mon Jul 20 09:46:41 2015 : Debug: cisco_accounting_username_bug = no Mon Jul 20 09:46:41 2015 : Debug: max_sessions = 16384 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_digest, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_digest Mon Jul 20 09:46:41 2015 : Debug: # Loading module "digest" from file /usr/local/etc/raddb/mods-enabled/digest Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_utf8, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_utf8 Mon Jul 20 09:46:41 2015 : Debug: # Loading module "utf8" from file /usr/local/etc/raddb/mods-enabled/utf8 Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_expr, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_expr Mon Jul 20 09:46:41 2015 : Debug: # Loading module "expr" from file /usr/local/etc/raddb/mods-enabled/expr Mon Jul 20 09:46:41 2015 : Debug: expr { Mon Jul 20 09:46:41 2015 : Debug: safe_characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /äéöüà âæçèéêëîïôÅùûüaÿà ÃÃÃÃÃÃÃÃÃÃÃÃÃÃÃÅÃß" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_detail, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_detail Mon Jul 20 09:46:41 2015 : Debug: # Loading module "detail" from file /usr/local/etc/raddb/mods-enabled/detail Mon Jul 20 09:46:41 2015 : Debug: detail { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d" Mon Jul 20 09:46:41 2015 : Debug: header = "%t" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: locking = no Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: log_packet_header = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_realm, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_realm Mon Jul 20 09:46:41 2015 : Debug: # Loading module "IPASS" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: realm IPASS { Mon Jul 20 09:46:41 2015 : Debug: format = "prefix" Mon Jul 20 09:46:41 2015 : Debug: delimiter = "/" Mon Jul 20 09:46:41 2015 : Debug: ignore_default = no Mon Jul 20 09:46:41 2015 : Debug: ignore_null = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "suffix" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: realm suffix { Mon Jul 20 09:46:41 2015 : Debug: format = "suffix" Mon Jul 20 09:46:41 2015 : Debug: delimiter = "@" Mon Jul 20 09:46:41 2015 : Debug: ignore_default = no Mon Jul 20 09:46:41 2015 : Debug: ignore_null = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "realmpercent" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: realm realmpercent { Mon Jul 20 09:46:41 2015 : Debug: format = "suffix" Mon Jul 20 09:46:41 2015 : Debug: delimiter = "%" Mon Jul 20 09:46:41 2015 : Debug: ignore_default = no Mon Jul 20 09:46:41 2015 : Debug: ignore_null = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "ntdomain" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: realm ntdomain { Mon Jul 20 09:46:41 2015 : Debug: format = "prefix" Mon Jul 20 09:46:41 2015 : Debug: delimiter = "\\" Mon Jul 20 09:46:41 2015 : Debug: ignore_default = no Mon Jul 20 09:46:41 2015 : Debug: ignore_null = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_replicate, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_replicate Mon Jul 20 09:46:41 2015 : Debug: # Loading module "replicate" from file /usr/local/etc/raddb/mods-enabled/replicate Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_cache, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_cache Mon Jul 20 09:46:41 2015 : Debug: # Loading module "cache_eap" from file /usr/local/etc/raddb/mods-enabled/cache_eap Mon Jul 20 09:46:41 2015 : Debug: cache cache_eap { Mon Jul 20 09:46:41 2015 : Debug: driver = "rlm_cache_rbtree" Mon Jul 20 09:46:41 2015 : Debug: key = "%{%{control:State}:-%{%{reply:State}:-%{State}}}" Mon Jul 20 09:46:41 2015 : Debug: ttl = 15 Mon Jul 20 09:46:41 2015 : Debug: max_entries = 0 Mon Jul 20 09:46:41 2015 : Debug: epoch = 0 Mon Jul 20 09:46:41 2015 : Debug: add_stats = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_attr_filter, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_attr_filter Mon Jul 20 09:46:41 2015 : Debug: # Loading module "attr_filter.post-proxy" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: attr_filter attr_filter.post-proxy { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/etc/raddb/mods-config/attr_filter/post-proxy" Mon Jul 20 09:46:41 2015 : Debug: key = "%{Realm}" Mon Jul 20 09:46:41 2015 : Debug: relaxed = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "attr_filter.pre-proxy" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: attr_filter attr_filter.pre-proxy { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/etc/raddb/mods-config/attr_filter/pre-proxy" Mon Jul 20 09:46:41 2015 : Debug: key = "%{Realm}" Mon Jul 20 09:46:41 2015 : Debug: relaxed = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "attr_filter.access_reject" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: attr_filter attr_filter.access_reject { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/etc/raddb/mods-config/attr_filter/access_reject" Mon Jul 20 09:46:41 2015 : Debug: key = "%{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: relaxed = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "attr_filter.access_challenge" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: attr_filter attr_filter.access_challenge { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/etc/raddb/mods-config/attr_filter/access_challenge" Mon Jul 20 09:46:41 2015 : Debug: key = "%{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: relaxed = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "attr_filter.accounting_response" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: attr_filter attr_filter.accounting_response { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/etc/raddb/mods-config/attr_filter/accounting_response" Mon Jul 20 09:46:41 2015 : Debug: key = "%{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: relaxed = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "radutmp" from file /usr/local/etc/raddb/mods-enabled/radutmp Mon Jul 20 09:46:41 2015 : Debug: radutmp { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/radutmp" Mon Jul 20 09:46:41 2015 : Debug: username = "%{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: case_sensitive = yes Mon Jul 20 09:46:41 2015 : Debug: check_with_nas = yes Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: caller_id = yes Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_soh, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_soh Mon Jul 20 09:46:41 2015 : Debug: # Loading module "soh" from file /usr/local/etc/raddb/mods-enabled/soh Mon Jul 20 09:46:41 2015 : Debug: soh { Mon Jul 20 09:46:41 2015 : Debug: dhcp = yes Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_dhcp, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_dhcp Mon Jul 20 09:46:41 2015 : Debug: # Loading module "dhcp" from file /usr/local/etc/raddb/mods-enabled/dhcp Mon Jul 20 09:46:41 2015 : Debug: Adding values for DHCP-Parameter-Request-List Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 1 DHCP-Subnet-Mask Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 2 DHCP-Time-Offset Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 3 DHCP-Router-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 4 DHCP-Time-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 5 DHCP-IEN-116-Name-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 6 DHCP-Domain-Name-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 7 DHCP-Log-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 8 DHCP-Quotes-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 9 DHCP-LPR-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 10 DHCP-Impress-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 11 DHCP-RLP-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 12 DHCP-Hostname Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 13 DHCP-Boot-File-Size Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 14 DHCP-Merit-Dump-File Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 15 DHCP-Domain-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 16 DHCP-Swap-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 17 DHCP-Root-Path Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 18 DHCP-Bootp-Extensions-Path Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 19 DHCP-IP-Forward-Enable Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 20 DHCP-Source-Route-Enable Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 21 DHCP-Policy-Filter Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 22 DHCP-Max-Datagram-Reassembly-Size Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 23 DHCP-Default-IP-TTL Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 24 DHCP-Path-MTU-Aging-Timeout Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 25 DHCP-Path-MTU-Plateau-Table Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 26 DHCP-Interface-MTU-Size Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 27 DHCP-All-Subnets-Are-Local Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 28 DHCP-Broadcast-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 29 DHCP-Perform-Mask-Discovery Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 30 DHCP-Provide-Mask-To-Others Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 31 DHCP-Perform-Router-Discovery Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 32 DHCP-Router-Solicitation-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 33 DHCP-Static-Routes Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 34 DHCP-Trailer-Encapsulation Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 35 DHCP-ARP-Cache-Timeout Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 36 DHCP-Ethernet-Encapsulation Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 37 DHCP-Default-TCP-TTL Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 38 DHCP-Keep-Alive-Interval Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 39 DHCP-Keep-Alive-Garbage Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 40 DHCP-NIS-Domain-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 41 DHCP-NIS-Servers Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 42 DHCP-NTP-Servers Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 43 DHCP-Vendor Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 44 DHCP-NETBIOS-Name-Servers Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 45 DHCP-NETBIOS-Dgm-Dist-Servers Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 46 DHCP-NETBIOS-Node-Type Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 47 DHCP-NETBIOS Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 48 DHCP-X-Window-Font-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 49 DHCP-X-Window-Display-Mgr Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 50 DHCP-Requested-IP-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 51 DHCP-IP-Address-Lease-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 52 DHCP-Overload Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 53 DHCP-Message-Type Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 54 DHCP-DHCP-Server-Identifier Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 55 DHCP-Parameter-Request-List Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 56 DHCP-DHCP-Error-Message Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 57 DHCP-DHCP-Maximum-Msg-Size Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 58 DHCP-Renewal-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 59 DHCP-Rebinding-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 60 DHCP-Vendor-Class-Identifier Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 61 DHCP-Client-Identifier Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 62 DHCP-Netware-Domain-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 63 DHCP-Netware-Sub-Options Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 64 DHCP-NIS-Client-Domain-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 65 DHCP-NIS-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 66 DHCP-TFTP-Server-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 67 DHCP-Boot-File-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 68 DHCP-Home-Agent-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 69 DHCP-SMTP-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 70 DHCP-POP3-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 71 DHCP-NNTP-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 72 DHCP-WWW-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 73 DHCP-Finger-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 74 DHCP-IRC-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 75 DHCP-StreetTalk-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 76 DHCP-STDA-Server-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 77 DHCP-User-Class Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 78 DHCP-Directory-Agent Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 79 DHCP-Service-Scope Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 80 DHCP-Rapid-Commit Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 81 DHCP-Client-FQDN Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 82 DHCP-Relay-Agent-Information Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 83 DHCP-iSNS Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 84 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 85 DHCP-NDS-Servers Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 86 DHCP-NDS-Tree-Name Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 87 DHCP-NDS-Context Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 88 DHCP-BCMS-Server-IPv4-FQDN Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 89 DHCP-BCMS-Server-IPv4-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 90 DHCP-Authentication Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 91 DHCP-Client-Last-Txn-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 92 DHCP-associated-ip Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 93 DHCP-Client-System Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 94 DHCP-Client-NDI Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 95 DHCP-LDAP Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 96 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 97 DHCP-UUID/GUID Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 98 DHCP-User-Auth Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 99 DHCP-GeoConf-Civic Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 100 DHCP-Timezone-Posix Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 101 DHCP-Timezone-Database Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 102 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 103 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 104 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 105 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 106 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 107 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 108 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 109 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 110 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 111 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 112 DHCP-Netinfo-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 113 DHCP-Netinfo-Tag Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 114 DHCP-URL Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 115 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 116 DHCP-Auto-Config Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 117 DHCP-Name-Service-Search Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 118 DHCP-Subnet-Selection-Option Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 119 DHCP-Domain-Search Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 120 DHCP-SIP-Servers-DHCP-Option Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 121 DHCP-Classless-Static-Route Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 122 DHCP-CCC Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 123 DHCP-GeoConf-Option Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 124 DHCP-V-I-Vendor-Class Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 125 DHCP-V-I-Vendor-Specific Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 126 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 127 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 128 DHCP-TFTP-Server-IP-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 129 DHCP-Call-Server-IP-address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 130 DHCP-Vendor-Discrimination-Str Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 131 DHCP-Remote-Stats-Svr-IP-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 132 DHCP-IEEE-802.1P-VLAN-ID Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 133 DHCP-IEEE-802.1Q-L2-Priority Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 134 DHCP-Diffserv-Code-Point Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 135 DHCP-HTTP-Proxy Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 136 DHCP-PANA-Agent Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 137 DHCP-LoST-Server Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 138 DHCP-CAPWAP-AC-IPv4-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 139 DHCP-MoS-IPv4-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 140 DHCP-MoS-IPv4-FQDN Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 141 DHCP-SIP-UA-Configuration-Service-Domains Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 142 DHCP-ANDSF-IPv4-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 143 DHCP-ANDSF-IPv6-Address Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 144 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 145 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 146 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 147 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 148 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 149 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 150 DHCP-TFTP-Server-IPv4-Address Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 151 DHCP-Query-Status-Code Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 152 DHCP-Query-Server-Base-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 153 DHCP-Query-Start-Time-Of-State Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 154 DHCP-Query-Start-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 155 DHCP-Query-End-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 156 DHCP-State Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 157 DHCP-Data-Source Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 158 DHCP-PCP-IPv4-Server-Address Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 159 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 160 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 161 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 162 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 163 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 164 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 165 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 166 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 167 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 168 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 169 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 170 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 171 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 172 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 173 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 174 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 175 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 176 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 177 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 178 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 179 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 180 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 181 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 182 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 183 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 184 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 185 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 186 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 187 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 188 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 189 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 190 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 191 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 192 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 193 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 194 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 195 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 196 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 197 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 198 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 199 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 200 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 201 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 202 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 203 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 204 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 205 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 206 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 207 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 208 DHCP-PXELINUX-Magic Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 209 DHCP-Packet-Format Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 210 DHCP-Path-Prefix Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 211 DHCP-Reboot-Time Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 212 DHCP-6RD Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 213 DHCP-Access-Network-Domain-Name Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 214 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 215 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 216 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 217 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 218 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 219 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 220 DHCP-Virtual-Subnet-Allocation Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 221 DHCP-Virtual-Subnet-Selection Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 222 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 223 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 224 DHCP-Site-specific-0 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 225 DHCP-Site-specific-1 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 226 DHCP-Site-specific-2 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 227 DHCP-Site-specific-3 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 228 DHCP-Site-specific-4 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 229 DHCP-Site-specific-5 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 230 DHCP-Site-specific-6 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 231 DHCP-Site-specific-7 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 232 DHCP-Site-specific-8 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 233 DHCP-Site-specific-9 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 234 DHCP-Site-specific-10 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 235 DHCP-Site-specific-11 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 236 DHCP-Site-specific-12 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 237 DHCP-Site-specific-13 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 238 DHCP-Site-specific-14 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 239 DHCP-Site-specific-15 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 240 DHCP-Site-specific-16 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 241 DHCP-Site-specific-17 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 242 DHCP-Site-specific-18 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 243 DHCP-Site-specific-19 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 244 DHCP-Site-specific-20 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 245 DHCP-Site-specific-21 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 246 DHCP-Site-specific-22 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 247 DHCP-Site-specific-23 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 248 DHCP-Site-specific-24 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 249 DHCP-Site-specific-25 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 250 DHCP-Site-specific-26 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 251 DHCP-Site-specific-27 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 252 DHCP-Site-specific-28 Mon Jul 20 09:46:41 2015 : Debug: Adding DHCP-Parameter-Request-List value 253 DHCP-Site-specific-30 Mon Jul 20 09:46:41 2015 : Debug: No DHCP RFC space attribute at 254 Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_files, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_files Mon Jul 20 09:46:41 2015 : Debug: # Loading module "files" from file /usr/local/etc/raddb/mods-enabled/files Mon Jul 20 09:46:41 2015 : Debug: files { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/etc/raddb/mods-config/files/authorize" Mon Jul 20 09:46:41 2015 : Debug: acctusersfile = "/usr/local/etc/raddb/mods-config/files/accounting" Mon Jul 20 09:46:41 2015 : Debug: preproxy_usersfile = "/usr/local/etc/raddb/mods-config/files/pre-proxy" Mon Jul 20 09:46:41 2015 : Debug: compat = "cistron" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_unix, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_unix Mon Jul 20 09:46:41 2015 : Debug: # Loading module "unix" from file /usr/local/etc/raddb/mods-enabled/unix Mon Jul 20 09:46:41 2015 : Debug: unix { Mon Jul 20 09:46:41 2015 : Debug: radwtmp = "/usr/local/var/log/radius/radwtmp" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Creating attribute Unix-Group Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_always, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_always Mon Jul 20 09:46:41 2015 : Debug: # Loading module "reject" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always reject { Mon Jul 20 09:46:41 2015 : Debug: rcode = "reject" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "fail" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always fail { Mon Jul 20 09:46:41 2015 : Debug: rcode = "fail" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "ok" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always ok { Mon Jul 20 09:46:41 2015 : Debug: rcode = "ok" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "handled" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always handled { Mon Jul 20 09:46:41 2015 : Debug: rcode = "handled" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "invalid" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always invalid { Mon Jul 20 09:46:41 2015 : Debug: rcode = "invalid" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "userlock" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always userlock { Mon Jul 20 09:46:41 2015 : Debug: rcode = "userlock" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "notfound" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always notfound { Mon Jul 20 09:46:41 2015 : Debug: rcode = "notfound" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "noop" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always noop { Mon Jul 20 09:46:41 2015 : Debug: rcode = "noop" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "updated" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:41 2015 : Debug: always updated { Mon Jul 20 09:46:41 2015 : Debug: rcode = "updated" Mon Jul 20 09:46:41 2015 : Debug: simulcount = 0 Mon Jul 20 09:46:41 2015 : Debug: mpp = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_mschap, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_mschap Mon Jul 20 09:46:41 2015 : Debug: # Loading module "mschap" from file /usr/local/etc/raddb/mods-enabled/mschap Mon Jul 20 09:46:41 2015 : Debug: mschap { Mon Jul 20 09:46:41 2015 : Debug: use_mppe = yes Mon Jul 20 09:46:41 2015 : Debug: require_encryption = no Mon Jul 20 09:46:41 2015 : Debug: require_strong = no Mon Jul 20 09:46:41 2015 : Debug: with_ntdomain_hack = yes Mon Jul 20 09:46:41 2015 : Debug: passchange { Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: allow_retry = yes Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_logintime, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_logintime Mon Jul 20 09:46:41 2015 : Debug: # Loading module "logintime" from file /usr/local/etc/raddb/mods-enabled/logintime Mon Jul 20 09:46:41 2015 : Debug: logintime { Mon Jul 20 09:46:41 2015 : Debug: minimum_timeout = 60 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_chap, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_chap Mon Jul 20 09:46:41 2015 : Debug: # Loading module "chap" from file /usr/local/etc/raddb/mods-enabled/chap Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_exec, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_exec Mon Jul 20 09:46:41 2015 : Debug: # Loading module "exec" from file /usr/local/etc/raddb/mods-enabled/exec Mon Jul 20 09:46:41 2015 : Debug: exec { Mon Jul 20 09:46:41 2015 : Debug: wait = no Mon Jul 20 09:46:41 2015 : Debug: input_pairs = "request" Mon Jul 20 09:46:41 2015 : Debug: shell_escape = yes Mon Jul 20 09:46:41 2015 : Debug: timeout = 10 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "echo" from file /usr/local/etc/raddb/mods-enabled/echo Mon Jul 20 09:46:41 2015 : Debug: exec echo { Mon Jul 20 09:46:41 2015 : Debug: wait = yes Mon Jul 20 09:46:41 2015 : Debug: program = "/bin/echo %{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: input_pairs = "request" Mon Jul 20 09:46:41 2015 : Debug: output_pairs = "reply" Mon Jul 20 09:46:41 2015 : Debug: shell_escape = yes Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "auth_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:41 2015 : Debug: detail auth_log { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d" Mon Jul 20 09:46:41 2015 : Debug: header = "%t" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: locking = no Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: log_packet_header = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "reply_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:41 2015 : Debug: detail reply_log { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/reply-detail-%Y%m%d" Mon Jul 20 09:46:41 2015 : Debug: header = "%t" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: locking = no Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: log_packet_header = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "pre_proxy_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:41 2015 : Debug: detail pre_proxy_log { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/pre-proxy-detail-%Y%m%d" Mon Jul 20 09:46:41 2015 : Debug: header = "%t" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: locking = no Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: log_packet_header = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "post_proxy_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:41 2015 : Debug: detail post_proxy_log { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/post-proxy-detail-%Y%m%d" Mon Jul 20 09:46:41 2015 : Debug: header = "%t" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: locking = no Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: log_packet_header = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_passwd, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_passwd Mon Jul 20 09:46:41 2015 : Debug: # Loading module "etc_passwd" from file /usr/local/etc/raddb/mods-enabled/passwd Mon Jul 20 09:46:41 2015 : Debug: passwd etc_passwd { Mon Jul 20 09:46:41 2015 : Debug: filename = "/etc/passwd" Mon Jul 20 09:46:41 2015 : Debug: format = "*User-Name:Crypt-Password:" Mon Jul 20 09:46:41 2015 : Debug: delimiter = ":" Mon Jul 20 09:46:41 2015 : Debug: ignore_nislike = no Mon Jul 20 09:46:41 2015 : Debug: ignore_empty = yes Mon Jul 20 09:46:41 2015 : Debug: allow_multiple_keys = no Mon Jul 20 09:46:41 2015 : Debug: hash_size = 100 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "ntlm_auth" from file /usr/local/etc/raddb/mods-enabled/ntlm_auth Mon Jul 20 09:46:41 2015 : Debug: exec ntlm_auth { Mon Jul 20 09:46:41 2015 : Debug: wait = yes Mon Jul 20 09:46:41 2015 : Debug: program = "/path/to/ntlm_auth --request-nt-key --domain=MYDOMAIN --username=%{mschap:User-Name} --password=%{User-Password}" Mon Jul 20 09:46:41 2015 : Debug: shell_escape = yes Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_expiration, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_expiration Mon Jul 20 09:46:41 2015 : Debug: # Loading module "expiration" from file /usr/local/etc/raddb/mods-enabled/expiration Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_linelog, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_linelog Mon Jul 20 09:46:41 2015 : Debug: # Loading module "linelog" from file /usr/local/etc/raddb/mods-enabled/linelog Mon Jul 20 09:46:41 2015 : Debug: linelog { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/linelog" Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: syslog_severity = "info" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: format = "This is a log message for %{User-Name}" Mon Jul 20 09:46:41 2015 : Debug: reference = "messages.%{%{reply:Packet-Type}:-default}" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Loading module "log_accounting" from file /usr/local/etc/raddb/mods-enabled/linelog Mon Jul 20 09:46:41 2015 : Debug: linelog log_accounting { Mon Jul 20 09:46:41 2015 : Debug: filename = "/usr/local/var/log/radius/linelog-accounting" Mon Jul 20 09:46:41 2015 : Debug: escape_filenames = no Mon Jul 20 09:46:41 2015 : Debug: syslog_severity = "info" Mon Jul 20 09:46:41 2015 : Debug: permissions = 384 Mon Jul 20 09:46:41 2015 : Debug: format = "" Mon Jul 20 09:46:41 2015 : Debug: reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_dynamic_clients, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_dynamic_clients Mon Jul 20 09:46:41 2015 : Debug: # Loading module "dynamic_clients" from file /usr/local/etc/raddb/mods-enabled/dynamic_clients Mon Jul 20 09:46:41 2015 : Debug: Loaded rlm_preprocess, checking if it's valid Mon Jul 20 09:46:41 2015 : Debug: # Loaded module rlm_preprocess Mon Jul 20 09:46:41 2015 : Debug: # Loading module "preprocess" from file /usr/local/etc/raddb/mods-enabled/preprocess Mon Jul 20 09:46:41 2015 : Debug: preprocess { Mon Jul 20 09:46:41 2015 : Debug: huntgroups = "/usr/local/etc/raddb/mods-config/preprocess/huntgroups" Mon Jul 20 09:46:41 2015 : Debug: hints = "/usr/local/etc/raddb/mods-config/preprocess/hints" Mon Jul 20 09:46:41 2015 : Debug: with_ascend_hack = no Mon Jul 20 09:46:41 2015 : Debug: ascend_channels_per_line = 23 Mon Jul 20 09:46:41 2015 : Debug: with_ntdomain_hack = no Mon Jul 20 09:46:41 2015 : Debug: with_specialix_jetstream_hack = no Mon Jul 20 09:46:41 2015 : Debug: with_cisco_vsa_hack = no Mon Jul 20 09:46:41 2015 : Debug: with_alvarion_vsa_hack = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: instantiate { Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: modules { Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "pap" from file /usr/local/etc/raddb/mods-enabled/pap Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "eap" from file /usr/local/etc/raddb/mods-enabled/eap Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_md5 Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_leap Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_gtc Mon Jul 20 09:46:41 2015 : Debug: gtc { Mon Jul 20 09:46:41 2015 : Debug: challenge = "Password: " Mon Jul 20 09:46:41 2015 : Debug: auth_type = "PAP" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_tls Mon Jul 20 09:46:41 2015 : Debug: tls { Mon Jul 20 09:46:41 2015 : Debug: tls = "tls-common" Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: tls-config tls-common { Mon Jul 20 09:46:41 2015 : Debug: rsa_key_exchange = no Mon Jul 20 09:46:41 2015 : Debug: dh_key_exchange = yes Mon Jul 20 09:46:41 2015 : Debug: rsa_key_length = 512 Mon Jul 20 09:46:41 2015 : Debug: dh_key_length = 512 Mon Jul 20 09:46:41 2015 : Debug: verify_depth = 0 Mon Jul 20 09:46:41 2015 : Debug: ca_path = "/usr/local/etc/raddb/certs" Mon Jul 20 09:46:41 2015 : Debug: pem_file_type = yes Mon Jul 20 09:46:41 2015 : Debug: private_key_file = "/usr/local/etc/raddb/certs/server.pem" Mon Jul 20 09:46:41 2015 : Debug: certificate_file = "/usr/local/etc/raddb/certs/server.pem" Mon Jul 20 09:46:41 2015 : Debug: ca_file = "/usr/local/etc/raddb/certs/ca.pem" Mon Jul 20 09:46:41 2015 : Debug: private_key_password = "whatever" Mon Jul 20 09:46:41 2015 : Debug: dh_file = "/usr/local/etc/raddb/certs/dh" Mon Jul 20 09:46:41 2015 : Debug: fragment_size = 1024 Mon Jul 20 09:46:41 2015 : Debug: include_length = yes Mon Jul 20 09:46:41 2015 : Debug: check_crl = no Mon Jul 20 09:46:41 2015 : Debug: check_all_crl = no Mon Jul 20 09:46:41 2015 : Debug: cipher_list = "DEFAULT" Mon Jul 20 09:46:41 2015 : Debug: ecdh_curve = "prime256v1" Mon Jul 20 09:46:41 2015 : Debug: cache { Mon Jul 20 09:46:41 2015 : Debug: enable = yes Mon Jul 20 09:46:41 2015 : Debug: lifetime = 24 Mon Jul 20 09:46:41 2015 : Debug: max_entries = 255 Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: verify { Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: ocsp { Mon Jul 20 09:46:41 2015 : Debug: enable = no Mon Jul 20 09:46:41 2015 : Debug: override_cert_url = yes Mon Jul 20 09:46:41 2015 : Debug: url = "http://127.0.0.1/ocsp/" Mon Jul 20 09:46:41 2015 : Debug: use_nonce = yes Mon Jul 20 09:46:41 2015 : Debug: timeout = 0 Mon Jul 20 09:46:41 2015 : Debug: softfail = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_ttls Mon Jul 20 09:46:41 2015 : Debug: ttls { Mon Jul 20 09:46:41 2015 : Debug: tls = "tls-common" Mon Jul 20 09:46:41 2015 : Debug: default_eap_type = "md5" Mon Jul 20 09:46:41 2015 : Debug: copy_request_to_tunnel = no Mon Jul 20 09:46:41 2015 : Debug: use_tunneled_reply = no Mon Jul 20 09:46:41 2015 : Debug: virtual_server = "inner-tunnel" Mon Jul 20 09:46:41 2015 : Debug: include_length = yes Mon Jul 20 09:46:41 2015 : Debug: require_client_cert = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: tls: Using cached TLS configuration from previous invocation Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_peap Mon Jul 20 09:46:41 2015 : Debug: peap { Mon Jul 20 09:46:41 2015 : Debug: tls = "tls-common" Mon Jul 20 09:46:41 2015 : Debug: default_eap_type = "mschapv2" Mon Jul 20 09:46:41 2015 : Debug: copy_request_to_tunnel = no Mon Jul 20 09:46:41 2015 : Debug: use_tunneled_reply = no Mon Jul 20 09:46:41 2015 : Debug: proxy_tunneled_request_as_eap = yes Mon Jul 20 09:46:41 2015 : Debug: virtual_server = "inner-tunnel" Mon Jul 20 09:46:41 2015 : Debug: soh = no Mon Jul 20 09:46:41 2015 : Debug: require_client_cert = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: tls: Using cached TLS configuration from previous invocation Mon Jul 20 09:46:41 2015 : Debug: # Linked to sub-module rlm_eap_mschapv2 Mon Jul 20 09:46:41 2015 : Debug: mschapv2 { Mon Jul 20 09:46:41 2015 : Debug: with_ntdomain_hack = no Mon Jul 20 09:46:41 2015 : Debug: send_error = no Mon Jul 20 09:46:41 2015 : Debug: } Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "detail" from file /usr/local/etc/raddb/mods-enabled/detail Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "IPASS" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "suffix" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "realmpercent" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "ntdomain" from file /usr/local/etc/raddb/mods-enabled/realm Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "cache_eap" from file /usr/local/etc/raddb/mods-enabled/cache_eap Mon Jul 20 09:46:41 2015 : Debug: rlm_cache (cache_eap): Driver rlm_cache_rbtree (module rlm_cache_rbtree) loaded and linked Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "attr_filter.post-proxy" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/attr_filter/post-proxy Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "attr_filter.pre-proxy" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/attr_filter/pre-proxy Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "attr_filter.access_reject" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/attr_filter/access_reject Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "attr_filter.access_challenge" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/attr_filter/access_challenge Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "attr_filter.accounting_response" from file /usr/local/etc/raddb/mods-enabled/attr_filter Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/attr_filter/accounting_response Mon Jul 20 09:46:41 2015 : Debug: # Instantiating module "files" from file /usr/local/etc/raddb/mods-enabled/files Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/authorize Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users5 Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users6 Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users7 Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users8 Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users_pppoe Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users_ppp Mon Jul 20 09:46:41 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/Users/users_pppoa Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:17 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Remote-Id =' to 'Agent-Remote-Id ==' Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Circuit-Id =' to 'Agent-Circuit-Id ==' Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:35 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:47 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:66 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:90 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Remote-Id =' to 'Agent-Remote-Id ==' Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Circuit-Id =' to 'Agent-Circuit-Id ==' Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:116 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Remote-Id =' to 'Agent-Remote-Id ==' Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Circuit-Id =' to 'Agent-Circuit-Id ==' Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:133 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:152 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:176 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Remote-Id =' to 'Agent-Remote-Id ==' Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Circuit-Id =' to 'Agent-Circuit-Id ==' Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:201 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:218 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:16 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:42 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:61 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:87 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:107 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:119 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:130 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:149 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:159 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:169 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:17 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:42 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:65 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:85 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:104 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:127 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:146 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:160 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:171 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:17 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:37 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:56 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:76 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:94 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:12 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:26 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:39 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:52 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:65 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:79 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:92 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:105 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:118 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:132 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:148 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:11 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Remote-Id =' to 'Agent-Remote-Id ==' Mon Jul 20 09:46:41 2015 : Debug: Changing 'Agent-Circuit-Id =' to 'Agent-Circuit-Id ==' Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:24 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:38 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:52 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:67 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:83 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:96 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:12 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:41 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:26 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:41 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:57 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:72 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:87 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:100 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:115 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:193 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:200 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: [/usr/local/etc/raddb/mods-config/files/authorize]:206 Cistron compatibility checks for entry DEFAULT ... Mon Jul 20 09:46:42 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/accounting Mon Jul 20 09:46:42 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/files/pre-proxy Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "reject" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "fail" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "ok" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "handled" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "invalid" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "userlock" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "notfound" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "noop" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "updated" from file /usr/local/etc/raddb/mods-enabled/always Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "mschap" from file /usr/local/etc/raddb/mods-enabled/mschap Mon Jul 20 09:46:42 2015 : Debug: rlm_mschap (mschap): using internal authentication Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "logintime" from file /usr/local/etc/raddb/mods-enabled/logintime Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "auth_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:42 2015 : Debug: rlm_detail (auth_log): 'User-Password' suppressed, will not appear in detail output Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "reply_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "pre_proxy_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "post_proxy_log" from file /usr/local/etc/raddb/mods-enabled/detail.log Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "etc_passwd" from file /usr/local/etc/raddb/mods-enabled/passwd Mon Jul 20 09:46:42 2015 : Debug: rlm_passwd: nfields: 3 keyfield 0(User-Name) listable: no Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "expiration" from file /usr/local/etc/raddb/mods-enabled/expiration Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "linelog" from file /usr/local/etc/raddb/mods-enabled/linelog Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "log_accounting" from file /usr/local/etc/raddb/mods-enabled/linelog Mon Jul 20 09:46:42 2015 : Debug: # Instantiating module "preprocess" from file /usr/local/etc/raddb/mods-enabled/preprocess Mon Jul 20 09:46:42 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/preprocess/huntgroups Mon Jul 20 09:46:42 2015 : Debug: reading pairlist file /usr/local/etc/raddb/mods-config/preprocess/hints Mon Jul 20 09:46:42 2015 : Debug: } # modules Mon Jul 20 09:46:42 2015 : Debug: radiusd: #### Loading Virtual Servers #### Mon Jul 20 09:46:42 2015 : Debug: server { # from file /usr/local/etc/raddb/radiusd.conf Mon Jul 20 09:46:42 2015 : Debug: } # server Mon Jul 20 09:46:42 2015 : Debug: server default { # from file /usr/local/etc/raddb/sites-enabled/default Mon Jul 20 09:46:42 2015 : Debug: # Loading authenticate {...} Mon Jul 20 09:46:42 2015 : Debug: digest Mon Jul 20 09:46:42 2015 : Debug: eap Mon Jul 20 09:46:42 2015 : Debug: # Loading authorize {...} Mon Jul 20 09:46:42 2015 : Debug: policy filter_username { Mon Jul 20 09:46:42 2015 : Debug: if (!&User-Name) { Mon Jul 20 09:46:42 2015 : Debug: noop Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: if (&User-Name =~ / /) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message += 'Rejected: Username contains whitespace' Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: reject Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: if (&User-Name =~ /@.*@/) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message += 'Rejected: Multiple @ in username' Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: reject Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: if (&User-Name =~ /\.\./) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message += 'Rejected: Username contains ..s' Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: reject Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: if (&User-Name =~ /@/ && !&User-Name =~ /@(.+)\.(.+)$/) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message += 'Rejected: Realm does not have at least one dot separator' Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: reject Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: if (&User-Name =~ /\.$/) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message += 'Rejected: Realm ends with a dot' Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: reject Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: if (&User-Name =~ /@\./) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message += 'Rejected: Realm begins with a dot' Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: reject Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: preprocess Mon Jul 20 09:46:42 2015 : Debug: chap Mon Jul 20 09:46:42 2015 : Debug: mschap Mon Jul 20 09:46:42 2015 : Debug: digest Mon Jul 20 09:46:42 2015 : Debug: suffix Mon Jul 20 09:46:42 2015 : Debug: eap Mon Jul 20 09:46:42 2015 : Debug: files Mon Jul 20 09:46:42 2015 : Warning: Ignoring "sql" (see raddb/mods-available/README.rst) Mon Jul 20 09:46:42 2015 : Warning: Ignoring "ldap" (see raddb/mods-available/README.rst) Mon Jul 20 09:46:42 2015 : Debug: expiration Mon Jul 20 09:46:42 2015 : Debug: logintime Mon Jul 20 09:46:42 2015 : Debug: pap Mon Jul 20 09:46:42 2015 : Debug: # Loading preacct {...} Mon Jul 20 09:46:42 2015 : Debug: preprocess Mon Jul 20 09:46:42 2015 : Debug: policy acct_unique { Mon Jul 20 09:46:42 2015 : Debug: if ("%{string:Class}" =~ /ai:([0-9a-f]{32})/) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &Acct-Unique-Session-Id := "%{md5:%{1},%{Acct-Session-ID}}" Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: else { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &Acct-Unique-Session-Id := "%{md5:%{User-Name},%{Acct-Session-ID},%{%{NAS-IPv6-Address}:-%{NAS-IP-Address}},%{NAS-Identifier},%{NAS-Port-ID},%{NAS-Port}}" Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: suffix Mon Jul 20 09:46:42 2015 : Debug: files Mon Jul 20 09:46:42 2015 : Debug: # Loading accounting {...} Mon Jul 20 09:46:42 2015 : Debug: detail Mon Jul 20 09:46:42 2015 : Debug: unix Mon Jul 20 09:46:42 2015 : Debug: exec Mon Jul 20 09:46:42 2015 : Debug: attr_filter.accounting_response Mon Jul 20 09:46:42 2015 : Debug: # Loading post-proxy {...} Mon Jul 20 09:46:42 2015 : Debug: eap Mon Jul 20 09:46:42 2015 : Debug: # Loading post-auth {...} Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply[*] += &session-state[*] Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: exec Mon Jul 20 09:46:42 2015 : Debug: policy remove_reply_message_if_eap { Mon Jul 20 09:46:42 2015 : Debug: if (&reply:EAP-Message && &reply:Reply-Message) { Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &reply:Reply-Message !* ANY Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: else { Mon Jul 20 09:46:42 2015 : Debug: noop Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: } # server default Mon Jul 20 09:46:42 2015 : Debug: server inner-tunnel { # from file /usr/local/etc/raddb/sites-enabled/inner-tunnel Mon Jul 20 09:46:42 2015 : Debug: # Loading authenticate {...} Mon Jul 20 09:46:42 2015 : Debug: eap Mon Jul 20 09:46:42 2015 : Debug: # Loading authorize {...} Mon Jul 20 09:46:42 2015 : Debug: chap Mon Jul 20 09:46:42 2015 : Debug: mschap Mon Jul 20 09:46:42 2015 : Debug: suffix Mon Jul 20 09:46:42 2015 : Debug: update { Mon Jul 20 09:46:42 2015 : Debug: &control:Proxy-To-Realm := LOCAL Mon Jul 20 09:46:42 2015 : Debug: } Mon Jul 20 09:46:42 2015 : Debug: eap Mon Jul 20 09:46:42 2015 : Debug: files Mon Jul 20 09:46:42 2015 : Debug: expiration Mon Jul 20 09:46:42 2015 : Debug: logintime Mon Jul 20 09:46:42 2015 : Debug: pap Mon Jul 20 09:46:42 2015 : Debug: # Loading session {...} Mon Jul 20 09:46:42 2015 : Debug: radutmp Mon Jul 20 09:46:42 2015 : Debug: # Loading post-proxy {...} Mon Jul 20 09:46:42 2015 : Debug: eap Mon Jul 20 09:46:42 2015 : Debug: # Loading post-auth {...} Mon Jul 20 09:46:42 2015 : Debug: } # server inner-tunnel Mon Jul 20 09:46:42 2015 : Debug: radiusd: #### Opening IP addresses and Ports #### Mon Jul 20 09:46:42 2015 : Debug: Listening on auth address 50.50.1.1 port 1812 Mon Jul 20 09:46:42 2015 : Debug: Listening on acct address 50.50.1.1 port 1813 Mon Jul 20 09:46:42 2015 : Debug: Opening new proxy socket 'proxy address 50.50.1.1 port 0' Mon Jul 20 09:46:42 2015 : Debug: Listening on proxy address 50.50.1.1 port 40465 Mon Jul 20 09:46:42 2015 : Info: Ready to process requests Mon Jul 20 09:48:00 2015 : Debug: (0) Received Access-Request Id 94 from 50.50.1.2:1812 to 50.50.1.1:1812 length 119 Mon Jul 20 09:48:00 2015 : Debug: (0) User-Name = "00:19:95:20:00:02" Mon Jul 20 09:48:00 2015 : Debug: (0) User-Password = "xxxx" Mon Jul 20 09:48:00 2015 : Debug: (0) NAS-Identifier = "S" Mon Jul 20 09:48:00 2015 : Debug: (0) NAS-Port = 16842817 Mon Jul 20 09:48:00 2015 : Debug: (0) NAS-Port-Type = Async Mon Jul 20 09:48:00 2015 : Debug: (0) session-state: No State attribute Mon Jul 20 09:48:00 2015 : Debug: (0) Empty authorize section. Using default return values. Mon Jul 20 09:48:00 2015 : ERROR: (0) No Auth-Type found: rejecting the user via Post-Auth-Type = Reject Mon Jul 20 09:48:00 2015 : Debug: (0) Failed to authenticate the user Mon Jul 20 09:48:00 2015 : Debug: (0) Using Post-Auth-Type Reject Mon Jul 20 09:48:00 2015 : Debug: (0) Post-Auth-Type sub-section not found. Ignoring. Mon Jul 20 09:48:00 2015 : Debug: (0) Delaying response for 1.000000 seconds Mon Jul 20 09:48:00 2015 : Debug: Waking up in 0.3 seconds. Mon Jul 20 09:48:01 2015 : Debug: Waking up in 0.6 seconds. Mon Jul 20 09:48:01 2015 : Debug: (0) <delay>: Sending delayed response Mon Jul 20 09:48:01 2015 : Debug: (0) <delay>: Sent Access-Reject Id 94 from 50.50.1.1:1812 to 50.50.1.2:1812 length 20 Mon Jul 20 09:48:01 2015 : Debug: Waking up in 3.9 seconds. Mon Jul 20 09:48:05 2015 : Debug: (0) <delay>: Cleaning up request packet ID 94 with timestamp +78 Mon Jul 20 09:48:05 2015 : Info: Ready to process requests Thanks -------------------------------------------- On Fri, 7/24/15, Alan DeKok <aland@deployingradius.com> wrote: Subject: Re: Empty authorize section. Using default return values. error in 3.0.9 To: "Ums" <ums_17@yahoo.com>, "FreeRadius users mailing list" <freeradius-users@lists.freeradius.org> Date: Friday, July 24, 2015, 3:35 AM On Jul 23, 2015, at 10:57 PM, Ums via Freeradius-Users <freeradius-users@lists.freeradius.org> wrote:

I had added the output

  There's nothing attached.   The only way you get that message is if you edited the default configuration, and broke it.   Don't do that.  The default configuration works.   Alan DeKok.