Thanks for the reply.
I've downloaded ver 0.9.0 and I've compiled it on 64-bit and again, I've
got the same results. Please find the debug messages below.
While testing with a 64-bit client as:
./radclient xxx.xxx.xxx.xxx auth secret < test_auth
The user get authenticated and this is the reply
rad_recv: Access-Request packet from host 194.170.195.10:44606, id=147,
length=87
Sun Jul 27 11:51:59 2003 : Debug: Thread 1 assigned request 0
Sun Jul 27 11:51:59 2003 : Debug: --- Walking the entire request list
---
Sun Jul 27 11:51:59 2003 : Debug: Threads: total/active/spare threads =
5/1/4
Sun Jul 27 11:51:59 2003 : Debug: Waking up in 5 seconds...
Sun Jul 27 11:51:59 2003 : Debug: Thread 1 handling request 0, (1
handled so far)
User-Name = "user101"
User-Password = "test1234"
NAS-IP-Address = xxx.xxx.xxx.xxx
NAS-Port = 0
NAS-Port-Type = Async
Service-Type = Framed-User
Framed-Protocol = PPP
Sun Jul 27 11:51:59 2003 : Debug: modcall: entering group authorize
Sun Jul 27 11:51:59 2003 : Debug: modcall[authorize]: module
"preprocess" returns ok
Sun Jul 27 11:51:59 2003 : Debug: modcall[authorize]: module "chap"
returns noop
Sun Jul 27 11:51:59 2003 : Debug: rlm_realm: No '@' in User-Name =
"user101", looking up realm NULL
Sun Jul 27 11:51:59 2003 : Debug: rlm_realm: No such realm "NULL"
Sun Jul 27 11:51:59 2003 : Debug: modcall[authorize]: module "suffix"
returns noop
Sun Jul 27 11:51:59 2003 : Debug: users: Matched DEFAULT at 152
Sun Jul 27 11:51:59 2003 : Debug: users: Matched DEFAULT at 171
Sun Jul 27 11:51:59 2003 : Debug: users: Matched DEFAULT at 183
Sun Jul 27 11:51:59 2003 : Debug: modcall[authorize]: module "files"
returns ok
Sun Jul 27 11:51:59 2003 : Debug: modcall[authorize]: module "mschap"
returns noop
Sun Jul 27 11:51:59 2003 : Debug: modcall: entering group redundant
Sun Jul 27 11:51:59 2003 : Debug: radius_xlat: 'user101'
Sun Jul 27 11:51:59 2003 : Debug: rlm_sql (sql1): sql_set_user escaped
user --> 'user101'
Sun Jul 27 11:51:59 2003 : Debug: radius_xlat: 'SELECT
id,user_id,Attribute,pwd_Value, op FROM user_profile_new WHERE user_id =
'user101' AND Status = 'W' AND NVL(CALLING_STATION_ID, '041234567') =
'041234567' ORDER BY id'
Sun Jul 27 11:51:59 2003 : Debug: rlm_sql (sql1): Reserving sql socket
id: 1
Sun Jul 27 11:51:59 2003 : Error: rlm_sql: The 'op' field for attribute
'Crypt-Password = cUTAc33b3ghLs' is NULL, or non-existent.
Sun Jul 27 11:51:59 2003 : Error: rlm_sql: You MUST FIX THIS if you want
the configuration to behave as you expect.
Sun Jul 27 11:51:59 2003 : Debug: radius_xlat: ''
Sun Jul 27 11:51:59 2003 : Debug: radius_xlat: 'SELECT 0
id,User_id,Attribute_name,Attribute_Value, '' op FROM
user_Attributes_new WHERE User_id = 'user101''
Sun Jul 27 11:51:59 2003 : Error: rlm_sql: The 'op' field for attribute
'Port-Limit = 1' is NULL, or non-existent.
Sun Jul 27 11:51:59 2003 : Error: rlm_sql: You MUST FIX THIS if you want
the configuration to behave as you expect.
Sun Jul 27 11:51:59 2003 : Error: rlm_sql: unknown attribute
Unisphere-Egress-Policy-Name
Sun Jul 27 11:51:59 2003 : Error: rlm_sql (sql1): Error getting data
from database
Sun Jul 27 11:51:59 2003 : Debug: radius_xlat: ''
Sun Jul 27 11:51:59 2003 : Debug: rlm_sql (sql1): Released sql socket
id: 1
Sun Jul 27 11:51:59 2003 : Debug: modcall[authorize]: module "sql1"
returns ok
Sun Jul 27 11:51:59 2003 : Debug: modcall: group redundant returns ok
Sun Jul 27 11:51:59 2003 : Debug: modcall: group authorize returns ok
Sun Jul 27 11:51:59 2003 : Debug: rad_check_password: Found Auth-Type
System
Sun Jul 27 11:51:59 2003 : Debug: auth: type Crypt
Sending Access-Accept of id 147 to 194.170.195.10:44606
Port-Limit == 1
Sun Jul 27 11:51:59 2003 : Debug: Finished request 0
Sun Jul 27 11:51:59 2003 : Debug: Going to the next request
Sun Jul 27 11:51:59 2003 : Debug: Thread 1 waiting to be assigned a
request
Sun Jul 27 11:52:04 2003 : Debug: --- Walking the entire request list
---
Sun Jul 27 11:52:04 2003 : Debug: Threads: total/active/spare threads =
5/0/5
Sun Jul 27 11:52:04 2003 : Debug: Waking up in 1 seconds...
Sun Jul 27 11:52:05 2003 : Debug: --- Walking the entire request list
---
Sun Jul 27 11:52:05 2003 : Debug: Cleaning up request 0 ID 147 with
timestamp 3f23849f
Sun Jul 27 11:52:05 2003 : Debug: Nothing to do. Sleeping until we see
a request.
While testing with a 64-bit client as:
./radclient xxx.xxx.xxx.xxx auth secret < test_auth
the server is not responding and I got the following:
rad_recv: Access-Request packet from host 194.170.195.10:44607, id=163,
length=87
Sun Jul 27 11:52:36 2003 : Debug: Thread 2 assigned request 1
Sun Jul 27 11:52:36 2003 : Debug: --- Walking the entire request list
---
Sun Jul 27 11:52:36 2003 : Debug: Threads: total/active/spare threads =
5/1/4
Sun Jul 27 11:52:36 2003 : Debug: Waking up in 5 seconds...
Sun Jul 27 11:52:36 2003 : Debug: Thread 2 handling request 1, (1
handled so far)
User-Name = "user101"
User-Password = "[EMAIL PROTECTED]"
NAS-IP-Address = xxx.xxx.xxx.xxx
NAS-Port = 0
NAS-Port-Type = Async
Service-Type = Framed-User
Framed-Protocol = PPP
Sun Jul 27 11:52:36 2003 : Debug: modcall: entering group authorize
Sun Jul 27 11:52:36 2003 : Debug: modcall[authorize]: module
"preprocess" returns ok
Sun Jul 27 11:52:36 2003 : Debug: modcall[authorize]: module "chap"
returns noop
Sun Jul 27 11:52:36 2003 : Debug: rlm_realm: No '@' in User-Name =
"user101", looking up realm NULL
Sun Jul 27 11:52:36 2003 : Debug: rlm_realm: No such realm "NULL"
Sun Jul 27 11:52:36 2003 : Debug: modcall[authorize]: module "suffix"
returns noop
Sun Jul 27 11:52:36 2003 : Debug: users: Matched DEFAULT at 152
Sun Jul 27 11:52:36 2003 : Debug: users: Matched DEFAULT at 171
Sun Jul 27 11:52:36 2003 : Debug: users: Matched DEFAULT at 183
Sun Jul 27 11:52:36 2003 : Debug: modcall[authorize]: module "files"
returns ok
Sun Jul 27 11:52:36 2003 : Debug: modcall[authorize]: module "mschap"
returns noop
Sun Jul 27 11:52:36 2003 : Debug: modcall: entering group redundant
Sun Jul 27 11:52:36 2003 : Debug: radius_xlat: 'user101'
Sun Jul 27 11:52:36 2003 : Debug: rlm_sql (sql1): sql_set_user escaped
user --> 'user101'
Sun Jul 27 11:52:36 2003 : Debug: radius_xlat: 'SELECT
id,user_id,Attribute,pwd_Value, op FROM user_profile_new WHERE user_id =
'user101' AND Status = 'W' AND NVL(CALLING_STATION_ID, '041234567') =
'041234567' ORDER BY id'
Sun Jul 27 11:52:36 2003 : Debug: rlm_sql (sql1): Reserving sql socket
id: 0
Sun Jul 27 11:52:36 2003 : Error: rlm_sql: The 'op' field for attribute
'Crypt-Password = cUTAc33b3ghLs' is NULL, or non-existent.
Sun Jul 27 11:52:36 2003 : Error: rlm_sql: You MUST FIX THIS if you want
the configuration to behave as you expect.
Sun Jul 27 11:52:36 2003 : Debug: radius_xlat: ''
Sun Jul 27 11:52:36 2003 : Debug: radius_xlat: 'SELECT 0
id,User_id,Attribute_name,Attribute_Value, '' op FROM
user_Attributes_new WHERE User_id = 'user101''
Sun Jul 27 11:52:36 2003 : Error: rlm_sql: The 'op' field for attribute
'Port-Limit = 1' is NULL, or non-existent.
Sun Jul 27 11:52:36 2003 : Error: rlm_sql: You MUST FIX THIS if you want
the configuration to behave as you expect.
Sun Jul 27 11:52:36 2003 : Error: rlm_sql: unknown attribute
Unisphere-Egress-Policy-Name
Sun Jul 27 11:52:36 2003 : Error: rlm_sql (sql1): Error getting data
from database
Sun Jul 27 11:52:36 2003 : Debug: radius_xlat: ''
Sun Jul 27 11:52:36 2003 : Debug: rlm_sql (sql1): Released sql socket
id: 0
Sun Jul 27 11:52:36 2003 : Debug: modcall[authorize]: module "sql1"
returns ok
Sun Jul 27 11:52:36 2003 : Debug: modcall: group redundant returns ok
Sun Jul 27 11:52:36 2003 : Debug: modcall: group authorize returns ok
Sun Jul 27 11:52:36 2003 : Debug: rad_check_password: Found Auth-Type
System
Sun Jul 27 11:52:36 2003 : Debug: auth: type Crypt
Sun Jul 27 11:52:36 2003 : Debug: auth: Failed to validate the user.
Sun Jul 27 11:52:36 2003 : Debug: WARNING: Unprintable characters in
the password. ? Double-check the shared secret on the server and the
NAS!
Sun Jul 27 11:52:36 2003 : Debug: Delaying request 1 for 1 seconds
Sun Jul 27 11:52:36 2003 : Debug: Finished request 1
Sun Jul 27 11:52:36 2003 : Debug: Going to the next request
Sun Jul 27 11:52:36 2003 : Debug: Thread 2 waiting to be assigned a
request
Sun Jul 27 11:52:41 2003 : Debug: --- Walking the entire request list
---
Sun Jul 27 11:52:41 2003 : Debug: Threads: total/active/spare threads =
5/0/5
Sending Access-Reject of id 163 to 194.170.195.10:44607
Sun Jul 27 11:52:41 2003 : Debug: Waking up in 1 seconds...
Sun Jul 27 11:52:42 2003 : Debug: --- Walking the entire request list
---
Sun Jul 27 11:52:42 2003 : Debug: Cleaning up request 1 ID 163 with
timestamp 3f2384c4
Sun Jul 27 11:52:42 2003 : Debug: Nothing to do. Sleeping until we see
a request.
Appreciate your kind help.
Regards
------------------------------------------------------------------------
-------------------
Yasser Ahmed Hosny
-
List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
