Freeswitch not terminating call after receiving "503 Service not available" response.
Hi, I have this scenario: Proxy - FS -- LCR I make a call from an user register in my proxy, passing trough freeswitch ( for media transcoding) , to my LCR server. The LCR looks for one route for my call, but I doesn't found any, so It replays "503 Service not available, no more gateways". When FS receives this response , *it sends a re invite* to the LCR server, falling again in the same error reply. In my case I don't what FS to send the re invite , I need it to pass the reply ("503 Service not available, no more gateways") to the proxy. How can I manage this? Regards, Camila *Camila Troncoso Solar **|* Ingeniero de Desarollo +56 2 22408535 *·* +56 9 97327220 | ctroncoso@redvoiss.net Badajoz 130, piso 16, Las Condes | Santiago - CHILE | *www.redvoiss.com <http://www.redvoiss.com>*
What does your dialplan look like? A bridge with a 503 reply will fail. If FS is sending another INVITE that suggests it's doing another bridge when the first fails. On 15 April 2014 22:02, Camila Troncoso <ctroncoso@redvoiss.net> wrote:
Hi,
I have this scenario:
Proxy – FS -- LCR
I make a call from an user register in my proxy, passing trough freeswitch ( for media transcoding) , to my LCR server.
The LCR looks for one route for my call, but I doesn’t found any, so It replays “503 Service not available, no more gateways”.
When FS receives this response , *it sends a re invite* to the LCR server, falling again in the same error reply.
In my case I don’t what FS to send the re invite , I need it to pass the reply (“503 Service not available, no more gateways”) to the proxy.
How can I manage this?
Regards,
Camila
* Camila Troncoso Solar **|* Ingeniero de Desarollo
+56 2 22408535 *·* +56 9 97327220 | ctroncoso@redvoiss.net
Badajoz 130, piso 16, Las Condes | Santiago - CHILE | *www.redvoiss.com <http://www.redvoiss.com>*
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com
Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com
FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
Hi, My dialplan is like this, mi call matches "to_LCR_condition9": <context name="default"> <extension name="header_test_extension" continue="true"> <condition field="${sip_user_agent}" expression="AddPac SIP Gateway"> <action application="export" data="sdp_m_per_ptime=false"/> </condition> </extension> <extension name="to_LCR_condition1"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition2"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition3"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition4"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition5"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexb=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition6"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition7"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition8"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition9"> <condition field="network_addr" expression="^64\.76\.154\.110$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n' 'a=rtpmap:4 G723/8000\n' 'a=fmtp:4 annexa=no\n'}sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_PROXY_BORDE"> <condition field="network_addr" expression="^64\.76\.154\.36$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension> <extension name="to_PROXY_BORDE_2"> <condition field="network_addr" expression="^64\.76\.154\.198$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension> </context> *De:* freeswitch-users-bounces@lists.freeswitch.org [mailto: freeswitch-users-bounces@lists.freeswitch.org] *En nombre de *Steven Ayre *Enviado el:* martes, 15 de abril de 2014 18:46 *Para:* FreeSWITCH Users Help *Asunto:* Re: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response. What does your dialplan look like? A bridge with a 503 reply will fail. If FS is sending another INVITE that suggests it's doing another bridge when the first fails. On 15 April 2014 22:02, Camila Troncoso <ctroncoso@redvoiss.net> wrote: Hi, I have this scenario: Proxy - FS -- LCR I make a call from an user register in my proxy, passing trough freeswitch ( for media transcoding) , to my LCR server. The LCR looks for one route for my call, but I doesn't found any, so It replays "503 Service not available, no more gateways". When FS receives this response , *it sends a re invite* to the LCR server, falling again in the same error reply. In my case I don't what FS to send the re invite , I need it to pass the reply ("503 Service not available, no more gateways") to the proxy. How can I manage this? Regards, Camila *Camila Troncoso Solar **|* Ingeniero de Desarollo +56 2 22408535 *·* +56 9 97327220 | ctroncoso@redvoiss.net Badajoz 130, piso 16, Las Condes | Santiago - CHILE | *www.redvoiss.com <http://www.redvoiss.com>* _________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
Steven , I tried the same with a simpler dialplan, but the same error happened , here is the freeswitch debug with sip trace, you can notice that it sends the second INVITE without checking any dialplan (highlight in red). Please I need some help with this issue. recv 1147 bytes from udp/[64.76.154.110]:5060 at 15:53:07.155639: ------------------------------------------------------------------------ INVITE sip:02740056997327220@64.76.154.219 SIP/2.0 Record-Route: <sip:64.76.154.110;lr=on;ftag=vc6acyloo.g2izl7bhjjjs-fx0islg2l;nat=yes;did=ab4.ee7bd2> Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060 ;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Max-Forwards: 69 From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net> Contact: "557100036659" <sip:557100036659@64.76.155.66:5060> Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, timer, norefersub Warning: Session Expires REMO 1800 Min-SE: 90 User-Agent: iSip v4.7/iPhoneOS Content-Type: application/sdp Content-Length: 223 P-hint: inbound->outbound v=0 o=- 3606738789 3606738789 IN IP4 192.168.103.248 s=isipsdp c=IN IP4 64.76.154.110 t=0 0 a=X-nat:0 m=audio 55454 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ------------------------------------------------------------------------ send 602 bytes to udp/[64.76.154.110]:5060 at 15:53:07.157149: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060 ;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Record-Route: <sip:64.76.154.110;lr=on;ftag=vc6acyloo.g2izl7bhjjjs-fx0islg2l;nat=yes;did=ab4.ee7bd2> From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net> Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Content-Length: 0 ------------------------------------------------------------------------ 2014-04-17 12:53:07.155425 [NOTICE] switch_channel.c:976 New Channel sofia/internal/557100036659@pxext.redvoiss.net[5e32cd4e-c648-11e3-a4ce-197d189e446d] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_NEW 2014-04-17 12:53:07.155425 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/557100036659@pxext.redvoiss.net) State NEW 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5597 Channel sofia/internal/ 557100036659@pxext.redvoiss.net entering state [received][100] 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5608 Remote SDP: v=0 o=- 3606738789 3606738789 IN IP4 192.168.103.248 s=isipsdp c=IN IP4 64.76.154.110 t=0 0 a=X-nat:0 m=audio 55454 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5821 (sofia/internal/ 557100036659@pxext.redvoiss.net) State Change CS_NEW -> CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/557100036659@pxext.redvoiss.net) State INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:86 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:126 (sofia/internal/ 557100036659@pxext.redvoiss.net) State Change CS_INIT -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/557100036659@pxext.redvoiss.net) State INIT going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:2012 (sofia/internal/ 557100036659@pxext.redvoiss.net) Callstate Change DOWN -> RINGING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:117 sofia/internal/557100036659@pxext.redvoiss.net Standard ROUTING 2014-04-17 12:53:07.175246 [INFO] mod_dialplan_xml.c:557 Processing 557100036659 <557100036659>->02740056997327220 in context public Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_LCR] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [from_LCR] network_addr(64.76.154.110) =~ /^64\.76\.154\.36$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_LCR_INC] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [from_LCR_INC] network_addr(64.76.154.110) =~ /^64\.76\.154\.198$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_PROXY_Borde] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [from_PROXY_Borde] network_addr(64.76.154.110) =~ /^64\.76\.154\.110$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [from_PROXY_Borde] destination_number(02740056997327220) =~ /^(.+)$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action transfer(02740056997327220 XML default) 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_ROUTING -> CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:242 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:209 sofia/internal/557100036659@pxext.redvoiss.net Standard EXECUTE EXECUTE sofia/internal/557100036659@pxext.redvoiss.nettransfer(02740056997327220 XML default) 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr.c:1790 (sofia/internal/ 557100036659@pxext.redvoiss.net) State Change CS_EXECUTE -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:830 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [NOTICE] switch_ivr.c:1797 Transfer sofia/internal/557100036659@pxext.redvoiss.net to XML[02740056997327220@default] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:117 sofia/internal/557100036659@pxext.redvoiss.net Standard ROUTING 2014-04-17 12:53:07.175246 [INFO] mod_dialplan_xml.c:557 Processing 557100036659 <557100036659>->02740056997327220 in context default Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_sippstn] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_sippstn] network_addr(64.76.154.110) =~ /^64\.76\.154\.150$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_siptout] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_siptout] network_addr(64.76.154.110) =~ /^64\.76\.154\.36$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_homologado] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_homologado] network_addr(64.76.154.110) =~ /^64\.76\.154\.35$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_lcr] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [to_lcr] destination_number(02740056997327220) =~ /^(.+)$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(call_timeout=50) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(hangup_after_bridge=true) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action export(nolocal:absolute_codec_string=G729) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(sip_invite_domain=siplcr.redvoiss.net) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action bridge(sofia/64.76.154.219/02740056997327220@siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_ROUTING -> CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:242 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:209 sofia/internal/557100036659@pxext.redvoiss.net Standard EXECUTE EXECUTE sofia/internal/557100036659@pxext.redvoiss.net set(call_timeout=50) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/ 557100036659@pxext.redvoiss.net SET [call_timeout]=[50] EXECUTE sofia/internal/557100036659@pxext.redvoiss.netset(hangup_after_bridge=true) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/ 557100036659@pxext.redvoiss.net SET [hangup_after_bridge]=[true] EXECUTE sofia/internal/557100036659@pxext.redvoiss.netexport(nolocal:absolute_codec_string=G729) 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:1143 EXPORT (export_vars) (REMOTE ONLY) [absolute_codec_string]=[G729] EXECUTE sofia/internal/557100036659@pxext.redvoiss.netset(sip_invite_domain= siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/ 557100036659@pxext.redvoiss.net SET [sip_invite_domain]=[siplcr.redvoiss.net ] EXECUTE sofia/internal/557100036659@pxext.redvoiss.net bridge(sofia/ 64.76.154.219/02740056997327220@siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:1097 sofia/internal/ 557100036659@pxext.redvoiss.net EXPORTING[export_vars] [absolute_codec_string]=[G729] to event 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr_originate.c:2039 Parsing global variables 2014-04-17 12:53:07.175246 [NOTICE] switch_channel.c:976 New Channel sofia/internal/02740056997327220@siplcr.redvoiss.net[5e377966-c648-11e3-a4d9-197d189e446d] 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:4963 (sofia/internal/ 02740056997327220@siplcr.redvoiss.net) State Change CS_NEW -> CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:5033 [zrtp_passthru] Setting a-leg inherit_codec=true 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:5036 [zrtp_passthru] Setting b-leg absolute_codec_string='PCMU@8000h@20i@64000b' 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:86 sofia/internal/ 02740056997327220@siplcr.redvoiss.net SOFIA INIT 2014-04-17 12:53:07.175246 [DEBUG] sofia_glue.c:2664 Local SDP: v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:126 (sofia/internal/ 02740056997327220@siplcr.redvoiss.net) State Change CS_INIT -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State INIT going to sleep send 1106 bytes to udp/[64.76.154.36]:5060 at 15:53:07.192253: ------------------------------------------------------------------------ 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_ROUTING INVITE sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKgD9HQ9j8mHF0r Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Contact: <sip:mod_sofia@64.76.154.219:5060> User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 227 P-hint: inbound->outbound X-FS-Support: update_display,send_info Remote-Party-ID: "557100036659" <sip:557100036659@64.76.154.219
;party=calling;screen=yes;privacy=off
v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/ 02740056997327220@siplcr.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State CONSUME_MEDIA going to sleep recv 350 bytes from udp/[64.76.154.36]:5060 at 15:53:07.193234: ------------------------------------------------------------------------ SIP/2.0 100 Trying AUTH Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5597 Channel sofia/internal/ 02740056997327220@siplcr.redvoiss.net entering state [calling][0] Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 377 bytes from udp/[64.76.154.36]:5060 at 15:53:07.194910: ------------------------------------------------------------------------ SIP/2.0 100 trying -- your call is important to us Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.449218: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ send 1106 bytes to udp/[64.76.154.36]:5060 at 15:53:07.449648: ------------------------------------------------------------------------ INVITE sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKHp2aS43Bjt5jm Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Contact: <sip:mod_sofia@64.76.154.219:5060> User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 227 P-hint: inbound->outbound X-FS-Support: update_display,send_info Remote-Party-ID: "557100036659" <sip:557100036659@64.76.154.219
;party=calling;screen=yes;privacy=off
v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ recv 350 bytes from udp/[64.76.154.36]:5060 at 15:53:07.451301: ------------------------------------------------------------------------ SIP/2.0 100 Trying AUTH Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 377 bytes from udp/[64.76.154.36]:5060 at 15:53:07.452867: ------------------------------------------------------------------------ SIP/2.0 100 trying -- your call is important to us Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.510067: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-cea5
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ send 391 bytes to udp/[64.76.154.36]:5060 at 15:53:07.510555: ------------------------------------------------------------------------ ACK sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKHp2aS43Bjt5jm Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-cea5
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 ACK Content-Length: 0 ------------------------------------------------------------------------ 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] sofia.c:5597 Channel sofia/internal/ 02740056997327220@siplcr.redvoiss.net entering state [terminated][503] 2014-04-17 12:53:07.495409 [DEBUG] switch_channel.c:3011 (sofia/internal/ 02740056997327220@siplcr.redvoiss.net) Callstate Change DOWN -> HANGUP 2014-04-17 12:53:07.495409 [NOTICE] sofia.c:6404 Hangup sofia/internal/ 02740056997327220@siplcr.redvoiss.net [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.495409 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [KILL] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_HANGUP 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State HANGUP 2014-04-17 12:53:07.495409 [DEBUG] mod_sofia.c:503 Channel sofia/internal/ 02740056997327220@siplcr.redvoiss.net hanging up, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:48 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State HANGUP going to sleep 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_HANGUP -> CS_REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:92 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State REPORTING going to sleep 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_REPORTING -> CS_DESTROY 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1518 Session 10 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Locked, Waiting on external entities 2014-04-17 12:53:07.495409 [DEBUG] switch_ivr_originate.c:3601 Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.495409 [NOTICE] switch_core_session.c:1536 Session 10 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Ended 2014-04-17 12:53:07.495409 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/02740056997327220@siplcr.redvoiss.net [CS_DESTROY] 2014-04-17 12:53:07.495409 [INFO] mod_dptools.c:3078 Originate Failed. Cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_channel.c:3011 (sofia/internal/ 557100036659@pxext.redvoiss.net) Callstate Change RINGING -> HANGUP 2014-04-17 12:53:07.515177 [NOTICE] mod_dptools.c:3198 Hangup sofia/internal/557100036659@pxext.redvoiss.net [CS_EXECUTE] [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Callstate Change HANGUP -> DOWN 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/557100036659@pxext.redvoiss.net [KILL] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State DESTROY 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:396 sofia/internal/ 02740056997327220@siplcr.redvoiss.net SOFIA DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:99 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State DESTROY going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:2708 sofia/internal/557100036659@pxext.redvoiss.net skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_HANGUP 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/557100036659@pxext.redvoiss.net) State HANGUP 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:497 sofia/internal/ 557100036659@pxext.redvoiss.net Overriding SIP cause 503 with 503 from the other leg 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:503 Channel sofia/internal/ 557100036659@pxext.redvoiss.net hanging up, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 503 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:48 sofia/internal/557100036659@pxext.redvoiss.net Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/557100036659@pxext.redvoiss.net) State HANGUP going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_HANGUP -> CS_REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/557100036659@pxext.redvoiss.net) State REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:92 sofia/internal/557100036659@pxext.redvoiss.net Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/557100036659@pxext.redvoiss.net) State REPORTING going to sleep send 920 bytes to udp/[64.76.154.110]:5060 at 15:53:07.517918: ------------------------------------------------------------------------ SIP/2.0 503 Service Unavailable Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060 ;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Max-Forwards: 68 From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net>;tag=K893tH0p1j8ce Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Reason: Q.850;cause=41;text="NORMAL_TEMPORARY_FAILURE" Content-Length: 0 Remote-Party-ID: "02740056997327220" < sip:02740056997327220@pxext.redvoiss.net
;party=calling;privacy=off;screen=no
------------------------------------------------------------------------ 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_REPORTING -> CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1518 Session 9 (sofia/internal/557100036659@pxext.redvoiss.net) Locked, Waiting on external entities 2014-04-17 12:53:07.515177 [NOTICE] switch_core_session.c:1536 Session 9 (sofia/internal/557100036659@pxext.redvoiss.net) Ended 2014-04-17 12:53:07.515177 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/557100036659@pxext.redvoiss.net [CS_DESTROY] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/557100036659@pxext.redvoiss.net) Callstate Change HANGUP -> DOWN recv 368 bytes from udp/[64.76.154.110]:5060 at 15:53:07.519416: ------------------------------------------------------------------------ ACK sip:02740056997327220@64.76.154.219 SIP/2.0 Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Max-Forwards: 69 From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net>;tag=K893tH0p1j8ce Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 ACK Content-Length: 0 ------------------------------------------------------------------------ 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/557100036659@pxext.redvoiss.net) State DESTROY 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:396 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:99 sofia/internal/557100036659@pxext.redvoiss.net Standard DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/557100036659@pxext.redvoiss.net) State DESTROY going to sleep recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.901037: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:08.901171: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 *De:* Camila Troncoso [mailto:ctroncoso@redvoiss.net] *Enviado el:* miércoles, 16 de abril de 2014 10:03 *Para:* FreeSWITCH Users Help *Asunto:* RE: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response. Hi, My dialplan is like this, mi call matches "to_LCR_condition9": <context name="default"> <extension name="header_test_extension" continue="true"> <condition field="${sip_user_agent}" expression="AddPac SIP Gateway"> <action application="export" data="sdp_m_per_ptime=false"/> </condition> </extension> <extension name="to_LCR_condition1"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition2"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition3"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition4"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition5"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexb=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition6"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition7"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition8"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition9"> <condition field="network_addr" expression="^64\.76\.154\.110$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n' 'a=rtpmap:4 G723/8000\n' 'a=fmtp:4 annexa=no\n'}sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_PROXY_BORDE"> <condition field="network_addr" expression="^64\.76\.154\.36$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension> <extension name="to_PROXY_BORDE_2"> <condition field="network_addr" expression="^64\.76\.154\.198$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension> </context> *De:* freeswitch-users-bounces@lists.freeswitch.org [mailto: freeswitch-users-bounces@lists.freeswitch.org] *En nombre de *Steven Ayre *Enviado el:* martes, 15 de abril de 2014 18:46 *Para:* FreeSWITCH Users Help *Asunto:* Re: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response. What does your dialplan look like? A bridge with a 503 reply will fail. If FS is sending another INVITE that suggests it's doing another bridge when the first fails. On 15 April 2014 22:02, Camila Troncoso <ctroncoso@redvoiss.net> wrote: Hi, I have this scenario: Proxy - FS -- LCR I make a call from an user register in my proxy, passing trough freeswitch ( for media transcoding) , to my LCR server. The LCR looks for one route for my call, but I doesn't found any, so It replays "503 Service not available, no more gateways". When FS receives this response , *it sends a re invite* to the LCR server, falling again in the same error reply. In my case I don't what FS to send the re invite , I need it to pass the reply ("503 Service not available, no more gateways") to the proxy. How can I manage this? Regards, Camila *Camila Troncoso Solar **|* Ingeniero de Desarollo +56 2 22408535 *·* +56 9 97327220 | ctroncoso@redvoiss.net Badajoz 130, piso 16, Las Condes | Santiago - CHILE | *www.redvoiss.com <http://www.redvoiss.com>* _________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
If anyone has this problem, i solved it, it was the SVR that comes enable by default. I disabled it and it work fine. Regards *De:* Camila Troncoso [mailto:ctroncoso@redvoiss.net] *Enviado el:* jueves, 17 de abril de 2014 13:03 *Para:* Camila Troncoso; FreeSWITCH Users Help *Asunto:* RE: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response. Steven , I tried the same with a simpler dialplan, but the same error happened , here is the freeswitch debug with sip trace, you can notice that it sends the second INVITE without checking any dialplan (highlight in red). Please I need some help with this issue. recv 1147 bytes from udp/[64.76.154.110]:5060 at 15:53:07.155639: ------------------------------------------------------------------------ INVITE sip:02740056997327220@64.76.154.219 SIP/2.0 Record-Route: < sip:64.76.154.110;lr=on;ftag=vc6acyloo.g2izl7bhjjjs-fx0islg2l;nat=yes;did=ab4.ee7bd2
Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060 ;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Max-Forwards: 69 From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net> Contact: "557100036659" <sip:557100036659@64.76.155.66:5060> Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, timer, norefersub Warning: Session Expires REMO 1800 Min-SE: 90 User-Agent: iSip v4.7/iPhoneOS Content-Type: application/sdp Content-Length: 223 P-hint: inbound->outbound v=0 o=- 3606738789 3606738789 IN IP4 192.168.103.248 s=isipsdp c=IN IP4 64.76.154.110 t=0 0 a=X-nat:0 m=audio 55454 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ------------------------------------------------------------------------ send 602 bytes to udp/[64.76.154.110]:5060 at 15:53:07.157149: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060 ;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Record-Route: < sip:64.76.154.110;lr=on;ftag=vc6acyloo.g2izl7bhjjjs-fx0islg2l;nat=yes;did=ab4.ee7bd2
From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net> Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Content-Length: 0 ------------------------------------------------------------------------ 2014-04-17 12:53:07.155425 [NOTICE] switch_channel.c:976 New Channel sofia/internal/557100036659@pxext.redvoiss.net[5e32cd4e-c648-11e3-a4ce-197d189e446d] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_NEW 2014-04-17 12:53:07.155425 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/557100036659@pxext.redvoiss.net) State NEW 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5597 Channel sofia/internal/ 557100036659@pxext.redvoiss.net entering state [received][100] 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5608 Remote SDP: v=0 o=- 3606738789 3606738789 IN IP4 192.168.103.248 s=isipsdp c=IN IP4 64.76.154.110 t=0 0 a=X-nat:0 m=audio 55454 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5821 (sofia/internal/ 557100036659@pxext.redvoiss.net) State Change CS_NEW -> CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/557100036659@pxext.redvoiss.net) State INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:86 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:126 (sofia/internal/ 557100036659@pxext.redvoiss.net) State Change CS_INIT -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/557100036659@pxext.redvoiss.net) State INIT going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:2012 (sofia/internal/ 557100036659@pxext.redvoiss.net) Callstate Change DOWN -> RINGING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:117 sofia/internal/557100036659@pxext.redvoiss.net Standard ROUTING 2014-04-17 12:53:07.175246 [INFO] mod_dialplan_xml.c:557 Processing 557100036659 <557100036659>->02740056997327220 in context public Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_LCR] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [from_LCR] network_addr(64.76.154.110) =~ /^64\.76\.154\.36$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_LCR_INC] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [from_LCR_INC] network_addr(64.76.154.110) =~ /^64\.76\.154\.198$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_PROXY_Borde] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [from_PROXY_Borde] network_addr(64.76.154.110) =~ /^64\.76\.154\.110$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [from_PROXY_Borde] destination_number(02740056997327220) =~ /^(.+)$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action transfer(02740056997327220 XML default) 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_ROUTING -> CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:242 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:209 sofia/internal/557100036659@pxext.redvoiss.net Standard EXECUTE EXECUTE sofia/internal/557100036659@pxext.redvoiss.nettransfer(02740056997327220 XML default) 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr.c:1790 (sofia/internal/ 557100036659@pxext.redvoiss.net) State Change CS_EXECUTE -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:830 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [NOTICE] switch_ivr.c:1797 Transfer sofia/internal/557100036659@pxext.redvoiss.net to XML[02740056997327220@default] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:117 sofia/internal/557100036659@pxext.redvoiss.net Standard ROUTING 2014-04-17 12:53:07.175246 [INFO] mod_dialplan_xml.c:557 Processing 557100036659 <557100036659>->02740056997327220 in context default Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_sippstn] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_sippstn] network_addr(64.76.154.110) =~ /^64\.76\.154\.150$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_siptout] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_siptout] network_addr(64.76.154.110) =~ /^64\.76\.154\.36$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_homologado] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_homologado] network_addr(64.76.154.110) =~ /^64\.76\.154\.35$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_lcr] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [to_lcr] destination_number(02740056997327220) =~ /^(.+)$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(call_timeout=50) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(hangup_after_bridge=true) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action export(nolocal:absolute_codec_string=G729) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(sip_invite_domain=siplcr.redvoiss.net) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action bridge(sofia/64.76.154.219/02740056997327220@siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_ROUTING -> CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:242 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:209 sofia/internal/557100036659@pxext.redvoiss.net Standard EXECUTE EXECUTE sofia/internal/557100036659@pxext.redvoiss.net set(call_timeout=50) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/ 557100036659@pxext.redvoiss.net SET [call_timeout]=[50] EXECUTE sofia/internal/557100036659@pxext.redvoiss.netset(hangup_after_bridge=true) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/ 557100036659@pxext.redvoiss.net SET [hangup_after_bridge]=[true] EXECUTE sofia/internal/557100036659@pxext.redvoiss.netexport(nolocal:absolute_codec_string=G729) 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:1143 EXPORT (export_vars) (REMOTE ONLY) [absolute_codec_string]=[G729] EXECUTE sofia/internal/557100036659@pxext.redvoiss.netset(sip_invite_domain= siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/ 557100036659@pxext.redvoiss.net SET [sip_invite_domain]=[siplcr.redvoiss.net ] EXECUTE sofia/internal/557100036659@pxext.redvoiss.net bridge(sofia/ 64.76.154.219/02740056997327220@siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:1097 sofia/internal/ 557100036659@pxext.redvoiss.net EXPORTING[export_vars] [absolute_codec_string]=[G729] to event 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr_originate.c:2039 Parsing global variables 2014-04-17 12:53:07.175246 [NOTICE] switch_channel.c:976 New Channel sofia/internal/02740056997327220@siplcr.redvoiss.net[5e377966-c648-11e3-a4d9-197d189e446d] 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:4963 (sofia/internal/ 02740056997327220@siplcr.redvoiss.net) State Change CS_NEW -> CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:5033 [zrtp_passthru] Setting a-leg inherit_codec=true 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:5036 [zrtp_passthru] Setting b-leg absolute_codec_string='PCMU@8000h@20i@64000b' 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:86 sofia/internal/ 02740056997327220@siplcr.redvoiss.net SOFIA INIT 2014-04-17 12:53:07.175246 [DEBUG] sofia_glue.c:2664 Local SDP: v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:126 (sofia/internal/ 02740056997327220@siplcr.redvoiss.net) State Change CS_INIT -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State INIT going to sleep send 1106 bytes to udp/[64.76.154.36]:5060 at 15:53:07.192253: ------------------------------------------------------------------------ 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_ROUTING INVITE sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKgD9HQ9j8mHF0r Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Contact: <sip:mod_sofia@64.76.154.219:5060> User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 227 P-hint: inbound->outbound X-FS-Support: update_display,send_info Remote-Party-ID: "557100036659" <sip:557100036659@64.76.154.219
;party=calling;screen=yes;privacy=off
v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/ 02740056997327220@siplcr.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State CONSUME_MEDIA going to sleep recv 350 bytes from udp/[64.76.154.36]:5060 at 15:53:07.193234: ------------------------------------------------------------------------ SIP/2.0 100 Trying AUTH Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5597 Channel sofia/internal/ 02740056997327220@siplcr.redvoiss.net entering state [calling][0] Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 377 bytes from udp/[64.76.154.36]:5060 at 15:53:07.194910: ------------------------------------------------------------------------ SIP/2.0 100 trying -- your call is important to us Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.449218: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ send 1106 bytes to udp/[64.76.154.36]:5060 at 15:53:07.449648: ------------------------------------------------------------------------ INVITE sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKHp2aS43Bjt5jm Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Contact: <sip:mod_sofia@64.76.154.219:5060> User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 227 P-hint: inbound->outbound X-FS-Support: update_display,send_info Remote-Party-ID: "557100036659" <sip:557100036659@64.76.154.219
;party=calling;screen=yes;privacy=off
v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ recv 350 bytes from udp/[64.76.154.36]:5060 at 15:53:07.451301: ------------------------------------------------------------------------ SIP/2.0 100 Trying AUTH Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 377 bytes from udp/[64.76.154.36]:5060 at 15:53:07.452867: ------------------------------------------------------------------------ SIP/2.0 100 trying -- your call is important to us Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.510067: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-cea5
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ send 391 bytes to udp/[64.76.154.36]:5060 at 15:53:07.510555: ------------------------------------------------------------------------ ACK sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKHp2aS43Bjt5jm Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-cea5
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 ACK Content-Length: 0 ------------------------------------------------------------------------ 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] sofia.c:5597 Channel sofia/internal/ 02740056997327220@siplcr.redvoiss.net entering state [terminated][503] 2014-04-17 12:53:07.495409 [DEBUG] switch_channel.c:3011 (sofia/internal/ 02740056997327220@siplcr.redvoiss.net) Callstate Change DOWN -> HANGUP 2014-04-17 12:53:07.495409 [NOTICE] sofia.c:6404 Hangup sofia/internal/ 02740056997327220@siplcr.redvoiss.net [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.495409 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [KILL] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_HANGUP 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State HANGUP 2014-04-17 12:53:07.495409 [DEBUG] mod_sofia.c:503 Channel sofia/internal/ 02740056997327220@siplcr.redvoiss.net hanging up, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:48 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State HANGUP going to sleep 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_HANGUP -> CS_REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:92 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State REPORTING going to sleep 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_REPORTING -> CS_DESTROY 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1518 Session 10 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Locked, Waiting on external entities 2014-04-17 12:53:07.495409 [DEBUG] switch_ivr_originate.c:3601 Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.495409 [NOTICE] switch_core_session.c:1536 Session 10 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Ended 2014-04-17 12:53:07.495409 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/02740056997327220@siplcr.redvoiss.net [CS_DESTROY] 2014-04-17 12:53:07.495409 [INFO] mod_dptools.c:3078 Originate Failed. Cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_channel.c:3011 (sofia/internal/ 557100036659@pxext.redvoiss.net) Callstate Change RINGING -> HANGUP 2014-04-17 12:53:07.515177 [NOTICE] mod_dptools.c:3198 Hangup sofia/internal/557100036659@pxext.redvoiss.net [CS_EXECUTE] [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Callstate Change HANGUP -> DOWN 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/557100036659@pxext.redvoiss.net [KILL] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State DESTROY 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:396 sofia/internal/ 02740056997327220@siplcr.redvoiss.net SOFIA DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:99 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State DESTROY going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:2708 sofia/internal/557100036659@pxext.redvoiss.net skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_HANGUP 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/557100036659@pxext.redvoiss.net) State HANGUP 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:497 sofia/internal/ 557100036659@pxext.redvoiss.net Overriding SIP cause 503 with 503 from the other leg 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:503 Channel sofia/internal/ 557100036659@pxext.redvoiss.net hanging up, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 503 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:48 sofia/internal/557100036659@pxext.redvoiss.net Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/557100036659@pxext.redvoiss.net) State HANGUP going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_HANGUP -> CS_REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/557100036659@pxext.redvoiss.net) State REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:92 sofia/internal/557100036659@pxext.redvoiss.net Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/557100036659@pxext.redvoiss.net) State REPORTING going to sleep send 920 bytes to udp/[64.76.154.110]:5060 at 15:53:07.517918: ------------------------------------------------------------------------ SIP/2.0 503 Service Unavailable Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060 ;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Max-Forwards: 68 From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net>;tag=K893tH0p1j8ce Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Reason: Q.850;cause=41;text="NORMAL_TEMPORARY_FAILURE" Content-Length: 0 Remote-Party-ID: "02740056997327220" < sip:02740056997327220@pxext.redvoiss.net
;party=calling;privacy=off;screen=no
------------------------------------------------------------------------ 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_REPORTING -> CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1518 Session 9 (sofia/internal/557100036659@pxext.redvoiss.net) Locked, Waiting on external entities 2014-04-17 12:53:07.515177 [NOTICE] switch_core_session.c:1536 Session 9 (sofia/internal/557100036659@pxext.redvoiss.net) Ended 2014-04-17 12:53:07.515177 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/557100036659@pxext.redvoiss.net [CS_DESTROY] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/557100036659@pxext.redvoiss.net) Callstate Change HANGUP -> DOWN recv 368 bytes from udp/[64.76.154.110]:5060 at 15:53:07.519416: ------------------------------------------------------------------------ ACK sip:02740056997327220@64.76.154.219 SIP/2.0 Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Max-Forwards: 69 From: "557100036659" <sip:557100036659@pxext.redvoiss.net
;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l
To: <sip:0056997327220@pxext.redvoiss.net>;tag=K893tH0p1j8ce Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 ACK Content-Length: 0 ------------------------------------------------------------------------ 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/557100036659@pxext.redvoiss.net) State DESTROY 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:396 sofia/internal/ 557100036659@pxext.redvoiss.net SOFIA DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:99 sofia/internal/557100036659@pxext.redvoiss.net Standard DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/557100036659@pxext.redvoiss.net) State DESTROY going to sleep recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.901037: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 ------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:08.901171: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net
;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f
Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0 *De:* Camila Troncoso [mailto:ctroncoso@redvoiss.net] *Enviado el:* miércoles, 16 de abril de 2014 10:03 *Para:* FreeSWITCH Users Help *Asunto:* RE: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response. Hi, My dialplan is like this, mi call matches "to_LCR_condition9": <context name="default"> <extension name="header_test_extension" continue="true"> <condition field="${sip_user_agent}" expression="AddPac SIP Gateway"> <action application="export" data="sdp_m_per_ptime=false"/> </condition> </extension> <extension name="to_LCR_condition1"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition2"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition3"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition4"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition5"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexb=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition6"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition7"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition8"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_LCR_condition9"> <condition field="network_addr" expression="^64\.76\.154\.110$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="sip_invite_domain= siplcr.redvoiss.net"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n' 'a=rtpmap:4 G723/8000\n' 'a=fmtp:4 annexa=no\n'}sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension> <extension name="to_PROXY_BORDE"> <condition field="network_addr" expression="^64\.76\.154\.36$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension> <extension name="to_PROXY_BORDE_2"> <condition field="network_addr" expression="^64\.76\.154\.198$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension> </context> *De:* freeswitch-users-bounces@lists.freeswitch.org [mailto: freeswitch-users-bounces@lists.freeswitch.org] *En nombre de *Steven Ayre *Enviado el:* martes, 15 de abril de 2014 18:46 *Para:* FreeSWITCH Users Help *Asunto:* Re: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response. What does your dialplan look like? A bridge with a 503 reply will fail. If FS is sending another INVITE that suggests it's doing another bridge when the first fails. On 15 April 2014 22:02, Camila Troncoso <ctroncoso@redvoiss.net> wrote: Hi, I have this scenario: Proxy - FS -- LCR I make a call from an user register in my proxy, passing trough freeswitch ( for media transcoding) , to my LCR server. The LCR looks for one route for my call, but I doesn't found any, so It replays "503 Service not available, no more gateways". When FS receives this response , *it sends a re invite* to the LCR server, falling again in the same error reply. In my case I don't what FS to send the re invite , I need it to pass the reply ("503 Service not available, no more gateways") to the proxy. How can I manage this? Regards, Camila *Camila Troncoso Solar **|* Ingeniero de Desarollo +56 2 22408535 *·* +56 9 97327220 | ctroncoso@redvoiss.net Badajoz 130, piso 16, Las Condes | Santiago - CHILE | *www.redvoiss.com <http://www.redvoiss.com>* _________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
That would probably indicate bad DNS somewhere SRV is not optional ;) /b Sent from my iPhone
On Apr 17, 2014, at 2:16 PM, Camila Troncoso <ctroncoso@redvoiss.net> wrote:
If anyone has this problem, i solved it, it was the SVR that comes enable by default. I disabled it and it work fine.
Regards
De: Camila Troncoso [mailto:ctroncoso@redvoiss.net] Enviado el: jueves, 17 de abril de 2014 13:03 Para: Camila Troncoso; FreeSWITCH Users Help Asunto: RE: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response.
Steven ,
I tried the same with a simpler dialplan, but the same error happened , here is the freeswitch debug with sip trace, you can notice that it sends the second INVITE without checking any dialplan (highlight in red).
Please I need some help with this issue.
recv 1147 bytes from udp/[64.76.154.110]:5060 at 15:53:07.155639: ------------------------------------------------------------------------ INVITE sip:02740056997327220@64.76.154.219 SIP/2.0 Record-Route: <sip:64.76.154.110;lr=on;ftag=vc6acyloo.g2izl7bhjjjs-fx0islg2l;nat=yes;did=ab4.ee7bd2> Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Max-Forwards: 69 From: "557100036659" <sip:557100036659@pxext.redvoiss.net>;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l To: <sip:0056997327220@pxext.redvoiss.net> Contact: "557100036659" <sip:557100036659@64.76.155.66:5060> Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Supported: replaces, 100rel, timer, norefersub Warning: Session Expires REMO 1800 Min-SE: 90 User-Agent: iSip v4.7/iPhoneOS Content-Type: application/sdp Content-Length: 223 P-hint: inbound->outbound
v=0 o=- 3606738789 3606738789 IN IP4 192.168.103.248 s=isipsdp c=IN IP4 64.76.154.110 t=0 0 a=X-nat:0 m=audio 55454 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 ------------------------------------------------------------------------ send 602 bytes to udp/[64.76.154.110]:5060 at 15:53:07.157149: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Record-Route: <sip:64.76.154.110;lr=on;ftag=vc6acyloo.g2izl7bhjjjs-fx0islg2l;nat=yes;did=ab4.ee7bd2> From: "557100036659" <sip:557100036659@pxext.redvoiss.net>;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l To: <sip:0056997327220@pxext.redvoiss.net> Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Content-Length: 0
------------------------------------------------------------------------ 2014-04-17 12:53:07.155425 [NOTICE] switch_channel.c:976 New Channel sofia/internal/557100036659@pxext.redvoiss.net [5e32cd4e-c648-11e3-a4ce-197d189e446d] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.155425 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_NEW 2014-04-17 12:53:07.155425 [DEBUG] switch_core_state_machine.c:433 (sofia/internal/557100036659@pxext.redvoiss.net) State NEW 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5597 Channel sofia/internal/557100036659@pxext.redvoiss.net entering state [received][100] 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5608 Remote SDP: v=0 o=- 3606738789 3606738789 IN IP4 192.168.103.248 s=isipsdp c=IN IP4 64.76.154.110 t=0 0 a=X-nat:0 m=audio 55454 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15
2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5821 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_NEW -> CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/557100036659@pxext.redvoiss.net) State INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:86 sofia/internal/557100036659@pxext.redvoiss.net SOFIA INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:126 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_INIT -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/557100036659@pxext.redvoiss.net) State INIT going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:2012 (sofia/internal/557100036659@pxext.redvoiss.net) Callstate Change DOWN -> RINGING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/557100036659@pxext.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:117 sofia/internal/557100036659@pxext.redvoiss.net Standard ROUTING 2014-04-17 12:53:07.175246 [INFO] mod_dialplan_xml.c:557 Processing 557100036659 <557100036659>->02740056997327220 in context public Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_LCR] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [from_LCR] network_addr(64.76.154.110) =~ /^64\.76\.154\.36$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_LCR_INC] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [from_LCR_INC] network_addr(64.76.154.110) =~ /^64\.76\.154\.198$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [public->from_PROXY_Borde] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [from_PROXY_Borde] network_addr(64.76.154.110) =~ /^64\.76\.154\.110$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [from_PROXY_Borde] destination_number(02740056997327220) =~ /^(.+)$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action transfer(02740056997327220 XML default) 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_ROUTING -> CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:242 sofia/internal/557100036659@pxext.redvoiss.net SOFIA EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:209 sofia/internal/557100036659@pxext.redvoiss.net Standard EXECUTE EXECUTE sofia/internal/557100036659@pxext.redvoiss.net transfer(02740056997327220 XML default) 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr.c:1790 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_EXECUTE -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:830 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [NOTICE] switch_ivr.c:1797 Transfer sofia/internal/557100036659@pxext.redvoiss.net to XML[02740056997327220@default] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/557100036659@pxext.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:117 sofia/internal/557100036659@pxext.redvoiss.net Standard ROUTING 2014-04-17 12:53:07.175246 [INFO] mod_dialplan_xml.c:557 Processing 557100036659 <557100036659>->02740056997327220 in context default Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_sippstn] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_sippstn] network_addr(64.76.154.110) =~ /^64\.76\.154\.150$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_siptout] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_siptout] network_addr(64.76.154.110) =~ /^64\.76\.154\.36$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_homologado] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (FAIL) [to_homologado] network_addr(64.76.154.110) =~ /^64\.76\.154\.35$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net parsing [default->to_lcr] continue=false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Regex (PASS) [to_lcr] destination_number(02740056997327220) =~ /^(.+)$/ break=on-false Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(call_timeout=50) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(hangup_after_bridge=true) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action export(nolocal:absolute_codec_string=G729) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action set(sip_invite_domain=siplcr.redvoiss.net) Dialplan: sofia/internal/557100036659@pxext.redvoiss.net Action bridge(sofia/64.76.154.219/02740056997327220@siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_ROUTING -> CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/557100036659@pxext.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:242 sofia/internal/557100036659@pxext.redvoiss.net SOFIA EXECUTE 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:209 sofia/internal/557100036659@pxext.redvoiss.net Standard EXECUTE EXECUTE sofia/internal/557100036659@pxext.redvoiss.net set(call_timeout=50) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/557100036659@pxext.redvoiss.net SET [call_timeout]=[50] EXECUTE sofia/internal/557100036659@pxext.redvoiss.net set(hangup_after_bridge=true) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/557100036659@pxext.redvoiss.net SET [hangup_after_bridge]=[true] EXECUTE sofia/internal/557100036659@pxext.redvoiss.net export(nolocal:absolute_codec_string=G729) 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:1143 EXPORT (export_vars) (REMOTE ONLY) [absolute_codec_string]=[G729] EXECUTE sofia/internal/557100036659@pxext.redvoiss.net set(sip_invite_domain=siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] mod_dptools.c:1367 sofia/internal/557100036659@pxext.redvoiss.net SET [sip_invite_domain]=[siplcr.redvoiss.net] EXECUTE sofia/internal/557100036659@pxext.redvoiss.net bridge(sofia/64.76.154.219/02740056997327220@siplcr.redvoiss.net) 2014-04-17 12:53:07.175246 [DEBUG] switch_channel.c:1097 sofia/internal/557100036659@pxext.redvoiss.net EXPORTING[export_vars] [absolute_codec_string]=[G729] to event 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr_originate.c:2039 Parsing global variables 2014-04-17 12:53:07.175246 [NOTICE] switch_channel.c:976 New Channel sofia/internal/02740056997327220@siplcr.redvoiss.net [5e377966-c648-11e3-a4d9-197d189e446d] 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:4963 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_NEW -> CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:5033 [zrtp_passthru] Setting a-leg inherit_codec=true 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:5036 [zrtp_passthru] Setting b-leg absolute_codec_string='PCMU@8000h@20i@64000b' 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_INIT 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State INIT 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:86 sofia/internal/02740056997327220@siplcr.redvoiss.net SOFIA INIT 2014-04-17 12:53:07.175246 [DEBUG] sofia_glue.c:2664 Local SDP: v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv
2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:126 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_INIT -> CS_ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:454 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State INIT going to sleep send 1106 bytes to udp/[64.76.154.36]:5060 at 15:53:07.192253: ------------------------------------------------------------------------ 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_ROUTING INVITE sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKgD9HQ9j8mHF0r Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Contact: <sip:mod_sofia@64.76.154.219:5060> User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 227 P-hint: inbound->outbound X-FS-Support: update_display,send_info Remote-Party-ID: "557100036659" <sip:557100036659@64.76.154.219>;party=calling;screen=yes;privacy=off
v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State ROUTING 2014-04-17 12:53:07.175246 [DEBUG] mod_sofia.c:149 sofia/internal/02740056997327220@siplcr.redvoiss.net SOFIA ROUTING 2014-04-17 12:53:07.175246 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State ROUTING going to sleep 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State CONSUME_MEDIA 2014-04-17 12:53:07.175246 [DEBUG] switch_core_state_machine.c:489 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State CONSUME_MEDIA going to sleep recv 350 bytes from udp/[64.76.154.36]:5060 at 15:53:07.193234: ------------------------------------------------------------------------ SIP/2.0 100 Trying AUTH Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> 2014-04-17 12:53:07.175246 [DEBUG] sofia.c:5597 Channel sofia/internal/02740056997327220@siplcr.redvoiss.net entering state [calling][0] Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ recv 377 bytes from udp/[64.76.154.36]:5060 at 15:53:07.194910: ------------------------------------------------------------------------ SIP/2.0 100 trying -- your call is important to us Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.449218: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net>;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ send 1106 bytes to udp/[64.76.154.36]:5060 at 15:53:07.449648: ------------------------------------------------------------------------ INVITE sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKHp2aS43Bjt5jm Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Contact: <sip:mod_sofia@64.76.154.219:5060> User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 227 P-hint: inbound->outbound X-FS-Support: update_display,send_info Remote-Party-ID: "557100036659" <sip:557100036659@64.76.154.219>;party=calling;screen=yes;privacy=off
v=0 o=FreeSWITCH 1397725819 1397725820 IN IP4 64.76.154.219 s=FreeSWITCH c=IN IP4 64.76.154.219 t=0 0 m=audio 24168 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 ------------------------------------------------------------------------ recv 350 bytes from udp/[64.76.154.36]:5060 at 15:53:07.451301: ------------------------------------------------------------------------ SIP/2.0 100 Trying AUTH Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ recv 377 bytes from udp/[64.76.154.36]:5060 at 15:53:07.452867: ------------------------------------------------------------------------ SIP/2.0 100 trying -- your call is important to us Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net> Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.510067: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKHp2aS43Bjt5jm From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net>;tag=9d729cbd5d1f51d0e4d8e178be0f0379-cea5 Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ send 391 bytes to udp/[64.76.154.36]:5060 at 15:53:07.510555: ------------------------------------------------------------------------ ACK sip:02740056997327220@siplcr.redvoiss.net SIP/2.0 Via: SIP/2.0/UDP 64.76.154.219;rport;branch=z9hG4bKHp2aS43Bjt5jm Max-Forwards: 67 From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net>;tag=9d729cbd5d1f51d0e4d8e178be0f0379-cea5 Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 ACK Content-Length: 0
------------------------------------------------------------------------ 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:975 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] sofia.c:5597 Channel sofia/internal/02740056997327220@siplcr.redvoiss.net entering state [terminated][503] 2014-04-17 12:53:07.495409 [DEBUG] switch_channel.c:3011 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Callstate Change DOWN -> HANGUP 2014-04-17 12:53:07.495409 [NOTICE] sofia.c:6404 Hangup sofia/internal/02740056997327220@siplcr.redvoiss.net [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.495409 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [KILL] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_HANGUP 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State HANGUP 2014-04-17 12:53:07.495409 [DEBUG] mod_sofia.c:503 Channel sofia/internal/02740056997327220@siplcr.redvoiss.net hanging up, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:48 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State HANGUP going to sleep 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_HANGUP -> CS_REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State REPORTING 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:92 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State REPORTING going to sleep 2014-04-17 12:53:07.495409 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State Change CS_REPORTING -> CS_DESTROY 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/02740056997327220@siplcr.redvoiss.net [BREAK] 2014-04-17 12:53:07.495409 [DEBUG] switch_core_session.c:1518 Session 10 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Locked, Waiting on external entities 2014-04-17 12:53:07.495409 [DEBUG] switch_ivr_originate.c:3601 Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.495409 [NOTICE] switch_core_session.c:1536 Session 10 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Ended 2014-04-17 12:53:07.495409 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/02740056997327220@siplcr.redvoiss.net [CS_DESTROY] 2014-04-17 12:53:07.495409 [INFO] mod_dptools.c:3078 Originate Failed. Cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_channel.c:3011 (sofia/internal/557100036659@pxext.redvoiss.net) Callstate Change RINGING -> HANGUP 2014-04-17 12:53:07.515177 [NOTICE] mod_dptools.c:3198 Hangup sofia/internal/557100036659@pxext.redvoiss.net [CS_EXECUTE] [NORMAL_TEMPORARY_FAILURE] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Callstate Change HANGUP -> DOWN 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/02740056997327220@siplcr.redvoiss.net) Running State Change CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_channel.c:3034 Send signal sofia/internal/557100036659@pxext.redvoiss.net [KILL] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State DESTROY 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:396 sofia/internal/02740056997327220@siplcr.redvoiss.net SOFIA DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:99 sofia/internal/02740056997327220@siplcr.redvoiss.net Standard DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/02740056997327220@siplcr.redvoiss.net) State DESTROY going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:2708 sofia/internal/557100036659@pxext.redvoiss.net skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:477 (sofia/internal/557100036659@pxext.redvoiss.net) State EXECUTE going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_HANGUP 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/557100036659@pxext.redvoiss.net) State HANGUP 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:497 sofia/internal/557100036659@pxext.redvoiss.net Overriding SIP cause 503 with 503 from the other leg 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:503 Channel sofia/internal/557100036659@pxext.redvoiss.net hanging up, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:633 Responding to INVITE with: 503 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:48 sofia/internal/557100036659@pxext.redvoiss.net Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:676 (sofia/internal/557100036659@pxext.redvoiss.net) State HANGUP going to sleep 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:446 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_HANGUP -> CS_REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:415 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/557100036659@pxext.redvoiss.net) State REPORTING 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:92 sofia/internal/557100036659@pxext.redvoiss.net Standard REPORTING, cause: NORMAL_TEMPORARY_FAILURE 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:758 (sofia/internal/557100036659@pxext.redvoiss.net) State REPORTING going to sleep send 920 bytes to udp/[64.76.154.110]:5060 at 15:53:07.517918: ------------------------------------------------------------------------ SIP/2.0 503 Service Unavailable Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Via: SIP/2.0/UDP 192.168.103.248:5060;received=64.76.155.66;rport=5060;branch=z9hG4bKPjkcihuvdiz6orbyqwy2mwwx7zqnpmc7uf Max-Forwards: 68 From: "557100036659" <sip:557100036659@pxext.redvoiss.net>;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l To: <sip:0056997327220@pxext.redvoiss.net>;tag=K893tH0p1j8ce Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 INVITE User-Agent: FreeSWITCH-mod_sofia/1.3.17+git~20130312T033518Z~7d29a92f55 Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REFER, NOTIFY Supported: timer, precondition, path, replaces Allow-Events: talk, hold, conference, refer Reason: Q.850;cause=41;text="NORMAL_TEMPORARY_FAILURE" Content-Length: 0 Remote-Party-ID: "02740056997327220" <sip:02740056997327220@pxext.redvoiss.net>;party=calling;privacy=off;screen=no
------------------------------------------------------------------------ 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:440 (sofia/internal/557100036659@pxext.redvoiss.net) State Change CS_REPORTING -> CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1310 Send signal sofia/internal/557100036659@pxext.redvoiss.net [BREAK] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_session.c:1518 Session 9 (sofia/internal/557100036659@pxext.redvoiss.net) Locked, Waiting on external entities 2014-04-17 12:53:07.515177 [NOTICE] switch_core_session.c:1536 Session 9 (sofia/internal/557100036659@pxext.redvoiss.net) Ended 2014-04-17 12:53:07.515177 [NOTICE] switch_core_session.c:1540 Close Channel sofia/internal/557100036659@pxext.redvoiss.net [CS_DESTROY] 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:565 (sofia/internal/557100036659@pxext.redvoiss.net) Callstate Change HANGUP -> DOWN recv 368 bytes from udp/[64.76.154.110]:5060 at 15:53:07.519416: ------------------------------------------------------------------------ ACK sip:02740056997327220@64.76.154.219 SIP/2.0 Via: SIP/2.0/UDP 64.76.154.110;branch=z9hG4bK7a9.98e8b847.0 Max-Forwards: 69 From: "557100036659" <sip:557100036659@pxext.redvoiss.net>;tag=vc6acyloo.g2izl7bhjjjs-fx0islg2l To: <sip:0056997327220@pxext.redvoiss.net>;tag=K893tH0p1j8ce Call-ID: ltvhtt7fatoposx1rmg0lfyycwtghlvh CSeq: 20731 ACK Content-Length: 0
------------------------------------------------------------------------ 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:568 (sofia/internal/557100036659@pxext.redvoiss.net) Running State Change CS_DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/557100036659@pxext.redvoiss.net) State DESTROY 2014-04-17 12:53:07.515177 [DEBUG] mod_sofia.c:396 sofia/internal/557100036659@pxext.redvoiss.net SOFIA DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:99 sofia/internal/557100036659@pxext.redvoiss.net Standard DESTROY 2014-04-17 12:53:07.515177 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/557100036659@pxext.redvoiss.net) State DESTROY going to sleep recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:07.901037: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net>;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
------------------------------------------------------------------------ recv 420 bytes from udp/[64.76.154.36]:5060 at 15:53:08.901171: ------------------------------------------------------------------------ SIP/2.0 503 Service not available, no more gateways Via: SIP/2.0/UDP 64.76.154.219;rport=5060;branch=z9hG4bKgD9HQ9j8mHF0r From: "557100036659" <sip:557100036659@64.76.154.219>;tag=mH3vvcHtyUyZS To: <sip:02740056997327220@siplcr.redvoiss.net>;tag=9d729cbd5d1f51d0e4d8e178be0f0379-256f Call-ID: 359631e7-40eb-1232-32a9-0050569256e8 CSeq: 58538929 INVITE Server: kamailio (3.2.4 (x86_64/linux)) Content-Length: 0
De: Camila Troncoso [mailto:ctroncoso@redvoiss.net] Enviado el: miércoles, 16 de abril de 2014 10:03 Para: FreeSWITCH Users Help Asunto: RE: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response.
Hi,
My dialplan is like this, mi call matches “to_LCR_condition9”:
<context name="default">
<extension name="header_test_extension" continue="true"> <condition field="${sip_user_agent}" expression="AddPac SIP Gateway"> <action application="export" data="sdp_m_per_ptime=false"/> </condition> </extension>
<extension name="to_LCR_condition1"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition2"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition3"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition4"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition5"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexb=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition6"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:18 annexb=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:4 annexa=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition7"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=no)(.*)/s"> <action application="export" data="sip_force_audio_fmtp=annexa=no"/> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition8"> <condition field="network_addr" expression="^64\.76\.154\.110$"/> <condition field="${switch_r_sdp}" expression="/(.*)(a=fmtp:4 annexa=yes)(.*)/s"> <action application="export" data="sip_append_audio_sdp=a=fmtp:18 annexb=no"/> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="inherit_codec=true"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_LCR_condition9"> <condition field="network_addr" expression="^64\.76\.154\.110$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="export" data="nolocal:absolute_codec_string=G729,G723"/> <action application="set" data="sip_invite_domain=siplcr.redvoiss.net"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n' 'a=rtpmap:4 G723/8000\n' 'a=fmtp:4 annexa=no\n'}sofia/$${domain}/${destination_number}@siplcr.redvoiss.net"/> </condition> </extension>
<extension name="to_PROXY_BORDE"> <condition field="network_addr" expression="^64\.76\.154\.36$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension>
<extension name="to_PROXY_BORDE_2"> <condition field="network_addr" expression="^64\.76\.154\.198$"> <action application="set" data="call_timeout=50"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="sip_invite_domain=64.76.154.110"/> <action application="export" data="nolocal:absolute_codec_string=G729,PCMU,PCMA,iLBC"/> <action application="bridge" data="{sip_append_audio_sdp='a=rtpmap:18 G729/8000\n' 'a=fmtp:18 annexb=no\n'}sofia/$${domain}/${destination_number}@64.76.154.110"/> </condition> </extension>
</context>
De: freeswitch-users-bounces@lists.freeswitch.org [mailto:freeswitch-users-bounces@lists.freeswitch.org] En nombre de Steven Ayre Enviado el: martes, 15 de abril de 2014 18:46 Para: FreeSWITCH Users Help Asunto: Re: [Freeswitch-users] Freeswitch not terminating call after receiving "503 Service not available" response.
What does your dialplan look like?
A bridge with a 503 reply will fail. If FS is sending another INVITE that suggests it's doing another bridge when the first fails.
On 15 April 2014 22:02, Camila Troncoso <ctroncoso@redvoiss.net> wrote: Hi,
I have this scenario:
Proxy – FS -- LCR
I make a call from an user register in my proxy, passing trough freeswitch ( for media transcoding) , to my LCR server. The LCR looks for one route for my call, but I doesn’t found any, so It replays “503 Service not available, no more gateways”. When FS receives this response , it sends a re invite to the LCR server, falling again in the same error reply.
In my case I don’t what FS to send the re invite , I need it to pass the reply (“503 Service not available, no more gateways”) to the proxy.
How can I manage this?
Regards,
Camila
<image001.gif>
Camila Troncoso Solar | Ingeniero de Desarollo +56 2 22408535 · +56 9 97327220 | ctroncoso@redvoiss.net Badajoz 130, piso 16, Las Condes | Santiago - CHILE | www.redvoiss.com
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com
Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com
FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.com
Official FreeSWITCH Sites http://www.freeswitch.org http://wiki.freeswitch.org http://www.cluecon.com
FreeSWITCH-users mailing list FreeSWITCH-users@lists.freeswitch.org http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
participants (3)
-
Brian West
-
Camila Troncoso
-
Steven Ayre