Freeradius2 with mysql function on openwrt.
bruno d'ambrosio
brunodambrosio2011 at hotmail.it
Mon Jun 8 18:20:52 CEST 2015
Hi Mate
Thanks. For Help.
Openwrt not have the module "acct_unique" look at the end of debug, please
This is the debug:
Mon Jun 8 18:00:15 2015 : Info: radiusd: FreeRADIUS Version 2.2.7, for
host mips-openwrt-linux-gnu, built on Jun 8 2015 at 15:48:14
Mon Jun 8 18:00:15 2015 : Debug: Server was built with:
Mon Jun 8 18:00:15 2015 : Debug: accounting
Mon Jun 8 18:00:15 2015 : Debug: authentication
Mon Jun 8 18:00:15 2015 : Debug: WITH_DHCP
Mon Jun 8 18:00:15 2015 : Debug: WITH_VMPS
Mon Jun 8 18:00:15 2015 : Debug: Server core libs:
Mon Jun 8 18:00:15 2015 : Debug: ssl: OpenSSL 1.0.1h 5 Jun 2014
Mon Jun 8 18:00:15 2015 : Info: Copyright (C) 1999-2015 The FreeRADIUS server project and contributors.
Mon Jun 8 18:00:15 2015 : Info: There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A
Mon Jun 8 18:00:15 2015 : Info: PARTICULAR PURPOSE.
Mon Jun 8 18:00:15 2015 : Info: You may redistribute copies of FreeRADIUS under the terms of the
Mon Jun 8 18:00:15 2015 : Info: GNU General Public License.
Mon Jun 8 18:00:15 2015 : Info: For more information about these matters, see the file named COPYRIGHT.
Mon Jun 8 18:00:15 2015 : Info: Starting - reading configuration files ...
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/radiusd.conf
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/clients.conf
Mon Jun 8 18:00:15 2015 : Debug: including files in directory /etc/freeradius2/modules/
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/always
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/attr_filter
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/attr_rewrite
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/chap
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/detail
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/echo
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/exec
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/expiration
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/expr
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/files
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/inner-eap
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/ldap
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/logintime
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/mschap
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/pap
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/preprocess
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/radutmp
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/realm
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/modules/sradutmp
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/sql.conf
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/sql/mysql/dialup.conf
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/sql/mysql/counter.conf
Mon Jun 8 18:00:15 2015 : Debug: including files in directory /etc/freeradius2/sites/
Mon Jun 8 18:00:15 2015 : Debug: including configuration file /etc/freeradius2/sites/default
Mon Jun 8 18:00:15 2015 : Debug: main {
Mon Jun 8 18:00:15 2015 : Debug: allow_core_dumps = no
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: including dictionary file /etc/freeradius2/dictionary
Mon Jun 8 18:00:15 2015 : Debug: main {
Mon Jun 8 18:00:15 2015 : Debug: name = "radiusd"
Mon Jun 8 18:00:15 2015 : Debug: prefix = "/usr"
Mon Jun 8 18:00:15 2015 : Debug: localstatedir = "/var"
Mon Jun 8 18:00:15 2015 : Debug: sbindir = "/usr/sbin"
Mon Jun 8 18:00:15 2015 : Debug: logdir = "/var/log"
Mon Jun 8 18:00:15 2015 : Debug: run_dir = "/var/run"
Mon Jun 8 18:00:15 2015 : Debug: libdir = "/usr/lib/freeradius2"
Mon Jun 8 18:00:15 2015 : Debug: radacctdir = "/var/db/radacct"
Mon Jun 8 18:00:15 2015 : Debug: hostname_lookups = no
Mon Jun 8 18:00:15 2015 : Debug: max_request_time = 30
Mon Jun 8 18:00:15 2015 : Debug: cleanup_delay = 5
Mon Jun 8 18:00:15 2015 : Debug: max_requests = 1024
Mon Jun 8 18:00:15 2015 : Debug: pidfile = "/var/run/radiusd.pid"
Mon Jun 8 18:00:15 2015 : Debug: checkrad = "/usr/sbin/checkrad"
Mon Jun 8 18:00:15 2015 : Debug: debug_level = 0
Mon Jun 8 18:00:15 2015 : Debug: proxy_requests = no
Mon Jun 8 18:00:15 2015 : Debug: log {
Mon Jun 8 18:00:15 2015 : Debug: stripped_names = no
Mon Jun 8 18:00:15 2015 : Debug: auth = yes
Mon Jun 8 18:00:15 2015 : Debug: auth_badpass = no
Mon Jun 8 18:00:15 2015 : Debug: auth_goodpass = no
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: security {
Mon Jun 8 18:00:15 2015 : Debug: max_attributes = 200
Mon Jun 8 18:00:15 2015 : Debug: reject_delay = 1
Mon Jun 8 18:00:15 2015 : Debug: status_server = yes
Mon Jun 8 18:00:15 2015 : Debug: allow_vulnerable_openssl = no
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: radiusd: #### Loading Realms and Home Servers ####
Mon Jun 8 18:00:15 2015 : Debug: radiusd: #### Loading Clients ####
Mon Jun 8 18:00:15 2015 : Debug: radiusd: #### Instantiating modules ####
Mon Jun 8 18:00:15 2015 : Debug: instantiate {
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: radiusd: #### Loading Virtual Servers ####
Mon Jun 8 18:00:15 2015 : Debug: server { # from file /etc/freeradius2w?ðiusd
Mon Jun 8 18:00:15 2015 : Debug: modules {
Mon Jun 8 18:00:15 2015 : Debug: Module: Checking authenticate {...} for more modules to load
Mon Jun 8 18:00:15 2015 : Debug: (Loaded rlm_pap, checking if it's valid)
Mon Jun 8 18:00:15 2015 : Debug: Module: Linked to module rlm_pap
Mon Jun 8 18:00:15 2015 : Debug: Module: Instantiating module "pap" from file /etc/freeradius2/modules/pap
Mon Jun 8 18:00:15 2015 : Debug: pap {
Mon Jun 8 18:00:15 2015 : Debug: encryption_scheme = "auto"
Mon Jun 8 18:00:15 2015 : Debug: auto_header = yes
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: (Loaded rlm_chap, checking if it's valid)
Mon Jun 8 18:00:15 2015 : Debug: Module: Linked to module rlm_chap
Mon Jun 8 18:00:15 2015 : Debug: Module: Instantiating module "chap" from file /etc/freeradius2/modules/chap
Mon Jun 8 18:00:15 2015 : Debug: (Loaded rlm_mschap, checking if it's valid)
Mon Jun 8 18:00:15 2015 : Debug: Module: Linked to module rlm_mschap
Mon Jun 8 18:00:15 2015 : Debug: Module: Instantiating module "mschap" from file /etc/freeradius2/modules/mschap
Mon Jun 8 18:00:15 2015 : Debug: mschap {
Mon Jun 8 18:00:15 2015 : Debug: use_mppe = yes
Mon Jun 8 18:00:15 2015 : Debug: require_encryption = no
Mon Jun 8 18:00:15 2015 : Debug: require_strong = no
Mon Jun 8 18:00:15 2015 : Debug: with_ntdomain_hack = no
Mon Jun 8 18:00:15 2015 : Debug: allow_retry = yes
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: Module: Checking authorize {...} for more modules to load
Mon Jun 8 18:00:15 2015 : Debug: (Loaded rlm_files, checking if it's valid)
Mon Jun 8 18:00:15 2015 : Debug: Module: Linked to module rlm_files
Mon Jun 8 18:00:15 2015 : Debug: Module: Instantiating module "files" from file /etc/freeradius2/modules/files
Mon Jun 8 18:00:15 2015 : Debug: files {
Mon Jun 8 18:00:15 2015 : Debug: usersfile = "/etc/freeradius2/users"
Mon Jun 8 18:00:15 2015 : Debug: acctusersfile = "/etc/freeradius2/acct_users"
Mon Jun 8 18:00:15 2015 : Debug: preproxy_usersfile = "/etc/freeradius2/preproxy_users"
Mon Jun 8 18:00:15 2015 : Debug: compat = "no"
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: reading pairlist file /etc/freeradius2/users
Mon Jun 8 18:00:15 2015 : Debug: reading pairlist file /etc/freeradius2/acct_users
Mon Jun 8 18:00:15 2015 : Debug: reading pairlist file /etc/freeradius2/preproxy_users
Mon Jun 8 18:00:15 2015 : Debug: (Loaded rlm_sql, checking if it's valid)
Mon Jun 8 18:00:15 2015 : Debug: Module: Linked to module rlm_sql
Mon Jun 8 18:00:15 2015 : Debug: Module: Instantiating module "sql" from file /etc/freeradius2/sql.conf
Mon Jun 8 18:00:15 2015 : Debug: sql {
Mon Jun 8 18:00:15 2015 : Debug: driver = "rlm_sql_mysql"
Mon Jun 8 18:00:15 2015 : Debug: server = "localhost"
Mon Jun 8 18:00:15 2015 : Debug: port = ""
Mon Jun 8 18:00:15 2015 : Debug: login = "freeradius"
Mon Jun 8 18:00:15 2015 : Debug: password = "radius"
Mon Jun 8 18:00:15 2015 : Debug: radius_db = "radius"
Mon Jun 8 18:00:15 2015 : Debug: read_groups = yes
Mon Jun 8 18:00:15 2015 : Debug: sqltrace = no
Mon Jun 8 18:00:15 2015 : Debug: sqltracefile = "/var/log/sqltrace.sql"
Mon Jun 8 18:00:15 2015 : Debug: readclients = yes
Mon Jun 8 18:00:15 2015 : Debug: deletestalesessions = yes
Mon Jun 8 18:00:15 2015 : Debug: num_sql_socks = 32
Mon Jun 8 18:00:15 2015 : Debug: lifetime = 0
Mon Jun 8 18:00:15 2015 : Debug: max_queries = 0
Mon Jun 8 18:00:15 2015 : Debug: sql_user_name = "%{User-Name}"
Mon Jun 8 18:00:15 2015 : Debug: default_user_profile = ""
Mon Jun 8 18:00:15 2015 : Debug: nas_query = "SELECT id, nasname, shortname, type, secret, server FROM nas"
Mon
Jun 8 18:00:15 2015 : Debug: authorize_check_query = "SELECT id,
username, attribute, value, op FROM radcheck WHERE
username = '%{SQL-User-Name}' ORDER BY id"
Mon Jun 8
18:00:15 2015 : Debug: authorize_reply_query = "SELECT id,
username, attribute, value, op FROM radreply WHERE
username = '%{SQL-User-Name}' ORDER BY id"
Mon Jun 8
18:00:15 2015 : Debug: authorize_group_check_query = "SELECT id,
groupname, attribute, Value, op FROM
radgroupcheck WHERE groupname = '%{Sql-Group}' ORDER
BY id"
Mon Jun 8 18:00:15 2015 : Debug:
authorize_group_reply_query = "SELECT id, groupname,
attribute, value, op FROM radgroupreply
WHERE groupname = '%{Sql-Group}' ORDER BY id"
Mon Jun 8
18:00:15 2015 : Debug: 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'"
Mon Jun 8 18:00:15 2015 : Debug:
accounting_update_query = " UPDATE radacct
SET framedipaddress = '%{Framed-IP-Address}',
acctsessiontime = '%{%{Acct-Session-Time}:-0}',
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}'"
Mon
Jun 8 18:00:15 2015 : Debug: 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}:-0}', '%{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}')"
Mon Jun 8 18:00:15 2015 :
Debug: 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}')"
Mon Jun 8 18:00:15 2015 : Debug:
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}'"
Mon
Jun 8 18:00:15 2015 : Debug: accounting_stop_query = "
UPDATE radacct SET acctstoptime = '%S',
acctsessiontime = '%{%{Acct-Session-Time}:-0}',
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}'"
Mon Jun 8 18:00:15 2015 : Debug:
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}:-0}', '%{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}')"
Mon Jun 8 18:00:15 2015 : Debug:
group_membership_query = "SELECT groupname FROM
radusergroup WHERE username = '%{SQL-User-Name}'
ORDER BY priority"
Mon Jun 8 18:00:15 2015 : Debug: connect_failure_retry_delay = 60
Mon Jun 8 18:00:15 2015 : Debug: simul_count_query = ""
Mon
Jun 8 18:00:15 2015 : Debug: simul_verify_query = "SELECT
radacctid, acctsessionid, username,
nasipaddress, nasportid, framedipaddress,
callingstationid, framedprotocol FROM
radacct WHERE username =
'%{SQL-User-Name}' AND acctstoptime IS
NULL"
Mon Jun 8 18:00:15 2015 : Debug: postauth_query =
"INSERT INTO radpostauth (username, pass,
reply, authdate) VALUES
( '%{User-Name}',
'%{%{User-Password}:-%{Chap-Password}}',
'%{reply:Packet-Type}', '%S')"
Mon Jun 8 18:00:15 2015 : Debug:
safe-characters =
"@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect to freeradius at localhost:/radius
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 0
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #0
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #0
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #0
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 1
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #1
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #1
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #1
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 2
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #2
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #2
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #2
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 3
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #3
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #3
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #3
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 4
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #4
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #4
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #4
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 5
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #5
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #5
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #5
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 6
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #6
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #6
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #6
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 7
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #7
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #7
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #7
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 8
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #8
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #8
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #8
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 9
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #9
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #9
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #9
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 10
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #10
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #10
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #10
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 11
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #11
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #11
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #11
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 12
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #12
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #12
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #12
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 13
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #13
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #13
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #13
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 14
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #14
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #14
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #14
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 15
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #15
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #15
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #15
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 16
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #16
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #16
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #16
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 17
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #17
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #17
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #17
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 18
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #18
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #18
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #18
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 19
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #19
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #19
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #19
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 20
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #20
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #20
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #20
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 21
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #21
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #21
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #21
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 22
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #22
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #22
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #22
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 23
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #23
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #23
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #23
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 24
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #24
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #24
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #24
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 25
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #25
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #25
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #25
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 26
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #26
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #26
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #26
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 27
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #27
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #27
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #27
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 28
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #28
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #28
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #28
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 29
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #29
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #29
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #29
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 30
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #30
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #30
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #30
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): starting 31
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Attempting to connect rlm_sql_mysql #31
Mon Jun 8 18:00:15 2015 : Info: rlm_sql_mysql: Starting connect to MySQL server for #31
Mon Jun 8 18:00:15 2015 : Info: rlm_sql (sql): Connected new DB handle, #31
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): Processing generate_sql_clients
Mon
Jun 8 18:00:15 2015 : Debug: rlm_sql (sql) in generate_sql_clients:
query is SELECT id, nasname, shortname, type, secret, server FROM nas
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): Reserving sql socket id: 31
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): Read entry nasname=127.0.0.1,shortname=radius,secret=testing123
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): Adding client 127.0.0.1 (radius, server=<none>) to clients list
Mon Jun 8 18:00:15 2015 : Debug: rlm_sql (sql): Released sql socket id: 31
Mon Jun 8 18:00:15 2015 : Debug: (Loaded rlm_sqlcounter, checking if it's valid)
Mon Jun 8 18:00:15 2015 : Debug: Module: Linked to module rlm_sqlcounter
Mon
Jun 8 18:00:15 2015 : Debug: Module: Instantiating module
"noresetcounter" from file /etc/freeradius2/sql/mysql/counter.conf
Mon Jun 8 18:00:15 2015 : Debug: sqlcounter noresetcounter {
Mon Jun 8 18:00:15 2015 : Debug: counter-name = "Max-All-Session-Time"
Mon Jun 8 18:00:15 2015 : Debug: check-name = "Max-All-Session"
Mon Jun 8 18:00:15 2015 : Debug: reply-name = "Session-Timeout"
Mon Jun 8 18:00:15 2015 : Debug: key = "User-Name"
Mon Jun 8 18:00:15 2015 : Debug: sqlmod-inst = "sql"
Mon Jun 8 18:00:15 2015 : Debug: query = "SELECT IFNULL(SUM(AcctSessionTime),0) FROM radacct WHERE UserName='%{%k}'"
Mon Jun 8 18:00:15 2015 : Debug: reset = "never"
Mon
Jun 8 18:00:15 2015 : Debug: safe-characters =
"@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Check attribute Max-All-Session is number 2131
Mon
Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Current Time: 1433779215
[2015-06-08 18:00:15], Next reset 0 [2015-06-08 18:00:00]
Mon Jun 8
18:00:15 2015 : Debug: rlm_sqlcounter: Current Time: 1433779215
[2015-06-08 18:00:15], Prev reset 0 [2015-06-08 18:00:00]
Mon Jun 8 18:00:15 2015 : Debug: Module: Instantiating module "dailycounter" from file /etc/freeradius2/sql/mysql/counter.conf
Mon Jun 8 18:00:15 2015 : Debug: sqlcounter dailycounter {
Mon Jun 8 18:00:15 2015 : Debug: counter-name = "Daily-Session-Time"
Mon Jun 8 18:00:15 2015 : Debug: check-name = "Max-Daily-Session"
Mon Jun 8 18:00:15 2015 : Debug: reply-name = "Session-Timeout"
Mon Jun 8 18:00:15 2015 : Debug: key = "User-Name"
Mon Jun 8 18:00:15 2015 : Debug: sqlmod-inst = "sql"
Mon
Jun 8 18:00:15 2015 : Debug: query = "SELECT SUM(acctsessiontime
- GREATEST((%b - UNIX_TIMESTAMP(acctstarttime)),
0)) FROM radacct WHERE username = '%{%k}'
AND UNIX_TIMESTAMP(acctstarttime) + acctsessiontime
> '%b'"
Mon Jun 8 18:00:15 2015 : Debug: reset = "daily"
Mon
Jun 8 18:00:15 2015 : Debug: safe-characters =
"@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Check attribute Max-Daily-Session is number 2133
Mon
Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Current Time: 1433779215
[2015-06-08 18:00:15], Next reset 1433800800 [2015-06-09 00:00:00]
Mon
Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Current Time: 1433779215
[2015-06-08 18:00:15], Prev reset 1433714400 [2015-06-08 00:00:00]
Mon
Jun 8 18:00:15 2015 : Debug: Module: Instantiating module
"monthlycounter" from file /etc/freeradius2/sql/mysql/counter.conf
Mon Jun 8 18:00:15 2015 : Debug: sqlcounter monthlycounter {
Mon Jun 8 18:00:15 2015 : Debug: counter-name = "Monthly-Session-Time"
Mon Jun 8 18:00:15 2015 : Debug: check-name = "Max-Monthly-Session"
Mon Jun 8 18:00:15 2015 : Debug: reply-name = "Session-Timeout"
Mon Jun 8 18:00:15 2015 : Debug: key = "User-Name"
Mon Jun 8 18:00:15 2015 : Debug: sqlmod-inst = "sql"
Mon
Jun 8 18:00:15 2015 : Debug: query = "SELECT SUM(acctsessiontime
- GREATEST((%b - UNIX_TIMESTAMP(acctstarttime)),
0)) FROM radacct WHERE username='%{%k}'
AND UNIX_TIMESTAMP(acctstarttime) + acctsessiontime
> '%b'"
Mon Jun 8 18:00:15 2015 : Debug: reset = "monthly"
Mon
Jun 8 18:00:15 2015 : Debug: safe-characters =
"@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
Mon Jun 8 18:00:15 2015 : Debug: }
Mon Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Check attribute Max-Monthly-Session is number 2135
Mon
Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Current Time: 1433779215
[2015-06-08 18:00:15], Next reset 1435701600 [2015-07-01 00:00:00]
Mon
Jun 8 18:00:15 2015 : Debug: rlm_sqlcounter: Current Time: 1433779215
[2015-06-08 18:00:15], Prev reset 1433109600 [2015-06-01 00:00:00]
Mon Jun 8 18:00:15 2015 : Debug: Module: Checking preacct {...} for more modules to load
Mon Jun 8 18:00:15 2015 : Error: /etc/freeradius2/sites/default[365]: Failed to find "acct_unique" in the "modules" section.
Mon Jun 8 18:00:15 2015 : Error: /etc/freeradius2/sites/default[341]: Errors parsing preacct section.
More information about the Freeradius-Users
mailing list