radius accounting not starting....
Somanath Mishra
somanath.mishra at planetsbrain.com
Fri Mar 15 14:41:21 CET 2019
Hi Team,
i facing one problem in accounting part. So after authrization
accounting part is not starting. i am getting data in radpostauth
"Accept-Accept" ,but in radacct there is no data.
here is debugging logs:
freeradius | Ready to process requests
freeradius | (0) Received Access-Request Id 153 from 192.168.0.4:47212
to 172.25.0.101:1812 length 182
freeradius | (0) Service-Type = Login-User
freeradius | (0) Framed-MTU = 1250
freeradius | (0) User-Name = "12347@@TM11"
freeradius | (0) User-Password = "b3957233dd5294cbf47d95fb3f584239"
freeradius | (0) Calling-Station-Id = "9c:4e:36:9c:71:18"
freeradius | (0) Called-Station-Id = "00:0c:29:67:6d:ec"
freeradius | (0) Connect-Info = "CONNECT Unknown Radio"
freeradius | (0) Framed-IP-Address = 10.0.1.24
freeradius | (0) NAS-IP-Address = 192.168.0.4
freeradius | (0) NAS-Port-Type = Wireless-802.11
freeradius | (0) NAS-Port = 0
freeradius | (0) Message-Authenticator =
0xda54bc22f970f04a4435875330451229
freeradius | (0) # Executing section authorize from file
/etc/freeradius/sites-enabled/default
freeradius | (0) authorize {
freeradius | (0) policy filter_username {
freeradius | (0) if (&User-Name) {
freeradius | (0) if (&User-Name) -> TRUE
freeradius | (0) if (&User-Name) {
freeradius | (0) if (&User-Name =~ / /) {
freeradius | (0) if (&User-Name =~ / /) -> FALSE
freeradius | (0) if (&User-Name =~ /\.\./ ) {
freeradius | (0) if (&User-Name =~ /\.\./ ) -> FALSE
freeradius | (0) if (&User-Name =~ /\.$/) {
freeradius | (0) if (&User-Name =~ /\.$/) -> FALSE
freeradius | (0) if (&User-Name =~ /@\./) {
freeradius | (0) if (&User-Name =~ /@\./) -> FALSE
freeradius | (0) } # if (&User-Name) = notfound
freeradius | (0) } # policy filter_username = notfound
freeradius | (0) [preprocess] = ok
freeradius | (0) [chap] = noop
freeradius | (0) [mschap] = noop
freeradius | (0) [digest] = noop
freeradius | (0) suffix: Checking for suffix after "@"
freeradius | (0) suffix: Looking up realm "TM11" for User-Name =
"12347@@TM11"
freeradius | (0) suffix: No such realm "TM11"
freeradius | (0) [suffix] = noop
freeradius | (0) eap: No EAP-Message, not doing EAP
freeradius | (0) [eap] = noop
freeradius | (0) [files] = noop
freeradius | (0) sql: EXPAND %{User-Name}
freeradius | (0) sql: --> 12347@@TM11
freeradius | (0) sql: SQL-User-Name set to '12347@@TM11'
freeradius | rlm_sql (sql): Closing connection (1): Hit idle_timeout,
was idle for 305 seconds
freeradius | rlm_sql_mysql: Socket destructor called, closing socket
freeradius | rlm_sql (sql): Closing connection (2): Hit idle_timeout,
was idle for 305 seconds
freeradius | rlm_sql_mysql: Socket destructor called, closing socket
freeradius | rlm_sql (sql): Closing connection (3): Hit idle_timeout,
was idle for 305 seconds
freeradius | rlm_sql_mysql: Socket destructor called, closing socket
freeradius | rlm_sql (sql): Closing connection (4): Hit idle_timeout,
was idle for 305 seconds
freeradius | rlm_sql (sql): You probably need to lower "min"
freeradius | rlm_sql_mysql: Socket destructor called, closing socket
freeradius | rlm_sql (sql): Closing connection (0): Hit idle_timeout,
was idle for 305 seconds
freeradius | rlm_sql (sql): You probably need to lower "min"
freeradius | rlm_sql_mysql: Socket destructor called, closing socket
freeradius | rlm_sql (sql): Closing connection (5): Hit idle_timeout,
was idle for 305 seconds
freeradius | rlm_sql (sql): You probably need to lower "min"
freeradius | rlm_sql_mysql: Socket destructor called, closing socket
freeradius | rlm_sql (sql): 0 of 0 connections in use. You may need
to increase "spare"
freeradius | rlm_sql (sql): Opening additional connection (6), 1 of 32
pending slots used
freeradius | rlm_sql_mysql: Starting connect to MySQL server
freeradius | rlm_sql_mysql: Connected to database 'radius' on
172.25.0.100 via TCP/IP, server version 5.7.25, protocol version 10
freeradius | rlm_sql (sql): Reserved connection (6)
freeradius | (0) sql: EXPAND SELECT id, username, attribute, value, op
FROM radcheck WHERE username = '%{SQL-User-Name}' ORDER BY id
freeradius | (0) sql: --> SELECT id, username, attribute, value, op
FROM radcheck WHERE username = '12347@@TM11' ORDER BY id
freeradius | (0) sql: Executing select query: SELECT id, username,
attribute, value, op FROM radcheck WHERE username = '12347@@TM11' ORDER BY
id
freeradius | (0) sql: User found in radcheck table
freeradius | (0) sql: Conditional check items matched, merging
assignment check items
freeradius | (0) sql: Cleartext-Password :=
"b3957233dd5294cbf47d95fb3f584239"
freeradius | (0) sql: EXPAND SELECT id, username, attribute, value, op
FROM radreply WHERE username = '%{SQL-User-Name}' ORDER BY id
freeradius | (0) sql: --> SELECT id, username, attribute, value, op
FROM radreply WHERE username = '12347@@TM11' ORDER BY id
freeradius | (0) sql: Executing select query: SELECT id, username,
attribute, value, op FROM radreply WHERE username = '12347@@TM11' ORDER BY
id
freeradius | (0) sql: EXPAND SELECT groupname FROM radusergroup WHERE
username = '%{SQL-User-Name}' ORDER BY priority
freeradius | (0) sql: --> SELECT groupname FROM radusergroup WHERE
username = '12347@@TM11' ORDER BY priority
freeradius | (0) sql: Executing select query: SELECT groupname FROM
radusergroup WHERE username = '12347@@TM11' ORDER BY priority
freeradius | (0) sql: User found in the group table
freeradius | (0) sql: EXPAND SELECT id, groupname, attribute, Value, op
FROM radgroupcheck WHERE groupname = '%{SQL-Group}' ORDER BY id
freeradius | (0) sql: --> SELECT id, groupname, attribute, Value, op
FROM radgroupcheck WHERE groupname = 'allowall' ORDER BY id
freeradius | (0) sql: Executing select query: SELECT id, groupname,
attribute, Value, op FROM radgroupcheck WHERE groupname = 'allowall' ORDER
BY id
freeradius | (0) sql: Group "allowall": Conditional check items matched
freeradius | (0) sql: Group "allowall": Merging assignment check items
freeradius | (0) sql: Framed-Protocol := 0
freeradius | (0) sql: EXPAND SELECT id, groupname, attribute, value, op
FROM radgroupreply WHERE groupname = '%{SQL-Group}' ORDER BY id
freeradius | (0) sql: --> SELECT id, groupname, attribute, value, op
FROM radgroupreply WHERE groupname = 'allowall' ORDER BY id
freeradius | (0) sql: Executing select query: SELECT id, groupname,
attribute, value, op FROM radgroupreply WHERE groupname = 'allowall' ORDER
BY id
freeradius | (0) sql: Group "allowall": Merging reply items
freeradius | rlm_sql (sql): Released connection (6)
freeradius | Need 2 more connections to reach min connections (3)
freeradius | rlm_sql (sql): Opening additional connection (7), 1 of 31
pending slots used
freeradius | rlm_sql_mysql: Starting connect to MySQL server
freeradius | rlm_sql_mysql: Connected to database 'radius' on
172.25.0.100 via TCP/IP, server version 5.7.25, protocol version 10
freeradius | (0) [sql] = ok
freeradius | (0) [expiration] = noop
freeradius | (0) [logintime] = noop
freeradius | (0) [pap] = updated
freeradius | (0) } # authorize = updated
freeradius | (0) Found Auth-Type = PAP
freeradius | (0) # Executing group from file
/etc/freeradius/sites-enabled/default
freeradius | (0) Auth-Type PAP {
freeradius | (0) pap: Login attempt with password
freeradius | (0) pap: Comparing with "known good" Cleartext-Password
freeradius | (0) pap: User authenticated successfully
freeradius | (0) [pap] = ok
freeradius | (0) } # Auth-Type PAP = ok
freeradius | (0) # Executing section post-auth from file
/etc/freeradius/sites-enabled/default
freeradius | (0) post-auth {
freeradius | (0) update {
freeradius | (0) No attributes updated
freeradius | (0) } # update = noop
freeradius | (0) sql: EXPAND .query
freeradius | (0) sql: --> .query
freeradius | (0) sql: Using query template 'query'
freeradius | rlm_sql (sql): Reserved connection (6)
freeradius | (0) sql: EXPAND %{User-Name}
freeradius | (0) sql: --> 12347@@TM11
freeradius | (0) sql: SQL-User-Name set to '12347@@TM11'
freeradius | (0) sql: EXPAND INSERT INTO radpostauth (username, pass,
reply, authdate) VALUES ( '%{SQL-User-Name}',
'%{%{User-Password}:-%{Chap-Password}}', '%{reply:Packet-Type}', '%S')
freeradius | (0) sql: --> INSERT INTO radpostauth (username, pass,
reply, authdate) VALUES ( '12347@@TM11',
'b3957233dd5294cbf47d95fb3f584239', 'Access-Accept', '2019-03-15
13:18:27')
freeradius | (0) sql: Executing query: INSERT INTO radpostauth
(username, pass, reply, authdate) VALUES ( '12347@@TM11',
'b3957233dd5294cbf47d95fb3f584239', 'Access-Accept', '2019-03-15
13:18:27')
freeradius | (0) sql: SQL query returned: success
freeradius | (0) sql: 1 record(s) updated
freeradius | rlm_sql (sql): Released connection (6)
freeradius | (0) [sql] = ok
freeradius | (0) [exec] = noop
freeradius | (0) policy remove_reply_message_if_eap {
freeradius | (0) if (&reply:EAP-Message && &reply:Reply-Message) {
freeradius | (0) if (&reply:EAP-Message && &reply:Reply-Message)
-> FALSE
freeradius | (0) else {
freeradius | (0) [noop] = noop
freeradius | (0) } # else = noop
freeradius | (0) } # policy remove_reply_message_if_eap = noop
freeradius | (0) } # post-auth = ok
freeradius | (0) Sent Access-Accept Id 153 from 172.25.0.101:1812 to
192.168.0.4:47212 length 0
freeradius | (0) Finished request
freeradius | Waking up in 4.9 seconds.
freeradius | (0) Cleaning up request packet ID 153 with timestamp +305
freeradius | Ready to process requests
please help me on this.
thanks in advance.
More information about the Freeradius-Users
mailing list