Hi Daniel,
 
Thanks for your advice.
I got the logs at the kamailio startup and the a call:
 
nathelper.so]
 0(19400) DEBUG: <core> [sr_module.c:871]: DEBUG: init_mod: nathelper
 0(19400) DEBUG: nathelper [nathelper.c:633]: url is udp:127.0.0.1:7722, len is 18
 0(19400) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (-127): nathelper
 1(19401) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (1): nathelper
 1(19401) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
 2(19402) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (2): nathelper
 2(19402) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
 3(19403) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (3): nathelper
 3(19403) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
 4(19404) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (4): nathelper
 4(19404) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
 5(19405) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (-1): nathelper
 5(19405) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
 6(19406) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (-1): nathelper
 6(19406) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
 0(19400) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (0): nathelper
 8(19408) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (-2): nathelper
 9(19409) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (-1): nathelper
 9(19409) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
10(19410) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (5): nathelper
10(19410) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
11(19411) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (6): nathelper
11(19411) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
12(19412) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (7): nathelper
12(19412) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
13(19413) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (8): nathelper
13(19413) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it enabled
14(19414) DEBUG: <core> [sr_module.c:807]: DEBUG: init_mod_child (-4): nathelper
 2(19402) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 2(19402) DEBUG: nathelper [nathelper.c:3196]: proxy reply: 48590 210.13.X.Y
 4(19404) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(19404) ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy
 4(19404) ERROR: nathelper [nathelper.c:2492]: proxy <udp:127.0.0.1:7722> does not respond, disable it
 4(19404) ERROR: nathelper [nathelper.c:3144]: no available proxies
 4(19404) ERROR: nathelper [nathelper.c:2627]: no available proxies
AppSer01:ipunity@/var/log$
AppSer01:ipunity@/var/log$
 
AppSer01:root@/$  /usr/local/bin/rtpproxy -f -u kamailio -l 210.13.X.Y -d DBUG -s udp:localhost:7722
INFO:main: rtpproxy started, pid 19177
DBUG:handle_command: received command "19401_0 V"
DBUG:doreply: sending reply "19401_0 20040107
"
DBUG:handle_command: received command "19401_1 VF 20050322"
DBUG:doreply: sending reply "19401_1 1
"
DBUG:handle_command: received command "19401_2 VF 20071116"
DBUG:doreply: sending reply "19401_2 1
"
DBUG:handle_command: received command "19402_0 V"
DBUG:doreply: sending reply "19402_0 20040107
"
DBUG:handle_command: received command "19402_1 VF 20050322"
DBUG:doreply: sending reply "19402_1 1
"
DBUG:handle_command: received command "19402_2 VF 20071116"
DBUG:doreply: sending reply "19402_2 1
"
DBUG:handle_command: received command "19401_3 VF 20081102"
DBUG:doreply: sending reply "19401_3 1
"
DBUG:handle_command: received command "19403_0 V"
DBUG:doreply: sending reply "19403_0 20040107
"
DBUG:handle_command: received command "19403_1 VF 20050322"
DBUG:doreply: sending reply "19403_1 1
"
DBUG:handle_command: received command "19403_2 VF 20071116"
DBUG:doreply: sending reply "19403_2 1
"
DBUG:handle_command: received command "19402_3 VF 20081102"
DBUG:doreply: sending reply "19402_3 1
"
DBUG:handle_command: received command "19403_3 VF 20081102"
DBUG:doreply: sending reply "19403_3 1
"
DBUG:handle_command: received command "19404_0 V"
DBUG:doreply: sending reply "19404_0 20040107
"
DBUG:handle_command: received command "19404_1 VF 20050322"
DBUG:doreply: sending reply "19404_1 1
"
DBUG:handle_command: received command "19404_2 VF 20071116"
DBUG:doreply: sending reply "19404_2 1
"
DBUG:handle_command: received command "19404_3 VF 20081102"
DBUG:doreply: sending reply "19404_3 1
"
DBUG:handle_command: received command "19405_0 V"
DBUG:doreply: sending reply "19405_0 20040107
"
DBUG:handle_command: received command "19405_1 VF 20050322"
DBUG:doreply: sending reply "19405_1 1
"
DBUG:handle_command: received command "19405_2 VF 20071116"
DBUG:doreply: sending reply "19405_2 1
"
DBUG:handle_command: received command "19405_3 VF 20081102"
DBUG:doreply: sending reply "19405_3 1
"
DBUG:handle_command: received command "19406_0 V"
DBUG:doreply: sending reply "19406_0 20040107
"
DBUG:handle_command: received command "19406_1 VF 20050322"
DBUG:doreply: sending reply "19406_1 1
"
DBUG:handle_command: received command "19406_2 VF 20071116"
DBUG:doreply: sending reply "19406_2 1
"
DBUG:handle_command: received command "19406_3 VF 20081102"
DBUG:doreply: sending reply "19406_3 1
"
DBUG:handle_command: received command "19409_0 V"
DBUG:doreply: sending reply "19409_0 20040107
"
DBUG:handle_command: received command "19409_1 VF 20050322"
DBUG:doreply: sending reply "19409_1 1
"
DBUG:handle_command: received command "19409_2 VF 20071116"
DBUG:doreply: sending reply "19409_2 1
"
DBUG:handle_command: received command "19410_0 V"
DBUG:doreply: sending reply "19410_0 20040107
"
DBUG:handle_command: received command "19410_1 VF 20050322"
DBUG:doreply: sending reply "19410_1 1
"
DBUG:handle_command: received command "19410_2 VF 20071116"
DBUG:doreply: sending reply "19410_2 1
"
DBUG:handle_command: received command "19409_3 VF 20081102"
DBUG:doreply: sending reply "19409_3 1
"
DBUG:handle_command: received command "19410_3 VF 20081102"
DBUG:doreply: sending reply "19410_3 1
"
DBUG:handle_command: received command "19411_0 V"
DBUG:doreply: sending reply "19411_0 20040107
"
DBUG:handle_command: received command "19411_1 VF 20050322"
DBUG:doreply: sending reply "19411_1 1
"
DBUG:handle_command: received command "19411_2 VF 20071116"
DBUG:doreply: sending reply "19411_2 1
"
DBUG:handle_command: received command "19411_3 VF 20081102"
DBUG:doreply: sending reply "19411_3 1
"
DBUG:handle_command: received command "19412_0 V"
DBUG:doreply: sending reply "19412_0 20040107
"
DBUG:handle_command: received command "19412_1 VF 20050322"
DBUG:doreply: sending reply "19412_1 1
"
DBUG:handle_command: received command "19412_2 VF 20071116"
DBUG:doreply: sending reply "19412_2 1
"
DBUG:handle_command: received command "19412_3 VF 20081102"
DBUG:doreply: sending reply "19412_3 1
"
DBUG:handle_command: received command "19413_0 V"
DBUG:doreply: sending reply "19413_0 20040107
"
DBUG:handle_command: received command "19413_1 VF 20050322"
DBUG:doreply: sending reply "19413_1 1
"
DBUG:handle_command: received command "19413_2 VF 20071116"
DBUG:doreply: sending reply "19413_2 1
"
DBUG:handle_command: received command "19413_3 VF 20081102"
DBUG:doreply: sending reply "19413_3 1
"
DBUG:handle_command: received command "19402_4 Uc18,101 NzQ3YWU0MTcxOGYzY2EwYjUwYTUyNWY3NzU0YzBiNmM. 116.237.74.228 5756 f41c0c28;1"
INFO:handle_command: new session NzQ3YWU0MTcxOGYzY2EwYjUwYTUyNWY3NzU0YzBiNmM., tag f41c0c28;1 requested, type strong
INFO:handle_command: new session on a port 48590 created, tag f41c0c28;1
INFO:handle_command: pre-filling caller's address with 116.237.74.228:5756
DBUG:doreply: sending reply "19402_4 48590 210.13.X.Y"

INFO:process_rtp: session timeout
INFO:remove_session: RTP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: RTCP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: session on ports 48590/0 is cleaned up

Thanks,
Kevin

Date: Fri, 6 Aug 2010 12:03:39 +0200
From: miconda@gmail.com
To: kevin.jzh@hotmail.com
CC: sr-users@lists.sip-router.org
Subject: Re: [SR-Users] Kamailio 3.0 cann't access the RTPProxy

Hello,

the commands for starting new sessions happen during calls, is the log from starting kamailio is or taken during testing with calls?

Is the rtpproxy used by many instance or just by one?

I suggest you take the log only at the time you start kamailio so we know exactly what is printed at that time.

Cheers,
Daniel


On 8/4/10 3:13 AM, KevinJin wrote:
Hi Daniel,
 
I have run the RTPProxy in debug model and get the following log, seems rtpproxy is responsding however nathelper is still disable it.
Please help what's wrong here.
 
Thanks,
Kevin
=======RTPProxy Log == Y.Z replaces the real IP======================
AppSer01:root@/$  /usr/local/bin/rtpproxy -f -u kamailio -l 210.13.Y.Z -d DBUG -s udp:localhost:7722
INFO:main: rtpproxy started, pid 28528
DBUG:handle_command: received command "15244_8 Uc18,101 OTIwMjRiMzYyZDU4ZjlkZDM3NWVmOWEwNmRlNjgyYzk. 116.237.74.228 53370 4729f84d;1"
INFO:handle_command: new session OTIwMjRiMzYyZDU4ZjlkZDM3NWVmOWEwNmRlNjgyYzk., tag 4729f84d;1 requested, type strong
INFO:handle_command: new session on a port 49092 created, tag 4729f84d;1
INFO:handle_command: pre-filling caller's address with 116.237.74.228:53370
DBUG:doreply: sending reply "15244_8 49092 210.13.Y.Z
"

INFO:process_rtp: session timeout
INFO:remove_session: RTP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: RTCP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: session on ports 49092/0 is cleaned up
DBUG:handle_command: received command "15247_10 V"
DBUG:doreply: sending reply "15247_10 20040107
"
DBUG:handle_command: received command "15247_11 VF 20050322"
DBUG:doreply: sending reply "15247_11 1
"
DBUG:handle_command: received command "15247_12 VF 20071116"
DBUG:doreply: sending reply "15247_12 1
"
DBUG:handle_command: received command "15247_13 VF 20081102"
DBUG:doreply: sending reply "15247_13 1
"
DBUG:handle_command: received command "15247_14 Uc18,101 YmYwNWNhM2RiYzM0MmQ4ZTFjMWY0ZjkxMzk1ODkxYTI. 116.237.74.228 22894 963ae84b;1"
INFO:handle_command: new session YmYwNWNhM2RiYzM0MmQ4ZTFjMWY0ZjkxMzk1ODkxYTI., tag 963ae84b;1 requested, type strong
INFO:handle_command: new session on a port 41750 created, tag 963ae84b;1
INFO:handle_command: pre-filling caller's address with 116.237.74.228:22894
DBUG:doreply: sending reply "15247_14 41750 210.13.Y.Z
"
INFO:process_rtp: session timeout
INFO:remove_session: RTP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: RTCP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: session on ports 41750/0 is cleaned up
DBUG:handle_command: received command "15244_9 V"
DBUG:doreply: sending reply "15244_9 20040107
"
DBUG:handle_command: received command "15244_10 VF 20050322"
DBUG:doreply: sending reply "15244_10 1
"
DBUG:handle_command: received command "15244_11 VF 20071116"
DBUG:doreply: sending reply "15244_11 1
"
DBUG:handle_command: received command "15244_12 VF 20081102"
DBUG:doreply: sending reply "15244_12 1
"
DBUG:handle_command: received command "15244_13 D YmYwNWNhM2RiYzM0MmQ4ZTFjMWY0ZjkxMzk1ODkxYTI. 3e596861-67d7-4c23-bd53-0a7c96e229bd 963ae84b"
INFO:handle_command: delete request failed: session YmYwNWNhM2RiYzM0MmQ4ZTFjMWY0ZjkxMzk1ODkxYTI., tags 3e596861-67d7-4c23-bd53-0a7c96e229bd/963ae84b not found
DBUG:doreply: sending reply "15244_13 E8
"
 
DBUG:handle_command: received command "15245_19 Uc18,101 ZjA1MDlhOTZkMmI3NjZiMDIwNDY2Mjc4ZWFhMzQzNGQ. 116.237.74.228 49292 3f4f367e;1"
INFO:handle_command: new session ZjA1MDlhOTZkMmI3NjZiMDIwNDY2Mjc4ZWFhMzQzNGQ., tag 3f4f367e;1 requested, type strong
INFO:handle_command: new session on a port 49698 created, tag 3f4f367e;1
INFO:handle_command: pre-filling caller's address with 116.237.74.228:49292
DBUG:doreply: sending reply "15245_19 49698 210.13.Y.Z
"
INFO:process_rtp: session timeout
INFO:remove_session: RTP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: RTCP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: session on ports 49698/0 is cleaned up
DBUG:handle_command: received command "15244_14 V"
DBUG:doreply: sending reply "15244_14 20040107
"
DBUG:handle_command: received command "15244_15 VF 20050322"
DBUG:doreply: sending reply "15244_15 1
"
DBUG:handle_command: received command "15244_16 VF 20071116"
DBUG:doreply: sending reply "15244_16 1
"
DBUG:handle_command: received command "15244_17 VF 20081102"
DBUG:doreply: sending reply "15244_17 1
"
DBUG:handle_command: received command "15244_18 Uc18,101 MGNiMmM5OWE5Mjg4ZTU1NmQ3NjhlYjIyYmQ2ZTQyNmY. 116.237.74.228 32004 91602c3f;1"
INFO:handle_command: new session MGNiMmM5OWE5Mjg4ZTU1NmQ3NjhlYjIyYmQ2ZTQyNmY., tag 91602c3f;1 requested, type strong
INFO:handle_command: new session on a port 49824 created, tag 91602c3f;1
INFO:handle_command: pre-filling caller's address with 116.237.74.228:32004
DBUG:doreply: sending reply "15244_18 49824 210.13.Y.Z
"
INFO:process_rtp: session timeout
INFO:remove_session: RTP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: RTCP stats: 0 in from callee, 0 in from caller, 0 relayed, 0 dropped
INFO:remove_session: session on ports 49824/0 is cleaned up
 
========Kamailio Log ==========================================
AppSer01:ipunity@/var/log$ tail -f kamailio.log |grep nathelper
 1(15244) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 1(15244) DEBUG: nathelper [nathelper.c:3196]: proxy reply: 49092 210.13.Y.Z
 2(15245) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 2(15245) ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy
 2(15245) ERROR: nathelper [nathelper.c:2492]: proxy <udp:127.0.0.1:7722> does not respond, disable it
 2(15245) ERROR: nathelper [nathelper.c:3144]: no available proxies
 4(15247) ERROR: nathelper [nathelper.c:2627]: no available proxies
 4(15247) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(15247) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it re-enabled
 4(15247) DEBUG: nathelper [nathelper.c:3196]: proxy reply: 41750 210.13.Y.Z
 3(15246) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 3(15246) ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy
 3(15246) ERROR: nathelper [nathelper.c:2492]: proxy <udp:127.0.0.1:7722> does not respond, disable it
 3(15246) ERROR: nathelper [nathelper.c:3144]: no available proxies
 1(15244) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it re-enabled
 2(15245) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 2(15245) DEBUG: nathelper [nathelper.c:3196]: proxy reply: 49698 210.13.Y.Z
 4(15247) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(15247) ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy
 4(15247) ERROR: nathelper [nathelper.c:2492]: proxy <udp:127.0.0.1:7722> does not respond, disable it
 4(15247) ERROR: nathelper [nathelper.c:3144]: no available proxies
 3(15246) ERROR: nathelper [nathelper.c:2627]: no available proxies
 1(15244) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 1(15244) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it re-enabled
 1(15244) DEBUG: nathelper [nathelper.c:3196]: proxy reply: 49824 210.13.Y.Z
 4(15247) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(15247) ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy
 4(15247) ERROR: nathelper [nathelper.c:2492]: proxy <udp:127.0.0.1:7722> does not respond, disable it
 4(15247) ERROR: nathelper [nathelper.c:3144]: no available proxies
 4(15247) ERROR: nathelper [nathelper.c:2627]: no available proxies
=============END of Nathelper log ==
 

From: kevin.jzh@hotmail.com
To: miconda@gmail.com
CC: sr-users@lists.sip-router.org
Subject: RE: [SR-Users] Kamailio 3.0 cann't access the RTPProxy
Date: Thu, 29 Jul 2010 01:13:00 +0800

Hi Daniel,
 
Here is the debug message related to nethelper in the kamailio log:
The proxy is circling btw enabled and disabled, what could be the cause?
 
4(15247) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(15247) ERROR: nathelper [nathelper.c:3144]: no available proxies
 1(15244) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 1(15244) ERROR: nathelper [nathelper.c:3144]: no available proxies
 2(15245) INFO: nathelper [nathelper.c:2369]: rtp proxy <udp:127.0.0.1:7722> found, support for it re-enabled
 3(15246) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 3(15246) DEBUG: nathelper [nathelper.c:3196]: proxy reply: 46634 210.13.x.y
 4(15247) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(15247) ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy
 4(15247) ERROR: nathelper [nathelper.c:2492]: proxy <udp:127.0.0.1:7722> does not respond, disable it
 4(15247) ERROR: nathelper [nathelper.c:3144]: no available proxies
 1(15244) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 1(15244) ERROR: nathelper [nathelper.c:3144]: no available proxies
 2(15245) ERROR: nathelper [nathelper.c:2627]: no available proxies
 4(15247) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 4(15247) ERROR: nathelper [nathelper.c:3144]: no available proxies
 3(15246) DEBUG: nathelper [nhelpr_funcs.c:148]: type <application/sdp> found valid
 3(15246) ERROR: nathelper [nathelper.c:3144]: no available proxies
 1(15244) ERROR: nathelper [nathelper.c:2627]: no available proxies
 
Thanks,
Kevin

From: kevin.jzh@hotmail.com
To: miconda@gmail.com
CC: sr-users@lists.sip-router.org
Subject: RE: [SR-Users] Kamailio 3.0 cann't access the RTPProxy
Date: Wed, 28 Jul 2010 19:42:27 +0800


 Hi,
 
Yes, I changed the kamailio config as well, but didn't see any packet from Kamailio on the port.
And the error message is as following:
 
WARNING: tm [uac.c:111]: Warning: uac does not spread across the whole hash table                                                              
 ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy                                                                          
 ERROR: nathelper [nathelper.c:2492]: proxy <udp:210.13.x.y:7722> does not respond, disable it         
 ERROR: nathelper [nathelper.c:3144]: no available proxies
 ERROR: nathelper [nathelper.c:2457]: can't send command to a RTP proxy                                                                    
 ERROR: nathelper [nathelper.c:2492]: proxy <udp:210.13.x.y:7722> does not respond, disable it          
 ERROR: nathelper [nathelper.c:3144]: no available proxies   
 ERROR: nathelper [nathelper.c:2627]: no available proxies   
 ERROR: nathelper [nathelper.c:2627]: no available proxies   
 
Thanks,
Kevin

-- 
Daniel-Constantin Mierla
http://www.asipto.com/