Tue Jun 14 11:52:19 2005 : Debug: Thread 1 handling request 5, (2 handled so far) User-Name = "-----------" User-Password = "-------" Service-Type = Framed-User Framed-Protocol = PPP NAS-IP-Address = ------ NAS-Port = 14 NAS-Port-Type = ISDN Tue Jun 14 11:52:19 2005 : Debug: Processing the authorize section of radiusd.conf Tue Jun 14 11:52:19 2005 : Debug: modcall: entering group authorize for request 5 Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: calling preprocess (rlm_preprocess) for request 5Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: returned from preprocess (rlm_preprocess) for request 5 Tue Jun 14 11:52:19 2005 : Debug: modcall[authorize]: module "preprocess" returns ok for request 5 Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: calling chap (rlm_chap) for request 5 Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: returned from chap (rlm_chap) for request 5 Tue Jun 14 11:52:19 2005 : Debug: modcall[authorize]: module "chap" returns noop for request 5 Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: calling suffix (rlm_realm) for request 5 Tue Jun 14 11:52:19 2005 : Debug: rlm_realm: No '@' in User-Name = "-----------", looking up realm NULL Tue Jun 14 11:52:19 2005 : Debug: rlm_realm: No such realm "NULL" Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: returned from suffix (rlm_realm) for request 5 Tue Jun 14 11:52:19 2005 : Debug: modcall[authorize]: module "suffix" returns noop for request 5 Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: calling sql (rlm_sql) for request 5 Tue Jun 14 11:52:19 2005 : Debug: radius_xlat: '-----------' Tue Jun 14 11:52:19 2005 : Debug: rlm_sql (sql): sql_set_user escaped user --> '-----------' Tue Jun 14 11:52:19 2005 : Debug: radius_xlat: 'SELECT id,UserName,Attribute,Value,op FROM radcheck WHERE Username = '-----------' ORDER BY id' Tue Jun 14 11:52:19 2005 : Debug: rlm_sql (sql): Reserving sql socket id: 4 Tue Jun 14 11:52:19 2005 : Debug: radius_xlat: 'SELECT radgroupcheck.id,radgroupcheck.GroupName,radgroupcheck.Attribute,radgroupcheck.Value,radgroupcheck.op FROM radgroupcheck,usergroup WHERE usergroup.Username = '-----------' AND usergroup.GroupName = radgroupcheck.GroupName ORDER BY radgroupcheck.id' Tue Jun 14 11:52:19 2005 : Debug: radius_xlat: 'SELECT id,UserName,Attribute,Value,op FROM radreply WHERE Username = '-----------' ORDER BY id' Tue Jun 14 11:52:19 2005 : Debug: radius_xlat: 'SELECT radgroupreply.id,radgroupreply.GroupName,radgroupreply.Attribute,radgroupreply.Value,radgroupreply.op FROM radgroupreply,usergroup WHERE usergroup.Username = '-----------' AND usergroup.GroupName = radgroupreply.GroupName ORDER BY radgroupreply.id' Tue Jun 14 11:52:19 2005 : Debug: rlm_sql (sql): Released sql socket id: 4 Tue Jun 14 11:52:19 2005 : Debug: modsingle[authorize]: returned from sql (rlm_sql) for request 5 Tue Jun 14 11:52:19 2005 : Debug: modcall[authorize]: module "sql" returns ok for request 5 Tue Jun 14 11:52:19 2005 : Debug: modcall: group authorize returns ok for request 5 Tue Jun 14 11:52:19 2005 : Debug: rad_check_password: Found Auth-Type Local Tue Jun 14 11:52:19 2005 : Debug: auth: type Local Tue Jun 14 11:52:19 2005 : Debug: auth: user supplied User-Password does NOT match local User-Password Tue Jun 14 11:52:19 2005 : Debug: auth: Failed to validate the user. Tue Jun 14 11:52:19 2005 : Auth: Login incorrect: [-----------/------] (from client sisr port 14)