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

[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 Uma -------------------------------------------- On Mon, 7/20/15, A.L.M.Buxey@lboro.ac.uk <A.L.M.Buxey@lboro.ac.uk> 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: Monday, July 20, 2015, 12:26 AM Hi,

I checked on the forum and saw various threads dealing with default config deleted etc

I have just installed this radius server and not deleted or over written any config , just added a few lines in the 2 files above

i have also given a cat of the sites-enabled/default

dont. please provide output of 'radiusd -X' from the startup of the server through to the reject of the client.  thats all you have to do. alan