I have a bug prone setup, but here goes:
Solaris 2.9 with:
Freeradius-1.0.0-pre2 and/or Freeradius-0.9.3
unixODBC 2.2.8
freetds 0.62.3
trying to connect to:
MSSQL 7.0 Database via unixODBC
I can use tsql and isql to query the database with the select
statements I've written and I have the exact same setup working in
production on two debian linux boxes, so I know that it "can" work.
Anyway, the first radtest I do here's what happens:
Wed Jun 16 16:01:26 2004 : Info: Ready to process requests.
Wed Jun 16 16:01:26 2004 : Debug: Thread 1 waiting to be assigned a request
Wed Jun 16 16:01:26 2004 : Debug: Thread 2 waiting to be assigned a request
Wed Jun 16 16:01:26 2004 : Debug: Thread 3 waiting to be assigned a request
Wed Jun 16 16:01:26 2004 : Debug: Thread 4 waiting to be assigned a request
Wed Jun 16 16:01:26 2004 : Debug: Thread 5 waiting to be assigned a request
rad_recv: Access-Request packet from host 127.0.0.1:32995, id=78, length=57
Wed Jun 16 16:01:54 2004 : Debug: --- Walking the entire request list ---
Wed Jun 16 16:01:54 2004 : Debug: Waking up in 31 seconds...
Wed Jun 16 16:01:54 2004 : Debug: Threads: total/active/spare threads = 5/0/5
Wed Jun 16 16:01:54 2004 : Debug: Thread 5 got semaphore
Wed Jun 16 16:01:54 2004 : Debug: Thread 5 handling request 0, (1
handled so far)
User-Name = "steve"
User-Password = "testing"
NAS-IP-Address = 255.255.255.255
NAS-Port = 123
Wed Jun 16 16:01:54 2004 : Debug: Processing the authorize section
of radiusd.conf
Wed Jun 16 16:01:54 2004 : Debug: modcall: entering group authorize
for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: calling
preprocess (rlm_preprocess) for request 0
Wed Jun 16 16:01:54 2004 : Error: Invalid operator for item Suffix:
reverting to '=='
Wed Jun 16 16:01:54 2004 : Error: Invalid operator for item Suffix:
reverting to '=='
Wed Jun 16 16:01:54 2004 : Error: Invalid operator for item Suffix:
reverting to '=='
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: returned
from preprocess (rlm_preprocess) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modcall[authorize]: module
"preprocess" returns ok for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: calling chap
(rlm_chap) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: returned
from chap (rlm_chap) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modcall[authorize]: module "chap"
returns noop for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: calling
suffix (rlm_realm) for request 0
Wed Jun 16 16:01:54 2004 : Debug: rlm_realm: No '@' in User-Name =
"steve", looking up realm NULL
Wed Jun 16 16:01:54 2004 : Debug: rlm_realm: No such realm "NULL"
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: returned
from suffix (rlm_realm) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modcall[authorize]: module
"suffix" returns noop for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: calling
files (rlm_files) for request 0
Wed Jun 16 16:01:54 2004 : Debug: users: Matched steve at 80
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: returned
from files (rlm_files) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modcall[authorize]: module "files"
returns ok for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: calling
mschap (rlm_mschap) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: returned
from mschap (rlm_mschap) for request 0
Wed Jun 16 16:01:54 2004 : Debug: modcall[authorize]: module
"mschap" returns noop for request 0
Wed Jun 16 16:01:54 2004 : Debug: modsingle[authorize]: calling sql
(rlm_sql) for request 0
Wed Jun 16 16:01:54 2004 : Debug: radius_xlat: 'steve'
Wed Jun 16 16:01:54 2004 : Debug: rlm_sql (sql): sql_set_user escaped
user --> 'steve'
Wed Jun 16 16:01:54 2004 : Debug: radius_xlat: 'SELECT
id,UserName,Attribute,Value,op FROM freeradAuthCheck WHERE Username =
'steve' ORDER BY id'
Wed Jun 16 16:01:54 2004 : Debug: rlm_sql (sql): Reserving sql socket id: 4
Wed Jun 16 16:01:54 2004 : Debug: query: SELECT
id,UserName,Attribute,Value,op FROM freeradAuthCheck WHERE Username =
'steve' ORDER BY id
Wed Jun 16 16:02:23 2004 : Error: no memory
between the sql query and the no memory statement it eats up a crap
load of memory and makes the server unresponsive, but due to good
error handling I guess it kills itself gracefully.
Obviously 0.9.3 and 1.0.0-pre2 have the problem, I didn't check past
that. I know it involves my unixodbc/freetds, but using isql doesn't
cause these errors. Can anyone tell me what sort of commands I can do
to bring to light more of what's going on.
-
List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
