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

Ums ums_17 at yahoo.com
Wed Jul 29 08:23:36 CEST 2015


I have not edited anything , just added users records thats all and my client 

The output was in the message thread

But here it is again



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





Mon Jul 20 09:48:00 2015 : Debug: (0) Received Access-Request Id 94 from 50.50.1.2:1812 to 50.50.1.1:1812 length 119 
Mon Jul 20 09:48:00 2015 : Debug: (0)   User-Name = "00:19:95:20:00:02" 
Mon Jul 20 09:48:00 2015 : Debug: (0)   User-Password = "xxxx" 
Mon Jul 20 09:48:00 2015 : Debug: (0)   NAS-Identifier = "S" 
Mon Jul 20 09:48:00 2015 : Debug: (0)   NAS-Port = 16842817 
Mon Jul 20 09:48:00 2015 : Debug: (0)   NAS-Port-Type = Async 
Mon Jul 20 09:48:00 2015 : Debug: (0) session-state: No State attribute 
Mon Jul 20 09:48:00 2015 : Debug: (0) Empty authorize section.  Using default return values. 
Mon Jul 20 09:48:00 2015 : ERROR: (0) No Auth-Type found: rejecting the user via Post-Auth-Type = Reject 
Mon Jul 20 09:48:00 2015 : Debug: (0) Failed to authenticate the user 
Mon Jul 20 09:48:00 2015 : Debug: (0) Using Post-Auth-Type Reject 
Mon Jul 20 09:48:00 2015 : Debug: (0) Post-Auth-Type sub-section not found.  Ignoring. 
Mon Jul 20 09:48:00 2015 : Debug: (0) Delaying response for 1.000000 seconds 
Mon Jul 20 09:48:00 2015 : Debug: Waking up in 0.3 seconds. 
Mon Jul 20 09:48:01 2015 : Debug: Waking up in 0.6 seconds. 
Mon Jul 20 09:48:01 2015 : Debug: (0) <delay>: Sending delayed response 
Mon Jul 20 09:48:01 2015 : Debug: (0) <delay>: Sent Access-Reject Id 94 from 50.50.1.1:1812 to 50.50.1.2:1812 length 20 
Mon Jul 20 09:48:01 2015 : Debug: Waking up in 3.9 seconds. 
Mon Jul 20 09:48:05 2015 : Debug: (0) <delay>: Cleaning up request packet ID 94 with timestamp +78 
Mon Jul 20 09:48:05 2015 : Info: Ready to process requests 



Thanks


--------------------------------------------
On Fri, 7/24/15, Alan DeKok <aland at deployingradius.com> wrote:

 Subject: Re: Empty authorize section. Using default return values. error in 3.0.9
 To: "Ums" <ums_17 at yahoo.com>, "FreeRadius users mailing list" <freeradius-users at lists.freeradius.org>
 Date: Friday, July 24, 2015, 3:35 AM
 
 On Jul 23, 2015, at 10:57
 PM, Ums via Freeradius-Users <freeradius-users at lists.freeradius.org>
 wrote:
 > I had added the output 
 
   There's nothing
 attached.
 
   The only way
 you get that message is if you edited the default
 configuration, and broke it.
 
   Don't do that.  The default
 configuration works.
 
  
 Alan DeKok.
 



More information about the Freeradius-Users mailing list