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/