I've been getting bombarded with old acct info, and looking into it, I
believe the reason the NAS keeps sending the same info over and over again,
is because radiusd isn't sending back any accounting-response.
Here is the debug output, I do notice that the session time is zero and
radiusd doesn't like that, but would that prevent radiusd from sending back
an accounting-response?
rad_recv: Accounting-Request packet from host 198.88.216.4 port 1647,
id=141, length=278
Event-Timestamp = "Jul 13 2007 17:12:30 CDT"
User-Name = "[EMAIL PROTECTED]"
NAS-IP-Address = 204.42.16.5
NAS-Identifier = "tnt1.core.peoria.il.bwsys.net"
NAS-Port = 1429
NAS-Port-Type = Async
Service-Type = Framed-User
Acct-Status-Type = Stop
Acct-Delay-Time = 13813416
Acct-Session-Id = "439719181"
Acct-Terminate-Cause = NAS-Request
X-Ascend-Disconnect-Cause = Unknown
X-Ascend-Connect-Progress = IPNCP-Opening
X-Ascend-PreSession-Time = 27
X-Ascend-Pre-Input-Octets = 352
X-Ascend-Pre-Output-Octets = 349
X-Ascend-Pre-Input-Packets = 11
X-Ascend-Pre-Output-Packets = 13
X-Ascend-Data-Rate = 28800
X-Ascend-Xmit-Rate = 37333
X-Ascend-Multilink-ID = 268768248
X-Ascend-Num-In-Multilink = 0
Acct-Link-Count = 1
Acct-Multi-Session-Id = "100513f8"
X-Ascend-Modem-PortNo = 31
X-Ascend-Modem-SlotNo = 15
X-Ascend-Modem-ShelfNo = 1
X-Ascend-Data-Svc = Switched-Voice-Bearer
Framed-Protocol = Ascend-MP
Framed-IP-Address = 0.0.0.0
Proxy-State = 0x3139
Processing the preacct section of radiusd.conf
modcall: entering group preacct for request 2209
rlm_acct_unique: WARNING: Attribute Client-IP-Address was not found in
request, unique ID MAY be inconsistent
rlm_acct_unique: Hashing 'NAS-Port = 1429,,NAS-IP-Address =
204.42.16.5,Acct-Session-Id = "439719181",User-Name = "[EMAIL PROTECTED]"'
rlm_acct_unique: Acct-Unique-Session-ID = "a9c91b40cff69183".
rlm_realm: Looking up realm "illicom.net" for User-Name =
"[EMAIL PROTECTED]"
rlm_realm: Found realm "illicom.net"
rlm_realm: Adding Stripped-User-Name = "spierce"
rlm_realm: Proxying request from user spierce to realm illicom.net
rlm_realm: Adding Realm = "illicom.net"
rlm_realm: Accounting realm is LOCAL.
rlm_realm: Request already proxied. Ignoring.
modcall: group preacct returns noop for request 2209
Processing the accounting section of radiusd.conf
modcall: entering group accounting for request 2209
radius_xlat: 'spierce'
rlm_sql (conxxus): sql_set_user escaped user --> 'spierce'
radius_xlat: ' update radacct set AcctStopTime
= dateadd(second,-13813416,convert(datetime,'2007-12-20 12:16:43')),
AcctSessionTime = '', AcctStatusType = 'Stop',
AcctInputOctets = '0', AcctOutputOctets = '0',
AcctInputPackets = '0', AcctOutputPackets = '0',
AcctTerminateCause = 'NAS-Request',
AscendDisconnectCause = 'Unknown', AscendDataRate =
'28800', AscendXmitRate = '37333' where
AcctSessionId = '439719181' and UserName = 'spierce'
and NASIPAddress = '204.42.16.5' and isnull(AcctStopTime,0) =
0 '
rlm_sql (conxxus): Reserving sql socket id: 4
radius_xlat: 'stop packet with zero session length. [user
'[EMAIL PROTECTED]', nas '204.42.16.5']'
rlm_sql (conxxus) in sql_accounting: stop packet with zero session length.
[user '[EMAIL PROTECTED]', nas '204.42.16.5']
rlm_sql (conxxus): Released sql socket id: 4
radius_xlat: ' insert into radacct
(AcctSessionId, AcctUniqueId, UserName,
Realm, NASIPAddress, NASIdentifier,
NASPort, NASPortType, AcctStartTime,
AcctStopTime, AcctSessionTime,
AcctAuthentic, AcctStatusType,
AcctInputOctets, AcctOutputOctets,
AcctInputPackets, AcctOutputPackets,
AcctTerminateCause, AscendDisconnectCause,
AscendModemShelf, AscendModemSlot,
AscendModemPort, AscendDataRate,
AscendXmitRate, CalledStationId,
CallingStationId, ServiceType,
FramedProtocol, FramedIPAddress) values
('439719181', 'a9c91b40cff69183',
'spierce', 'illicom.net', '204.42.16.5',
'tnt1.core.peoria.il.bwsys.net', '1429',
'Async', dateadd(second,-13813416-0,convert(datetime,'2007-12-20
12:16:43')),
dateadd(second,-13813416,convert(datetime,'2007-12-20 12:16:43')),
'', '', 'Stop', '0',
'0', '0', '0',
'NAS-Request', 'Unknown', '1',
'15', '31', '28800',
'37333', '', '',
'Framed-User', 'Ascend-MP', '0.0.0.0')
'
rlm_sql (conxxus): Released sql socket id: 4
modcall: group accounting returns noop for request 2209
Finished request 2209
Going to the next request
-
List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
