Dear all,

I am running Freeradius version 0.8.1 (snapshot 20030525) on Solaris 8
and having two Oracle Databases version 8i as Authentication and
Accounting back ends, worth to mention that the two DB are working as
fail-over to each other.
While sending Authentication requests and bringing one of the DB down,
the Freeradius keeps authenticating users from the other DB correctly,
this is perfect. But the problem is with accounting, I am sending one
Start accounting packet and got the reply from the primary DB, I brought
the Primary DB down, then I've sent another accounting packet, the
radius dies after detecting the DB is down. Below is part of the Debug
messages generated from Freeradius.

Any help would be highly appreciated.

rad_recv: Accounting-Request packet from host 194.170.127.242:45512,
id=66, length=107
Tue Jun 10 13:39:11 2003 : Debug: Thread 1 assigned request 0
Tue Jun 10 13:39:11 2003 : Debug: --- Walking the entire request list
---
Tue Jun 10 13:39:11 2003 : Debug: Threads: total/active/spare threads =
5/1/4
Tue Jun 10 13:39:11 2003 : Debug: Nothing to do.  Sleeping until we see
a request.
Tue Jun 10 13:39:11 2003 : Debug: Thread 1 handling request 0, (1
handled so far)
        User-Name = "eim1"
        User-Password = "Z\262 [EMAIL PROTECTED]"
        NAS-IP-Address = 194.170.127.204
        NAS-Port = 1234
        NAS-Port-Type = Async
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Calling-Station-Id = "2305809"
        Acct-Session-Id = "3790948411"
        Acct-Status-Type = Start
        Acct-Delay-Time = 0
Tue Jun 10 13:39:11 2003 : Debug: modcall: entering group accounting
Tue Jun 10 13:39:11 2003 : Debug: radius_xlat:  '/rad/hostdev/detail'
Tue Jun 10 13:39:11 2003 : Debug: rlm_detail: /rad/%C/detail expands to
/rad/hostdev/detail
Tue Jun 10 13:39:11 2003 : Debug:   modcall[accounting]: module "detail"
returns ok
Tue Jun 10 13:39:11 2003 : Debug: modcall: entering group redundant
Tue Jun 10 13:39:11 2003 : Debug: radius_xlat:  'eim1'
Tue Jun 10 13:39:11 2003 : Debug: rlm_sql (sql2): sql_set_user escaped
user --> 'eim1'
Tue Jun 10 13:39:11 2003 : Debug: radius_xlat:  'INSERT into RADACCT
(RadAcctId, 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('', '3790948411', '', 'eim1',
'','194.170.127.204', '1234', 'Async',
TO_DATE('2003-06-1013:39:11','yyyy-mm-dd hh24:mi:ss'), '', '0', '', '',
'', '0', '0', '','2305809', '', 'Framed-User', 'PPP', '', '0', '0')'
Tue Jun 10 13:39:11 2003 : Debug: rlm_sql (sql2): Reserving sql socket
id: 4
Tue Jun 10 13:39:11 2003 : Debug: rlm_sql (sql2): Released sql socket
id: 4
Tue Jun 10 13:39:11 2003 : Debug:   modcall[accounting]: module "sql2"
returns ok
Tue Jun 10 13:39:11 2003 : Debug: modcall: group redundant returns ok
Tue Jun 10 13:39:11 2003 : Debug: modcall: group accounting returns ok
Sending Accounting-Response of id 66 to 194.170.127.242:45512
Tue Jun 10 13:39:11 2003 : Debug: Finished request 0
Tue Jun 10 13:39:11 2003 : Debug: Going to the next request
Tue Jun 10 13:39:11 2003 : Debug: Thread 1 waiting to be assigned a
request
rad_recv: Accounting-Request packet from host 194.170.127.242:45514,
id=68, length=107
Tue Jun 10 13:41:40 2003 : Debug: Thread 2 assigned request 1
Tue Jun 10 13:41:40 2003 : Debug: --- Walking the entire request list
---
Tue Jun 10 13:41:40 2003 : Debug: Cleaning up request 0 ID 66 with
timestamp 3ee5a73f
Tue Jun 10 13:41:40 2003 : Debug: Nothing to do.  Sleeping until we see
a request.
Tue Jun 10 13:41:40 2003 : Debug: Thread 2 handling request 1, (1
handled so far)
        User-Name = "eim1"
        User-Password = "[EMAIL PROTECTED]"
        NAS-IP-Address = 194.170.127.204
        NAS-Port = 1234
        NAS-Port-Type = Async
        Service-Type = Framed-User
        Framed-Protocol = PPP
        Calling-Station-Id = "2305809"
        Acct-Session-Id = "3790948411"
        Acct-Status-Type = Start
        Acct-Delay-Time = 0
Tue Jun 10 13:41:40 2003 : Debug: modcall: entering group accounting
Tue Jun 10 13:41:40 2003 : Debug: radius_xlat:  '/rad/hostdev/detail'
Tue Jun 10 13:41:40 2003 : Debug: rlm_detail: /rad/%C/detail expands to
/rad/hostdev/detail
Tue Jun 10 13:41:40 2003 : Debug:   modcall[accounting]: module "detail"
returns ok
Tue Jun 10 13:41:40 2003 : Debug: modcall: entering group redundant
Tue Jun 10 13:41:40 2003 : Debug: radius_xlat:  'eim1'
Tue Jun 10 13:41:40 2003 : Debug: rlm_sql (sql2): sql_set_user escaped
user --> 'eim1'
Tue Jun 10 13:41:40 2003 : Debug: radius_xlat:  'INSERT into RADACCT
(RadAcctId, 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('', '3790948411', '', 'eim1', '',
'194.170.127.204', '1234', 'Async', TO_DATE('2003-06-10
13:41:40','yyyy-mm-dd hh24:mi:ss'), '', '0', '', '', '', '0', '0', '',
'2305809', '', 'Framed-User', 'PPP', '', '0', '0')'
Tue Jun 10 13:41:40 2003 : Debug: rlm_sql (sql2): Reserving sql socket
id: 3
Tue Jun 10 13:41:40 2003 : Error: rlm_sql_oracle: execute query failed
in sql_query: ORA-03113: end-of-file on communication channel 
Tue Jun 10 13:41:40 2003 : Debug: rlm_sql (sql2): Attempting to connect
rlm_sql_oracle #3
Tue Jun 10 13:41:40 2003 : Debug: --- Walking the entire request list
---
Tue Jun 10 13:41:40 2003 : Debug: Nothing to do.  Sleeping until we see
a request.
Tue Jun 10 13:41:40 2003 : Error: rlm_sql_oracle: Oracle logon failed:
'ORA-01034: ORACLE not available ORA-27101: shared memory realm does not
exist SVR4 Error: 2: No such file or directory '
Tue Jun 10 13:41:40 2003 : Error: rlm_sql (sql2): Failed to connect DB
handle #3
Tue Jun 10 13:41:40 2003 : Error: rlm_sql (sql2): reconnect failed,
database down?
Segmentation Fault

Regards

Yasser Ahmed Hosny




- 
List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html

Reply via email to