framed-compression error
Ufuk Eskici
ufukeskici at gmail.com
Wed Nov 6 08:10:34 CET 2013
debug is attached." Auth-Type := Local " is just set for test, auth fails
also without it.
2013/11/5 Alan DeKok <aland at deployingradius.com>
> Ufuk Eskici wrote:
> > Here is the table:
>
> I didn't ask for that.
>
> And you got it wrong. All of the documentation says DO NOT set
> "Auth-Type := Local".
>
> > pakcet output:
> >
> > Sending Access-Accept of id 254 to 78.169.249.8 port 1812
> > Framed-Protocol = PPP
> > Framed-Compression = Van-Jacobson-TCP-IP
> > Finished request 6.
>
> Which is entirely useless.
>
> I asked for the debug output. Not a tiny piece of it.
>
> Either post the entire debug output, or go away. You had this same
> issue when complaining you couldn't post messages to the list. I told
> you privately to follow instructions or be banned from the list. You
> think that doesn't apply to you.
>
> It does.
>
> Alan DeKok.
> -
> List info/subscribe/unsubscribe? See
> http://www.freeradius.org/list/users.html
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freeradius.org/pipermail/freeradius-users/attachments/20131106/1f13350d/attachment-0001.html>
-------------- next part --------------
FreeRADIUS Version 2.1.10, for host i686-pc-linux-gnu, built on Sep 24 2012 at 17:53:32
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/cui
including configuration file /etc/freeradius/modules/otp
including configuration file /etc/freeradius/modules/etc_group
including configuration file /etc/freeradius/modules/perl
including configuration file /etc/freeradius/modules/opendirectory
including configuration file /etc/freeradius/modules/mac2ip
including configuration file /etc/freeradius/modules/logintime
including configuration file /etc/freeradius/modules/counter
including configuration file /etc/freeradius/modules/files
including configuration file /etc/freeradius/modules/pam
including configuration file /etc/freeradius/modules/linelog
including configuration file /etc/freeradius/modules/detail.log
including configuration file /etc/freeradius/modules/always
including configuration file /etc/freeradius/modules/expr
including configuration file /etc/freeradius/modules/krb5
including configuration file /etc/freeradius/modules/ntlm_auth
including configuration file /etc/freeradius/modules/echo
including configuration file /etc/freeradius/modules/preprocess
including configuration file /etc/freeradius/modules/unix
including configuration file /etc/freeradius/modules/sqlcounter_expire_on_login
including configuration file /etc/freeradius/modules/acct_unique
including configuration file /etc/freeradius/modules/checkval
including configuration file /etc/freeradius/modules/passwd
including configuration file /etc/freeradius/modules/smbpasswd
including configuration file /etc/freeradius/modules/ippool
including configuration file /etc/freeradius/modules/wimax
including configuration file /etc/freeradius/modules/sql_log
including configuration file /etc/freeradius/modules/radutmp
including configuration file /etc/freeradius/modules/detail.example.com
including configuration file /etc/freeradius/modules/ldap
including configuration file /etc/freeradius/modules/inner-eap
including configuration file /etc/freeradius/modules/realm
including configuration file /etc/freeradius/modules/policy
including configuration file /etc/freeradius/modules/mac2vlan
including configuration file /etc/freeradius/modules/pap
including configuration file /etc/freeradius/modules/sradutmp
including configuration file /etc/freeradius/modules/digest
including configuration file /etc/freeradius/modules/mschap
including configuration file /etc/freeradius/modules/dynamic_clients
including configuration file /etc/freeradius/modules/exec
including configuration file /etc/freeradius/modules/smsotp
including configuration file /etc/freeradius/modules/attr_rewrite
including configuration file /etc/freeradius/modules/detail
including configuration file /etc/freeradius/modules/chap
including configuration file /etc/freeradius/modules/attr_filter
including configuration file /etc/freeradius/modules/expiration
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 {
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
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 = "testing123"
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
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 ####
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 inner-tunnel { # from file /etc/freeradius/sites-enabled/inner-tunnel
modules {
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
}
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 = "md5"
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"
cache {
enable = no
lifetime = 24
max_entries = 255
}
verify {
}
}
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"
}
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 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: Checking session {...} for more modules to load
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: 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 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}"
}
} # modules
} # server
server { # from file /etc/freeradius/radiusd.conf
modules {
Module: Checking authenticate {...} for more modules to load
Module: Linked to module rlm_digest
Module: Instantiating module "digest" from file /etc/freeradius/modules/digest
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_sql
Module: Instantiating module "sql" from file /etc/freeradius/sql.conf
sql {
driver = "rlm_sql_mysql"
server = "localhost"
port = ""
login = "freeradius"
password = "radius"
radius_db = "radius"
read_groups = yes
sqltrace = no
sqltracefile = "/var/log/freeradius/sqltrace.sql"
readclients = yes
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 freeradius 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
rlm_sql (sql): Processing generate_sql_clients
rlm_sql (sql) in generate_sql_clients: query is SELECT id, nasname, shortname, type, secret, server FROM nas
rlm_sql (sql): Reserving sql socket id: 4
rlm_sql (sql): Read entry nasname=78.169.249.7,shortname=radius,secret=password
rlm_sql (sql): Adding client 78.169.249.7 (radius, server=<none>) to clients list
rlm_sql (sql): Read entry nasname=78.169.249.8,shortname=radiuss,secret=password
rlm_sql (sql): Adding client 78.169.249.8 (radiuss, server=<none>) to clients list
rlm_sql (sql): Released sql socket id: 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/%{Client-IP-Address}/detail-%Y%m%d"
header = "%t"
detailperm = 384
dirperm = 493
locking = no
log_packet_header = no
}
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}"
}
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 = 1812
}
listen {
type = "acct"
ipaddr = *
port = 0
}
listen {
type = "auth"
ipaddr = 127.0.0.1
port = 18120
}
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 78.169.249.8 port 1812, id=251, length=315
User-Name = "ufuk at ttnet"
User-Password = "password11"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696558
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Session-Id = "FF10FFFF580000EE-5278AD60"
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9396"
LAC-Port = 411041792
# 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] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
[eap] No EAP-Message, not doing EAP
++[eap] returns noop
[files] users: Matched entry DEFAULT at line 172
++[files] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
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 = 'ufuk at ttnet' 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 = 'ufuk at ttnet' ORDER BY id
[sql] expand: SELECT groupname FROM radusergroup WHERE username = '%{SQL-User-Name}' ORDER BY priority -> SELECT groupname FROM radusergroup WHERE username = 'ufuk at ttnet' 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 = Local
WARNING: Please update your configuration, and remove 'Auth-Type = Local'
WARNING: Use the PAP or CHAP modules instead.
User-Password in the request is correct.
# Executing section post-auth from file /etc/freeradius/sites-enabled/default
+- entering group post-auth {...}
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{User-Password} -> password11
[sql] 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 ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:00')
rlm_sql (sql) in sql_postauth: query is INSERT INTO radpostauth (username, pass, reply, authdate) VALUES ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:00')
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 251 to 78.169.249.8 port 1812
Framed-Protocol = PPP
Framed-Compression = Van-Jacobson-TCP-IP
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 78.169.249.8 port 1812, id=236, length=581
User-Name = "ufuk at ttnet"
Acct-Status-Type = Stop
Acct-Session-Id = "FF10FFFF580000EE-5278AD60"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696558
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Authentic = RADIUS
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9396"
LAC-Port = 411041792
Acct-Session-Time = 0
Acct-Terminate-Cause = User-Error
Session-Error-Code = 24
Session-Error-Msg = "Authentication failure"
Acct-Input-Packets = 0
Acct-Output-Packets = 0
Acct-Input-Octets = 0
Acct-Output-Octets = 0
Acct-Input-Gigawords = 0
Acct-Output-Gigawords = 0
Acct-Input-Packets-64 = 0x0000000000000000
Acct-Output-Packets-64 = 0x0000000000000000
Acct-Input-Octets-64 = 0x0000000000000000
Acct-Output-Octets-64 = 0x0000000000000000
Acct-Mcast-In-Packets = 0
Acct-Mcast-Out-Packets = 0
Acct-Mcast-In-Octets = 0
Acct-Mcast-Out-Octets = 0
Acct-Mcast-In-Packets-64 = 0x0000000000000000
Acct-Mcast-Out-Packets-64 = 0x0000000000000000
Acct-Mcast-In-Octets-64 = 0x0000000000000000
Acct-Mcast-Out-Octets-64 = 0x0000000000000000
Event-Timestamp = "Nov 5 2013 10:33:37 EET"
# Executing section preacct from file /etc/freeradius/sites-enabled/default
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 2432696558,Client-IP-Address = 78.169.249.8,NAS-IP-Address = 78.169.249.8,Acct-Session-Id = "FF10FFFF580000EE-5278AD60",User-Name = "ufuk at ttnet"'
[acct_unique] Acct-Unique-Session-ID = "33f05d0bbd0ba733".
++[acct_unique] returns ok
[suffix] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
++[files] returns noop
# Executing section accounting from file /etc/freeradius/sites-enabled/default
+- entering group accounting {...}
[detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] expand: %t -> Tue Nov 5 10:34:00 2013
++[detail] returns ok
++[unix] returns ok
[radutmp] expand: /var/log/freeradius/radutmp -> /var/log/freeradius/radutmp
[radutmp] expand: %{User-Name} -> ufuk at ttnet
rlm_radutmp: Logout for NAS radiuss port 2432696558, but no Login record
++[radutmp] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{Acct-Input-Gigawords} -> 0
[sql] expand: %{Acct-Input-Octets} -> 0
[sql] expand: %{Acct-Output-Gigawords} -> 0
[sql] expand: %{Acct-Output-Octets} -> 0
[sql] expand: %{Acct-Delay-Time} ->
[sql] ... expanding second conditional
[sql] expand: 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}' -> UPDATE radacct SET acctstoptime = '2013-11-05 10:34:00', acctsessiontime = '0', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 |
rlm_sql (sql): Reserving sql socket id: 1
[sql] expand: stop packet with zero session length. [user '%{User-Name}', nas '%{NAS-IP-Address}'] -> stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
[sql] stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
rlm_sql (sql): Released sql socket id: 1
++[sql] returns noop
++[exec] returns noop
[attr_filter.accounting_response] expand: %{User-Name} -> ufuk at ttnet
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 236 to 78.169.249.8 port 1812
Finished request 1.
Cleaning up request 1 ID 236 with timestamp +6
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 78.169.249.8 port 1812, id=252, length=315
User-Name = "ufuk at ttnet"
User-Password = "password11"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696559
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Session-Id = "FF10FFFF580000EF-5278AD64"
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9397"
LAC-Port = 411041792
# 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] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
[eap] No EAP-Message, not doing EAP
++[eap] returns noop
[files] users: Matched entry DEFAULT at line 172
++[files] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
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 = 'ufuk at ttnet' 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 = 'ufuk at ttnet' ORDER BY id
[sql] expand: SELECT groupname FROM radusergroup WHERE username = '%{SQL-User-Name}' ORDER BY priority -> SELECT groupname FROM radusergroup WHERE username = 'ufuk at ttnet' 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 = Local
WARNING: Please update your configuration, and remove 'Auth-Type = Local'
WARNING: Use the PAP or CHAP modules instead.
User-Password in the request is correct.
# Executing section post-auth from file /etc/freeradius/sites-enabled/default
+- entering group post-auth {...}
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{User-Password} -> password11
[sql] 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 ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:03')
rlm_sql (sql) in sql_postauth: query is INSERT INTO radpostauth (username, pass, reply, authdate) VALUES ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:03')
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 252 to 78.169.249.8 port 1812
Framed-Protocol = PPP
Framed-Compression = Van-Jacobson-TCP-IP
Finished request 2.
Going to the next request
Waking up in 1.5 seconds.
rad_recv: Accounting-Request packet from host 78.169.249.8 port 1812, id=237, length=581
User-Name = "ufuk at ttnet"
Acct-Status-Type = Stop
Acct-Session-Id = "FF10FFFF580000EF-5278AD64"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696559
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Authentic = RADIUS
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9397"
LAC-Port = 411041792
Acct-Session-Time = 0
Acct-Terminate-Cause = User-Error
Session-Error-Code = 24
Session-Error-Msg = "Authentication failure"
Acct-Input-Packets = 0
Acct-Output-Packets = 0
Acct-Input-Octets = 0
Acct-Output-Octets = 0
Acct-Input-Gigawords = 0
Acct-Output-Gigawords = 0
Acct-Input-Packets-64 = 0x0000000000000000
Acct-Output-Packets-64 = 0x0000000000000000
Acct-Input-Octets-64 = 0x0000000000000000
Acct-Output-Octets-64 = 0x0000000000000000
Acct-Mcast-In-Packets = 0
Acct-Mcast-Out-Packets = 0
Acct-Mcast-In-Octets = 0
Acct-Mcast-Out-Octets = 0
Acct-Mcast-In-Packets-64 = 0x0000000000000000
Acct-Mcast-Out-Packets-64 = 0x0000000000000000
Acct-Mcast-In-Octets-64 = 0x0000000000000000
Acct-Mcast-Out-Octets-64 = 0x0000000000000000
Event-Timestamp = "Nov 5 2013 10:33:40 EET"
# Executing section preacct from file /etc/freeradius/sites-enabled/default
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 2432696559,Client-IP-Address = 78.169.249.8,NAS-IP-Address = 78.169.249.8,Acct-Session-Id = "FF10FFFF580000EF-5278AD64",User-Name = "ufuk at ttnet"'
[acct_unique] Acct-Unique-Session-ID = "c41b13c9c6769526".
++[acct_unique] returns ok
[suffix] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
++[files] returns noop
# Executing section accounting from file /etc/freeradius/sites-enabled/default
+- entering group accounting {...}
[detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] expand: %t -> Tue Nov 5 10:34:03 2013
++[detail] returns ok
++[unix] returns ok
[radutmp] expand: /var/log/freeradius/radutmp -> /var/log/freeradius/radutmp
[radutmp] expand: %{User-Name} -> ufuk at ttnet
rlm_radutmp: Logout for NAS radiuss port 2432696559, but no Login record
++[radutmp] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{Acct-Input-Gigawords} -> 0
[sql] expand: %{Acct-Input-Octets} -> 0
[sql] expand: %{Acct-Output-Gigawords} -> 0
[sql] expand: %{Acct-Output-Octets} -> 0
[sql] expand: %{Acct-Delay-Time} ->
[sql] ... expanding second conditional
[sql] expand: 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}' -> UPDATE radacct SET acctstoptime = '2013-11-05 10:34:03', acctsessiontime = '0', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 |
rlm_sql (sql): Reserving sql socket id: 3
[sql] expand: stop packet with zero session length. [user '%{User-Name}', nas '%{NAS-IP-Address}'] -> stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
[sql] stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
rlm_sql (sql): Released sql socket id: 3
++[sql] returns noop
++[exec] returns noop
[attr_filter.accounting_response] expand: %{User-Name} -> ufuk at ttnet
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 237 to 78.169.249.8 port 1812
Finished request 3.
Cleaning up request 3 ID 237 with timestamp +9
Going to the next request
Waking up in 1.5 seconds.
Cleaning up request 0 ID 251 with timestamp +6
Waking up in 3.4 seconds.
rad_recv: Access-Request packet from host 78.169.249.8 port 1812, id=253, length=315
User-Name = "ufuk at ttnet"
User-Password = "password11"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696560
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Session-Id = "FF10FFFF580000F0-5278AD67"
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9398"
LAC-Port = 411041792
# 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] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
[eap] No EAP-Message, not doing EAP
++[eap] returns noop
[files] users: Matched entry DEFAULT at line 172
++[files] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
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 = 'ufuk at ttnet' 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 = 'ufuk at ttnet' ORDER BY id
[sql] expand: SELECT groupname FROM radusergroup WHERE username = '%{SQL-User-Name}' ORDER BY priority -> SELECT groupname FROM radusergroup WHERE username = 'ufuk at ttnet' 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 = Local
WARNING: Please update your configuration, and remove 'Auth-Type = Local'
WARNING: Use the PAP or CHAP modules instead.
User-Password in the request is correct.
# Executing section post-auth from file /etc/freeradius/sites-enabled/default
+- entering group post-auth {...}
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{User-Password} -> password11
[sql] 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 ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:07')
rlm_sql (sql) in sql_postauth: query is INSERT INTO radpostauth (username, pass, reply, authdate) VALUES ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34: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 253 to 78.169.249.8 port 1812
Framed-Protocol = PPP
Framed-Compression = Van-Jacobson-TCP-IP
Finished request 4.
Going to the next request
Waking up in 1.5 seconds.
rad_recv: Accounting-Request packet from host 78.169.249.8 port 1812, id=238, length=581
User-Name = "ufuk at ttnet"
Acct-Status-Type = Stop
Acct-Session-Id = "FF10FFFF580000F0-5278AD67"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696560
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Authentic = RADIUS
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9398"
LAC-Port = 411041792
Acct-Session-Time = 0
Acct-Terminate-Cause = User-Error
Session-Error-Code = 24
Session-Error-Msg = "Authentication failure"
Acct-Input-Packets = 0
Acct-Output-Packets = 0
Acct-Input-Octets = 0
Acct-Output-Octets = 0
Acct-Input-Gigawords = 0
Acct-Output-Gigawords = 0
Acct-Input-Packets-64 = 0x0000000000000000
Acct-Output-Packets-64 = 0x0000000000000000
Acct-Input-Octets-64 = 0x0000000000000000
Acct-Output-Octets-64 = 0x0000000000000000
Acct-Mcast-In-Packets = 0
Acct-Mcast-Out-Packets = 0
Acct-Mcast-In-Octets = 0
Acct-Mcast-Out-Octets = 0
Acct-Mcast-In-Packets-64 = 0x0000000000000000
Acct-Mcast-Out-Packets-64 = 0x0000000000000000
Acct-Mcast-In-Octets-64 = 0x0000000000000000
Acct-Mcast-Out-Octets-64 = 0x0000000000000000
Event-Timestamp = "Nov 5 2013 10:33:44 EET"
# Executing section preacct from file /etc/freeradius/sites-enabled/default
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 2432696560,Client-IP-Address = 78.169.249.8,NAS-IP-Address = 78.169.249.8,Acct-Session-Id = "FF10FFFF580000F0-5278AD67",User-Name = "ufuk at ttnet"'
[acct_unique] Acct-Unique-Session-ID = "954ade8090b2c50c".
++[acct_unique] returns ok
[suffix] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
++[files] returns noop
# Executing section accounting from file /etc/freeradius/sites-enabled/default
+- entering group accounting {...}
[detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] expand: %t -> Tue Nov 5 10:34:07 2013
++[detail] returns ok
++[unix] returns ok
[radutmp] expand: /var/log/freeradius/radutmp -> /var/log/freeradius/radutmp
[radutmp] expand: %{User-Name} -> ufuk at ttnet
rlm_radutmp: Logout for NAS radiuss port 2432696560, but no Login record
++[radutmp] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{Acct-Input-Gigawords} -> 0
[sql] expand: %{Acct-Input-Octets} -> 0
[sql] expand: %{Acct-Output-Gigawords} -> 0
[sql] expand: %{Acct-Output-Octets} -> 0
[sql] expand: %{Acct-Delay-Time} ->
[sql] ... expanding second conditional
[sql] expand: 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}' -> UPDATE radacct SET acctstoptime = '2013-11-05 10:34:07', acctsessiontime = '0', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 |
rlm_sql (sql): Reserving sql socket id: 0
[sql] expand: stop packet with zero session length. [user '%{User-Name}', nas '%{NAS-IP-Address}'] -> stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
[sql] stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
rlm_sql (sql): Released sql socket id: 0
++[sql] returns noop
++[exec] returns noop
[attr_filter.accounting_response] expand: %{User-Name} -> ufuk at ttnet
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 238 to 78.169.249.8 port 1812
Finished request 5.
Cleaning up request 5 ID 238 with timestamp +13
Going to the next request
Waking up in 1.5 seconds.
Cleaning up request 2 ID 252 with timestamp +9
Waking up in 3.4 seconds.
rad_recv: Access-Request packet from host 78.169.249.8 port 1812, id=254, length=315
User-Name = "ufuk at ttnet"
User-Password = "password11"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696561
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Session-Id = "FF10FFFF580000F1-5278AD6B"
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9399"
LAC-Port = 411041792
# 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] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
[eap] No EAP-Message, not doing EAP
++[eap] returns noop
[files] users: Matched entry DEFAULT at line 172
++[files] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
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 = 'ufuk at ttnet' 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 = 'ufuk at ttnet' ORDER BY id
[sql] expand: SELECT groupname FROM radusergroup WHERE username = '%{SQL-User-Name}' ORDER BY priority -> SELECT groupname FROM radusergroup WHERE username = 'ufuk at ttnet' 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 = Local
WARNING: Please update your configuration, and remove 'Auth-Type = Local'
WARNING: Use the PAP or CHAP modules instead.
User-Password in the request is correct.
# Executing section post-auth from file /etc/freeradius/sites-enabled/default
+- entering group post-auth {...}
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{User-Password} -> password11
[sql] 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 ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:10')
rlm_sql (sql) in sql_postauth: query is INSERT INTO radpostauth (username, pass, reply, authdate) VALUES ( 'ufuk at ttnet', 'password11', 'Access-Accept', '2013-11-05 10:34:10')
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 254 to 78.169.249.8 port 1812
Framed-Protocol = PPP
Framed-Compression = Van-Jacobson-TCP-IP
Finished request 6.
Going to the next request
Waking up in 1.5 seconds.
rad_recv: Accounting-Request packet from host 78.169.249.8 port 1812, id=239, length=581
User-Name = "ufuk at ttnet"
Acct-Status-Type = Stop
Acct-Session-Id = "FF10FFFF580000F1-5278AD6B"
Service-Type = Framed-User
Framed-Protocol = PPP
NAS-Identifier = "SE1200"
NAS-IP-Address = 78.169.249.8
NAS-Port = 2432696561
NAS-Port-Type = Virtual
NAS-Port-Id = "0/17"
Medium-Type = DSL
Connect-Info = "1000000000/1000000000"
Calling-Station-Id = "SE800#3/1#1001:1"
Platform-Type = 5
OS-Version = "12.1.1.5"
Acct-Authentic = RADIUS
Tunnel-Type:0 = L2TP
Tunnel-Medium-Type:0 = IPv4
Tunnel-Server-Endpoint:0 = "10.10.0.1"
Tunnel-Client-Endpoint:0 = "10.0.0.1"
Tunnel-Server-Auth-Id:0 = "lns-1"
Tunnel-Client-Auth-Id:0 = "lac-1"
Tunnel-Max-Sessions = 65535
Tunnel-Max-Tunnels = 32767
Tunnel-Function = LNS-Only
Acct-Tunnel-Connection = "lac-1:28257:9399"
LAC-Port = 411041792
Acct-Session-Time = 0
Acct-Terminate-Cause = User-Error
Session-Error-Code = 24
Session-Error-Msg = "Authentication failure"
Acct-Input-Packets = 0
Acct-Output-Packets = 0
Acct-Input-Octets = 0
Acct-Output-Octets = 0
Acct-Input-Gigawords = 0
Acct-Output-Gigawords = 0
Acct-Input-Packets-64 = 0x0000000000000000
Acct-Output-Packets-64 = 0x0000000000000000
Acct-Input-Octets-64 = 0x0000000000000000
Acct-Output-Octets-64 = 0x0000000000000000
Acct-Mcast-In-Packets = 0
Acct-Mcast-Out-Packets = 0
Acct-Mcast-In-Octets = 0
Acct-Mcast-Out-Octets = 0
Acct-Mcast-In-Packets-64 = 0x0000000000000000
Acct-Mcast-Out-Packets-64 = 0x0000000000000000
Acct-Mcast-In-Octets-64 = 0x0000000000000000
Acct-Mcast-Out-Octets-64 = 0x0000000000000000
Event-Timestamp = "Nov 5 2013 10:33:47 EET"
# Executing section preacct from file /etc/freeradius/sites-enabled/default
+- entering group preacct {...}
++[preprocess] returns ok
[acct_unique] Hashing 'NAS-Port = 2432696561,Client-IP-Address = 78.169.249.8,NAS-IP-Address = 78.169.249.8,Acct-Session-Id = "FF10FFFF580000F1-5278AD6B",User-Name = "ufuk at ttnet"'
[acct_unique] Acct-Unique-Session-ID = "c2494efeec6feeb6".
++[acct_unique] returns ok
[suffix] Looking up realm "ttnet" for User-Name = "ufuk at ttnet"
[suffix] No such realm "ttnet"
++[suffix] returns noop
++[files] returns noop
# Executing section accounting from file /etc/freeradius/sites-enabled/default
+- entering group accounting {...}
[detail] expand: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/78.169.249.8/detail-20131105
[detail] expand: %t -> Tue Nov 5 10:34:10 2013
++[detail] returns ok
++[unix] returns ok
[radutmp] expand: /var/log/freeradius/radutmp -> /var/log/freeradius/radutmp
[radutmp] expand: %{User-Name} -> ufuk at ttnet
rlm_radutmp: Logout for NAS radiuss port 2432696561, but no Login record
++[radutmp] returns ok
[sql] expand: %{User-Name} -> ufuk at ttnet
[sql] sql_set_user escaped user --> 'ufuk at ttnet'
[sql] expand: %{Acct-Input-Gigawords} -> 0
[sql] expand: %{Acct-Input-Octets} -> 0
[sql] expand: %{Acct-Output-Gigawords} -> 0
[sql] expand: %{Acct-Output-Octets} -> 0
[sql] expand: %{Acct-Delay-Time} ->
[sql] ... expanding second conditional
[sql] expand: 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}' -> UPDATE radacct SET acctstoptime = '2013-11-05 10:34:10', acctsessiontime = '0', acctinputoctets = '0' << 32 | '0', acctoutputoctets = '0' << 32 |
rlm_sql (sql): Reserving sql socket id: 2
[sql] expand: stop packet with zero session length. [user '%{User-Name}', nas '%{NAS-IP-Address}'] -> stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
[sql] stop packet with zero session length. [user 'ufuk at ttnet', nas '78.169.249.8']
rlm_sql (sql): Released sql socket id: 2
++[sql] returns noop
++[exec] returns noop
[attr_filter.accounting_response] expand: %{User-Name} -> ufuk at ttnet
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 239 to 78.169.249.8 port 1812
Finished request 7.
Cleaning up request 7 ID 239 with timestamp +16
Going to the next request
Waking up in 1.5 seconds.
Cleaning up request 4 ID 253 with timestamp +13
Waking up in 3.4 seconds.
More information about the Freeradius-Users
mailing list