[Freeswitch-users] mod_radius_cdr does not work

Tue Aug 2 10:53:38 MSD 2011

Dear All,

i'm trying to use mod_radius_cdr, and FS successfully loaded it, but when i
make a call, it show error below on console, could anyone can help? Thanks
in advance.

2011-08-02 14:45:32.786095 [ERR] mod_radius_cdr.c:242 failed adding
Freeswitch-Src: 1002

*debug level log on console:*

freeswitch at freeswitch> 2011-08-02 14:45:32.546104 [DEBUG] sofia.c:7030 IP
222.128.70.10 Rejected by acl "domains". Falling back to Digest auth.
2011-08-02 14:45:32.546104 [WARNING] sofia_reg.c:1337 SIP auth challenge
(INVITE) on sofia profile 'internal' for [1001 at 124.193.106.104] from ip
222.128.70.10
2011-08-02 14:45:32.786095 [DEBUG] sofia.c:7030 IP 222.128.70.10 Rejected by
acl "domains". Falling back to Digest auth.
2011-08-02 14:45:32.786095 [NOTICE] switch_channel.c:897 New Channel
sofia/internal/1002 at 124.193.106.104 [d8030a1e-552b-4a32-b7f0-175653b65eb7]
2011-08-02 14:45:32.786095 [DEBUG] sofia.c:5084 Channel sofia/internal/
1002 at 124.193.106.104 entering state [received][100]
2011-08-02 14:45:32.786095 [DEBUG] sofia.c:5095 Remote SDP:
v=0
o=- 186895328 186895344 IN IP4 192.168.200.100
s=eyeBeam
c=IN IP4 192.168.200.100
t=0 0
m=audio 6200 RTP/AVP 18 100 6 0 8 3 98 97 5 102 101
a=rtpmap:100 speex/16000
a=rtpmap:98 ilbc/8000
a=rtpmap:97 speex/8000
a=rtpmap:102 l16/16000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=alt:1 1 : 21373DA4 8CC12811 192.168.200.100 6200

2011-08-02 14:45:32.786095 [DEBUG] sofia.c:5258 (sofia/internal/
1002 at 124.193.106.104) State Change CS_NEW -> CS_INIT
2011-08-02 14:45:32.786095 [DEBUG] switch_core_session.c:1154 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:32.786095 [DEBUG] switch_core_state_machine.c:325
(sofia/internal/1002 at 124.193.106.104) Running State Change CS_INIT
2011-08-02 14:45:32.786095 [DEBUG] switch_core_state_machine.c:364
(sofia/internal/1002 at 124.193.106.104) State INIT
2011-08-02 14:45:32.786095 [DEBUG] mod_sofia.c:85 sofia/internal/
1002 at 124.193.106.104 SOFIA INIT
2011-08-02 14:45:32.786095 [DEBUG] mod_sofia.c:125 (sofia/internal/
1002 at 124.193.106.104) State Change CS_INIT -> CS_ROUTING
2011-08-02 14:45:32.786095 [DEBUG] switch_core_session.c:1154 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:32.786095 [DEBUG] switch_core_state_machine.c:364
(sofia/internal/1002 at 124.193.106.104) State INIT going to sleep
2011-08-02 14:45:32.786095 [DEBUG] switch_core_state_machine.c:325
(sofia/internal/1002 at 124.193.106.104) Running State Change CS_ROUTING
2011-08-02 14:45:32.786095 [DEBUG] switch_channel.c:1821 (sofia/internal/
1002 at 124.193.106.104) Callstate Change DOWN -> RINGING
2011-08-02 14:45:32.786095 [DEBUG] switch_core_state_machine.c:373
(sofia/internal/1002 at 124.193.106.104) State ROUTING
2011-08-02 14:45:32.786095 [DEBUG] mod_sofia.c:148 sofia/internal/
1002 at 124.193.106.104 SOFIA ROUTING
2011-08-02 14:45:32.786095 [DEBUG] mod_radius_cdr.c:156 [mod_radius_cdr]
Entering my_on_routing
2011-08-02 14:45:32.786095 [ERR] mod_radius_cdr.c:242 failed adding
Freeswitch-Src: 1002
2011-08-02 14:45:32.786095 [DEBUG] switch_core_state_machine.c:373
(sofia/internal/1002 at 124.193.106.104) State ROUTING going to sleep
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:855 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:855 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:855 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:36.185722 [DEBUG] sofia.c:5084 Channel sofia/internal/
1002 at 124.193.106.104 entering state [terminated][487]
2011-08-02 14:45:36.185722 [DEBUG] switch_channel.c:2739 (sofia/internal/
1002 at 124.193.106.104) Callstate Change RINGING -> HANGUP
2011-08-02 14:45:36.185722 [NOTICE] sofia.c:5806 Hangup sofia/internal/
1002 at 124.193.106.104 [CS_ROUTING] [ORIGINATOR_CANCEL]
2011-08-02 14:45:36.185722 [DEBUG] switch_channel.c:2755 Send signal
sofia/internal/1002 at 124.193.106.104 [KILL]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:1154 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:325
(sofia/internal/1002 at 124.193.106.104) Running State Change CS_HANGUP
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:575
(sofia/internal/1002 at 124.193.106.104) State HANGUP
2011-08-02 14:45:36.185722 [DEBUG] mod_sofia.c:452 sofia/internal/
1002 at 124.193.106.104 Overriding SIP cause 487 with 487 from the other leg
2011-08-02 14:45:36.185722 [DEBUG] mod_sofia.c:458 Channel sofia/internal/
1002 at 124.193.106.104 hanging up, cause: ORIGINATOR_CANCEL
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:46
sofia/internal/1002 at 124.193.106.104 Standard HANGUP, cause:
ORIGINATOR_CANCEL
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:575
(sofia/internal/1002 at 124.193.106.104) State HANGUP going to sleep
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:356
(sofia/internal/1002 at 124.193.106.104) State Change CS_HANGUP -> CS_REPORTING
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:1154 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:325
(sofia/internal/1002 at 124.193.106.104) Running State Change CS_REPORTING
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:635
(sofia/internal/1002 at 124.193.106.104) State REPORTING
2011-08-02 14:45:36.185722 [DEBUG] mod_radius_cdr.c:424 [mod_radius_cdr]
Entering my_on_reporting
2011-08-02 14:45:36.185722 [ERR] mod_radius_cdr.c:463 failed adding
Freeswitch-Hangupcause: 487
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:635
(sofia/internal/1002 at 124.193.106.104) State REPORTING going to sleep
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:350
(sofia/internal/1002 at 124.193.106.104) State Change CS_REPORTING ->
CS_DESTROY
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:1154 Send signal
sofia/internal/1002 at 124.193.106.104 [BREAK]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_session.c:1326 Session 2
(sofia/internal/1002 at 124.193.106.104) Locked, Waiting on external entities
2011-08-02 14:45:36.185722 [NOTICE] switch_core_session.c:1344 Session 2
(sofia/internal/1002 at 124.193.106.104) Ended
2011-08-02 14:45:36.185722 [NOTICE] switch_core_session.c:1346 Close Channel
sofia/internal/1002 at 124.193.106.104 [CS_DESTROY]
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:464
(sofia/internal/1002 at 124.193.106.104) Callstate Change HANGUP -> DOWN
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:467
(sofia/internal/1002 at 124.193.106.104) Running State Change CS_DESTROY
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:477
(sofia/internal/1002 at 124.193.106.104) State DESTROY
2011-08-02 14:45:36.185722 [DEBUG] mod_sofia.c:363 sofia/internal/
1002 at 124.193.106.104 SOFIA DESTROY
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:60
sofia/internal/1002 at 124.193.106.104 Standard DESTROY
2011-08-02 14:45:36.185722 [DEBUG] switch_core_state_machine.c:477
(sofia/internal/1002 at 124.193.106.104) State DESTROY going to sleep

Regards,
Charles
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20110802/30a31642/attachment.html 