[asterisk-users] Duplicate Radius accounting in Asterisk.

Fri Jan 30 12:32:39 CST 2009

Hello list.

I'm having some problems with the CDR Radius in my Asterisk 1.4.  I'm
using two TC400B cards for transcoding.  When I reach nearly 100
simmultaneous calls, the CDR radius packets are being duplicated and I'm
getting this message in the asterisk console : 

cdr_radius.c:227 radius_log: Failed to record Radius CDR record!

I'm also using the radiusclient-ng 0.5.6 to interact with the radius
server.

What I'm seeing in the radius server side are 3 radius packets reaching
at almost the same time.  Please look at the debug:

Fri Jan 30 23:34:08 1998: DEBUG: Packet dump:

*** Received from 10.10.149.211 port 56844 ....

Code:       Accounting-Request

Identifier: 129

Authentic:  <237>U<254>W<129><156><159>D<153>A$<209><233>`G<9>

Attributes:

        Acct-Status-Type = Stop

        Asterisk-Acc-Code = "TO_PROVIDER"

        Asterisk-Src = "5502222272"

        Asterisk-Dst = "0130005411234618"

        Asterisk-Dst-Ctx = "INC_CALLS"

        Asterisk-Clid = ""sipp" <5502222272>"

        Asterisk-Chan = "SIP/5060-0972ae58"

        Asterisk-Dst-Chan = "SIP/TO_ITSP1-0972f830"

        Asterisk-Last-App = "Dial"

        Asterisk-Last-Data = "SIP/005411234618 at TO_ITSP1"

        Asterisk-Start-Time = "2009-01-30 14:51:23 +0000"

        Asterisk-Answer-Time = "2009-01-30 14:51:28 +0000"

        Asterisk-End-Time = "2009-01-30 14:52:50 +0000"

        Asterisk-Duration = 87

        Asterisk-Bill-Sec = 82

        Asterisk-Disposition = "ANSWERED"

        Asterisk-AMA-Flags = "DOCUMENTATION"

        Asterisk-Unique-ID = "1233327083.102"

        Asterisk-User-Field = "B2BUA-PROVIDER-PRUEBAS"

        User-Name = "SIP/5060-0972ae58"

        Acct-Session-Id = "1233327083.102"

        NAS-Port = 0

        Acct-Delay-Time = 0

        NAS-IP-Address = 10.10.149.211

Fri Jan 30 23:34:08 1998: DEBUG: Handling request with Handler
'Request-Type = Accounting-Request'

Fri Jan 30 23:34:08 1998: DEBUG:  Deleting session for
SIP/5060-0972ae58, 10.10.149.211, 0

Fri Jan 30 23:34:08 1998: DEBUG: Handling with AuthINTERNAL:

Fri Jan 30 23:34:08 1998: DEBUG: AuthBy INTERNAL result: ACCEPT, Fixed
by DefaultResult

Fri Jan 30 23:34:08 1998: DEBUG: Accounting accepted

Fri Jan 30 23:34:08 1998: DEBUG: Packet dump:

*** Sending to 10.10.149.211 port 56844 ....

Code:       Accounting-Response

Identifier: 129

Authentic:  <237>U<254>W<129><156><159>D<153>A$<209><233>`G<9>

Attributes:

Fri Jan 30 23:34:08 1998: DEBUG: Packet dump:

*** Received from 10.10.149.211 port 56844 ....

Code:       Accounting-Request

Identifier: 129

Authentic:  <237>U<254>W<129><156><159>D<153>A$<209><233>`G<9>

Attributes:

        Acct-Status-Type = Stop

        Asterisk-Acc-Code = "TO_PROVIDER"

        Asterisk-Src = "5502222272"

        Asterisk-Dst = "0130005411234618"

        Asterisk-Dst-Ctx = "INC_CALLS"

        Asterisk-Clid = ""sipp" <5502222272>"

        Asterisk-Chan = "SIP/5060-0972ae58"

        Asterisk-Dst-Chan = "SIP/TO_ITSP1-0972f830"

        Asterisk-Last-App = "Dial"

        Asterisk-Last-Data = "SIP/005411234618 at TO_ITSP1"

        Asterisk-Start-Time = "2009-01-30 14:51:23 +0000"

        Asterisk-Answer-Time = "2009-01-30 14:51:28 +0000"

        Asterisk-End-Time = "2009-01-30 14:52:50 +0000"

        Asterisk-Duration = 87

        Asterisk-Bill-Sec = 82

        Asterisk-Disposition = "ANSWERED"

        Asterisk-AMA-Flags = "DOCUMENTATION"

        Asterisk-Unique-ID = "1233327083.102"

        Asterisk-User-Field = "B2BUA-PROVIDER-PRUEBAS"

        User-Name = "SIP/5060-0972ae58"

        Acct-Session-Id = "1233327083.102"

        NAS-Port = 0

        Acct-Delay-Time = 0

        NAS-IP-Address = 10.10.149.211

Fri Jan 30 23:34:08 1998: INFO: Duplicate request id 129 received from
10.10.149.211(56844): ignored

Fri Jan 30 23:34:08 1998: DEBUG: Packet dump:

*** Received from 10.10.149.211 port 56844 ....

Code:       Accounting-Request

Identifier: 129

Authentic:  <237>U<254>W<129><156><159>D<153>A$<209><233>`G<9>

Attributes:

        Acct-Status-Type = Stop

        Asterisk-Acc-Code = "TO_PROVIDER"

        Asterisk-Src = "5502222272"

        Asterisk-Dst = "0130005411234618"

        Asterisk-Dst-Ctx = "INC_CALLS"

        Asterisk-Clid = ""sipp" <5502222272>"

        Asterisk-Chan = "SIP/5060-0972ae58"

        Asterisk-Dst-Chan = "SIP/TO_ITSP1-0972f830"

        Asterisk-Last-App = "Dial"

        Asterisk-Last-Data = "SIP/005411234618 at TO_ITSP1"

        Asterisk-Start-Time = "2009-01-30 14:51:23 +0000"

        Asterisk-Answer-Time = "2009-01-30 14:51:28 +0000"

        Asterisk-End-Time = "2009-01-30 14:52:50 +0000"

        Asterisk-Duration = 87

        Asterisk-Bill-Sec = 82

        Asterisk-Disposition = "ANSWERED"

        Asterisk-AMA-Flags = "DOCUMENTATION"

        Asterisk-Unique-ID = "1233327083.102"

        Asterisk-User-Field = "B2BUA-PROVIDER-PRUEBAS"

        User-Name = "SIP/5060-0972ae58"

        Acct-Session-Id = "1233327083.102"

        NAS-Port = 0

        Acct-Delay-Time = 0

        NAS-IP-Address = 10.10.149.211

Fri Jan 30 23:34:08 1998: INFO: Duplicate request id 129 received from
10.10.149.211(56844): ignored

I don't understand why this always happened when I reach 100 simm calls
and above.

It seems that asterisk is sending the 3 packets but I do not why.

Hope someone can help me.

Regards,

Ricardo.-

-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20090130/578cabf8/attachment.htm 