<html>
<head>
<style><!--
.hmmessage P
{
margin:0px;
padding:0px
}
body.hmmessage
{
font-size: 12pt;
font-family:Calibri
}
--></style></head>
<body class='hmmessage'><div dir='ltr'>Its in public network. OK. heres the log after setting log level to 9 . Please check the below console log. Hope it gives some more clues.<br><br><div><div>2014-09-18 17:39:10.825909 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/internal/alice@fs.mydomain.com</div><div>nua.c:645 nua_bye() nua: nua_bye: entering</div><div>nua_stack.c:529 nua_signal() nua(0x7f16a83a5240): sent signal r_bye</div><div>2014-09-18 17:39:10.825909 [DEBUG] switch_core_state_machine.c:58 sofia/internal/alice@fs.mydomain.com Standard HANGUP, cause: NORMAL_CLEARING</div><div>nua_stack.c:569 nua_stack_signal() nua(0x7f16a83a5240): recv signal r_bye</div><div>2014-09-18 17:39:10.825909 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/alice@fs.mydomain.com) State HANGUP going to sleep</div><div>nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering</div><div>soa.c:403 soa_set_params() soa_set_params(static::0x7f16b0135890, ...) called</div><div>soa.c:1784 soa_terminate() soa_terminate(static::0x7f16b0135890) called</div><div>soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::0x7f16b0135890) called</div><div>nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip</div><div>nta.c:8132 outgoing_prepare_send() nta outgoing create: no transport protocol</div><div>nta.c:1348 set_timeout() nta: timer shortened to 5000 ms</div><div>2014-09-18 17:39:10.825909 [DEBUG] switch_core_state_machine.c:502 (sofia/internal/alice@fs.mydomain.com) State Change CS_HANGUP -&gt; CS_REPORTING</div><div>nua_stack.c:271 nua_stack_event() nua(0x7f16a83a5240):<b> event r_bye 503 No transport</b></div><div>2014-09-18 17:39:10.825909 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/alice@fs.mydomain.com [BREAK]</div><div>nua_session.c:4137 signal_call_state_change() nua(0x7f16a83a5240): call state changed: terminating -&gt; terminated</div><div>nua_stack.c:271 nua_stack_event() nua(0x7f16a83a5240):<b> event i_state 503 to BYE</b></div><div>nua_stack.c:271 nua_stack_event() nua(0x7f16a83a5240): <b>event i_terminated 503 to BYE</b></div><div>nua_dialog.c:397 nua_dialog_usage_remove_at() nua(0x7f16a83a5240): removing session usage</div><div>soa.c:356 soa_destroy() soa_destroy(static::0x7f16b0135890) called</div><div>nta.c:4468 nta_leg_destroy() nta_leg_destroy(0x7f16b40f0940)</div><div>nua_session.c:351 nua_session_usage_destroy() nua: terminated session 0x7f16a83a5240</div><div>nua_stack.c:359 nua_application_event() nua: nua_application_event: entering</div><div>nua_stack.c:359 nua_application_event() nua: nua_application_event: entering</div><div>nua_stack.c:359 nua_application_event() nua: nua_application_event: entering</div><div>nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering</div><div>nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering</div><div>nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering</div><div>nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering</div><div>nua.c:342 nua_handle_bind() nua: nua_handle_bind: entering</div><div>nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering</div><div>2014-09-18 17:39:10.825909 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/alice@fs.mydomain.com) Running State Change CS_REPORTING</div><div>nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering</div><div>nua.c:921 nua_handle_destroy() nua: nua_handle_destroy: entering</div><div>nua_stack.c:529 nua_signal() nua(0x7f16a83a5240): sent signal r_destroy</div><div>nua_stack.c:569 nua_stack_signal() nua(0x7f16a83a5240): recv signal r_destroy</div><div>nta.c:4468 nta_leg_destroy() nta_leg_destroy((nil))</div></div><div><br></div><div>From: freeswitch-users-request@lists.freeswitch.org<br>Subject: FreeSWITCH-users Digest, Vol 99, Issue 165<br>To: freeswitch-users@lists.freeswitch.org<br>Date: Fri, 19 Sep 2014 02:10:52 +0400<br><br><pre>Send FreeSWITCH-users mailing list submissions to<br>        freeswitch-users@lists.freeswitch.org<br> <br>To subscribe or unsubscribe via the World Wide Web, visit<br>        <a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>or, via email, send a message with subject or body 'help' to<br>        freeswitch-users-request@lists.freeswitch.org<br> <br>You can reach the person managing the list at<br>        freeswitch-users-owner@lists.freeswitch.org<br> <br>When replying, please edit your Subject line so it is more specific<br>than "Re: Contents of FreeSWITCH-users digest..."<br></pre><br><br>--Forwarded Message Attachment--<br>From: brian@freeswitch.org<br>To: freeswitch-users@lists.freeswitch.org<br>Date: Thu, 18 Sep 2014 17:10:20 -0500<br>Subject: Re: [Freeswitch-users] FreeSWITCH not sending BYE<br><br><div dir="ltr">sofia loglevel all 9<div><br></div><div>Is this local network or over the public internet?</div></div><div class="ecxgmail_extra"><br><div class="ecxgmail_quote">On Thu, Sep 18, 2014 at 4:52 PM, Kamrul Khan <span dir="ltr">&lt;<a href="mailto:dodul@live.com" target="_blank">dodul@live.com</a>&gt;</span> wrote:<br><blockquote class="ecxgmail_quote" style="border-left:1px #ccc solid;padding-left:1ex;">


<div><div dir="ltr">I checked the sofia debug. Didnt get anything interesting. Is there some other reason why it might be happening ?&nbsp;<br><br><div>From: <a href="mailto:freeswitch-users-request@lists.freeswitch.org" target="_blank">freeswitch-users-request@lists.freeswitch.org</a><br>Subject: FreeSWITCH-users Digest, Vol 99, Issue 162<br>To: <a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br>Date: Fri, 19 Sep 2014 00:13:50 +0400<br><br><pre>Send FreeSWITCH-users mailing list submissions to<br>        <a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br> <br>To subscribe or unsubscribe via the World Wide Web, visit<br>        <a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>or, via email, send a message with subject or body 'help' to<br>        <a href="mailto:freeswitch-users-request@lists.freeswitch.org" target="_blank">freeswitch-users-request@lists.freeswitch.org</a><br> <br>You can reach the person managing the list at<br>        <a href="mailto:freeswitch-users-owner@lists.freeswitch.org" target="_blank">freeswitch-users-owner@lists.freeswitch.org</a><br> <br>When replying, please edit your Subject line so it is more specific<br>than "Re: Contents of FreeSWITCH-users digest..."<br></pre><br><br>--Forwarded Message Attachment--<br>From: <a href="mailto:steveayre@gmail.com" target="_blank">steveayre@gmail.com</a><br>To: <a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br>Date: Thu, 18 Sep 2014 21:12:48 +0100<br>Subject: Re: [Freeswitch-users] FreeSWITCH not sending BYE<br><br><div dir="ltr">Turn on the sofia stack debugging - perhaps that'll show an error within the stack where the stack is told to send bye but fails to do so.</div><div><br><div>On 18 September 2014 17:52, Kamrul Khan <span dir="ltr">&lt;<a href="mailto:dodul@live.com" target="_blank">dodul@live.com</a>&gt;</span> wrote:<br><blockquote style="border-left:1px #ccc solid;padding-left:1ex;">


<div><div dir="ltr"><pre>Hi,</pre><pre><span style="font-family:Calibri,sans-serif;font-size:12pt;">As you can see from the trace all the other packets are passing fine. Its just the BYE message thats not being sent. I just found the below line from my console log:</span></pre><pre><span style="font-family:Calibri;white-space:normal;">2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:465 Sending BYE to</span><span style="font-family:Calibri;white-space:normal;">&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" style="font-family:Calibri;white-space:normal;" target="_blank">sofia/internal/alice@fs.mydomain.com</a>
<span style="font-family:Calibri,sans-serif;font-size:12pt;">
So, the log says its sending BYE, but in reality it sends nothing. Any idea whats happening? please help.</span></pre><br>--Forwarded Message Attachment--<br>From: <a href="mailto:mike@jerris.com" target="_blank">mike@jerris.com</a><br>To: <a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br>Date: Wed, 17 Sep 2014 21:32:03 -0400<br>Subject: Re: [Freeswitch-users] FreeSWITCH not sending BYE<br><br>something is wrong here... all of the sip packets are coming from and going to the IP address of the freeswitch box? &nbsp;<div><br><div><div>On Sep 17, 2014, at 7:06 PM, Kamrul Khan &lt;<a href="mailto:dodul@live.com" target="_blank">dodul@live.com</a>&gt; wrote:</div><br><blockquote><div style="font-size:12pt;font-family:Calibri;font-style:normal;font-variant:normal;font-weight:normal;letter-spacing:normal;line-height:normal;text-align:start;text-indent:0px;text-transform:none;white-space:normal;word-spacing:0px;"><div dir="ltr">Hi,<br><br>Im using freeswitch version 1.4.6. Its not sending back any BYE message. So the caller side thinks call is still alive. The scenario is like the below:<br><br>Alice(10.1.1.1) ---&gt; Freeswitch(172.16.0.150)---&gt;Bob(10.2.1.1)<br><br>If the call is terminated by Bob. Bob sends BYE to Freeswitch. but, Freeswitch simply sends back a 200 OK to BOB and drops the call. Doesnt send back any BYE to Alice. Therefore, Alice thinks the Call is still alive. How to fix this. HELP!!!<br><br>Check my My SIP TRACE:<br><br>&nbsp;------------------------------------------------------------------------<br>recv 2234 bytes from udp/[172.16.0.150]:5063 at 16:48:42.959303:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; INVITE<span>&nbsp;</span><a target="_blank">sip:+12345678@fs.mydomain.com</a><span>&nbsp;</span>SIP/2.0<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK92c.41e977c95ac87d15f0c4b613d3349799.0<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKQ3XukR17yfTyWXoEF01daB399SarZSUQ;rport=64649<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;<br>&nbsp;&nbsp; Contact: "Alice"&lt;<a target="_blank">sip:alice@10.1.1.2:64649;rtcweb-breaker=no;click2call=no;transport=ws</a>&gt;;+g.oma.sip-im;+sip.ice;language="en,fr";received="<a target="_blank">sip:10.1.1.2:64649;transport=WS</a>"<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10769 INVITE<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Length: 1262<br>&nbsp;&nbsp; Max-Forwards: 69<br>&nbsp;&nbsp; User-Agent: IM-client/OMA1.0 sipML5-v1.0.0.0<br>&nbsp;&nbsp; Organization:<span>&nbsp;</span><a href="http://dingaling.ca/" target="_blank">Dingaling.ca</a><br>&nbsp;&nbsp; Path: &lt;<a target="_blank">sip:172.16.0.150:5063;lr</a>&gt;<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=Mozilla-SIPUA-31.0 322 1 IN IP4 0.0.0.0<br>&nbsp;&nbsp; s=Doubango Telecom - firefox<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; a=ice-ufrag:17e36105<br>&nbsp;&nbsp; a=ice-pwd:35179857c2c39018fb82455091801d8a<br>&nbsp;&nbsp; a=fingerprint:sha-256 68:54:EE:EF:A0:BF:93:B9:B6:63:18:0F:C1:A1:BE:5C:6F:49:11:67:1A:88:2D:DC:20:09:80:92:A4:4C:5A:F1<br>&nbsp;&nbsp; m=audio 60678 UDP/TLS/RTP/SAVPF 109 0 8 101<br>&nbsp;&nbsp; c=IN IP4 172.16.0.150<br>&nbsp;&nbsp; a=rtpmap:109 opus/48000/2<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:8 PCMA/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=fmtp:101 0-15<br>&nbsp;&nbsp; a=sendrecv<br>&nbsp;&nbsp; a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level<br>&nbsp;&nbsp; a=setup:actpass<br>&nbsp;&nbsp; a=candidate:0 1 UDP <a target="_blank">2128609535</a> 172.16.1.188 54467 typ host<br>&nbsp;&nbsp; a=candidate:2 1 UDP 1692467199 10.1.1.2 54467 typ srflx raddr 172.16.1.188 rport 54467<br>&nbsp;&nbsp; a=candidate:5 1 UDP <a target="_blank">2128543999</a> 192.168.56.1 54468 typ host<br>&nbsp;&nbsp; a=candidate:10 1 UDP <a target="_blank">2128478463</a> 192.168.232.1 54469 typ host<br>&nbsp;&nbsp; a=candidate:15 1 UDP <a target="_blank">2128412927</a> 192.168.146.1 54470 typ host<br>&nbsp;&nbsp; a=candidate:0 2 UDP <a target="_blank">2128609534</a> 172.16.1.188 54471 typ host<br>&nbsp;&nbsp; a=candidate:1 2 UDP 1692467198 10.1.1.2 54471 typ srflx raddr 172.16.1.188 rport 54471<br>&nbsp;&nbsp; a=candidate:5 2 UDP <a target="_blank">2128543998</a> 192.168.56.1 54472 typ host<br>&nbsp;&nbsp; a=candidate:10 2 UDP <a target="_blank">2128478462</a> 192.168.232.1 54473 typ host<br>&nbsp;&nbsp; a=candidate:15 2 UDP <a target="_blank">2128412926</a> 192.168.146.1 54474 typ host<br>&nbsp;&nbsp; a=rtcp-mux<br>&nbsp;&nbsp; a=nortpproxy:yes<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>send 619 bytes to udp/[172.16.0.150]:5063 at 16:48:42.959974:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 100 Trying<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK92c.41e977c95ac87d15f0c4b613d3349799.0;received=172.16.0.150<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKQ3XukR17yfTyWXoEF01daB399SarZSUQ;rport=64649<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10769 INVITE<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Content-Length: 0<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:42.945889 [NOTICE] switch_channel.c:1053 New Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[76f1d37a-b4c0-4247-9fb2-45cf6eadd969]<br>2014-09-17 16:48:42.945889 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:42.945889 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:42.945889 [DEBUG] switch_core_state_machine.c:470 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_NEW<br>2014-09-17 16:48:42.945889 [DEBUG] sofia.c:8367<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>receiving invite from <a href="http://172.16.0.150:5063" target="_blank">172.16.0.150:5063</a> version: 1.4.6 git 9479729 2014-06-03 19:35:16Z 64bit<br>2014-09-17 16:48:42.945889 [DEBUG] sofia.c:8534 IP 172.16.0.150 Rejected by acl "domains". Falling back to Digest auth.<br>2014-09-17 16:48:42.945889 [DEBUG] switch_core_state_machine.c:489 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State NEW<br>send 1069 bytes to udp/[172.16.0.150]:5063 at 16:48:42.962202:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 407 Proxy Authentication Required<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK92c.41e977c95ac87d15f0c4b613d3349799.0;received=172.16.0.150<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKQ3XukR17yfTyWXoEF01daB399SarZSUQ;rport=64649<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;;tag=80Ny99e7gvpUj<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10769 INVITE<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Accept: application/sdp<br>&nbsp;&nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>&nbsp;&nbsp; Supported: timer, path, replaces<br>&nbsp;&nbsp; Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer<br>&nbsp;&nbsp; Proxy-Authenticate: Digest realm="<a href="http://fs.mydomain.com/" target="_blank">fs.mydomain.com</a>", nonce="4c15231c-896a-4131-b7c2-621ab8342e9a", algorithm=MD5, qop="auth"<br>&nbsp;&nbsp; Content-Length: 0<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:42.945889 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:42.945889 [DEBUG] sofia.c:2033 detaching session 76f1d37a-b4c0-4247-9fb2-45cf6eadd969<br>recv 615 bytes from udp/[172.16.0.150]:5063 at 16:48:42.998781:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; ACK<span>&nbsp;</span><a target="_blank">sip:+12345678@fs.mydomain.com</a><span>&nbsp;</span>SIP/2.0<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK92c.41e977c95ac87d15f0c4b613d3349799.0<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKQ3XukR17yfTyWXoEF01daB399SarZSUQ;rport=64649<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;;tag=80Ny99e7gvpUj<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10769 ACK<br>&nbsp;&nbsp; Content-Length: 0<br>&nbsp;&nbsp; Max-Forwards: 69<br>&nbsp;&nbsp; Path: &lt;<a target="_blank">sip:172.16.0.150:5063;lr</a>&gt;<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>recv 2543 bytes from udp/[172.16.0.150]:5063 at 16:48:43.004244:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; INVITE<span>&nbsp;</span><a target="_blank">sip:+12345678@fs.mydomain.com</a><span>&nbsp;</span>SIP/2.0<br><br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK22c.2784592c8ddaf1dddc7bcb9bbcbecd6a.0<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKJtOEBT8qZTFStRrzMZcGKo1Tq8iXUdFm;rport=64649<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;<br>&nbsp;&nbsp; Contact: "Alice"&lt;<a target="_blank">sip:alice@10.1.1.2:64649;rtcweb-breaker=no;click2call=no;transport=ws</a>&gt;;+g.oma.sip-im;+sip.ice;language="en,fr";received="<a target="_blank">sip:10.1.1.2:64649;transport=WS</a>"<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10770 INVITE<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Length: 1262<br>&nbsp;&nbsp; Max-Forwards: 69<br>&nbsp;&nbsp; Proxy-Authorization: Digest username="alice",realm="<a href="http://fs.mydomain.com/" target="_blank">fs.mydomain.com</a>",nonce="4c15231c-896a-4131-b7c2-621ab8342e9a",uri="<a target="_blank">sip:+12345678@fs.mydomain.com</a>",response="3f71cf991c76159a30fe0fbea938cbb9",algorithm=MD5,cnonce="8dabac05b6f0a365d085158868220703",qop=auth,nc=00000001<br>&nbsp;&nbsp; User-Agent: IM-client/OMA1.0 sipML5-v1.0.0.0<br>&nbsp;&nbsp; Organization:<span>&nbsp;</span><a href="http://dingaling.ca/" target="_blank">Dingaling.ca</a><br>&nbsp;&nbsp; Path: &lt;<a target="_blank">sip:172.16.0.150:5063;lr</a>&gt;<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=Mozilla-SIPUA-31.0 322 1 IN IP4 0.0.0.0<br>&nbsp;&nbsp; s=Doubango Telecom - firefox<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; a=ice-ufrag:17e36105<br>&nbsp;&nbsp; a=ice-pwd:35179857c2c39018fb82455091801d8a<br>&nbsp;&nbsp; a=fingerprint:sha-256 68:54:EE:EF:A0:BF:93:B9:B6:63:18:0F:C1:A1:BE:5C:6F:49:11:67:1A:88:2D:DC:20:09:80:92:A4:4C:5A:F1<br>&nbsp;&nbsp; m=audio 38168 UDP/TLS/RTP/SAVPF 109 0 8 101<br>&nbsp;&nbsp; c=IN IP4 172.16.0.150<br>&nbsp;&nbsp; a=rtpmap:109 opus/48000/2<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:8 PCMA/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=fmtp:101 0-15<br>&nbsp;&nbsp; a=sendrecv<br>&nbsp;&nbsp; a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level<br>&nbsp;&nbsp; a=setup:actpass<br>&nbsp;&nbsp; a=candidate:0 1 UDP <a target="_blank">2128609535</a> 172.16.1.188 54467 typ host<br>&nbsp;&nbsp; a=candidate:2 1 UDP 1692467199 10.1.1.2 54467 typ srflx raddr 172.16.1.188 rport 54467<br>&nbsp;&nbsp; a=candidate:5 1 UDP <a target="_blank">2128543999</a> 192.168.56.1 54468 typ host<br>&nbsp;&nbsp; a=candidate:10 1 UDP <a target="_blank">2128478463</a> 192.168.232.1 54469 typ host<br>&nbsp;&nbsp; a=candidate:15 1 UDP <a target="_blank">2128412927</a> 192.168.146.1 54470 typ host<br>&nbsp;&nbsp; a=candidate:0 2 UDP <a target="_blank">2128609534</a> 172.16.1.188 54471 typ host<br>&nbsp;&nbsp; a=candidate:1 2 UDP 1692467198 10.1.1.2 54471 typ srflx raddr 172.16.1.188 rport 54471<br>&nbsp;&nbsp; a=candidate:5 2 UDP <a target="_blank">2128543998</a> 192.168.56.1 54472 typ host<br>&nbsp;&nbsp; a=candidate:10 2 UDP <a target="_blank">2128478462</a> 192.168.232.1 54473 typ host<br>&nbsp;&nbsp; a=candidate:15 2 UDP <a target="_blank">2128412926</a> 192.168.146.1 54474 typ host<br>&nbsp;&nbsp; a=rtcp-mux<br>&nbsp;&nbsp; a=nortpproxy:yes<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>send 619 bytes to udp/[172.16.0.150]:5063 at 16:48:43.005058:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 100 Trying<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK22c.2784592c8ddaf1dddc7bcb9bbcbecd6a.0;received=172.16.0.150<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKJtOEBT8qZTFStRrzMZcGKo1Tq8iXUdFm;rport=64649<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10770 INVITE<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Content-Length: 0<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:42.985935 [DEBUG] sofia.c:2138 Re-attaching to session 76f1d37a-b4c0-4247-9fb2-45cf6eadd969<br>2014-09-17 16:48:42.985935 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:42.985935 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:43.005913 [DEBUG] sofia.c:8367<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>receiving invite from <a href="http://172.16.0.150:5063" target="_blank">172.16.0.150:5063</a> version: 1.4.6 git 9479729 2014-06-03 19:35:16Z 64bit<br>2014-09-17 16:48:43.005913 [DEBUG] sofia.c:8534 IP 172.16.0.150 Rejected by acl "domains". Falling back to Digest auth.<br>2014-09-17 16:48:43.285898 [DEBUG] sofia.c:6229 Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>entering state [received][100]<br>2014-09-17 16:48:43.285898 [DEBUG] sofia.c:6239 Remote SDP:<br>v=0<br>o=Mozilla-SIPUA-31.0 322 1 IN IP4 0.0.0.0<br>s=Doubango Telecom - firefox<br>t=0 0<br>a=ice-ufrag:17e36105<br>a=ice-pwd:35179857c2c39018fb82455091801d8a<br>a=fingerprint:sha-256 68:54:EE:EF:A0:BF:93:B9:B6:63:18:0F:C1:A1:BE:5C:6F:49:11:67:1A:88:2D:DC:20:09:80:92:A4:4C:5A:F1<br>m=audio 38168 UDP/TLS/RTP/SAVPF 109 0 8 101<br>c=IN IP4 172.16.0.150<br>a=rtpmap:109 opus/48000/2<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-15<br>a=ptime:20<br>a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level<br>a=setup:actpass<br>a=candidate:0 1 UDP <a target="_blank">2128609535</a> 172.16.1.188 54467 typ host<br>a=candidate:2 1 UDP 1692467199 10.1.1.2 54467 typ srflx raddr 172.16.1.188 rport 54467<br>a=candidate:5 1 UDP <a target="_blank">2128543999</a> 192.168.56.1 54468 typ host<br>a=candidate:10 1 UDP <a target="_blank">2128478463</a> 192.168.232.1 54469 typ host<br>a=candidate:15 1 UDP <a target="_blank">2128412927</a> 192.168.146.1 54470 typ host<br>a=candidate:0 2 UDP <a target="_blank">2128609534</a> 172.16.1.188 54471 typ host<br>a=candidate:1 2 UDP 1692467198 10.1.1.2 54471 typ srflx raddr 172.16.1.188 rport 54471<br>a=candidate:5 2 UDP <a target="_blank">2128543998</a> 192.168.56.1 54472 typ host<br>a=candidate:10 2 UDP <a target="_blank">2128478462</a> 192.168.232.1 54473 typ host<br>a=candidate:15 2 UDP <a target="_blank">2128412926</a> 192.168.146.1 54474 typ host<br>a=rtcp-mux<br>a=nortpproxy:yes<br><br>2014-09-17 16:48:43.285898 [DEBUG] sofia.c:6494 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State Change CS_NEW -&gt; CS_INIT<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_session.c:1387 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:470 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_INIT<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:510 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State INIT<br>2014-09-17 16:48:43.285898 [DEBUG] mod_sofia.c:87<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SOFIA INIT<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:40<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Standard INIT<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:48 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State Change CS_INIT -&gt; CS_ROUTING<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_session.c:1387 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:510 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State INIT going to sleep<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:470 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_ROUTING<br>2014-09-17 16:48:43.285898 [DEBUG] switch_channel.c:2180 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Callstate Change DOWN -&gt; RINGING<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:526 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State ROUTING<br>2014-09-17 16:48:43.285898 [DEBUG] mod_sofia.c:123<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SOFIA ROUTING<br>2014-09-17 16:48:43.285898 [DEBUG] switch_core_state_machine.c:164<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Standard ROUTING<br>2014-09-17 16:48:43.285898 [INFO] mod_dialplan_xml.c:558 Processing Alice &lt;alice&gt;-&gt;+12345678 in context dal-ingress<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>parsing [dal-ingress-&gt;3a05956905ca41e2b43170968d44398e] continue=false<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Absolute Condition [3a05956905ca41e2b43170968d44398e]<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(dal-UUID=3a05956905ca41e2b43170968d44398e)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(dal-Language=en)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action set(effective_caller_id_number=17783315100)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action set(effective_caller_id_name=Alice)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action set(sip_rh_X-DAL-UUID=3a05956905ca41e2b43170968d44398e)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action set(sip_ph_X-DAL-UUID=3a05956905ca41e2b43170968d44398e)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action set(sip_bye_h_X-DAL-UUID=3a05956905ca41e2b43170968d44398e)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(DAL-Time-Limit=118)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(DAL-Time-Limit-Bye=you-have-reached-the-time-limit-for-this-call)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(DAL-Time-Limit-Warnings=60@aleg:you-have-one-minute-remaining,300@aleg:you-have-five-minutes-remaining-for-this-call)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(nolocal:execute_on_answer=lua mod_callmgr/on-bridge.lua)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action export(DAL-Report-URL=<a href="http://todo-kkhan.dlcworldwide.com/index.php/internal/" target="_blank">http://todo-kkhan.dlcworldwide.com/index.php/internal/</a>)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action event(Event-Subclass=callmgr::call_uuid,Event-Name=CUSTOM)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action set(sip_h_Route=&lt;<a target="_blank">sip:172.16.0.150:5063</a>&gt;)<br>Dialplan:<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Action bridge(sofia/gateway/bobspecial/0000100912345678;fs_path=sip:172.16.0.150:5063|sofia/gateway/bob/12345678;fs_path=sip:172.16.0.150:5063|sofia/gateway/navigata/12345678;fs_path=sip:172.16.0.150:5063|sofia/gateway/lesnet/12345678;fs_path=sip:<a href="http://172.16.0.150:5063" target="_blank">172.16.0.150:5063</a>)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:214 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State Change CS_ROUTING -&gt; CS_EXECUTE<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_session.c:1387 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:526 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State ROUTING going to sleep<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:470 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_EXECUTE<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:533 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State EXECUTE<br>2014-09-17 16:48:43.705898 [DEBUG] mod_sofia.c:178<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SOFIA EXECUTE<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:256<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Standard EXECUTE<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(dal-UUID=3a05956905ca41e2b43170968d44398e)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [dal-UUID]=[3a05956905ca41e2b43170968d44398e]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(dal-Language=en)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [dal-Language]=[en]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>set(effective_caller_id_number=17783315100)<br>2014-09-17 16:48:43.705898 [DEBUG] mod_dptools.c:1435<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SET [effective_caller_id_number]=[17783315100]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>set(effective_caller_id_name=Alice)<br>2014-09-17 16:48:43.705898 [DEBUG] mod_dptools.c:1435<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SET [effective_caller_id_name]=[Alice]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>set(sip_rh_X-DAL-UUID=3a05956905ca41e2b43170968d44398e)<br>2014-09-17 16:48:43.705898 [DEBUG] mod_dptools.c:1435<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SET [sip_rh_X-DAL-UUID]=[3a05956905ca41e2b43170968d44398e]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>set(sip_ph_X-DAL-UUID=3a05956905ca41e2b43170968d44398e)<br>2014-09-17 16:48:43.705898 [DEBUG] mod_dptools.c:1435<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SET [sip_ph_X-DAL-UUID]=[3a05956905ca41e2b43170968d44398e]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>set(sip_bye_h_X-DAL-UUID=3a05956905ca41e2b43170968d44398e)<br>2014-09-17 16:48:43.705898 [DEBUG] mod_dptools.c:1435<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SET [sip_bye_h_X-DAL-UUID]=[3a05956905ca41e2b43170968d44398e]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(DAL-Time-Limit=118)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [DAL-Time-Limit]=[118]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(DAL-Time-Limit-Bye=you-have-reached-the-time-limit-for-this-call)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [DAL-Time-Limit-Bye]=[you-have-reached-the-time-limit-for-this-call]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(DAL-Time-Limit-Warnings=60@aleg:you-have-one-minute-remaining,300@aleg:you-have-five-minutes-remaining-for-this-call)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [DAL-Time-Limit-Warnings]=[60@aleg:you-have-one-minute-remaining,300@aleg:you-have-five-minutes-remaining-for-this-call]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(nolocal:execute_on_answer=lua mod_callmgr/on-bridge.lua)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) (REMOTE ONLY) [execute_on_answer]=[lua mod_callmgr/on-bridge.lua]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>export(DAL-Report-URL=<a href="http://todo-kkhan.dlcworldwide.com/index.php/internal/" target="_blank">http://todo-kkhan.dlcworldwide.com/index.php/internal/</a>)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [DAL-Report-URL]=[<a href="http://todo-kkhan.dlcworldwide.com/index.php/internal/" target="_blank">http://todo-kkhan.dlcworldwide.com/index.php/internal/</a>]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>event(Event-Subclass=callmgr::call_uuid,Event-Name=CUSTOM)<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>set(sip_h_Route=&lt;<a target="_blank">sip:172.16.0.150:5063</a>&gt;)<br>2014-09-17 16:48:43.705898 [DEBUG] mod_dptools.c:1435<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SET [sip_h_Route]=[&lt;<a target="_blank">sip:172.16.0.150:5063</a>&gt;]<br>EXECUTE<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>bridge(sofia/gateway/bobspecial/0000100912345678;fs_path=sip:172.16.0.150:5063|sofia/gateway/bob/12345678;fs_path=sip:172.16.0.150:5063|sofia/gateway/navigata/12345678;fs_path=sip:172.16.0.150:5063|sofia/gateway/lesnet/12345678;fs_path=sip:<a href="http://172.16.0.150:5063" target="_blank">172.16.0.150:5063</a>)<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [dal-UUID]=[3a05956905ca41e2b43170968d44398e] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [dal-Language]=[en] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [DAL-Time-Limit]=[118] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [DAL-Time-Limit-Bye]=[you-have-reached-the-time-limit-for-this-call] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [DAL-Time-Limit-Warnings]=[60@aleg:you-have-one-minute-remaining,300@aleg:you-have-five-minutes-remaining-for-this-call] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [execute_on_answer]=[lua mod_callmgr/on-bridge.lua] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_channel.c:1199<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>EXPORTING[export_vars] [DAL-Report-URL]=[<a href="http://todo-kkhan.dlcworldwide.com/index.php/internal/" target="_blank">http://todo-kkhan.dlcworldwide.com/index.php/internal/</a>] to event<br>2014-09-17 16:48:43.705898 [DEBUG] switch_ivr_originate.c:2078 Parsing global variables<br>2014-09-17 16:48:43.705898 [NOTICE] switch_channel.c:1053 New Channel sofia/internal/0000100912345678 [3b3c0b87-2c5b-42a0-9a78-90449685f296]<br>2014-09-17 16:48:43.705898 [DEBUG] mod_sofia.c:4565 (sofia/internal/0000100912345678) State Change CS_NEW -&gt; CS_INIT<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:43.705898 [DEBUG] mod_sofia.c:4635 [zrtp_passthru] Setting a-leg inherit_codec=true<br>2014-09-17 16:48:43.705898 [DEBUG] mod_sofia.c:4638 [zrtp_passthru] Setting b-leg absolute_codec_string='opus@48000h@20i,PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b'<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0000100912345678) Running State Change CS_INIT<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:510 (sofia/internal/0000100912345678) State INIT<br>2014-09-17 16:48:43.705898 [DEBUG] mod_sofia.c:87 sofia/internal/0000100912345678 SOFIA INIT<br>2014-09-17 16:48:43.705898 [DEBUG] sofia_glue.c:1197<span>&nbsp;</span><a target="_blank">sip:172.16.0.150:5063</a><span>&nbsp;</span>Setting proxy route to sofia/internal/0000100912345678<br>2014-09-17 16:48:43.705898 [DEBUG] sofia_glue.c:1226 sofia/internal/0000100912345678 sending invite version: 1.4.6 git 9479729 2014-06-03 19:35:16Z 64bit<br>Local SDP:<br>v=0<br>o=FreeSWITCH 1410967571 1410967572 IN IP4 10.1.1.1<br>s=FreeSWITCH<br>c=IN IP4 10.1.1.1<br>t=0 0<br>m=audio 26552 RTP/AVP 109 0 8 101 13<br>a=rtpmap:109 opus/48000/2<br>a=fmtp:109 useinbandfec=1;usedtx=1;maxaveragebitrate=30000;ptime=20;minptime=20;maxptime=20;samplerate=48000<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-16<br>a=ptime:20<br>a=sendrecv<br><br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:40 sofia/internal/0000100912345678 Standard INIT<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/0000100912345678) State Change CS_INIT -&gt; CS_ROUTING<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:510 (sofia/internal/0000100912345678) State INIT going to sleep<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0000100912345678) Running State Change CS_ROUTING<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:526 (sofia/internal/0000100912345678) State ROUTING<br>2014-09-17 16:48:43.705898 [DEBUG] mod_sofia.c:123 sofia/internal/0000100912345678 SOFIA ROUTING<br>2014-09-17 16:48:43.705898 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/0000100912345678) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:526 (sofia/internal/0000100912345678) State ROUTING going to sleep<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0000100912345678) Running State Change CS_CONSUME_MEDIA<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:545 (sofia/internal/0000100912345678) State CONSUME_MEDIA<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_state_machine.c:545 (sofia/internal/0000100912345678) State CONSUME_MEDIA going to sleep<br>send 1513 bytes to udp/[172.16.0.150]:5063 at 16:48:43.720773:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; INVITE<span>&nbsp;</span><a target="_blank">sip:0000100912345678@10.2.1.1</a><span>&nbsp;</span>SIP/2.0<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 172.16.0.150:6090;rport;branch=z9hG4bKDytKNrBp1aDrQ<br>&nbsp;&nbsp; Route: &lt;<a target="_blank">sip:172.16.0.150:5063</a>&gt;<br>&nbsp;&nbsp; Route: &lt;<a target="_blank">sip:172.16.0.150:5063</a>&gt;<br>&nbsp;&nbsp; Max-Forwards: 68<br>&nbsp;&nbsp; From: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 65160997 INVITE<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:gw+bobspecial@172.16.0.150:6090;transport=udp;gw=bobspecial</a>&gt;<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>&nbsp;&nbsp; Supported: timer, path, replaces<br>&nbsp;&nbsp; Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Disposition: session<br>&nbsp;&nbsp; Content-Length: 390<br><br>&nbsp;&nbsp; X-FS-Support: update_display,send_info<br>&nbsp;&nbsp; Remote-Party-ID: "Alice" &lt;<a target="_blank">sip:17783315100@10.2.1.1</a>&gt;;party=calling;screen=yes;privacy=off<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=FreeSWITCH 1410967571 1410967572 IN IP4 10.1.1.1<br>&nbsp;&nbsp; s=FreeSWITCH<br>&nbsp;&nbsp; c=IN IP4 10.1.1.1<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; m=audio 26552 RTP/AVP 109 0 8 101 13<br>&nbsp;&nbsp; a=rtpmap:109 opus/48000/2<br>&nbsp;&nbsp; a=fmtp:109 useinbandfec=1;usedtx=1;maxaveragebitrate=30000;ptime=20;minptime=20;maxptime=20;samplerate=48000<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:8 PCMA/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=fmtp:101 0-16<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:43.705898 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:43.705898 [DEBUG] sofia.c:6229 Channel sofia/internal/0000100912345678 entering state [calling][0]<br>recv 577 bytes from udp/[172.16.0.150]:5063 at 16:48:43.819920:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 100 Trying<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 172.16.0.150:6090;rport=6090;branch=z9hG4bKDytKNrBp1aDrQ<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 65160997 INVITE<br>&nbsp;&nbsp; User-Agent: bobPBX<br>&nbsp;&nbsp; Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY<br>&nbsp;&nbsp; Supported: replaces<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1:5060</a>&gt;<br>&nbsp;&nbsp; Content-Length: 0<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>recv 917 bytes from udp/[172.16.0.150]:5063 at 16:48:46.221310:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 183 Session Progress<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 172.16.0.150:6090;rport=6090;branch=z9hG4bKDytKNrBp1aDrQ<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;;tag=as5129a390<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 65160997 INVITE<br>&nbsp;&nbsp; User-Agent: bobPBX<br>&nbsp;&nbsp; Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY<br>&nbsp;&nbsp; Supported: replaces<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1:5060</a>&gt;<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Length: 282<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=root 27411 27411 IN IP4 172.16.0.150<br>&nbsp;&nbsp; s=session<br>&nbsp;&nbsp; c=IN IP4 172.16.0.150<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; m=audio 49198 RTP/AVP 0 8 101<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:8 PCMA/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=fmtp:101 0-16<br>&nbsp;&nbsp; a=silenceSupp:off - - - -<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; a=sendrecv<br>&nbsp;&nbsp; a=nortpproxy:yes<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:46.205889 [DEBUG] sofia.c:6229 Channel sofia/internal/0000100912345678 entering state [proceeding][183]<br>2014-09-17 16:48:46.205889 [DEBUG] sofia.c:6239 Remote SDP:<br>v=0<br>o=root 27411 27411 IN IP4 172.16.0.150<br>s=session<br>c=IN IP4 172.16.0.150<br>t=0 0<br>m=audio 49198 RTP/AVP 0 8 101<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-16<br>a=silenceSupp:off - - - -<br>a=ptime:20<br>a=nortpproxy:yes<br><br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMU:0:8000:20:64000]/[opus:116:48000:20:0]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3437 Audio Codec Compare [PCMU:0:8000:20:64000] ++++ is saved as a match<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMA:8:8000:20:64000]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMA:8:8000:20:64000]/[opus:116:48000:20:0]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3437 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3309 Set telephone-event payload to 101<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:2343 Set Codec sofia/internal/0000100912345678 PCMU/8000 20 ms 160 samples 64000 bits<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_codec.c:111 sofia/internal/0000100912345678 Original read codec set to PCMU:0<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:3617 Set 2833 dtmf send payload to 101<br>2014-09-17 16:48:46.205889 [DEBUG] switch_core_media.c:4842 AUDIO RTP [sofia/internal/0000100912345678] 10.1.1.1 port 26552 -&gt; 172.16.0.150 port 49198 codec: 0 ms: 20<br>2014-09-17 16:48:46.205889 [DEBUG] switch_rtp.c:3351 Starting timer [soft] 160 bytes per 20ms<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:5189 Set 2833 dtmf send payload to 101<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:5195 Set 2833 dtmf receive payload to 101<br>2014-09-17 16:48:46.225921 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/0000100912345678!<br>2014-09-17 16:48:46.225921 [DEBUG] switch_channel.c:3391 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>[BREAK]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_channel.c:3395 (sofia/internal/0000100912345678) Callstate Change DOWN -&gt; EARLY<br>2014-09-17 16:48:46.225921 [DEBUG] switch_ivr_originate.c:412 Setting codec string on<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>to PCMU@8000h@20i<br>2014-09-17 16:48:46.225921 [INFO] switch_ivr_originate.c:3500 Sending early media<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [opus:109:48000:20:0]/[PCMU:0:8000:20:64000]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:3437 Audio Codec Compare [PCMU:0:8000:20:64000] ++++ is saved as a match<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:3383 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:3309 Set telephone-event payload to 101<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2343 Set Codec<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>PCMU/8000 20 ms 160 samples 64000 bits<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_codec.c:111<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Original read codec set to PCMU:0<br>2014-09-17 16:48:46.225921 [WARNING] switch_core_media.c:2548 NO candidate ACL defined, Defaulting to wan.auto<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 1 proto: UDP type: host addr: <a href="http://172.16.1.188:54467" target="_blank">172.16.1.188:54467</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 1 proto: UDP type: host addr: <a href="http://172.16.1.188:54467" target="_blank">172.16.1.188:54467</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 1 proto: UDP type: srflx addr: <a href="http://10.1.1.2:54467" target="_blank">10.1.1.2:54467</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2581 Choose audio Candidate cid: 1 proto: UDP type: srflx addr: <a href="http://10.1.1.2:54467" target="_blank">10.1.1.2:54467</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 1 proto: UDP type: host addr: <a href="http://192.168.56.1:54468" target="_blank">192.168.56.1:54468</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 1 proto: UDP type: host addr: <a href="http://192.168.56.1:54468" target="_blank">192.168.56.1:54468</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 1 proto: UDP type: host addr: <a href="http://192.168.232.1:54469" target="_blank">192.168.232.1:54469</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 1 proto: UDP type: host addr: <a href="http://192.168.232.1:54469" target="_blank">192.168.232.1:54469</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 1 proto: UDP type: host addr: <a href="http://192.168.146.1:54470" target="_blank">192.168.146.1:54470</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 1 proto: UDP type: host addr: <a href="http://192.168.146.1:54470" target="_blank">192.168.146.1:54470</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 2 proto: UDP type: host addr: <a href="http://172.16.1.188:54471" target="_blank">172.16.1.188:54471</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 2 proto: UDP type: host addr: <a href="http://172.16.1.188:54471" target="_blank">172.16.1.188:54471</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 2 proto: UDP type: srflx addr: <a href="http://10.1.1.2:54471" target="_blank">10.1.1.2:54471</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2581 Choose audio Candidate cid: 2 proto: UDP type: srflx addr: <a href="http://10.1.1.2:54471" target="_blank">10.1.1.2:54471</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 2 proto: UDP type: host addr: <a href="http://192.168.56.1:54472" target="_blank">192.168.56.1:54472</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 2 proto: UDP type: host addr: <a href="http://192.168.56.1:54472" target="_blank">192.168.56.1:54472</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 2 proto: UDP type: host addr: <a href="http://192.168.232.1:54473" target="_blank">192.168.232.1:54473</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 2 proto: UDP type: host addr: <a href="http://192.168.232.1:54473" target="_blank">192.168.232.1:54473</a><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:2572 Checking Candidate cid: 2 proto: UDP type: host addr: <a href="http://192.168.146.1:54474" target="_blank">192.168.146.1:54474</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2586 Save audio Candidate cid: 2 proto: UDP type: host addr: <a href="http://192.168.146.1:54474" target="_blank">192.168.146.1:54474</a><br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2710 setting remote audio ice addr to <a href="http://10.1.1.2:54467" target="_blank">10.1.1.2:54467</a> based on candidate<br>2014-09-17 16:48:46.225921 [NOTICE] switch_core_media.c:2730 setting remote rtcp audio addr to <a href="http://10.1.1.2:54471" target="_blank">10.1.1.2:54471</a> based on candidate<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:3626 Set 2833 dtmf send/recv payload to 101<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:4842 AUDIO RTP [<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>] 10.1.1.1 port 24858 -&gt; 10.1.1.2 port 54467 codec: 0 ms: 20<br>2014-09-17 16:48:46.225921 [DEBUG] switch_rtp.c:3351 Starting timer [soft] 160 bytes per 20ms<br>2014-09-17 16:48:46.225921 [INFO] switch_core_media.c:5011 Activating Audio ICE<br>2014-09-17 16:48:46.225921 [NOTICE] switch_rtp.c:3792 Activating RTP audio ICE: 17e36105:JMJwWUvXyYRgIAHV <a href="http://10.1.1.2:54467" target="_blank">10.1.1.2:54467</a><br>2014-09-17 16:48:46.225921 [INFO] switch_core_media.c:5054 Activating RTCP PORT 54471<br>2014-09-17 16:48:46.225921 [DEBUG] switch_rtp.c:3697 RTCP send rate is: 10000 and packet rate is: 20000 Remote Port: 54471<br>2014-09-17 16:48:46.225921 [DEBUG] switch_rtp.c:2170 Setting RTCP remote addr to <a href="http://10.1.1.2:54471" target="_blank">10.1.1.2:54471</a><br>2014-09-17 16:48:46.225921 [INFO] switch_core_media.c:5064 Activating RTCP ICE<br>2014-09-17 16:48:46.225921 [NOTICE] switch_rtp.c:3792 Activating RTCP audio ICE: 17e36105:JMJwWUvXyYRgIAHV <a href="http://10.1.1.2:54471" target="_blank">10.1.1.2:54471</a><br>2014-09-17 16:48:46.225921 [INFO] switch_rtp.c:2895 Activate RTP/RTCP audio DTLS client<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:5189 Set 2833 dtmf send payload to 101<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_media.c:5195 Set 2833 dtmf receive payload to 101<br>2014-09-17 16:48:46.225921 [NOTICE] sofia_media.c:92 Pre-Answer<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>!<br>2014-09-17 16:48:46.225921 [DEBUG] switch_channel.c:3395 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Callstate Change RINGING -&gt; EARLY<br>2014-09-17 16:48:46.225921 [DEBUG] mod_sofia.c:2222 Ring SDP:<br>v=0<br>o=FreeSWITCH 1410969268 1410969269 IN IP4 10.1.1.1<br>s=FreeSWITCH<br>c=IN IP4 10.1.1.1<br>t=0 0<br>a=msid-semantic: WMS RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>m=audio 24858 UDP/TLS/RTP/SAVPF 0 101<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:101 telephone-event/8000<br>a=ptime:20<br>a=sendrecv<br>a=fingerprint:sha-256 91:E9:37:67:75:A4:28:C0:E6:DB:6B:2B:B7:A6:5E:5C:B5:2D:99:89:CF:26:44:FA:D0:82:A0:9C:F2:A2:84:94<br>a=rtcp-mux<br>a=rtcp:24858 IN IP4 10.1.1.1<br>a=ssrc:271344810 cname:nx21mWJyvjncyrD8<br>a=ssrc:271344810 msid:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA a0<br>a=ssrc:271344810 mslabel:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>a=ssrc:271344810 label:RDPCOY3SmIJZRpeBKriKXkk9aND4STSAa0<br>a=ice-ufrag:JMJwWUvXyYRgIAHV<br>a=ice-pwd:XAN9nnyIxMLV4fUDRtZEdlrB<br>a=candidate:2725252931 1 udp 659136 10.1.1.1 24858 typ host generation 0<br><br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_session.c:907 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_ivr_originate.c:3551 Originate Resulted in Success: [sofia/internal/0000100912345678]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_session.c:907 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_session.c:907 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_ivr_bridge.c:1460 (sofia/internal/0000100912345678) State Change CS_CONSUME_MEDIA -&gt; CS_EXCHANGE_MEDIA<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>send 2056 bytes to udp/[172.16.0.150]:5063 at 16:48:46.238673:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 183 Session Progress<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK22c.2784592c8ddaf1dddc7bcb9bbcbecd6a.0;received=172.16.0.150<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKJtOEBT8qZTFStRrzMZcGKo1Tq8iXUdFm;rport=64649<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;;tag=99eQB5Zae5cee<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10770 INVITE<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:+12345678@172.16.0.150:6090;transport=udp</a>&gt;<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Accept: application/sdp<br>&nbsp;&nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>&nbsp;&nbsp; Supported: timer, path, replaces<br>&nbsp;&nbsp; Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Disposition: session<br>&nbsp;&nbsp; Content-Length: 799<br>&nbsp;&nbsp; X-DAL-UUID: 3a05956905ca41e2b43170968d44398e<br>&nbsp;&nbsp; Remote-Party-ID: "Outbound Call" &lt;<a target="_blank">sip:5063@fs.mydomain.com</a>&gt;;party=calling;privacy=off;screen=no<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=FreeSWITCH 1410969268 1410969269 IN IP4 10.1.1.1<br>&nbsp;&nbsp; s=FreeSWITCH<br>&nbsp;&nbsp; c=IN IP4 10.1.1.1<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; a=msid-semantic: WMS RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>&nbsp;&nbsp; m=audio 24858 UDP/TLS/RTP/SAVPF 0 101<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; a=fingerprint:sha-256 91:E9:37:67:75:A4:28:C0:E6:DB:6B:2B:B7:A6:5E:5C:B5:2D:99:89:CF:26:44:FA:D0:82:A0:9C:F2:A2:84:94<br>&nbsp;&nbsp; a=rtcp-mux<br>&nbsp;&nbsp; a=rtcp:24858 IN IP4 10.1.1.1<br>&nbsp;&nbsp; a=ssrc:271344810 cname:nx21mWJyvjncyrD8<br>&nbsp;&nbsp; a=ssrc:271344810 msid:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA a0<br>&nbsp;&nbsp; a=ssrc:271344810 mslabel:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>&nbsp;&nbsp; a=ssrc:271344810 label:RDPCOY3SmIJZRpeBKriKXkk9aND4STSAa0<br>&nbsp;&nbsp; a=ice-ufrag:JMJwWUvXyYRgIAHV<br>&nbsp;&nbsp; a=ice-pwd:XAN9nnyIxMLV4fUDRtZEdlrB<br>&nbsp;&nbsp; a=candidate:2725252931 1 udp 659136 10.1.1.1 24858 typ host generation 0<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0000100912345678) Running State Change CS_EXCHANGE_MEDIA<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:46.225921 [DEBUG] switch_core_state_machine.c:536 (sofia/internal/0000100912345678) State EXCHANGE_MEDIA<br>2014-09-17 16:48:46.225921 [DEBUG] mod_sofia.c:592 SOFIA EXCHANGE_MEDIA<br>2014-09-17 16:48:46.225921 [DEBUG] sofia.c:6229 Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>entering state [early][183]<br>2014-09-17 16:48:47.305892 [INFO] switch_rtp.c:2718 Changing audio DTLS state from HANDSHAKE to SETUP<br>2014-09-17 16:48:47.305892 [INFO] switch_rtp.c:2626 audio Fingerprint Verified.<br>2014-09-17 16:48:47.305892 [INFO] switch_rtp.c:3168 Activating Audio Secure RTP SEND<br>2014-09-17 16:48:47.305892 [DEBUG] switch_core_sqldb.c:2568 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80<br>2014-09-17 16:48:47.305892 [INFO] switch_rtp.c:3146 Activating Audio Secure RTP RECV<br>2014-09-17 16:48:47.305892 [INFO] switch_rtp.c:2666 Changing audio DTLS state from SETUP to READY<br>2014-09-17 16:48:47.305892 [DEBUG] switch_core_sqldb.c:2568 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80<br>2014-09-17 16:48:47.545899 [INFO] switch_rtp.c:5554 Auto Changing port from <a href="http://172.16.0.150:49198" target="_blank">172.16.0.150:49198</a> to <a href="http://10.1.1.1:49198" target="_blank">10.1.1.1:49198</a><br>recv 903 bytes from udp/[172.16.0.150]:5063 at 16:48:54.507821:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 200 OK<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 172.16.0.150:6090;rport=6090;branch=z9hG4bKDytKNrBp1aDrQ<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;;tag=as5129a390<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 65160997 INVITE<br>&nbsp;&nbsp; User-Agent: bobPBX<br>&nbsp;&nbsp; Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY<br>&nbsp;&nbsp; Supported: replaces<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1:5060</a>&gt;<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Length: 282<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=root 27411 27412 IN IP4 172.16.0.150<br>&nbsp;&nbsp; s=session<br>&nbsp;&nbsp; c=IN IP4 172.16.0.150<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; m=audio 49198 RTP/AVP 0 8 101<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:8 PCMA/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=fmtp:101 0-16<br>&nbsp;&nbsp; a=silenceSupp:off - - - -<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; a=sendrecv<br>&nbsp;&nbsp; a=nortpproxy:yes<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:54.505900 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:54.505900 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:54.526003 [DEBUG] sofia.c:6229 Channel sofia/internal/0000100912345678 entering state [completing][200]<br>2014-09-17 16:48:54.526003 [DEBUG] sofia.c:6239 Remote SDP:<br>v=0<br>o=root 27411 27412 IN IP4 172.16.0.150<br>s=session<br>c=IN IP4 172.16.0.150<br>t=0 0<br>m=audio 49198 RTP/AVP 0 8 101<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-16<br>a=silenceSupp:off - - - -<br>a=ptime:20<br>a=nortpproxy:yes<br><br>send 538 bytes to udp/[172.16.0.150]:5063 at 16:48:54.528674:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; ACK<span>&nbsp;</span><a target="_blank">sip:0000100912345678@10.2.1.1:5060</a><span>&nbsp;</span>SIP/2.0<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 172.16.0.150:6090;rport;branch=z9hG4bKe7KcQKvSyK3aK<br>&nbsp;&nbsp; Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Max-Forwards: 70<br>&nbsp;&nbsp; From: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;;tag=as5129a390<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 65160997 ACK<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:gw+bobspecial@172.16.0.150:6090;transport=udp;gw=bobspecial</a>&gt;<br>&nbsp;&nbsp; Content-Length: 0<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:54.526003 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:54.526003 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:54.526003 [DEBUG] sofia.c:6229 Channel sofia/internal/0000100912345678 entering state [ready][200]<br>2014-09-17 16:48:54.545977 [DEBUG] switch_channel.c:3631 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>[BREAK]<br>2014-09-17 16:48:54.545977 [NOTICE] sofia.c:6996 Channel [sofia/internal/0000100912345678] has been answered<br>EXECUTE sofia/internal/0000100912345678 lua(mod_callmgr/on-bridge.lua)<br>2014-09-17 16:48:54.545977 [ERR] mod_lua.cpp:203 cannot open /home/kkhan/fsdevel/scripts/mod_callmgr/on-bridge.lua: No such file or directory<br>2014-09-17 16:48:54.545977 [DEBUG] switch_cpp.cpp:1056 sofia/internal/0000100912345678 destroy/unlink session from object<br>2014-09-17 16:48:54.545977 [DEBUG] switch_channel.c:3685 (sofia/internal/0000100912345678) Callstate Change EARLY -&gt; ACTIVE<br>2014-09-17 16:48:54.545977 [DEBUG] mod_sofia.c:778 Local SDP<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>:<br>v=0<br>o=FreeSWITCH 1410969268 1410969270 IN IP4 10.1.1.1<br>s=FreeSWITCH<br>c=IN IP4 10.1.1.1<br>t=0 0<br>a=msid-semantic: WMS RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>m=audio 24858 UDP/TLS/RTP/SAVPF 0 101<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:101 telephone-event/8000<br>a=ptime:20<br>a=sendrecv<br>a=fingerprint:sha-256 91:E9:37:67:75:A4:28:C0:E6:DB:6B:2B:B7:A6:5E:5C:B5:2D:99:89:CF:26:44:FA:D0:82:A0:9C:F2:A2:84:94<br>a=rtcp-mux<br>a=rtcp:24858 IN IP4 10.1.1.1<br>a=ssrc:271344810 cname:nx21mWJyvjncyrD8<br>a=ssrc:271344810 msid:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA a0<br>a=ssrc:271344810 mslabel:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>a=ssrc:271344810 label:RDPCOY3SmIJZRpeBKriKXkk9aND4STSAa0<br>a=ice-ufrag:JMJwWUvXyYRgIAHV<br>a=ice-pwd:XAN9nnyIxMLV4fUDRtZEdlrB<br>a=candidate:6961800946 1 udp 659136 10.1.1.1 24858 typ host generation 0<br><br>2014-09-17 16:48:54.545977 [DEBUG] switch_core_session.c:907 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:54.545977 [NOTICE] switch_ivr_bridge.c:496 Channel [<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>] has been answered<br>send 2017 bytes to udp/[172.16.0.150]:5063 at 16:48:54.553616:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 200 OK<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK22c.2784592c8ddaf1dddc7bcb9bbcbecd6a.0;received=172.16.0.150<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKJtOEBT8qZTFStRrzMZcGKo1Tq8iXUdFm;rport=64649<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;;tag=99eQB5Zae5cee<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10770 INVITE<br>&nbsp;&nbsp; Contact: &lt;<a target="_blank">sip:+12345678@172.16.0.150:6090;transport=udp</a>&gt;<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>&nbsp;&nbsp; Supported: timer, path, replaces<br>&nbsp;&nbsp; Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer<br>&nbsp;&nbsp; Content-Type: application/sdp<br>&nbsp;&nbsp; Content-Disposition: session<br>&nbsp;&nbsp; Content-Length: 799<br>&nbsp;&nbsp; X-DAL-UUID: 3a05956905ca41e2b43170968d44398e<br>&nbsp;&nbsp; Remote-Party-ID: "Outbound Call" &lt;<a target="_blank">sip:5063@fs.mydomain.com</a>&gt;;party=calling;privacy=off;screen=no<br><br>&nbsp;&nbsp; v=0<br>&nbsp;&nbsp; o=FreeSWITCH 1410969268 1410969269 IN IP4 10.1.1.1<br>&nbsp;&nbsp; s=FreeSWITCH<br>&nbsp;&nbsp; c=IN IP4 10.1.1.1<br>&nbsp;&nbsp; t=0 0<br>&nbsp;&nbsp; a=msid-semantic: WMS RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>&nbsp;&nbsp; m=audio 24858 UDP/TLS/RTP/SAVPF 0 101<br>&nbsp;&nbsp; a=rtpmap:0 PCMU/8000<br>&nbsp;&nbsp; a=rtpmap:101 telephone-event/8000<br>&nbsp;&nbsp; a=ptime:20<br>&nbsp;&nbsp; a=fingerprint:sha-256 91:E9:37:67:75:A4:28:C0:E6:DB:6B:2B:B7:A6:5E:5C:B5:2D:99:89:CF:26:44:FA:D0:82:A0:9C:F2:A2:84:94<br>&nbsp;&nbsp; a=rtcp-mux<br>&nbsp;&nbsp; a=rtcp:24858 IN IP4 10.1.1.1<br>&nbsp;&nbsp; a=ssrc:271344810 cname:nx21mWJyvjncyrD8<br>&nbsp;&nbsp; a=ssrc:271344810 msid:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA a0<br>&nbsp;&nbsp; a=ssrc:271344810 mslabel:RDPCOY3SmIJZRpeBKriKXkk9aND4STSA<br>&nbsp;&nbsp; a=ssrc:271344810 label:RDPCOY3SmIJZRpeBKriKXkk9aND4STSAa0<br>&nbsp;&nbsp; a=ice-ufrag:JMJwWUvXyYRgIAHV<br>&nbsp;&nbsp; a=ice-pwd:XAN9nnyIxMLV4fUDRtZEdlrB<br>&nbsp;&nbsp; a=candidate:2725252931 1 udp 659136 10.1.1.1 24858 typ host generation 0<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:54.545977 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:54.545977 [DEBUG] switch_channel.c:3685 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Callstate Change EARLY -&gt; ACTIVE<br>2014-09-17 16:48:54.545977 [DEBUG] sofia.c:6229 Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>entering state [completed][200]<br>recv 1223 bytes from udp/[172.16.0.150]:5063 at 16:48:54.586519:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; ACK<span>&nbsp;</span><a target="_blank">sip:+12345678@172.16.0.150:6090;transport=udp</a><span>&nbsp;</span>SIP/2.0<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=ws;lr=on</a>&gt;<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK22c.b4fd273e140b6bfb8c10132eb6625886.0<br>&nbsp;&nbsp; Via: SIP/2.0/WS df7jal23ls0d.invalid;received=10.1.1.2;branch=z9hG4bKsqO0MlTVFcWedViMF5yV;rport=64649<br>&nbsp;&nbsp; From: "Alice"&lt;<a target="_blank">sip:alice@fs.mydomain.com</a>&gt;;tag=tKWvsNl5oHT5STgFSpWU<br>&nbsp;&nbsp; To: &lt;<a target="_blank">sip:+12345678@fs.mydomain.com</a>&gt;;tag=99eQB5Zae5cee<br>&nbsp;&nbsp; Contact: "Alice"&lt;<a target="_blank">sip:alice@10.1.1.2:64649;rtcweb-breaker=no;click2call=no;transport=ws</a>&gt;;+g.oma.sip-im;+sip.ice;language="en,fr";received="<a target="_blank">sip:10.1.1.2:64649;transport=WS</a>"<br>&nbsp;&nbsp; Call-ID: cdff3f60-5133-6104-9f7a-f50b516b2f32<br>&nbsp;&nbsp; CSeq: 10770 ACK<br>&nbsp;&nbsp; Content-Length: 0<br>&nbsp;&nbsp; Max-Forwards: 69<br>&nbsp;&nbsp; Proxy-Authorization: Digest username="alice",realm="<a href="http://fs.mydomain.com/" target="_blank">fs.mydomain.com</a>",nonce="4c15231c-896a-4131-b7c2-621ab8342e9a",uri="<a target="_blank">sip:+12345678@172.16.0.150:6090;transport=udp</a>",response="975327290415140c922c22a1c4c00f88",algorithm=MD5,cnonce="8dabac05b6f0a365d085158868220703",qop=auth,nc=00000002<br>&nbsp;&nbsp; User-Agent: IM-client/OMA1.0 sipML5-v1.0.0.0<br>&nbsp;&nbsp; Organization:<span>&nbsp;</span><a href="http://dingaling.ca/" target="_blank">Dingaling.ca</a><br>&nbsp;&nbsp; Path: &lt;<a target="_blank">sip:172.16.0.150:5063;lr</a>&gt;<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:48:54.585908 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:54.585908 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:54.585908 [DEBUG] switch_core_session.c:1052 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:48:54.585908 [DEBUG] sofia.c:6229 Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>entering state [ready][200]<br>2014-09-17 16:48:54.585908 [DEBUG] switch_core_session.c:969 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:48:54.585908 [DEBUG] switch_core_session.c:969 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>recv 774 bytes from udp/[172.16.0.150]:5063 at 16:49:00.467309:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; BYE<span>&nbsp;</span><a target="_blank">sip:gw+bobspecial@172.16.0.150:6090;transport=udp;gw=bobspecial</a><span>&nbsp;</span>SIP/2.0<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Record-Route: &lt;<a target="_blank">sip:10.1.1.1:5063;transport=udp;lr=on</a>&gt;<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK728.eb6d8a9209ac4e3ce276af87552fe9b7.0<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;rport=5063;branch=z9hG4bK728.5817c2e90986f57eeba11ed14bd3f311.0<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.2.1.1:5060;rport=5060;branch=z9hG4bK11bbf59f<br>&nbsp;&nbsp; From: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;;tag=as5129a390<br>&nbsp;&nbsp; To: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 102 BYE<br>&nbsp;&nbsp; User-Agent: bobPBX<br>&nbsp;&nbsp; Max-Forwards: 68<br>&nbsp;&nbsp; Content-Length: 0<br>&nbsp;&nbsp; Path: &lt;<a target="_blank">sip:172.16.0.150:5063;lr</a>&gt;<br>&nbsp;&nbsp; Path: &lt;<a target="_blank">sip:172.16.0.150:5063;lr</a>&gt;<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:49:00.465894 [DEBUG] switch_core_session.c:1052 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:49:00.485939 [NOTICE] sofia.c:926 Hangup sofia/internal/0000100912345678 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_channel.c:3218 Send signal sofia/internal/0000100912345678 [KILL]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>send 725 bytes to udp/[172.16.0.150]:5063 at 16:49:00.487587:<br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>&nbsp;&nbsp; SIP/2.0 200 OK<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;branch=z9hG4bK728.eb6d8a9209ac4e3ce276af87552fe9b7.0;received=172.16.0.150<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.1.1.1:5063;rport=5063;branch=z9hG4bK728.5817c2e90986f57eeba11ed14bd3f311.0<br>&nbsp;&nbsp; Via: SIP/2.0/UDP 10.2.1.1:5060;rport=5060;branch=z9hG4bK11bbf59f<br>&nbsp;&nbsp; From: &lt;<a target="_blank">sip:0000100912345678@10.2.1.1</a>&gt;;tag=as5129a390<br>&nbsp;&nbsp; To: "Alice" &lt;<a target="_blank">sip:bob@10.2.1.1</a>&gt;;tag=aK8FD0geBe30S<br>&nbsp;&nbsp; Call-ID: 9e1e4217-b95f-1232-dcb8-0015e9bb72e2<br>&nbsp;&nbsp; CSeq: 102 BYE<br>&nbsp;&nbsp; User-Agent: FreeSWITCH-mod_sofia/1.4.6+git~20140603T193516Z~9479729340~64bit<br>&nbsp;&nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>&nbsp;&nbsp; Supported: timer, path, replaces<br>&nbsp;&nbsp; Content-Length: 0<br><br>&nbsp;&nbsp; ------------------------------------------------------------------------<br>2014-09-17 16:49:00.485939 [DEBUG] switch_ivr_bridge.c:659 BRIDGE THREAD DONE [sofia/internal/0000100912345678]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_ivr_bridge.c:689 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>[BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:536 (sofia/internal/0000100912345678) State EXCHANGE_MEDIA going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0000100912345678) Running State Change CS_HANGUP<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:733 (sofia/internal/0000100912345678) Callstate Change ACTIVE -&gt; HANGUP<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/0000100912345678) State HANGUP<br>2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:413 Channel sofia/internal/0000100912345678 hanging up, cause: NORMAL_CLEARING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:58 sofia/internal/0000100912345678 Standard HANGUP, cause: NORMAL_CLEARING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/0000100912345678) State HANGUP going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:502 (sofia/internal/0000100912345678) State Change CS_HANGUP -&gt; CS_REPORTING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:470 (sofia/internal/0000100912345678) Running State Change CS_REPORTING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:821 (sofia/internal/0000100912345678) State REPORTING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:102 sofia/internal/0000100912345678 Standard REPORTING, cause: NORMAL_CLEARING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:821 (sofia/internal/0000100912345678) State REPORTING going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:496 (sofia/internal/0000100912345678) State Change CS_REPORTING -&gt; CS_DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1387 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1614 Session 104 (sofia/internal/0000100912345678) Locked, Waiting on external entities<br>2014-09-17 16:49:00.485939 [DEBUG] switch_ivr_bridge.c:578 sofia/internal/0000100912345678 ending bridge by request from write function<br>2014-09-17 16:49:00.485939 [DEBUG] switch_ivr_bridge.c:659 BRIDGE THREAD DONE [<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_ivr_bridge.c:689 Send signal sofia/internal/0000100912345678 [BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:907 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:49:00.485939 [NOTICE] switch_core_session.c:1632 Session 104 (sofia/internal/0000100912345678) Ended<br>2014-09-17 16:49:00.485939 [NOTICE] switch_core_session.c:1636 Close Channel sofia/internal/0000100912345678 [CS_DESTROY]<br>2014-09-17 16:49:00.485939 [NOTICE] switch_core_state_machine.c:313<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>has executed the last dialplan instruction, hanging up.<br>2014-09-17 16:49:00.485939 [NOTICE] switch_core_state_machine.c:315 Hangup<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[CS_EXECUTE] [NORMAL_CLEARING]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:624 (sofia/internal/0000100912345678) Running State Change CS_DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:634 (sofia/internal/0000100912345678) State DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:323 sofia/internal/0000100912345678 SOFIA DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_channel.c:3218 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>[KILL]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:109 sofia/internal/0000100912345678 Standard DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:634 (sofia/internal/0000100912345678) State DESTROY going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1387 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:533 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State EXECUTE going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:470 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_HANGUP<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:733 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Callstate Change ACTIVE -&gt; HANGUP<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:735 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State HANGUP<br>2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:407<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Overriding SIP cause 480 with 200 from the other leg<br>2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:413 Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>hanging up, cause: NORMAL_CLEARING<br>2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:465 Sending BYE to<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:58<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Standard HANGUP, cause: NORMAL_CLEARING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:735 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State HANGUP going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:502 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State Change CS_HANGUP -&gt; CS_REPORTING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1387 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:470 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_REPORTING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:821 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State REPORTING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:102<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Standard REPORTING, cause: NORMAL_CLEARING<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:821 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State REPORTING going to sleep<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:496 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State Change CS_REPORTING -&gt; CS_DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1387 Send signal<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[BREAK]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_session.c:1614 Session 103 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Locked, Waiting on external entities<br>2014-09-17 16:49:00.485939 [NOTICE] switch_core_session.c:1632 Session 103 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Ended<br>2014-09-17 16:49:00.485939 [NOTICE] switch_core_session.c:1636 Close Channel<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>[CS_DESTROY]<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:624 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) Running State Change CS_DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:634 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] mod_sofia.c:323<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>SOFIA DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:109<span>&nbsp;</span><a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a><span>&nbsp;</span>Standard DESTROY<br>2014-09-17 16:49:00.485939 [DEBUG] switch_core_state_machine.c:634 (<a href="mailto:sofia/internal/alice@fs.mydomain.com" target="_blank">sofia/internal/alice@fs.mydomain.com</a>) State DESTROY going to sleep<br><br><br><br><div>From:<span>&nbsp;</span><a href="mailto:freeswitch-users-request@lists.freeswitch.org" target="_blank">freeswitch-users-request@lists.freeswitch.org</a><br>Subject: FreeSWITCH-users Digest, Vol 99, Issue 146<br>To:<span>&nbsp;</span><a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br>Date: Thu, 18 Sep 2014 02:29:41 +0400<br><br><pre>Send FreeSWITCH-users mailing list submissions to<br>        <a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br> <br>To subscribe or unsubscribe via the World Wide Web, visit<br>        <a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>or, via email, send a message with subject or body 'help' to<br>        <a href="mailto:freeswitch-users-request@lists.freeswitch.org" target="_blank">freeswitch-users-request@lists.freeswitch.org</a><br> <br>You can reach the person managing the list at<br>        <a href="mailto:freeswitch-users-owner@lists.freeswitch.org" target="_blank">freeswitch-users-owner@lists.freeswitch.org</a><br> <br>When replying, please edit your Subject line so it is more specific<br>than "Re: Contents of FreeSWITCH-users digest..."<br></pre><br><br>--Forwarded Message Attachment--<br>From:<span>&nbsp;</span><a href="mailto:wstephen80@gmail.com" target="_blank">wstephen80@gmail.com</a><br>To:<span>&nbsp;</span><a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br>Date: Wed, 17 Sep 2014 22:58:23 +0200<br>Subject: Re: [Freeswitch-users] Call released with a 200 OK<br><br><div dir="ltr">I have a trace of one leg only I can try to capture both legs.<div>But a 200 OK with a Reason header is a valid SIP message&nbsp;(below 200 OK forwarded by FreeSWITCH)&nbsp;?</div><div><br></div><div><br></div><div><div>Frame 5: 957 bytes on wire (7656 bits), 957 bytes captured (7656 bits)</div><div>Ethernet II, Src: Hewlett-_f3:e9:2c (3c:d9:2b:f3:e9:2c), Dst: JuniperN_f6:ce:27 (78:19:f7:f6:ce:27)</div><div>Internet Protocol Version 4, Src: FreeSWITCH_IP (FreeSWITCH_IP), Dst: CUSTOMER_IP (CUSTOMER_IP)</div><div>User Datagram Protocol, Src Port: sip (5060), Dst Port: sip (5060)</div><div>Session Initiation Protocol (200)</div><div>&nbsp; &nbsp; Status-Line: SIP/2.0 200 OK</div><div>&nbsp; &nbsp; Message Header</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Via: SIP/2.0/UDP CUSTOMER_IP:5060;branch=z9hG4bK00E0F510095D15ED848E0A88725A</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Max-Forwards: 63</div><div>&nbsp; &nbsp; &nbsp; &nbsp; From: &lt;<a target="_blank">sip:cg@FreeSWITCH_IP</a>&gt;;tag=00E0F510095D15ED848E7A60E97C</div><div>&nbsp; &nbsp; &nbsp; &nbsp; To: &lt;<a target="_blank">sip:cd@FreeSWITCH_IP</a>&gt;;tag=5881vaN1reajB</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Call-ID:<span>&nbsp;</span><a href="mailto:ae8f80003582-5417017f-60871148-3ad46cc0-745bf31@127.0.0.1" target="_blank">ae8f80003582-5417017f-60871148-3ad46cc0-745bf31@127.0.0.1</a></div><div>&nbsp; &nbsp; &nbsp; &nbsp; CSeq: 14398 INVITE</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Contact: &lt;<a target="_blank">sip:cd@FreeSWITCH_IP:5060;transport=udp</a>&gt;</div><div>&nbsp; &nbsp; &nbsp; &nbsp; User-Agent: FS_1.2</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, NOTIFY</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Supported: timer, path, replaces</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Allow-Events: talk, hold, conference, refer</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Reason: Q.850;cause=16;text="NORMAL_CLEARING"</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Content-Type: application/sdp</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Content-Disposition: session</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Content-Length: 217</div><div>&nbsp; &nbsp; Message Body</div></div><div><br></div></div><div><br><div>On Wed, Sep 17, 2014 at 10:09 PM, Steven Ayre<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:steveayre@gmail.com" target="_blank">steveayre@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div dir="ltr">Can you post the sip trace for the call (all legs)</div><div><br><div><div><div>On 17 September 2014 19:54, Stephen Wilde<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:wstephen80@gmail.com" target="_blank">wstephen80@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br></div></div><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div><div><div dir="ltr">Anyone can help me on that?<span><font color="#888888"><br><div>Stephen</div></font></span></div><div><div><br><div>On Tue, Sep 16, 2014 at 9:58 PM, Stephen Wilde<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:wstephen80@gmail.com" target="_blank">wstephen80@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div dir="ltr"><div><span style="font-family:arial,sans-serif;font-size:13px;">I have a strange issue: some calls are dropped with a 200 OK containing the "Reason" header.</span><br></div><div style="font-size:13px;font-family:arial,sans-serif;">Is this valid?</div><div style="font-size:13px;font-family:arial,sans-serif;">The message flow is:</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">CUSTOMER ---- &nbsp; &nbsp; FS</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">INVITE -&gt;</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">&nbsp; &nbsp; &nbsp; &nbsp; &lt;- 100 Trying</div><div style="font-size:13px;font-family:arial,sans-serif;">&nbsp; &nbsp; &nbsp; &nbsp; &lt;- 180 Ringing</div><div style="font-size:13px;font-family:arial,sans-serif;">&nbsp; &nbsp; &nbsp; &nbsp; &lt;- 200 OK (containing the Reason Header)<br></div><div style="font-size:13px;font-family:arial,sans-serif;">ACK -&gt;</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">after some seconds...</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">BYE -&gt;</div><div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;">The 200 OK sent by FreeSwitch contain a "Reason Header":</div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div><font face="arial, sans-serif">Reason: Q.850;cause=16;text="NORMAL_CLEARING"</font><br></div><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif">And the call seems dropped and not connected in FreeSWITCH.</font></div><div><font face="arial, sans-serif">For the customer side the call seems connected with 200 OK (the customer ignore the Reason).</font></div><div><font face="arial, sans-serif">After some seconds, the customer try to disconnect the call with BYE but these messages are ignored by Freeswitch because the call was been already dropped.</font></div><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif">It's valid the Reason inside the 200 OK? It's possible that this 200 OK has been forwarded by Freeswitch from the outbound leg.</font></div><div><font face="arial, sans-serif">Any advice for that?</font></div><span><font color="#888888"><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif">Stephen</font></div><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif"><br></font></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div></font></span></div><div><br></div></div></blockquote></div><br></div></div><br></div></div>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<br><a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br><a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br><br>Official FreeSWITCH Sites<br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br><a href="http://confluence.freeswitch.org/" target="_blank">http://confluence.freeswitch.org</a><br><a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br><a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br><br>FreeSWITCH-users mailing list<br><a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br><a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br></div><br>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<br><a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br><a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br><br>Official FreeSWITCH Sites<br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br><a href="http://confluence.freeswitch.org/" target="_blank">http://confluence.freeswitch.org</a><br><a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br><a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br><br>FreeSWITCH-users mailing list<br><a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br><a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br></div><br><br>--Forwarded Message Attachment--<br>From:<span>&nbsp;</span><a href="mailto:steveayre@gmail.com" target="_blank">steveayre@gmail.com</a><br>To:<span>&nbsp;</span><a href="mailto:freeswitch-users@lists.freeswitch.org" target="_blank">freeswitch-users@lists.freeswitch.org</a><br>Date: Wed, 17 Sep 2014 23:28:37 +0100<br>Subject: Re: [Freeswitch-users] Call released with a 200 OK<br><br><div dir="ltr">rfc3326 - I believe it's valid in any packet, you can potentially have a Reason passed back before the end of the call.<br><div><br></div><div>It's the BYE that's hanging up the call not the 200 OK, but that could be an interop problem where a device doesn't expect the Reason in the 200 OK.</div></div><div><br><div>On 17 September 2014 21:58, Stephen Wilde<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:wstephen80@gmail.com" target="_blank">wstephen80@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div dir="ltr">I have a trace of one leg only I can try to capture both legs.<div>But a 200 OK with a Reason header is a valid SIP message&nbsp;(below 200 OK forwarded by FreeSWITCH)&nbsp;?</div><div><br></div><div><br></div><div><div>Frame 5: 957 bytes on wire (7656 bits), 957 bytes captured (7656 bits)</div><div>Ethernet II, Src: Hewlett-_f3:e9:2c (3c:d9:2b:f3:e9:2c), Dst: JuniperN_f6:ce:27 (78:19:f7:f6:ce:27)</div><div>Internet Protocol Version 4, Src: FreeSWITCH_IP (FreeSWITCH_IP), Dst: CUSTOMER_IP (CUSTOMER_IP)</div><div>User Datagram Protocol, Src Port: sip (5060), Dst Port: sip (5060)</div><div>Session Initiation Protocol (200)</div><div>&nbsp; &nbsp; Status-Line: SIP/2.0 200 OK</div><div>&nbsp; &nbsp; Message Header</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Via: SIP/2.0/UDP CUSTOMER_IP:5060;branch=z9hG4bK00E0F510095D15ED848E0A88725A</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Max-Forwards: 63</div><div>&nbsp; &nbsp; &nbsp; &nbsp; From: &lt;<a target="_blank">sip:cg@FreeSWITCH_IP</a>&gt;;tag=00E0F510095D15ED848E7A60E97C</div><div>&nbsp; &nbsp; &nbsp; &nbsp; To: &lt;<a target="_blank">sip:cd@FreeSWITCH_IP</a>&gt;;tag=5881vaN1reajB</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Call-ID:<span>&nbsp;</span><a href="mailto:ae8f80003582-5417017f-60871148-3ad46cc0-745bf31@127.0.0.1" target="_blank">ae8f80003582-5417017f-60871148-3ad46cc0-745bf31@127.0.0.1</a></div><div>&nbsp; &nbsp; &nbsp; &nbsp; CSeq: 14398 INVITE</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Contact: &lt;<a target="_blank">sip:cd@FreeSWITCH_IP:5060;transport=udp</a>&gt;</div><div>&nbsp; &nbsp; &nbsp; &nbsp; User-Agent: FS_1.2</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, REGISTER, REFER, NOTIFY</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Supported: timer, path, replaces</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Allow-Events: talk, hold, conference, refer</div><span>&nbsp; &nbsp; &nbsp; &nbsp; Reason: Q.850;cause=16;text="NORMAL_CLEARING"</span><div>&nbsp; &nbsp; &nbsp; &nbsp; Content-Type: application/sdp</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Content-Disposition: session</div><div>&nbsp; &nbsp; &nbsp; &nbsp; Content-Length: 217</div><div>&nbsp; &nbsp; Message Body</div></div><div><br></div></div><div><div><div><br><div>On Wed, Sep 17, 2014 at 10:09 PM, Steven Ayre<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:steveayre@gmail.com" target="_blank">steveayre@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div dir="ltr">Can you post the sip trace for the call (all legs)</div><div><br><div><div>On 17 September 2014 19:54, Stephen Wilde<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:wstephen80@gmail.com" target="_blank">wstephen80@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br></div><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div><div dir="ltr">Anyone can help me on that?<span><font color="#888888"><br><div>Stephen</div></font></span></div><div><div><br><div>On Tue, Sep 16, 2014 at 9:58 PM, Stephen Wilde<span>&nbsp;</span><span dir="ltr">&lt;<a href="mailto:wstephen80@gmail.com" target="_blank">wstephen80@gmail.com</a>&gt;</span><span>&nbsp;</span>wrote:<br><blockquote style="border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex;"><div dir="ltr"><div><span style="font-family:arial,sans-serif;font-size:13px;">I have a strange issue: some calls are dropped with a 200 OK containing the "Reason" header.</span><br></div><div style="font-size:13px;font-family:arial,sans-serif;">Is this valid?</div><div style="font-size:13px;font-family:arial,sans-serif;">The message flow is:</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">CUSTOMER ---- &nbsp; &nbsp; FS</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">INVITE -&gt;</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">&nbsp; &nbsp; &nbsp; &nbsp; &lt;- 100 Trying</div><div style="font-size:13px;font-family:arial,sans-serif;">&nbsp; &nbsp; &nbsp; &nbsp; &lt;- 180 Ringing</div><div style="font-size:13px;font-family:arial,sans-serif;">&nbsp; &nbsp; &nbsp; &nbsp; &lt;- 200 OK (containing the Reason Header)<br></div><div style="font-size:13px;font-family:arial,sans-serif;">ACK -&gt;</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">after some seconds...</div><div style="font-size:13px;font-family:arial,sans-serif;"><br></div><div style="font-size:13px;font-family:arial,sans-serif;">BYE -&gt;</div><div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;">BYE -&gt;</div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;">The 200 OK sent by FreeSwitch contain a "Reason Header":</div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div><font face="arial, sans-serif">Reason: Q.850;cause=16;text="NORMAL_CLEARING"</font><br></div><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif">And the call seems dropped and not connected in FreeSWITCH.</font></div><div><font face="arial, sans-serif">For the customer side the call seems connected with 200 OK (the customer ignore the Reason).</font></div><div><font face="arial, sans-serif">After some seconds, the customer try to disconnect the call with BYE but these messages are ignored by Freeswitch because the call was been already dropped.</font></div><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif">It's valid the Reason inside the 200 OK? It's possible that this 200 OK has been forwarded by Freeswitch from the outbound leg.</font></div><div><font face="arial, sans-serif">Any advice for that?</font></div><span><font color="#888888"><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif">Stephen</font></div><div><font face="arial, sans-serif"><br></font></div><div><font face="arial, sans-serif"><br></font></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div><div style="font-family:arial,sans-serif;font-size:13px;"><br></div></font></span></div><div><br></div></div></blockquote></div><br></div></div><br></div>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<br><a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br><a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br><br>Official FreeSWITCH Sites<br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br><a href="http://confluence.freeswitch.org/" target="_blank">http://confluence.freeswitch.org</a><br><a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br><a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br><br>FreeSWITCH-users mailing list<br><a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br><a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br></div><br>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<br><a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br><a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br><br>Official FreeSWITCH Sites<br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br><a href="http://confluence.freeswitch.org/" target="_blank">http://confluence.freeswitch.org</a><br><a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br><a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br><br>FreeSWITCH-users mailing list<br><a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br><a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br></div></div></div><br>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<br><a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br><a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br><br>Official FreeSWITCH Sites<br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br><a href="http://confluence.freeswitch.org/" target="_blank">http://confluence.freeswitch.org</a><br><a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br><a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br><br>FreeSWITCH-users mailing list<br><a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br><a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br></div></div></div>_________________________________________________________________________<br>Professional FreeSWITCH Consulting Services:<span>&nbsp;</span><br><a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br><a href="http://www.freeswitchsolutions.com/" target="_blank">http://www.freeswitchsolutions.com</a><br><br>Official FreeSWITCH Sites<br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a><br><a href="http://confluence.freeswitch.org/" target="_blank">http://confluence.freeswitch.org</a><br><a href="http://www.cluecon.com/" target="_blank">http://www.cluecon.com</a><br><br>FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br><a href="http://www.cudatel.com/" target="_blank">http://www.cudatel.com</a><br><br>FreeSWITCH-users mailing list<br><a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br><a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>UNSUBSCRIBE:http://<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">lists.freeswitch.org/mailman/options/freeswitch-users</a><br><a href="http://www.freeswitch.org/" target="_blank">http://www.freeswitch.org</a></div></blockquote></div><br></div>                                               </div></div>
<br>_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a href="mailto:consulting@freeswitch.org" target="_blank">consulting@freeswitch.org</a><br>
<a href="http://www.freeswitchsolutions.com" target="_blank">http://www.freeswitchsolutions.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
<a href="http://confluence.freeswitch.org" target="_blank">http://confluence.freeswitch.org</a><br>
<a href="http://www.cluecon.com" target="_blank">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>
<a href="http://www.cudatel.com" target="_blank">http://www.cudatel.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org" target="_blank">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br></div></div>                                               </div></div>
<br>_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a href="mailto:consulting@freeswitch.org">consulting@freeswitch.org</a><br>
<a href="http://www.freeswitchsolutions.com" target="_blank">http://www.freeswitchsolutions.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
<a href="http://confluence.freeswitch.org" target="_blank">http://confluence.freeswitch.org</a><br>
<a href="http://www.cluecon.com" target="_blank">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>
<a href="http://www.cudatel.com" target="_blank">http://www.cudatel.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br></blockquote></div><br><br clear="all"><div><br></div>-- <br><div dir="ltr">







<font face="courier new, monospace"><b><i><font size="4">Brian West</font></i></b><br><span style="font-size:x-small;"><a href="mailto:brian@freeswitch.org" target="_blank">brian@freeswitch.org</a></span></font><BR>
<font size="1" face="courier new, monospace"><img src="http&#58;//bkw.org/whmcslogo.png"><br></font><BR><font face="courier new, monospace"><b><i>Twitter: @FreeSWITCH , @briankwest</i></b><br><a href="http://www.freeswitchbook.com" target="_blank">http://www.freeswitchbook.com</a><br><a href="http://www.freeswitchcookbook.com" target="_blank">http://www.freeswitchcookbook.com</a></font><BR>
<font face="courier new, monospace"><b>T:</b>+19184209001 | <b>F:</b>+19184209002 | <b>M:</b>+1918424WEST (9378)<br><b>iNUM:</b>+883 5100 1420 9001 |&nbsp;<b>ISN:</b>410*543 |&nbsp;<b>Skype:</b>briankwest</font><BR></div>
</div></div>                                               </div></body>
</html>