I think this output is more complete and useful. Thank you one more
time.
servicos2:~# freeradius -X
FreeRADIUS Version 2.0.4, for host x86_64-pc-linux-gnu, built on Sep 7
2008 at 17:42:33
Copyright (C) 1999-2008 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.
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 configuration file /etc/freeradius/snmp.conf
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/inner-tunnel
including configuration file /etc/freeradius/sites-enabled/default
including dictionary file /etc/freeradius/dictionary
main {
prefix = "/usr"
localstatedir = "/var"
logdir = "/var/log/freeradius"
libdir = "/usr/lib/freeradius"
radacctdir = "/var/log/freeradius/radacct"
hostname_lookups = no
max_request_time = 30
cleanup_delay = 5
max_requests = 1024
allow_core_dumps = no
pidfile = "/var/run/freeradius/freeradius.pid"
user = "freerad"
group = "freerad"
checkrad = "/usr/sbin/checkrad"
debug_level = 0
proxy_requests = yes
security {
max_attributes = 200
reject_delay = 1
status_server = yes
}
}
client localhost {
ipaddr = 127.0.0.1
require_message_authenticator = no
secret = "testing123"
nastype = "other"
}
client 200.133.192.89 {
require_message_authenticator = no
secret = "teste123"
shortname = "servicos2"
}
client Calling-Station-Id {
require_message_authenticator = no
secret = "teste123"
shortname = "PC-Wagner"
}
client NAS-IP-Address {
require_message_authenticator = no
secret = "teste123"
shortname = "cisco6500"
nastype = "cisco"
}
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 = "testing123"
response_window = 20
max_outstanding = 65536
zombie_period = 40
status_check = "status-server"
ping_check = "none"
ping_interval = 30
check_interval = 30
num_answers_to_alive = 3
num_pings_to_alive = 3
revive_interval = 120
status_check_timeout = 4
}
home_server_pool my_auth_failover {
type = fail-over
home_server = localhost
}
realm example.com {
auth_pool = my_auth_failover
}
realm LOCAL {
}
realm NULL {
authhost = LOCAL
accthost = LOCAL
}
radiusd: #### Instantiating modules ####
instantiate {
Module: Linked to module rlm_exec
Module: Instantiating exec
exec {
wait = yes
input_pairs = "request"
shell_escape = yes
}
Module: Linked to module rlm_expr
Module: Instantiating expr
Module: Linked to module rlm_expiration
Module: Instantiating expiration
expiration {
reply-message = "Password Has Expired "
}
Module: Linked to module rlm_logintime
Module: Instantiating logintime
logintime {
reply-message = "You are calling outside your allowed timespan
"
minimum-timeout = 60
}
}
radiusd: #### Loading Virtual Servers ####
server inner-tunnel {
modules {
Module: Checking authenticate {...} for more modules to load
Module: Linked to module rlm_pap
Module: Instantiating pap
pap {
encryption_scheme = "auto"
auto_header = no
}
Module: Linked to module rlm_chap
Module: Instantiating chap
Module: Linked to module rlm_mschap
Module: Instantiating mschap
mschap {
use_mppe = yes
require_encryption = no
require_strong = no
with_ntdomain_hack = no
}
Module: Linked to module rlm_unix
Module: Instantiating unix
unix {
radwtmp = "/var/log/freeradius/radwtmp"
}
Module: Linked to module rlm_eap
Module: Instantiating eap
eap {
default_eap_type = "md5"
timer_expire = 60
ignore_unknown_eap_types = no
cisco_accounting_username_bug = no
}
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"
}
rlm_eap: Ignoring EAP-Type/tls because we do not have OpenSSL support.
rlm_eap: Ignoring EAP-Type/ttls because we do not have OpenSSL support.
rlm_eap: Ignoring EAP-Type/peap because we do not have OpenSSL support.
Module: Linked to sub-module rlm_eap_mschapv2
Module: Instantiating eap-mschapv2
mschapv2 {
with_ntdomain_hack = no
}
Module: Checking authorize {...} for more modules to load
Module: Linked to module rlm_realm
Module: Instantiating suffix
realm suffix {
format = "suffix"
delimiter = "@"
ignore_default = no
ignore_null = no
}
Module: Linked to module rlm_files
Module: Instantiating files
files {
usersfile = "/etc/freeradius/users"
acctusersfile = "/etc/freeradius/acct_users"
preproxy_usersfile = "/etc/freeradius/preproxy_users"
compat = "no"
}
Module: Checking session {...} for more modules to load
Module: Linked to module rlm_radutmp
Module: Instantiating radutmp
radutmp {
filename = "/var/log/freeradius/radutmp"
username = "%{User-Name}"
case_sensitive = yes
check_with_nas = yes
perm = 384
callerid = yes
}
Module: Checking post-proxy {...} for more modules to load
Module: Checking post-auth {...} for more modules to load
Module: Linked to module rlm_attr_filter
Module: Instantiating attr_filter.access_reject
attr_filter attr_filter.access_reject {
attrsfile = "/etc/freeradius/attrs.access_reject"
key = "%{User-Name}"
}
}
}
server {
modules {
Module: Checking authenticate {...} for more modules to load
Module: Checking authorize {...} for more modules to load
Module: Linked to module rlm_preprocess
Module: Instantiating 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_sql
Module: Instantiating sql
sql {
driver = "rlm_sql_mysql"
server = "localhost"
port = ""
login = "user_mysql"
password = "pass_user_mysql"
radius_db = "radius"
read_groups = yes
sqltrace = no
sqltracefile = "/var/log/freeradius/sqltrace.sql"
readclients = no
deletestalesessions = yes
num_sql_socks = 5
sql_user_name = "%{User-Name}"
default_user_profile = ""
nas_query = "SELECT id, nasname, shortname, type, secret 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 = 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 = 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 manu@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 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 detail
detail {
detailfile =
"/var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d"
header = "%t"
detailperm = 384
dirperm = 493
locking = no
log_packet_header = no
}
Module: Instantiating attr_filter.accounting_response
attr_filter attr_filter.accounting_response {
attrsfile = "/etc/freeradius/attrs.accounting_response"
key = "%{User-Name}"
}
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
}
}
radiusd: #### Opening IP addresses and Ports ####
listen {
type = "auth"
ipaddr = *
port = 0
}
listen {
type = "acct"
ipaddr = *
port = 0
}
main {
snmp = no
smux_password = ""
snmp_write_access = no
}
Listening on authentication address * port 1812
Listening on accounting address * port 1813
Listening on proxy address * port 1814
Ready to process requests.
rad_recv: Access-Request packet from host NAS-IP-Address port 21645,
id=124, length=82
NAS-IP-Address = NAS-IP-Address
NAS-Port = 1
NAS-Port-Type = Virtual
User-Name = "User-Name"
Calling-Station-Id = "Calling-Station-Id"
User-Password = "User-Password"
+- entering group authorize
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
rlm_realm: No '@' in User-Name = "User-Name", looking up realm NULL
rlm_realm: Found realm "NULL"
rlm_realm: Adding Stripped-User-Name = "User-Name"
rlm_realm: Adding Realm = "NULL"
rlm_realm: Authentication realm is LOCAL.
++[suffix] returns noop
rlm_eap: No EAP-Message, not doing EAP
++[eap] returns noop
++[files] returns noop
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
rlm_sql (sql): Reserving sql socket id: 4
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 = 'User-Name'
ORDER BY id
rlm_sql (sql): User found in radcheck table
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 = 'User-Name'
ORDER BY id
expand: SELECT groupname FROM radusergroup
WHERE username =
'%{SQL-User-Name}' ORDER BY priority -> SELECT
groupname FROM radusergroup
WHERE username = 'User-Name' ORDER BY priority
expand: SELECT id, groupname, attribute, Value,
op FROM radgroupcheck
WHERE groupname = '%{Sql-Group}' ORDER BY id ->
SELECT id, groupname, attribute,
Value, op FROM radgroupcheck WHERE groupname =
'pop-sp' ORDER BY
id
rlm_sql (sql): User found in group pop-sp
expand: SELECT id, groupname, attribute, value,
op FROM radgroupreply
WHERE groupname = '%{Sql-Group}' ORDER BY id ->
SELECT id, groupname, attribute,
value, op FROM radgroupreply WHERE groupname =
'pop-sp' ORDER BY
id
rlm_sql (sql): Released sql socket id: 4
++[sql] returns ok
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns updated
rad_check_password: Found Auth-Type
auth: type "PAP"
+- entering group PAP
rlm_pap: login attempt with password "User-Password"
rlm_pap: Using CRYPT encryption.
rlm_pap: User authenticated successfully
++[pap] returns ok
Login OK: [User-Name/User-Password] (from client cisco6500 port 1 cli
Calling-Station-Id)
+- entering group post-auth
rlm_sql (sql): Processing sql_postauth
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
expand: %{User-Password} -> User-Password
expand: INSERT INTO radpostauth
(username, pass, reply, authdate)
VALUES (
'%{User-Name}',
'%{%{User-Password}:-%{Chap-Password}}',
'%{reply:Packet-Type}', '%S') ->
INSERT INTO radpostauth (username, pass,
reply, authdate)
VALUES (
'User-Name', 'User-Password',
'Access-Accept', '2009-11-11 12:11:56')
rlm_sql (sql) in sql_postauth: query is INSERT INTO
radpostauth (username,
pass, reply, authdate) VALUES
( 'User-Name',
'User-Password',
'Access-Accept', '2009-11-11
12:11:56')
rlm_sql (sql): Reserving sql socket id: 3
rlm_sql (sql): Released sql socket id: 3
++[sql] returns ok
++[exec] returns noop
Sending Access-Accept of id 124 to NAS-IP-Address port 21645
Framed-Compression := Van-Jacobson-TCP-IP
Framed-Protocol := PPP
Service-Type := Login-User
Framed-MTU := 1500
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host NAS-IP-Address port 21645,
id=124, length=82
Sending duplicate reply to client cisco6500 port 21645 - ID: 124
Sending Access-Accept of id 124 to NAS-IP-Address port 21645
Cleaning up request 0 ID 124 with timestamp +16
Ready to process requests.
rad_recv: Access-Request packet from host NAS-IP-Address port 21645,
id=124, length=82
NAS-IP-Address = NAS-IP-Address
NAS-Port = 1
NAS-Port-Type = Virtual
User-Name = "User-Name"
Calling-Station-Id = "Calling-Station-Id"
User-Password = "User-Password"
+- entering group authorize
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
rlm_realm: No '@' in User-Name = "User-Name", looking up realm NULL
rlm_realm: Found realm "NULL"
rlm_realm: Adding Stripped-User-Name = "User-Name"
rlm_realm: Adding Realm = "NULL"
rlm_realm: Authentication realm is LOCAL.
++[suffix] returns noop
rlm_eap: No EAP-Message, not doing EAP
++[eap] returns noop
++[files] returns noop
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
rlm_sql (sql): Reserving sql socket id: 2
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 = 'User-Name'
ORDER BY id
rlm_sql (sql): User found in radcheck table
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 = 'User-Name'
ORDER BY id
expand: SELECT groupname FROM radusergroup
WHERE username =
'%{SQL-User-Name}' ORDER BY priority -> SELECT
groupname FROM radusergroup
WHERE username = 'User-Name' ORDER BY priority
expand: SELECT id, groupname, attribute, Value,
op FROM radgroupcheck
WHERE groupname = '%{Sql-Group}' ORDER BY id ->
SELECT id, groupname, attribute,
Value, op FROM radgroupcheck WHERE groupname =
'pop-sp' ORDER BY
id
rlm_sql (sql): User found in group pop-sp
expand: SELECT id, groupname, attribute, value,
op FROM radgroupreply
WHERE groupname = '%{Sql-Group}' ORDER BY id ->
SELECT id, groupname, attribute,
value, op FROM radgroupreply WHERE groupname =
'pop-sp' ORDER BY
id
rlm_sql (sql): Released sql socket id: 2
++[sql] returns ok
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns updated
rad_check_password: Found Auth-Type
auth: type "PAP"
+- entering group PAP
rlm_pap: login attempt with password "User-Password"
rlm_pap: Using CRYPT encryption.
rlm_pap: User authenticated successfully
++[pap] returns ok
Login OK: [User-Name/User-Password] (from client cisco6500 port 1 cli
Calling-Station-Id)
+- entering group post-auth
rlm_sql (sql): Processing sql_postauth
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
expand: %{User-Password} -> User-Password
expand: INSERT INTO radpostauth
(username, pass, reply, authdate)
VALUES (
'%{User-Name}',
'%{%{User-Password}:-%{Chap-Password}}',
'%{reply:Packet-Type}', '%S') ->
INSERT INTO radpostauth (username, pass,
reply, authdate)
VALUES (
'User-Name', 'User-Password',
'Access-Accept', '2009-11-11 12:12:07')
rlm_sql (sql) in sql_postauth: query is INSERT INTO
radpostauth (username,
pass, reply, authdate) VALUES
( 'User-Name',
'User-Password',
'Access-Accept', '2009-11-11
12:12:07')
rlm_sql (sql): Reserving sql socket id: 1
rlm_sql (sql): Released sql socket id: 1
++[sql] returns ok
++[exec] returns noop
Sending Access-Accept of id 124 to NAS-IP-Address port 21645
Framed-Compression := Van-Jacobson-TCP-IP
Framed-Protocol := PPP
Service-Type := Login-User
Framed-MTU := 1500
Finished request 1.
Going to the next request
Waking up in 4.9 seconds.
Cleaning up request 1 ID 124 with timestamp +27
Ready to process requests.
rad_recv: Access-Request packet from host NAS-IP-Address port 21645,
id=124, length=82
NAS-IP-Address = NAS-IP-Address
NAS-Port = 1
NAS-Port-Type = Virtual
User-Name = "User-Name"
Calling-Station-Id = "Calling-Station-Id"
User-Password = "User-Password"
+- entering group authorize
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
rlm_realm: No '@' in User-Name = "User-Name", looking up realm NULL
rlm_realm: Found realm "NULL"
rlm_realm: Adding Stripped-User-Name = "User-Name"
rlm_realm: Adding Realm = "NULL"
rlm_realm: Authentication realm is LOCAL.
++[suffix] returns noop
rlm_eap: No EAP-Message, not doing EAP
++[eap] returns noop
++[files] returns noop
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
rlm_sql (sql): Reserving sql socket id: 0
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 = 'User-Name'
ORDER BY id
rlm_sql (sql): User found in radcheck table
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 = 'User-Name'
ORDER BY id
expand: SELECT groupname FROM radusergroup
WHERE username =
'%{SQL-User-Name}' ORDER BY priority -> SELECT
groupname FROM radusergroup
WHERE username = 'User-Name' ORDER BY priority
expand: SELECT id, groupname, attribute, Value,
op FROM radgroupcheck
WHERE groupname = '%{Sql-Group}' ORDER BY id ->
SELECT id, groupname, attribute,
Value, op FROM radgroupcheck WHERE groupname =
'pop-sp' ORDER BY
id
rlm_sql (sql): User found in group pop-sp
expand: SELECT id, groupname, attribute, value,
op FROM radgroupreply
WHERE groupname = '%{Sql-Group}' ORDER BY id ->
SELECT id, groupname, attribute,
value, op FROM radgroupreply WHERE groupname =
'pop-sp' ORDER BY
id
rlm_sql (sql): Released sql socket id: 0
++[sql] returns ok
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns updated
rad_check_password: Found Auth-Type
auth: type "PAP"
+- entering group PAP
rlm_pap: login attempt with password "User-Password"
rlm_pap: Using CRYPT encryption.
rlm_pap: User authenticated successfully
++[pap] returns ok
Login OK: [User-Name/User-Password] (from client cisco6500 port 1 cli
Calling-Station-Id)
+- entering group post-auth
rlm_sql (sql): Processing sql_postauth
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
expand: %{User-Password} -> User-Password
expand: INSERT INTO radpostauth
(username, pass, reply, authdate)
VALUES (
'%{User-Name}',
'%{%{User-Password}:-%{Chap-Password}}',
'%{reply:Packet-Type}', '%S') ->
INSERT INTO radpostauth (username, pass,
reply, authdate)
VALUES (
'User-Name', 'User-Password',
'Access-Accept', '2009-11-11 12:12:12')
rlm_sql (sql) in sql_postauth: query is INSERT INTO
radpostauth (username,
pass, reply, authdate) VALUES
( 'User-Name',
'User-Password',
'Access-Accept', '2009-11-11
12:12:12')
rlm_sql (sql): Reserving sql socket id: 4
rlm_sql (sql): Released sql socket id: 4
++[sql] returns ok
++[exec] returns noop
Sending Access-Accept of id 124 to NAS-IP-Address port 21645
Framed-Compression := Van-Jacobson-TCP-IP
Framed-Protocol := PPP
Service-Type := Login-User
Framed-MTU := 1500
Finished request 2.
Going to the next request
Waking up in 4.9 seconds.
Cleaning up request 2 ID 124 with timestamp +32
Ready to process requests.
-------- Mensagem original --------
Hi, guys.
Please, could someone read this output from freeradius' debugging mode to help me? Thanks in advance.
(I just omitted some informations such as IP, User-Password etc)
My scenario is:
- Server: Debian GNU/Linux lenny x86_64 kernel 2.6.26-2-amd64
- Freeradius 2.0.4
- MySQL 5.0.51a
- Calling Station: Windows XP Professional 32 bits SP3
- Software client: SSH Secure Shell 3.2.9
- NAS client: Cisco6500 Catalyst - IOS versão 12.2(17r)S4
Going to the next request
Waking up in 4.9 seconds.
Cleaning up request 2 ID 121 with timestamp +17
Ready to process requests.
rad_recv: Access-Request packet from host NAS-IP-Address port 21645,
id=121, length=82
NAS-IP-Address = NAS-IP-Address
NAS-Port = 1
NAS-Port-Type = Virtual
User-Name = "User-Name"
Calling-Station-Id = "Calling-Station-Id"
User-Password = "User-Password"
+- entering group authorize
++[preprocess] returns ok
++[chap] returns noop
++[mschap] returns noop
rlm_realm: No '@' in User-Name = "User-Name", looking up realm NULL
rlm_realm: Found realm "NULL"
rlm_realm: Adding Stripped-User-Name = "User-Name"
rlm_realm: Adding Realm = "NULL"
rlm_realm: Authentication realm is LOCAL.
++[suffix] returns noop
rlm_eap: No EAP-Message, not doing EAP
++[eap] returns noop
++[files] returns noop
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
rlm_sql (sql): Reserving sql socket id: 3
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 = 'User-Name' ORDER BY id
rlm_sql (sql): User found in radcheck table
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 = 'User-Name' ORDER BY id
expand: SELECT groupname FROM radusergroup
WHERE username = '%{SQL-User-Name}' ORDER BY priority ->
SELECT groupname FROM radusergroup WHERE username =
'User-Name' ORDER BY priority
expand: SELECT id, groupname, attribute, Value,
op FROM radgroupcheck WHERE groupname =
'%{Sql-Group}' ORDER BY id -> SELECT id, groupname,
attribute, Value, op FROM radgroupcheck
WHERE groupname = 'pop-sp' ORDER BY id
rlm_sql (sql): User found in group pop-sp
expand: SELECT id, groupname, attribute, value,
op FROM radgroupreply WHERE groupname =
'%{Sql-Group}' ORDER BY id -> SELECT id, groupname,
attribute, value, op FROM radgroupreply
WHERE groupname = 'pop-sp' ORDER BY id
rlm_sql (sql): Released sql socket id: 3
++[sql] returns ok
++[expiration] returns noop
++[logintime] returns noop
++[pap] returns updated
rad_check_password: Found Auth-Type
auth: type "PAP"
+- entering group PAP
rlm_pap: login attempt with password "User-Password"
rlm_pap: Using CRYPT encryption.
rlm_pap: User authenticated successfully
++[pap] returns ok
Login OK: [User-Name/User-Password] (from client cisco6500 port 1 cli
Calling-Station-Id)
+- entering group post-auth
rlm_sql (sql): Processing sql_postauth
expand: %{User-Name} -> User-Name
rlm_sql (sql): sql_set_user escaped user --> 'User-Name'
expand: %{User-Password} -> User-Password
expand: INSERT INTO radpostauth
(username, pass, reply, authdate) VALUES
( '%{User-Name}',
'%{%{User-Password}:-%{Chap-Password}}',
'%{reply:Packet-Type}', '%S') -> INSERT INTO
radpostauth (username, pass, reply,
authdate) VALUES (
'User-Name',
'User-Password', 'Access-Accept', '2009-11-11
11:33:27')
rlm_sql (sql) in sql_postauth: query is INSERT INTO
radpostauth (username, pass, reply,
authdate) VALUES (
'User-Name',
'User-Password', 'Access-Accept', '2009-11-11
11:33:27')
rlm_sql (sql): Reserving sql socket id: 2
rlm_sql (sql): Released sql socket id: 2
++[sql] returns ok
++[exec] returns noop
Sending Access-Accept of id 121 to NAS-IP-Address port 21645
Framed-Compression := Van-Jacobson-TCP-IP
Framed-Protocol := PPP
Service-Type := Login-User
Framed-MTU := 1500
Finished request 3.
Going to the next request
Waking up in 4.9 seconds.
Cleaning up request 3 ID 121 with timestamp +23
Ready to process requests.
--
Wagner Pereira
PoP-SP/RNP - Ponto de Presença da RNP em São Paulo
CCE/USP - Centro de Computação Eletrônica da Universidade de São Paulo
http://www.pop-sp.rnp.br
(11) 3091-8902
--
Wagner Pereira
PoP-SP/RNP - Ponto de Presença da RNP em São Paulo
CCE/USP - Centro de Computação Eletrônica da Universidade de São Paulo
http://www.pop-sp.rnp.br
(11) 3091-8902