freeradius 2 certificate compatibility issue with ubuntu 14.04

Dustin S dsoodak at yahoo.com
Sat Apr 30 01:54:53 CEST 2016



radtest bobsql h3llo 192.168.0.166 100 t3sting123 
and
radtest -t mschap bobsql h3llo 192.168.0.166 100 t3sting123both work fine from my ubuntu desktop and 
radtest -t mschap bobsql h3llo 127.0.0.1:18120 0 t3sting123
works fine from the server (notes in file "inner-tunnel" say that this should mean that peap will work). However, 
radtest -t eap-md5 bobsql h3llo 192.168.0.166 100 t3sting123does not work from my ubuntu desktop or the ubuntu server in which freeradius is running (used same command string except with 127.0.0.1 as IP address)

"freeradius -X" output says to look at
http://wiki.freeradius.org/guide/Certificate-Compatibility
which describes the symptoms of my issue but only shows suggestions for what to do if your client is a Windows machine.

Unfortunately, I haven't messed with secure certificates explicitly so don't know how to troubleshoot them. Strangely enough, eap worked fine with the partly-functional mutant hybrid freeradius v2/3 that I ended up with when I tried to install the unofficial freeradius v3 release for Ubuntu.

Dustin

p.s.: using v2 since v3 isn't supported on Ubuntu yet. After a full week of trying both the unofficial release and attempting to compile it myself, I realized that I don't know anywhere near enough about freeradius to debug it properly.


"radtest" output:

root at gremlin:/etc/freeradius# radtest -t eap-md5  bobsql h3llo 127.0.0.1 100 t3sting123 
Sending Access-Request packet to host 127.0.0.1 port 1812, id=249, length=0 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 192.168.0.166 
NAS-Port = 100 
Message-Authenticator = 0x00 
EAP-Code = Response 
EAP-Type-Identity = "bobsql" 
EAP-Message = 0x02f8000b01626f6273716c 
Received Access-Challenge packet from host 127.0.0.1 port 1812, id=249, length=64 
EAP-Message = 0x01f900061920 
Message-Authenticator = 0x67456e4b517c4e986b3d0c7f23d589a1 
State = 0x141de28714e4fbb2053fa9d69b9894c2 
EAP-Id = 249 
EAP-Code = Request 
EAP-Type-TTLS = 0x20 
root at gremlin:/etc/freeradius#


"freeradius -X" output:


root at gremlin:/etc/freeradius# freeradius -X 
FreeRADIUS Version 2.1.12, for host x86_64-pc-linux-gnu, built on Aug 26 2015 at 14:47:03 
Copyright (C) 1999-2009 The FreeRADIUS server project and contributors. 
There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A 
PARTICULAR PURPOSE. 
You may redistribute copies of FreeRADIUS under the terms of the 
GNU General Public License v2. 
Starting - reading configuration files ... 
including configuration file /etc/freeradius/radiusd.conf 
including configuration file /etc/freeradius/proxy.conf 
including configuration file /etc/freeradius/clients.conf 
including files in directory /etc/freeradius/modules/ 
including configuration file /etc/freeradius/modules/realm 
including configuration file /etc/freeradius/modules/sql_log 
including configuration file /etc/freeradius/modules/counter 
including configuration file /etc/freeradius/modules/ntlm_auth 
including configuration file /etc/freeradius/modules/dynamic_clients 
including configuration file /etc/freeradius/modules/sqlcounter_expire_on_login 
including configuration file /etc/freeradius/modules/wimax 
including configuration file /etc/freeradius/modules/detail 
including configuration file /etc/freeradius/modules/mac2ip 
including configuration file /etc/freeradius/modules/unix 
including configuration file /etc/freeradius/modules/mschap 
including configuration file /etc/freeradius/modules/soh 
including configuration file /etc/freeradius/modules/ldap 
including configuration file /etc/freeradius/modules/attr_rewrite 
including configuration file /etc/freeradius/modules/smbpasswd 
including configuration file /etc/freeradius/modules/krb5 
including configuration file /etc/freeradius/modules/sradutmp 
including configuration file /etc/freeradius/modules/mac2vlan 
including configuration file /etc/freeradius/modules/exec 
including configuration file /etc/freeradius/modules/cui 
including configuration file /etc/freeradius/modules/digest 
including configuration file /etc/freeradius/modules/echo 
including configuration file /etc/freeradius/modules/radutmp 
including configuration file /etc/freeradius/modules/preprocess 
including configuration file /etc/freeradius/modules/linelog 
including configuration file /etc/freeradius/modules/mschap.new 
including configuration file /etc/freeradius/modules/ippool 
including configuration file /etc/freeradius/modules/policy 
including configuration file /etc/freeradius/modules/detail.example.com 
including configuration file /etc/freeradius/modules/detail.log 
including configuration file /etc/freeradius/modules/passwd 
including configuration file /etc/freeradius/modules/always 
including configuration file /etc/freeradius/modules/rediswho 
including configuration file /etc/freeradius/modules/acct_unique 
including configuration file /etc/freeradius/modules/etc_group 
including configuration file /etc/freeradius/modules/redis 
including configuration file /etc/freeradius/modules/opendirectory 
including configuration file /etc/freeradius/modules/expiration 
including configuration file /etc/freeradius/modules/mschap.bak 
including configuration file /etc/freeradius/modules/smsotp 
including configuration file /etc/freeradius/modules/logintime 
including configuration file /etc/freeradius/modules/perl 
including configuration file /etc/freeradius/modules/replicate 
including configuration file /etc/freeradius/modules/chap 
including configuration file /etc/freeradius/modules/attr_filter 
including configuration file /etc/freeradius/modules/pam 
including configuration file /etc/freeradius/modules/otp 
including configuration file /etc/freeradius/modules/expr 
including configuration file /etc/freeradius/modules/inner-eap 
including configuration file /etc/freeradius/modules/checkval 
including configuration file /etc/freeradius/modules/pap 
including configuration file /etc/freeradius/modules/files 
including configuration file /etc/freeradius/eap.conf 
including configuration file /etc/freeradius/sql.conf 
including configuration file /etc/freeradius/sql/mysql/dialup.conf 
including configuration file /etc/freeradius/policy.conf 
including files in directory /etc/freeradius/sites-enabled/ 
including configuration file /etc/freeradius/sites-enabled/default 
including configuration file /etc/freeradius/sites-enabled/inner-tunnel 
main { 
user = "freerad" 
group = "freerad" 
allow_core_dumps = no 
} 
including dictionary file /etc/freeradius/dictionary 
main { 
name = "freeradius" 
prefix = "/usr" 
localstatedir = "/var" 
sbindir = "/usr/sbin" 
logdir = "/var/log/freeradius" 
run_dir = "/var/run/freeradius" 
libdir = "/usr/lib/freeradius" 
radacctdir = "/var/log/freeradius/radacct" 
hostname_lookups = no 
max_request_time = 30 
cleanup_delay = 5 
max_requests = 1024 
pidfile = "/var/run/freeradius/freeradius.pid" 
checkrad = "/usr/sbin/checkrad" 
debug_level = 0 
proxy_requests = yes 
log { 
stripped_names = no 
auth = no 
auth_badpass = no 
auth_goodpass = no 
} 
security { 
max_attributes = 200 
reject_delay = 1 
status_server = yes 
} 
} 
radiusd: #### Loading Realms and Home Servers #### 
proxy server { 
retry_delay = 5 
retry_count = 3 
default_fallback = no 
dead_time = 120 
wake_all_if_all_dead = no 
} 
home_server localhost { 
ipaddr = 127.0.0.1 
port = 1812 
type = "auth" 
secret = "t3sting123" 
response_window = 20 
max_outstanding = 65536 
require_message_authenticator = yes 
zombie_period = 40 
status_check = "status-server" 
ping_interval = 30 
check_interval = 30 
num_answers_to_alive = 3 
num_pings_to_alive = 3 
revive_interval = 120 
status_check_timeout = 4 
coa { 
irt = 2 
mrt = 16 
mrc = 5 
mrd = 30 
} 
} 
home_server_pool my_auth_failover { 
type = fail-over 
home_server = localhost 
} 
realm example.com { 
auth_pool = my_auth_failover 
} 
realm LOCAL { 
} 
radiusd: #### Loading Clients #### 
client 192.168.0.99 { 
require_message_authenticator = no 
secret = "t3sting123" 
shortname = "OfficeAP" 
nastype = "other" 
} 
client 192.168.0.103 { 
require_message_authenticator = no 
secret = "t3sting123" 
shortname = "OfficeUbiquitiAP" 
nastype = "other" 
} 
client 192.168.0.102 { 
require_message_authenticator = no 
secret = "t3sting123" 
shortname = "DustinUbuntu" 
nastype = "other" 
} 
client localhost { 
ipaddr = 127.0.0.1 
require_message_authenticator = no 
secret = "t3sting123" 
nastype = "other" 
} 
radiusd: #### Instantiating modules #### 
instantiate { 
Module: Linked to module rlm_exec 
Module: Instantiating module "exec" from file /etc/freeradius/modules/exec 
exec { 
wait = no 
input_pairs = "request" 
shell_escape = yes 
} 
Module: Linked to module rlm_expr 
Module: Instantiating module "expr" from file /etc/freeradius/modules/expr 
Module: Linked to module rlm_expiration 
Module: Instantiating module "expiration" from file /etc/freeradius/modules/expiration 
expiration { 
reply-message = "Password Has Expired  " 
} 
Module: Linked to module rlm_logintime 
Module: Instantiating module "logintime" from file /etc/freeradius/modules/logintime 
logintime { 
reply-message = "You are calling outside your allowed timespan  " 
minimum-timeout = 60 
} 
} 
radiusd: #### Loading Virtual Servers #### 
server { # from file /etc/freeradius/radiusd.conf 
modules { 
Module: Creating Auth-Type = digest 
Module: Creating Post-Auth-Type = REJECT 
Module: Checking authenticate {...} for more modules to load 
Module: Linked to module rlm_pap 
Module: Instantiating module "pap" from file /etc/freeradius/modules/pap 
pap { 
encryption_scheme = "auto" 
auto_header = no 
} 
Module: Linked to module rlm_chap 
Module: Instantiating module "chap" from file /etc/freeradius/modules/chap 
Module: Linked to module rlm_mschap 
Module: Instantiating module "mschap" from file /etc/freeradius/modules/mschap 
mschap { 
use_mppe = yes 
require_encryption = no 
require_strong = no 
with_ntdomain_hack = no 
allow_retry = yes 
} 
Module: Linked to module rlm_digest 
Module: Instantiating module "digest" from file /etc/freeradius/modules/digest 
Module: Linked to module rlm_unix 
Module: Instantiating module "unix" from file /etc/freeradius/modules/unix 
unix { 
radwtmp = "/var/log/freeradius/radwtmp" 
} 
Module: Linked to module rlm_eap 
Module: Instantiating module "eap" from file /etc/freeradius/eap.conf 
eap { 
default_eap_type = "peap" 
timer_expire = 60 
ignore_unknown_eap_types = no 
cisco_accounting_username_bug = no 
max_sessions = 4096 
} 
Module: Linked to sub-module rlm_eap_md5 
Module: Instantiating eap-md5 
Module: Linked to sub-module rlm_eap_leap 
Module: Instantiating eap-leap 
Module: Linked to sub-module rlm_eap_gtc 
Module: Instantiating eap-gtc 
gtc { 
challenge = "Password: " 
auth_type = "PAP" 
} 
Module: Linked to sub-module rlm_eap_tls 
Module: Instantiating eap-tls 
tls { 
rsa_key_exchange = no 
dh_key_exchange = yes 
rsa_key_length = 512 
dh_key_length = 512 
verify_depth = 0 
CA_path = "/etc/freeradius/certs" 
pem_file_type = yes 
private_key_file = "/etc/freeradius/certs/server.key" 
certificate_file = "/etc/freeradius/certs/server.pem" 
CA_file = "/etc/freeradius/certs/ca.pem" 
private_key_password = "whatever" 
dh_file = "/etc/freeradius/certs/dh" 
random_file = "/dev/urandom" 
fragment_size = 1024 
include_length = yes 
check_crl = no 
cipher_list = "DEFAULT" 
make_cert_command = "/etc/freeradius/certs/bootstrap" 
ecdh_curve = "prime256v1" 
cache { 
enable = no 
lifetime = 24 
max_entries = 255 
} 
verify { 
} 
ocsp { 
enable = no 
override_cert_url = yes 
url = "http://127.0.0.1/ocsp/" 
} 
} 
Module: Linked to sub-module rlm_eap_ttls 
Module: Instantiating eap-ttls 
ttls { 
default_eap_type = "md5" 
copy_request_to_tunnel = no 
use_tunneled_reply = no 
virtual_server = "inner-tunnel" 
include_length = yes 
} 
Module: Linked to sub-module rlm_eap_peap 
Module: Instantiating eap-peap 
peap { 
default_eap_type = "mschapv2" 
copy_request_to_tunnel = no 
use_tunneled_reply = no 
proxy_tunneled_request_as_eap = yes 
virtual_server = "inner-tunnel" 
soh = no 
} 
Module: Linked to sub-module rlm_eap_mschapv2 
Module: Instantiating eap-mschapv2 
mschapv2 { 
with_ntdomain_hack = no 
send_error = no 
} 
Module: Checking authorize {...} for more modules to load 
Module: Linked to module rlm_preprocess 
Module: Instantiating module "preprocess" from file /etc/freeradius/modules/preprocess 
preprocess { 
huntgroups = "/etc/freeradius/huntgroups" 
hints = "/etc/freeradius/hints" 
with_ascend_hack = no 
ascend_channels_per_line = 23 
with_ntdomain_hack = no 
with_specialix_jetstream_hack = no 
with_cisco_vsa_hack = no 
with_alvarion_vsa_hack = no 
} 
Module: Linked to module rlm_realm 
Module: Instantiating module "suffix" from file /etc/freeradius/modules/realm 
realm suffix { 
format = "suffix" 
delimiter = "@" 
ignore_default = no 
ignore_null = no 
} 
Module: Linked to module rlm_files 
Module: Instantiating module "files" from file /etc/freeradius/modules/files 
files { 
usersfile = "/etc/freeradius/users" 
acctusersfile = "/etc/freeradius/acct_users" 
preproxy_usersfile = "/etc/freeradius/preproxy_users" 
compat = "no" 
} 
Module: Linked to module rlm_sql 
Module: Instantiating module "sql" from file /etc/freeradius/sql.conf 
sql { 
driver = "rlm_sql_mysql" 
server = "localhost" 
port = "" 
login = "radius" 
password = "radpass" 
radius_db = "radius" 
read_groups = yes 
sqltrace = no 
sqltracefile = "/var/log/freeradius/sqltrace.sql" 
readclients = no 
deletestalesessions = yes 
num_sql_socks = 5 
lifetime = 0 
max_queries = 0 
sql_user_name = "%{User-Name}" 
default_user_profile = "" 
nas_query = "SELECT id, nasname, shortname, type, secret, server FROM nas" 
authorize_check_query = "SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id" 
authorize_reply_query = "SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id" 
authorize_group_check_query = "SELECT id, groupname, attribute,           Value, op           FROM radgroupcheck           WHERE groupname = '%{Sql-Group}'           ORDER BY id" 
authorize_group_reply_query = "SELECT id, groupname, attribute,           value, op           FROM radgroupreply           WHERE groupname = '%{Sql-Group}'           ORDER BY id" 
accounting_onoff_query = "          UPDATE radacct           SET              acctstoptime       =  '%S',              acctsessiontime    =  unix_timestamp('%S') -                                    unix_timestamp(acctstarttime),              acctterminatecause =  '%{Acct-Terminate-Cause}',              acctstopdelay      =  %{%{Acct-Delay-Time}:-0}           WHERE acctstoptime IS NULL           AND nasipaddress      =  '%{NAS-IP-Address}'           AND acctstarttime     <= '%S'" 
accounting_update_query = "           UPDATE radacct           SET              framedipaddress = '%{Framed-IP-Address}',              acctsessiontime     = '%{Acct-Session-Time}',              acctinputoctets     = '%{%{Acct-Input-Gigawords}:-0}'  << 32 |                                    '%{%{Acct-Input-Octets}:-0}',              acctoutputoctets    = '%{%{Acct-Output-Gigawords}:-0}' << 32 |                                    '%{%{Acct-Output-Octets}:-0}'           WHERE acctsessionid = '%{Acct-Session-Id}'           AND username        = '%{SQL-User-Name}'           AND nasipaddress    = '%{NAS-IP-Address}'" 
accounting_update_query_alt = "           INSERT INTO radacct             (acctsessionid,    acctuniqueid,      username,              realm,            nasipaddress,      nasportid,              nasporttype,      acctstarttime,     acctsessiontime,              acctauthentic,    connectinfo_start, acctinputoctets,              acctoutputoctets, calledstationid,   callingstationid,              servicetype,      framedprotocol,    framedipaddress,              acctstartdelay,   xascendsessionsvrkey)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}',              DATE_SUB('%S',                       INTERVAL (%{%{Acct-Session-Time}:-0} +                                 %{%{Acct-Delay-Time}:-0}) SECOND),                       '%{Acct-Session-Time}',              '%{Acct-Authentic}', '',              '%{%{Acct-Input-Gigawords}:-0}' << 32 |              '%{%{Acct-Input-Octets}:-0}',              '%{%{Acct-Output-Gigawords}:-0}' << 32 |              '%{%{Acct-Output-Octets}:-0}',              '%{Called-Station-Id}', '%{Calling-Station-Id}',              '%{Service-Type}', '%{Framed-Protocol}',              '%{Framed-IP-Address}',              '0', '%{X-Ascend-Session-Svr-Key}')" 
accounting_start_query = "           INSERT INTO radacct             (acctsessionid,    acctuniqueid,     username,              realm,            nasipaddress,     nasportid,              nasporttype,      acctstarttime,    acctstoptime,              acctsessiontime,  acctauthentic,    connectinfo_start,              connectinfo_stop, acctinputoctets,  acctoutputoctets,              calledstationid,  callingstationid, acctterminatecause,              servicetype,      framedprotocol,   framedipaddress,              acctstartdelay,   acctstopdelay,    xascendsessionsvrkey)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}', '%S', NULL,              '0', '%{Acct-Authentic}', '%{Connect-Info}',              '', '0', '0',              '%{Called-Station-Id}', '%{Calling-Station-Id}', '',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '%{%{Acct-Delay-Time}:-0}', '0', '%{X-Ascend-Session-Svr-Key}')" 
accounting_start_query_alt = "           UPDATE radacct SET              acctstarttime     = '%S',              acctstartdelay    = '%{%{Acct-Delay-Time}:-0}',              connectinfo_start = '%{Connect-Info}'           WHERE acctsessionid  = '%{Acct-Session-Id}'           AND username         = '%{SQL-User-Name}'           AND nasipaddress     = '%{NAS-IP-Address}'" 
accounting_stop_query = "           UPDATE radacct SET              acctstoptime       = '%S',              acctsessiontime    = '%{Acct-Session-Time}',              acctinputoctets    = '%{%{Acct-Input-Gigawords}:-0}' << 32 |                                   '%{%{Acct-Input-Octets}:-0}',              acctoutputoctets   = '%{%{Acct-Output-Gigawords}:-0}' << 32 |                                   '%{%{Acct-Output-Octets}:-0}',              acctterminatecause = '%{Acct-Terminate-Cause}',              acctstopdelay      = '%{%{Acct-Delay-Time}:-0}',              connectinfo_stop   = '%{Connect-Info}'           WHERE acctsessionid   = '%{Acct-Session-Id}'           AND username          = '%{SQL-User-Name}'           AND nasipaddress      = '%{NAS-IP-Address}'" 
accounting_stop_query_alt = "           INSERT INTO radacct             (acctsessionid, acctuniqueid, username,              realm, nasipaddress, nasportid,              nasporttype, acctstarttime, acctstoptime,              acctsessiontime, acctauthentic, connectinfo_start,              connectinfo_stop, acctinputoctets, acctoutputoctets,              calledstationid, callingstationid, acctterminatecause,              servicetype, framedprotocol, framedipaddress,              acctstartdelay, acctstopdelay)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}',              DATE_SUB('%S',                  INTERVAL (%{%{Acct-Session-Time}:-0} +                  %{%{Acct-Delay-Time}:-0}) SECOND),              '%S', '%{Acct-Session-Time}', '%{Acct-Authentic}', '',              '%{Connect-Info}',              '%{%{Acct-Input-Gigawords}:-0}' << 32 |              '%{%{Acct-Input-Octets}:-0}',              '%{%{Acct-Output-Gigawords}:-0}' << 32 |              '%{%{Acct-Output-Octets}:-0}',              '%{Called-Station-Id}', '%{Calling-Station-Id}',              '%{Acct-Terminate-Cause}',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '0', '%{%{Acct-Delay-Time}:-0}')" 
group_membership_query = "SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority" 
connect_failure_retry_delay = 60 
simul_count_query = "" 
simul_verify_query = "SELECT radacctid, acctsessionid, username,                                nasipaddress, nasportid, framedipaddress,                                callingstationid, framedprotocol                                FROM radacct                                WHERE username = '%{SQL-User-Name}'                                AND acctstoptime IS NULL" 
postauth_query = "INSERT INTO radpostauth                           (username, pass, reply, authdate)                           VALUES (                           '%{User-Name}',                           '%{%{User-Password}:-%{Chap-Password}}',                           '%{reply:Packet-Type}', '%S')" 
safe-characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /" 
} 
rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked 
rlm_sql (sql): Attempting to connect to radius at localhost:/radius 
rlm_sql (sql): starting 0 
rlm_sql (sql): Attempting to connect rlm_sql_mysql #0 
rlm_sql_mysql: Starting connect to MySQL server for #0 
rlm_sql (sql): Connected new DB handle, #0 
rlm_sql (sql): starting 1 
rlm_sql (sql): Attempting to connect rlm_sql_mysql #1 
rlm_sql_mysql: Starting connect to MySQL server for #1 
rlm_sql (sql): Connected new DB handle, #1 
rlm_sql (sql): starting 2 
rlm_sql (sql): Attempting to connect rlm_sql_mysql #2 
rlm_sql_mysql: Starting connect to MySQL server for #2 
rlm_sql (sql): Connected new DB handle, #2 
rlm_sql (sql): starting 3 
rlm_sql (sql): Attempting to connect rlm_sql_mysql #3 
rlm_sql_mysql: Starting connect to MySQL server for #3 
rlm_sql (sql): Connected new DB handle, #3 
rlm_sql (sql): starting 4 
rlm_sql (sql): Attempting to connect rlm_sql_mysql #4 
rlm_sql_mysql: Starting connect to MySQL server for #4 
rlm_sql (sql): Connected new DB handle, #4 
Module: Checking preacct {...} for more modules to load 
Module: Linked to module rlm_acct_unique 
Module: Instantiating module "acct_unique" from file /etc/freeradius/modules/acct_unique 
acct_unique { 
key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port" 
} 
Module: Checking accounting {...} for more modules to load 
Module: Linked to module rlm_detail 
Module: Instantiating module "detail" from file /etc/freeradius/modules/detail 
detail { 
detailfile = "/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d" 
header = "%t" 
detailperm = 384 
dirperm = 493 
locking = no 
log_packet_header = no 
} 
Module: Linked to module rlm_radutmp 
Module: Instantiating module "radutmp" from file /etc/freeradius/modules/radutmp 
radutmp { 
filename = "/var/log/freeradius/radutmp" 
username = "%{User-Name}" 
case_sensitive = yes 
check_with_nas = yes 
perm = 384 
callerid = yes 
} 
Module: Linked to module rlm_attr_filter 
Module: Instantiating module "attr_filter.accounting_response" from file /etc/freeradius/modules/attr_filter 
attr_filter attr_filter.accounting_response { 
attrsfile = "/etc/freeradius/attrs.accounting_response" 
key = "%{User-Name}" 
relaxed = no 
} 
Module: Checking session {...} for more modules to load 
Module: Checking post-proxy {...} for more modules to load 
Module: Checking post-auth {...} for more modules to load 
Module: Instantiating module "attr_filter.access_reject" from file /etc/freeradius/modules/attr_filter 
attr_filter attr_filter.access_reject { 
attrsfile = "/etc/freeradius/attrs.access_reject" 
key = "%{User-Name}" 
relaxed = no 
} 
} # modules 
} # server 
server inner-tunnel { # from file /etc/freeradius/sites-enabled/inner-tunnel 
modules { 
Module: Checking authenticate {...} for more modules to load 
Module: Checking authorize {...} for more modules to load 
Module: Checking session {...} for more modules to load 
Module: Checking post-proxy {...} for more modules to load 
Module: Checking post-auth {...} for more modules to load 
} # modules 
} # server 
radiusd: #### Opening IP addresses and Ports #### 
listen { 
type = "auth" 
ipaddr = * 
port = 0 
} 
listen { 
type = "acct" 
ipaddr = * 
port = 0 
} 
listen { 
type = "auth" 
ipaddr = 127.0.0.1 
port = 18120 
} 
... adding new socket proxy address * port 54028 
Listening on authentication address * port 1812 
Listening on accounting address * port 1813 
Listening on authentication address 127.0.0.1 port 18120 as server inner-tunnel 
Listening on proxy address * port 1814 
Ready to process requests. 
rad_recv: Access-Request packet from host 192.168.0.102 port 51972, id=22, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x63b41003de06fef4cdb10d9c674732c1 
EAP-Message = 0x024c000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 76 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 4 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 4 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 22 to 192.168.0.102 port 51972 
EAP-Message = 0x014d00061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0xc5d1b741c59cae74e5c335d132a13974 
Finished request 0. 
Going to the next request 
Waking up in 4.9 seconds. 
Cleaning up request 0 ID 22 with timestamp +19 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0xc5d1b741c59cae74 did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Ready to process requests. 
rad_recv: Access-Request packet from host 192.168.0.102 port 47914, id=228, length=76 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0xd09eb513c856865b83d9773becc09c8e 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] No EAP-Message, not doing EAP 
++[eap] returns noop 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 3 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 3 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
++[pap] returns updated 
Found Auth-Type = PAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group PAP {...} 
[pap] login attempt with password "h3llo" 
[pap] Using clear text password "h3llo" 
[pap] User authenticated successfully 
++[pap] returns ok 
# Executing section post-auth from file /etc/freeradius/sites-enabled/default 
+- entering group post-auth {...} 
++[exec] returns noop 
Sending Access-Accept of id 228 to 192.168.0.102 port 47914 
Finished request 1. 
Going to the next request 
Waking up in 4.9 seconds. 
Cleaning up request 1 ID 228 with timestamp +33 
Ready to process requests. 
rad_recv: Access-Request packet from host 192.168.0.102 port 45062, id=5, length=132 
User-Name = "bobsql" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x1b2d3bc48e1628fcb67a4aabec4c7603 
MS-CHAP-Challenge = 0x5431fdaef2ef481f 
MS-CHAP-Response = 0x0001000000000000000000000000000000000000000000000000e386da5486bad62e690e1aecc0dbe0efa9027ee1d3a642d1 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
[mschap] Found MS-CHAP attributes.  Setting 'Auth-Type  = mschap' 
++[mschap] returns ok 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] No EAP-Message, not doing EAP 
++[eap] returns noop 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 2 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 2 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = MSCHAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group MS-CHAP {...} 
[mschap] Told to do MS-CHAPv1 with NT-Password 
[mschap] adding MS-CHAPv1 MPPE keys 
++[mschap] returns ok 
# Executing section post-auth from file /etc/freeradius/sites-enabled/default 
+- entering group post-auth {...} 
++[exec] returns noop 
Sending Access-Accept of id 5 to 192.168.0.102 port 45062 
MS-CHAP-MPPE-Keys = 0x567e728a9a0f730b1e841a812034ebe1960d1c03a812a7920000000000000000 
MS-MPPE-Encryption-Policy = 0x00000001 
MS-MPPE-Encryption-Types = 0x00000006 
Finished request 2. 
Going to the next request 
Waking up in 4.9 seconds. 
rad_recv: Access-Request packet from host 192.168.0.102 port 40888, id=206, length=132 
User-Name = "bobsql" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x0292ae5c52b3c5905b43ae731beb7c63 
MS-CHAP-Challenge = 0x597fc32c1884f15d 
MS-CHAP-Response = 0x0001000000000000000000000000000000000000000000000000f480f2c91ecbb02affca1cd6e0aaf8530fea4f70431b300c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
[mschap] Found MS-CHAP attributes.  Setting 'Auth-Type  = mschap' 
++[mschap] returns ok 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] No EAP-Message, not doing EAP 
++[eap] returns noop 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 1 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 1 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = MSCHAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group MS-CHAP {...} 
[mschap] Told to do MS-CHAPv1 with NT-Password 
[mschap] adding MS-CHAPv1 MPPE keys 
++[mschap] returns ok 
# Executing section post-auth from file /etc/freeradius/sites-enabled/default 
+- entering group post-auth {...} 
++[exec] returns noop 
Sending Access-Accept of id 206 to 192.168.0.102 port 40888 
MS-CHAP-MPPE-Keys = 0x567e728a9a0f730b1e841a812034ebe1960d1c03a812a7920000000000000000 
MS-MPPE-Encryption-Policy = 0x00000001 
MS-MPPE-Encryption-Types = 0x00000006 
Finished request 3. 
Going to the next request 
Waking up in 2.7 seconds. 
rad_recv: Access-Request packet from host 192.168.0.102 port 35961, id=32, length=132 
User-Name = "bobsql" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x2d707df31b6b58f446440e937e530bca 
MS-CHAP-Challenge = 0x71541771cc7aa8b4 
MS-CHAP-Response = 0x000100000000000000000000000000000000000000000000000077613cdac309e699b0324e1318081226f5bb67816eb7765a 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
[mschap] Found MS-CHAP attributes.  Setting 'Auth-Type  = mschap' 
++[mschap] returns ok 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] No EAP-Message, not doing EAP 
++[eap] returns noop 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 0 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 0 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = MSCHAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group MS-CHAP {...} 
[mschap] Told to do MS-CHAPv1 with NT-Password 
[mschap] adding MS-CHAPv1 MPPE keys 
++[mschap] returns ok 
# Executing section post-auth from file /etc/freeradius/sites-enabled/default 
+- entering group post-auth {...} 
++[exec] returns noop 
Sending Access-Accept of id 32 to 192.168.0.102 port 35961 
MS-CHAP-MPPE-Keys = 0x567e728a9a0f730b1e841a812034ebe1960d1c03a812a7920000000000000000 
MS-MPPE-Encryption-Policy = 0x00000001 
MS-MPPE-Encryption-Types = 0x00000006 
Finished request 4. 
Going to the next request 
Waking up in 1.5 seconds. 
Cleaning up request 2 ID 5 with timestamp +51 
Waking up in 2.2 seconds. 
Cleaning up request 3 ID 206 with timestamp +54 
Waking up in 1.2 seconds. 
Cleaning up request 4 ID 32 with timestamp +55 
Ready to process requests. 
rad_recv: Access-Request packet from host 192.168.0.102 port 53710, id=147, length=132 
User-Name = "bobsql" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x037f49ae3b5ec235d4eaf2267a9b6e25 
MS-CHAP-Challenge = 0x5ad7026bacfbcb0c 
MS-CHAP-Response = 0x0001000000000000000000000000000000000000000000000000fd3865d282111e51a5d1e78a11224e705e16b4ab346fe1c3 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
[mschap] Found MS-CHAP attributes.  Setting 'Auth-Type  = mschap' 
++[mschap] returns ok 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] No EAP-Message, not doing EAP 
++[eap] returns noop 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 4 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 4 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = MSCHAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group MS-CHAP {...} 
[mschap] Told to do MS-CHAPv1 with NT-Password 
[mschap] adding MS-CHAPv1 MPPE keys 
++[mschap] returns ok 
# Executing section post-auth from file /etc/freeradius/sites-enabled/default 
+- entering group post-auth {...} 
++[exec] returns noop 
Sending Access-Accept of id 147 to 192.168.0.102 port 53710 
MS-CHAP-MPPE-Keys = 0x567e728a9a0f730b1e841a812034ebe1960d1c03a812a7920000000000000000 
MS-MPPE-Encryption-Policy = 0x00000001 
MS-MPPE-Encryption-Types = 0x00000006 
Finished request 5. 
Going to the next request 
Waking up in 4.9 seconds. 
rad_recv: Access-Request packet from host 192.168.0.102 port 55717, id=241, length=132 
User-Name = "bobsql" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0xa99ccc3a5cca5d0421ce40151860f354 
MS-CHAP-Challenge = 0x3ec6b2e188f8077e 
MS-CHAP-Response = 0x00010000000000000000000000000000000000000000000000008a8fc890c2cadcde9db7d78760239b1f592968d44a90cdfd 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
[mschap] Found MS-CHAP attributes.  Setting 'Auth-Type  = mschap' 
++[mschap] returns ok 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] No EAP-Message, not doing EAP 
++[eap] returns noop 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 3 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 3 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = MSCHAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group MS-CHAP {...} 
[mschap] Told to do MS-CHAPv1 with NT-Password 
[mschap] adding MS-CHAPv1 MPPE keys 
++[mschap] returns ok 
# Executing section post-auth from file /etc/freeradius/sites-enabled/default 
+- entering group post-auth {...} 
++[exec] returns noop 
Sending Access-Accept of id 241 to 192.168.0.102 port 55717 
MS-CHAP-MPPE-Keys = 0x567e728a9a0f730b1e841a812034ebe1960d1c03a812a7920000000000000000 
MS-MPPE-Encryption-Policy = 0x00000001 
MS-MPPE-Encryption-Types = 0x00000006 
Finished request 6. 
Going to the next request 
Waking up in 1.6 seconds. 
Cleaning up request 5 ID 147 with timestamp +79 
Waking up in 3.3 seconds. 
Cleaning up request 6 ID 241 with timestamp +83 
Ready to process requests. 
rad_recv: Access-Request packet from host 192.168.0.102 port 57932, id=206, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x03d3363df4078fcc0bbfd49d66c8a305 
EAP-Message = 0x0291000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 145 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 2 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 2 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 206 to 192.168.0.102 port 57932 
EAP-Message = 0x019200061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0x3449d6e934dbcf8a2066e164bff70373 
Finished request 7. 
Going to the next request 
Waking up in 4.9 seconds. 
rad_recv: Access-Request packet from host 192.168.0.102 port 53425, id=97, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x0a13ff3dd26d20da7de439ed156f8f1e 
EAP-Message = 0x029b000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 155 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 1 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 1 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 97 to 192.168.0.102 port 53425 
EAP-Message = 0x019c00061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0xbb63c299bbffdb53b656996c0040d033 
Finished request 8. 
Going to the next request 
Waking up in 2.9 seconds. 
Cleaning up request 7 ID 206 with timestamp +96 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0x3449d6e934dbcf8a did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Waking up in 2.0 seconds. 
rad_recv: Access-Request packet from host 192.168.0.102 port 52917, id=200, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 127.0.1.1 
NAS-Port = 100 
Message-Authenticator = 0x1b1dd77b91fd5119c952cba3c7b0789d 
EAP-Message = 0x02a5000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 165 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 0 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 0 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 200 to 192.168.0.102 port 52917 
EAP-Message = 0x01a600061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0xfcde2609fc783fe3cd6f633607ab2cb1 
Finished request 9. 
Going to the next request 
Waking up in 1.6 seconds. 
Cleaning up request 8 ID 97 with timestamp +98 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0xbb63c299bbffdb53 did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Waking up in 3.3 seconds. 
Cleaning up request 9 ID 200 with timestamp +101 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0xfcde2609fc783fe3 did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Ready to process requests. 
rad_recv: Access-Request packet from host 127.0.0.1 port 52521, id=229, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 192.168.0.166 
NAS-Port = 100 
Message-Authenticator = 0xd7caba718106a9d1e4802f69771d9a79 
EAP-Message = 0x02e4000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 228 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 4 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 4 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 229 to 127.0.0.1 port 52521 
EAP-Message = 0x01e500061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0xba25f065bac0e928512b36076da019ff 
Finished request 10. 
Going to the next request 
Waking up in 4.9 seconds. 
Cleaning up request 10 ID 229 with timestamp +129 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0xba25f065bac0e928 did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Ready to process requests. 
rad_recv: Access-Request packet from host 127.0.0.1 port 33835, id=239, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 192.168.0.166 
NAS-Port = 100 
Message-Authenticator = 0xa1e0465c6ce9d505a1d80a9e5a4652be 
EAP-Message = 0x02ee000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 238 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 3 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 3 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 239 to 127.0.0.1 port 33835 
EAP-Message = 0x01ef00061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0x3ef8b2793e17abd6ae69ec18fa4cfd0f 
Finished request 11. 
Going to the next request 
Waking up in 4.9 seconds. 
rad_recv: Access-Request packet from host 127.0.0.1 port 47780, id=249, length=89 
User-Name = "bobsql" 
User-Password = "h3llo" 
NAS-IP-Address = 192.168.0.166 
NAS-Port = 100 
Message-Authenticator = 0x522e550039140c1bb17ae9f549a2a18e 
EAP-Message = 0x02f8000b01626f6273716c 
# Executing section authorize from file /etc/freeradius/sites-enabled/default 
+- entering group authorize {...} 
++[preprocess] returns ok 
++[chap] returns noop 
++[mschap] returns noop 
++[digest] returns noop 
[suffix] No '@' in User-Name = "bobsql", looking up realm NULL 
[suffix] No such realm "NULL" 
++[suffix] returns noop 
[eap] EAP packet type response id 248 length 11 
[eap] No EAP Start, assuming it's an on-going EAP conversation 
++[eap] returns updated 
++[files] returns noop 
[sql]   expand: %{User-Name} -> bobsql 
[sql] sql_set_user escaped user --> 'bobsql' 
rlm_sql (sql): Reserving sql socket id: 2 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'bobsql'           ORDER BY id 
[sql] User found in radcheck table 
[sql]   expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'bobsql'           ORDER BY id 
[sql]   expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'bobsql'           ORDER BY priority 
rlm_sql (sql): Released sql socket id: 2 
++[sql] returns ok 
++[expiration] returns noop 
++[logintime] returns noop 
[pap] WARNING: Auth-Type already set.  Not setting to PAP 
++[pap] returns noop 
Found Auth-Type = EAP 
# Executing group from file /etc/freeradius/sites-enabled/default 
+- entering group authenticate {...} 
[eap] EAP Identity 
[eap] processing type tls 
[tls] Initiate 
[tls] Start returned 1 
++[eap] returns handled 
Sending Access-Challenge of id 249 to 127.0.0.1 port 47780 
EAP-Message = 0x01f900061920 
Message-Authenticator = 0x00000000000000000000000000000000 
State = 0x141de28714e4fbb2053fa9d69b9894c2 
Finished request 12. 
Going to the next request 
Waking up in 2.1 seconds. 
Cleaning up request 11 ID 239 with timestamp +141 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0x3ef8b2793e17abd6 did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Waking up in 2.8 seconds. 
Cleaning up request 12 ID 249 with timestamp +143 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
WARNING: !! EAP session for state 0x141de28714e4fbb2 did not finish! 
WARNING: !! Please read http://wiki.freeradius.org/Certificate_Compatibility 
WARNING: !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 
Ready to process requests.



More information about the Freeradius-Users mailing list