Hi
I tried my level best to get this query going on but its still not get
into proper action.
I am writing down the debug info from Radius Server. Have a look over
it and let me know that how can i get this query going on.
Scenario:
a user 'masad2' is calling another endpoint 'user'. After looking at
first query request reply, u can see that Radius send Access-Accept.
But then the request comes up again from Calling Station (I didnt do
it by myself rather program gets its execution after single click). So
how can i continue with accepting the first request only and not to
process the rest of the requests?
Debug:
Supplying it as an Attachment Cz its big for writing over here.
Thanx
On 5/20/05, Marcin Jessa <[EMAIL PROTECTED]> wrote:
> Hi.
>
> Looks like this query will use quite a while to get executed.
> What does the debug mode say? Any timeouts?
>
> Regards,
> Marcin Jessa
>
> On Fri, 20 May 2005 13:16:20 +0500
> Kamran Bukhari <[EMAIL PROTECTED]> wrote:
>
> > Hello
> >
> > I want to do the authentication using MYsql on Radius. I was doing it
> > till now when i ended up with new query of my own. I developed a new
> > query for authentication which is not allowing me to enter. Help me
> > out with it.
> >
> > authorize_check_query = "SELECT DISTINCT
> > ${authcheck_table}.id,${authcheck_table}.UserName,${authcheck_table}.Attribute,${authcheck_table}.Value,${authcheck_table}.op
> > FROM ${authcheck_table}, ${groupcheck_table} WHERE
> > (${authcheck_table}.Username = '%{Calling-Station-Id}') and
> > (${authcheck_table}.Permission = 'allow') and
> > (${groupcheck_table}.Permission='allow') and
> > (${groupcheck_table}.UserName='%{Calling-Station-Id}') and
> > (${groupcheck_table}.Blocked='Called-Station-Id') ORDER BY
> > ${authcheck_table}.id"
> >
> >
> >
> > authcheck_table is like this
> >
> > Id UserName Attribute op Value Permission
> >
> >
> > and my groupcheck_table table is like this
> >
> > UserName Blocked Permission
> >
> >
> > The basic problem I am facing is that i want to use alias from
> > calling-station-id. How can i do this ? I want to cut alias from both
> > the attributes (Calling-Station-Id and Called-Station-Id) and then
> > want to match them against the values in the table.
> >
> > Help me out
> >
> >
> >
> > --
> > Kamran Bukhari
> >
> > -
> > List info/subscribe/unsubscribe? See
> > http://www.freeradius.org/list/users.html
>
--
Kamran Bukhari
rad_recv: Access-Request packet from host 150.150.15.112:3893, id=255,
length=227
User-Name = "masad2"
User-Password = "common"
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Login-User
Framed-IP-Address = 150.150.15.112
Calling-Station-Id = "masad2"
Called-Station-Id = "user"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=originate"
h323-call-type = "h323-call-type=VoIP"
h323-gw-id = "h323-gw-id=GK2"
Processing the authorize section of radiusd.conf
modcall: entering group authorize for request 0
radius_xlat: '/usr/local/var/log/radius/radacct//auth-detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d
expands to /usr/local/var/log/radius/radacct//auth-detail-20050524
modcall[authorize]: module "auth_log" returns ok for request 0
radius_xlat: 'masad2'
rlm_sql (sql): sql_set_user escaped user --> 'masad2'
radius_xlat: 'SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2') and
(radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2') and (Block.Blocked='user') ORDER BY radcheck.id'
rlm_sql (sql): Reserving sql socket id: 4
rlm_sql_mysql: query: SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2') and
(radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2') and (Block.Blocked='user') ORDER BY radcheck.id
radius_xlat: ''
radius_xlat: 'SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2') and
(radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2') and (Block.Blocked='user') ORDER BY radcheck.id'
rlm_sql_mysql: query: SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2') and
(radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2') and (Block.Blocked='user') ORDER BY radcheck.id
radius_xlat: ''
rlm_sql (sql): Released sql socket id: 4
modcall[authorize]: module "sql" returns ok for request 0
modcall: group authorize returns ok for request 0
auth: type Local
auth: user supplied User-Password matches local User-Password
Sending Access-Accept of id 255 to 150.150.15.112:3893
Password == "common"
Finished request 0
Going to the next request
--- Walking the entire request list ---
Waking up in 6 seconds...
rad_recv: Accounting-Request packet from host 150.150.15.112:16117, id=39,
length=352
Acct-Status-Type = Start
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Login-User
Acct-Session-Id = "4292adf200000004"
User-Name = "masad2"
Framed-IP-Address = 150.150.15.112
Calling-Station-Id = "masad2"
Called-Station-Id = "user"
h323-gw-id = "h323-gw-id=GK2"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=proxy"
h323-call-type = "h323-call-type=VoIP"
h323-setup-time = "h323-setup-time=09:54:36.000 West Asia Standard Time
Tue May 24 2005"
h323-remote-address = "h323-remote-address=150.150.15.38"
Acct-Delay-Time = 0
Processing the preacct section of radiusd.conf
modcall: entering group preacct for request 1
modcall[preacct]: module "preprocess" returns noop for request 1
rlm_acct_unique: WARNING: Attribute NAS-Port was not found in request, unique
ID MAY be inconsistent
rlm_acct_unique: Hashing ',Client-IP-Address = 150.150.15.112,NAS-IP-Address =
127.0.0.1,Acct-Session-Id = "4292adf200000004",User-Name = "masad2"'
rlm_acct_unique: Acct-Unique-Session-ID = "811ef57e4097a4a4".
modcall[preacct]: module "acct_unique" returns ok for request 1
rlm_realm: No '@' in User-Name = "masad2", looking up realm NULL
rlm_realm: No such realm "NULL"
modcall[preacct]: module "suffix" returns noop for request 1
modcall[preacct]: module "files" returns noop for request 1
modcall: group preacct returns ok for request 1
Processing the accounting section of radiusd.conf
modcall: entering group accounting for request 1
radius_xlat: '/usr/local/var/log/radius/radacct/150.150.15.112/detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to
/usr/local/var/log/radius/radacct/150.150.15.112/detail-20050524
modcall[accounting]: module "detail" returns ok for request 1
modcall[accounting]: module "unix" returns noop for request 1
radius_xlat: 'masad2'
rlm_sql (sql): sql_set_user escaped user --> 'masad2'
radius_xlat: '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('4292adf200000004', '811ef57e4097a4a4',
'masad2', '', '127.0.0.1', '', 'Virtual', '2005-05-24 09:47:36', '0', '0', '',
'', '', '0', '0', 'user', 'masad2', '', 'Login-User', '', '150.150.15.112',
'0', '0')'
radius_xlat: '/usr/local/var/log/radius/sqltrace.sql'
rlm_sql (sql): Reserving sql socket id: 3
rlm_sql_mysql: 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) values('4292adf200000004',
'811ef57e4097a4a4', 'masad2', '', '127.0.0.1', '', 'Virtual', '2005-05-24
09:47:36', '0', '0', '', '', '', '0', '0', 'user', 'masad2', '', 'Login-User',
'', '150.150.15.112', '0', '0')
rlm_sql (sql): Released sql socket id: 3
modcall[accounting]: module "sql" returns ok for request 1
radius_xlat: '/usr/local/var/log/radius/radutmp'
radius_xlat: 'masad2'
rlm_radutmp: No NAS-Port seen. Cannot do anything.
rlm_radumtp: WARNING: checkrad will probably not work!
modcall[accounting]: module "radutmp" returns noop for request 1
modcall: group accounting returns ok for request 1
Sending Accounting-Response of id 39 to 150.150.15.112:16117
Finished request 1
Going to the next request
Waking up in 6 seconds...
rad_recv: Access-Request packet from host 150.150.15.112:3893, id=0, length=239
User-Name = "user"
User-Password = "common"
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Call-Check
Framed-IP-Address = 150.150.15.38
Calling-Station-Id = "masad2 [150.150.15.112]"
Called-Station-Id = "user"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=answer"
h323-call-type = "h323-call-type=VoIP"
h323-gw-id = "h323-gw-id=GK2"
Processing the authorize section of radiusd.conf
modcall: entering group authorize for request 2
radius_xlat: '/usr/local/var/log/radius/radacct//auth-detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d
expands to /usr/local/var/log/radius/radacct//auth-detail-20050524
modcall[authorize]: module "auth_log" returns ok for request 2
radius_xlat: 'user'
rlm_sql (sql): sql_set_user escaped user --> 'user'
radius_xlat: 'SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id'
rlm_sql (sql): Reserving sql socket id: 2
rlm_sql_mysql: query: SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id
rlm_sql (sql): User user not found in radcheck
radius_xlat: ''
radius_xlat: ''
rlm_sql (sql): Released sql socket id: 2
modcall[authorize]: module "sql" returns ok for request 2
modcall: group authorize returns ok for request 2
auth: No authenticate method (Auth-Type) configuration found for the request:
Rejecting the user
auth: Failed to validate the user.
Delaying request 2 for 1 seconds
Finished request 2
Going to the next request
Waking up in 6 seconds...
rad_recv: Accounting-Request packet from host 150.150.15.112:16117, id=40,
length=471
Acct-Status-Type = Stop
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Login-User
Acct-Session-Id = "4292adf200000004"
User-Name = "masad2"
Framed-IP-Address = 150.150.15.112
Acct-Session-Time = 0
Calling-Station-Id = "masad2"
Called-Station-Id = "user"
h323-gw-id = "h323-gw-id=GK2"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=proxy"
h323-call-type = "h323-call-type=VoIP"
h323-setup-time = "h323-setup-time=09:54:36.000 West Asia Standard Time
Tue May 24 2005"
h323-disconnect-time = "h323-disconnect-time=09:54:36.000 West Asia
Standard Time Tue May 24 2005"
h323-disconnect-cause = "h323-disconnect-cause=10"
h323-remote-address = "h323-remote-address=150.150.15.38"
Acct-Delay-Time = 0
Processing the preacct section of radiusd.conf
modcall: entering group preacct for request 3
modcall[preacct]: module "preprocess" returns noop for request 3
rlm_acct_unique: WARNING: Attribute NAS-Port was not found in request, unique
ID MAY be inconsistent
rlm_acct_unique: Hashing ',Client-IP-Address = 150.150.15.112,NAS-IP-Address =
127.0.0.1,Acct-Session-Id = "4292adf200000004",User-Name = "masad2"'
rlm_acct_unique: Acct-Unique-Session-ID = "811ef57e4097a4a4".
modcall[preacct]: module "acct_unique" returns ok for request 3
rlm_realm: No '@' in User-Name = "masad2", looking up realm NULL
rlm_realm: No such realm "NULL"
modcall[preacct]: module "suffix" returns noop for request 3
modcall[preacct]: module "files" returns noop for request 3
modcall: group preacct returns ok for request 3
Processing the accounting section of radiusd.conf
modcall: entering group accounting for request 3
radius_xlat: '/usr/local/var/log/radius/radacct/150.150.15.112/detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to
/usr/local/var/log/radius/radacct/150.150.15.112/detail-20050524
modcall[accounting]: module "detail" returns ok for request 3
modcall[accounting]: module "unix" returns noop for request 3
radius_xlat: 'masad2'
rlm_sql (sql): sql_set_user escaped user --> 'masad2'
radius_xlat: 'UPDATE radacct SET AcctStopTime = '2005-05-24 09:47:36',
AcctSessionTime = '0', AcctInputOctets = '', AcctOutputOctets = '',
AcctTerminateCause = '', AcctStopDelay = '0', ConnectInfo_stop = '' WHERE
AcctSessionId = '4292adf200000004' AND UserName = 'masad2' AND NASIPAddress =
'127.0.0.1''
radius_xlat: '/usr/local/var/log/radius/sqltrace.sql'
rlm_sql (sql): Reserving sql socket id: 1
rlm_sql_mysql: query: UPDATE radacct SET AcctStopTime = '2005-05-24 09:47:36',
AcctSessionTime = '0', AcctInputOctets = '', AcctOutputOctets = '',
AcctTerminateCause = '', AcctStopDelay = '0', ConnectInfo_stop = '' WHERE
AcctSessionId = '4292adf200000004' AND UserName = 'masad2' AND NASIPAddress =
'127.0.0.1'
rlm_sql (sql): Released sql socket id: 1
modcall[accounting]: module "sql" returns ok for request 3
radius_xlat: '/usr/local/var/log/radius/radutmp'
radius_xlat: 'masad2'
rlm_radutmp: No NAS-Port seen. Cannot do anything.
rlm_radumtp: WARNING: checkrad will probably not work!
modcall[accounting]: module "radutmp" returns noop for request 3
modcall: group accounting returns ok for request 3
Sending Accounting-Response of id 40 to 150.150.15.112:16117
Finished request 3
Going to the next request
Waking up in 6 seconds...
--- Walking the entire request list ---
Sending Access-Reject of id 0 to 150.150.15.112:3893
Cleaning up request 2 ID 0 with timestamp 4292a3d8
Cleaning up request 1 ID 39 with timestamp 4292a3d8
Cleaning up request 3 ID 40 with timestamp 4292a3d8
Cleaning up request 0 ID 255 with timestamp 4292a3d8
Nothing to do. Sleeping until we see a request.
rad_recv: Access-Request packet from host 150.150.15.112:3893, id=1, length=239
User-Name = "user"
User-Password = "common"
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Call-Check
Framed-IP-Address = 150.150.15.38
Calling-Station-Id = "masad2 [150.150.15.112]"
Called-Station-Id = "user"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=answer"
h323-call-type = "h323-call-type=VoIP"
h323-gw-id = "h323-gw-id=GK2"
Processing the authorize section of radiusd.conf
modcall: entering group authorize for request 4
radius_xlat: '/usr/local/var/log/radius/radacct//auth-detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d
expands to /usr/local/var/log/radius/radacct//auth-detail-20050524
modcall[authorize]: module "auth_log" returns ok for request 4
radius_xlat: 'user'
rlm_sql (sql): sql_set_user escaped user --> 'user'
radius_xlat: 'SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id'
rlm_sql (sql): Reserving sql socket id: 0
rlm_sql_mysql: query: SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id
rlm_sql (sql): User user not found in radcheck
radius_xlat: ''
radius_xlat: ''
rlm_sql (sql): Released sql socket id: 0
modcall[authorize]: module "sql" returns ok for request 4
modcall: group authorize returns ok for request 4
auth: No authenticate method (Auth-Type) configuration found for the request:
Rejecting the user
auth: Failed to validate the user.
Delaying request 4 for 1 seconds
Finished request 4
Going to the next request
--- Walking the entire request list ---
Waking up in 1 seconds...
--- Walking the entire request list ---
Waking up in 1 seconds...
--- Walking the entire request list ---
Sending Access-Reject of id 1 to 150.150.15.112:3893
Waking up in 4 seconds...
rad_recv: Access-Request packet from host 150.150.15.112:3893, id=2, length=239
User-Name = "user"
User-Password = "common"
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Call-Check
Framed-IP-Address = 150.150.15.38
Calling-Station-Id = "masad2 [150.150.15.112]"
Called-Station-Id = "user"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=answer"
h323-call-type = "h323-call-type=VoIP"
h323-gw-id = "h323-gw-id=GK2"
Processing the authorize section of radiusd.conf
modcall: entering group authorize for request 5
radius_xlat: '/usr/local/var/log/radius/radacct//auth-detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d
expands to /usr/local/var/log/radius/radacct//auth-detail-20050524
modcall[authorize]: module "auth_log" returns ok for request 5
radius_xlat: 'user'
rlm_sql (sql): sql_set_user escaped user --> 'user'
radius_xlat: 'SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id'
rlm_sql (sql): Reserving sql socket id: 4
rlm_sql_mysql: query: SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id
rlm_sql (sql): User user not found in radcheck
radius_xlat: ''
radius_xlat: ''
rlm_sql (sql): Released sql socket id: 4
modcall[authorize]: module "sql" returns ok for request 5
modcall: group authorize returns ok for request 5
auth: No authenticate method (Auth-Type) configuration found for the request:
Rejecting the user
auth: Failed to validate the user.
Delaying request 5 for 1 seconds
Finished request 5
Going to the next request
Waking up in 4 seconds...
--- Walking the entire request list ---
Cleaning up request 4 ID 1 with timestamp 4292a3de
Sending Access-Reject of id 2 to 150.150.15.112:3893
Waking up in 2 seconds...
rad_recv: Access-Request packet from host 150.150.15.112:3893, id=3, length=239
User-Name = "user"
User-Password = "common"
NAS-IP-Address = 127.0.0.1
NAS-Identifier = "GK2"
NAS-Port-Type = Virtual
Service-Type = Call-Check
Framed-IP-Address = 150.150.15.38
Calling-Station-Id = "masad2 [150.150.15.112]"
Called-Station-Id = "user"
h323-conf-id = "h323-conf-id=4B53E709 5F31810 96D1000C F171813D"
h323-call-origin = "h323-call-origin=answer"
h323-call-type = "h323-call-type=VoIP"
h323-gw-id = "h323-gw-id=GK2"
Processing the authorize section of radiusd.conf
modcall: entering group authorize for request 6
radius_xlat: '/usr/local/var/log/radius/radacct//auth-detail-20050524'
rlm_detail:
/usr/local/var/log/radius/radacct/%{Client-IP-Address}/auth-detail-%Y%m%d
expands to /usr/local/var/log/radius/radacct//auth-detail-20050524
modcall[authorize]: module "auth_log" returns ok for request 6
radius_xlat: 'user'
rlm_sql (sql): sql_set_user escaped user --> 'user'
radius_xlat: 'SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id'
rlm_sql (sql): Reserving sql socket id: 3
rlm_sql_mysql: query: SELECT DISTINCT
radcheck.id,radcheck.UserName,radcheck.Attribute,radcheck.Value,radcheck.op
FROM radcheck, Block WHERE (radcheck.Username = 'masad2 =5B150.150.15.112=5D')
and (radcheck.Permission = 'allow') and (Block.Permission='allow') and
(Block.UserName='masad2 =5B150.150.15.112=5D') and (Block.Blocked='user') ORDER
BY radcheck.id
rlm_sql (sql): User user not found in radcheck
radius_xlat: ''
radius_xlat: ''
rlm_sql (sql): Released sql socket id: 3
modcall[authorize]: module "sql" returns ok for request 6
modcall: group authorize returns ok for request 6
auth: No authenticate method (Auth-Type) configuration found for the request:
Rejecting the user
auth: Failed to validate the user.
Delaying request 6 for 1 seconds
Finished request 6
Going to the next request
Waking up in 2 seconds...
--- Walking the entire request list ---
Cleaning up request 5 ID 2 with timestamp 4292a3e0
Sending Access-Reject of id 3 to 150.150.15.112:3893
Waking up in 4 seconds...
--- Walking the entire request list ---
Cleaning up request 6 ID 3 with timestamp 4292a3e4
Nothing to do. Sleeping until we see a request.