<div dir="ltr"><div><div>Hi <br><br></div><div>I am trying to send call from webrtc to freeswitch and then bridge to an external endpoint that is a normal SIP phone.  I tried to use sip_secure_media=false to force the media to be converted from SAVP to AVP.  <br><br></div><div>But the outgoing INVITE is still showing SAVP ( sip trace blow ).  Does anyone know  where I am doing wrong?   any help will be greately appreciated.<br></div><div><br></div></div>2015-08-17 15:29:46.341244 [INFO] mod_dialplan_xml.c:637 Processing 1001 &lt;1001&gt;-&gt;1002 in context default<br><br>Dialplan: sofia/internal/1001@y.y.y.y:5060 parsing [default-&gt;incoming_calls] continue=false<br><br>Dialplan: sofia/internal/1001@y.y.y.y:5060 Regex (PASS) [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false<br><br>Dialplan: sofia/internal/1001@y.y.y.y:5060 Action bridge({sip_secure_media=false}[sip_secure_media=false]sofia/internal/754617162742492@x.x.x.x)<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1001@y.y.y.y:5060) State Change CS_ROUTING -&gt; CS_EXECUTE<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@y.y.y.y:5060) State ROUTING going to sleep<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@y.y.y.y:5060) Running State Change CS_EXECUTE<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@y.y.y.y:5060) State EXECUTE<br><br>2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:196 sofia/internal/1001@y.y.y.y:5060 SOFIA EXECUTE<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1001@y.y.y.y:5060 Standard EXECUTE<br><br>EXECUTE sofia/internal/1001@y.y.y.y:5060 bridge({sip_secure_media=false}[sip_secure_media=false]sofia/internal/754617162742492@x.x.x.x)<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:2104 Parsing global variables<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:2557 Parsing session specific variables<br><br>2015-08-17 15:29:46.341244 [NOTICE] switch_channel.c:1089 New Channel sofia/internal/754617162742492@x.x.x.x [ca6d5930-44f4-11e5-9cc9-c9574f94e170]<br><br>2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4735 (sofia/internal/754617162742492@x.x.x.x) State Change CS_NEW -&gt; CS_INIT<br><br>2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4805 [zrtp_passthru] Setting a-leg inherit_codec=true<br><br>2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4808 [zrtp_passthru] Setting b-leg absolute_codec_string=&#39;mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMU@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b&#39;<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@x.x.x.x) Running State Change CS_INIT<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617162742492@x.x.x.x) State INIT<br><br>2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:88 sofia/internal/754617162742492@x.x.x.x SOFIA INIT<br><br>2015-08-17 15:29:46.341244 [DEBUG] sofia_glue.c:1257 sofia/internal/754617162742492@x.x.x.x sending invite version: 1.7.0 git 58f1272 2015-08-14 17:51:12Z 64bit<br><br>Local SDP:<br><br>v=0<br><br>o=- 4133111956976529630 2 IN IP4 127.0.0.1<br><br>s=-<br><br>t=0 0<br><br>a=group:BUNDLE audio<br><br>a=msid-semantic: WMS media_stream<br><br>m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126<br><br>c=IN IP4 0.0.0.0<br><br>a=rtpmap:111 opus/48000/2<br><br>a=fmtp:111 minptime=10; useinbandfec=1<br><br>a=rtpmap:103 ISAC/16000<br><br>a=rtpmap:9 G722/8000<br><br>a=rtpmap:102 ILBC/8000<br><br>a=rtpmap:0 PCMU/8000<br><br>a=rtpmap:8 PCMA/8000<br><br>a=rtpmap:106 CN/32000<br><br>a=rtpmap:105 CN/16000<br><br>a=rtpmap:13 CN/8000<br><br>a=rtpmap:127 red/8000<br><br>a=rtpmap:126 telephone-event/8000<br><br>a=rtcp:9 IN IP4 0.0.0.0<br><br>a=ice-ufrag:Gn8CX52vaidE1C73<br><br>a=ice-pwd:16VDNSZodn+NJp8u3O1mQrMy<br><br>a=fingerprint:sha-1 19:57:5D:7A:BD:7B:42:3B:C9:1B:2F:A6:D2:4F:32:FD:C3:23:14:D9<br><br>a=setup:actpass<br><br>a=mid:audio<br><br>a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level<br><br>a=extmap:3 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a><br><br>a=rtcp-mux<br><br>a=maxptime:60<br><br>a=ssrc:3618235845 cname:3hHDnnOtFofiuRz2<br><br>a=ssrc:3618235845 msid:media_stream audio_track<br><br>a=ssrc:3618235845 mslabel:media_stream<br><br>a=ssrc:3618235845 label:audio_track<br><br>a=candidate:186199869 1 udp 2122260223 192.168.1.101 60710 typ host generation 0<br><br>a=candidate:4049598204 1 udp 2122194687 10.73.229.110  52079 typ host generation 0<br><br>a=candidate:186199869 2 udp 2122260222 192.168.1.101 64150 typ host generation 0<br><br>a=candidate:4049598204 2 udp 2122194686 10.73.229.110 51909 typ host generation 0<br><br>a=candidate:1167774669 1 tcp 1518280447 192.168.1.101 55638 typ host tcptype passive generation 0<br><br>a=candidate:3218868748 1 tcp 1518214911 10.73.229.110 55639 typ host tcptype passive generation 0<br><br>a=candidate:1167774669 2 tcp 1518280446 192.168.1.101 55640 typ host tcptype passive generation 0<br><br>a=candidate:3218868748 2 tcp 1518214910 10.73.229.110 55641 typ host tcptype passive generation 0<br><br>a=candidate:2320574857 1 udp 1686052607 27.38.56.3 36782 typ srflx raddr 192.168.1.101 rport 60710 generation 0<br><br>a=candidate:2320574857 2 udp 1686052606 27.38.56.3 37553 typ srflx raddr 192.168.1.101 rport 64150 generation 0<br><br>a=candidate:1880617032 1 udp 1685987071 112.97.38.179 2308 typ srflx raddr 10.73.229.110 rport 52079 generation 0<br><br>a=candidate:1880617032 2 udp 1685987070 112.97.38.179 2307 typ srflx raddr 10.73.229.110 rport 51909 generation 0<br><br>a=candidate:2922827951 1 udp 41885439 146.185.149.11 55532 typ relay raddr 27.38.56.3 rport 36782 generation 0<br><br>a=candidate:2922827951 2 udp 41885438 146.185.149.11 54104 typ relay raddr 27.38.56.3 rport 37553 generation 0<br><br>a=candidate:2922827951 2 udp 41819902 146.185.149.11 63311 typ relay raddr 112.97.38.179 rport 54091 generation 0<br><br>a=candidate:2922827951 1 udp 41819903 146.185.149.11 49576 typ relay raddr 112.97.38.179 rport 54092 generation 0<br><br> <br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:40 sofia/internal/754617162742492@x.x.x.x Standard INIT<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/754617162742492@x.x.x.x) State Change CS_INIT -&gt; CS_ROUTING<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617162742492@x.x.x.x) State INIT going to sleep<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@x.x.x.x) Running State Change CS_ROUTING<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617162742492@x.x.x.x) State ROUTING<br><br>2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:141 sofia/internal/754617162742492@x.x.x.x SOFIA ROUTING<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/754617162742492@x.x.x.x) State Change CS_ROUTING -&gt; CS_CONSUME_MEDIA<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617162742492@x.x.x.x) State ROUTING going to sleep<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@x.x.x.x) Running State Change CS_CONSUME_MEDIA<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617162742492@x.x.x.x) State CONSUME_MEDIA<br><br>2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617162742492@x.x.x.x) State CONSUME_MEDIA going to sleep<br><br>send 3635 bytes to udp/[69.27.168.50]:5060 at 15:29:46.355875:<br><br>   ------------------------------------------------------------------------<br><br>   INVITE sip:754617162742492@x.x.x.x SIP/2.0<br><br>   Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e<br><br>   Max-Forwards: 69<br><br>   From: &quot;Extension 1001&quot; &lt;sip:1001@y.y.y.y&gt;;tag=H6HrjU4ZH1KjD<br><br>  To: &lt;sip:754617162742492@x.x.x.x&gt;<br><br>   Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be<br><br>   CSeq: 79576629 INVITE<br><br>   Contact: &lt;sip:mod_sofia@y.y.y.y:5060&gt;<br><br>   User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit<br><br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br><br>   Supported: timer, path, replaces<br><br>   Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer<br><br>   Content-Type: application/sdp<br><br>   Content-Disposition: session<br><br>   Content-Length: 2665<br><br>   X-FS-Support: update_display,send_info<br><br>   Remote-Party-ID: &quot;Extension 1001&quot; &lt;sip:1001@y.y.y.y&gt;;party=calling;screen=yes;privacy=off<br><br> <br><br>   v=0<br><br>  o=- 4133111956976529630 2 IN IP4 y.y.y.y<br><br>   s=-<br><br>   t=0 0<br><br>   a=group:BUNDLE audio<br><br>   a=msid-semantic: WMS media_stream<br><br>   m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126<br><br>   c=IN IP4 0.0.0.0<br><br>   a=rtpmap:111 opus/48000/2<br><br>   a=fmtp:111 minptime=10; useinbandfec=1<br><br>   a=rtpmap:103 ISAC/16000<br><br>   a=rtpmap:9 G722/8000<br><br>   a=rtpmap:102 ILBC/8000<br><br>   a=rtpmap:0 PCMU/8000<br><br>   a=rtpmap:8 PCMA/8000<br><br>   a=rtpmap:106 CN/32000<br><br>   a=rtpmap:105 CN/16000<br><br>   a=rtpmap:13 CN/8000<br><br>   a=rtpmap:127 red/8000<br><br>   a=rtpmap:126 telephone-event/8000<br><br>   a=rtcp:9 IN IP4 0.0.0.0<br><br>   a=ice-ufrag:Gn8CX52vaidE1C73<br><br>   a=ice-pwd:16VDNSZodn+NJp8u3O1mQrMy<br><br>   a=fingerprint:sha-1 19:57:5D:7A:BD:7B:42:3B:C9:1B:2F:A6:D2:4F:32:FD:C3:23:14:D9<br><br>   a=setup:actpass<br><br>   a=mid:audio<br><br>   a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level<br><br>   a=extmap:3 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a><br><br>   a=rtcp-mux<br><br>   a=maxptime:60<br><br>   a=ssrc:3618235845 cname:3hHDnnOtFofiuRz2<br><br>   a=ssrc:3618235845 msid:media_stream audio_track<br><br>   a=ssrc:3618235845 mslabel:media_stream<br><br>   a=ssrc:3618235845 label:audio_track<br><br>   a=candidate:186199869 1 udp 2122260223 192.168.1.101 60710 typ host generation 0<br><br>   a=candidate:4049598204 1 udp 2122194687 10.73.229.110 52079 typ host generation 0<br><br>   a=candidate:186199869 2 udp 2122260222 192.168.1.101 64150 typ host generation 0<br><br>   a=candidate:4049598204 2 udp 2122194686 10.73.229.110 51909 typ host generation 0<br><br>   a=candidate:1167774669 1 tcp 1518280447 192.168.1.101 55638 typ host tcptype passive generation 0<br><br>   a=candidate:3218868748 1 tcp 1518214911 10.73.229.110 55639 typ host tcptype passive generation 0<br><br>   a=candidate:1167774669 2 tcp 1518280446 192.168.1.101 55640 typ host tcptype passive generation 0<br><br>   a=candidate:3218868748 2 tcp 1518214910 10.73.229.110 55641 typ host tcptype passive generation 0<br><br>   a=candidate:2320574857 1 udp 1686052607 27.38.56.3 36782 typ srflx raddr 192.168.1.101 rport 60710 generation 0<br><br>   a=candidate:2320574857 2 udp 1686052606 27.38.56.3 37553 typ srflx raddr 192.168.1.101 rport 64150 generation 0<br><br>   a=candidate:1880617032 1 udp 1685987071 112.97.38.179 2308 typ srflx raddr 10.73.229.110 rport 52079 generation 0<br><br>   a=candidate:1880617032 2 udp 1685987070 112.97.38.179 2307 typ srflx raddr 10.73.229.110 rport 51909 generation 0<br><br>   a=candidate:2922827951 1 udp 41885439 146.185.149.11 55532 typ relay raddr 27.38.56.3 rport 36782 generation 0<br><br>   a=candidate:2922827951 2 udp 41885438 146.185.149.11 54104 typ relay raddr 27.38.56.3 rport 37553 generation 0<br><br>   a=candidate:2922827951 2 udp 41819902 146.185.149.11 63311 typ relay raddr 112.97.38.179 rport 54091 generation 0<br><br>   a=candidate:2922827951 1 udp 41819903 146.185.149.11 49576 typ relay raddr 112.97.38.179 rport 54092 generation 0<br><br>   ------------------------------------------------------------------------<br><br>2015-08-17 15:29:46.341244 [DEBUG] sofia.c:6715 Channel sofia/internal/754617162742492@x.x.x.x entering state [calling][0]<br><br>recv 308 bytes from udp/[x.x.x.x]:5060 at 15:29:46.357317:<br><br>   ------------------------------------------------------------------------<br><br>   SIP/2.0 100 Trying<br><br>   Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e<br><br>   From: &quot;Extension 1001&quot; &lt;sip:1001@y.y.y.y&gt;;tag=H6HrjU4ZH1KjD<br><br>   To: &lt;sip:754617162742492@x.x.x.x&gt;<br><br>   Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be<br><br>   CSeq: 79576629 INVITE<br><br>   User-Agent: DNL-Switch<br><br>   Content-Length: 0<br><br> <br><br>   ------------------------------------------------------------------------<br><br>recv 433 bytes from udp/[x.x.x.x]:5060 at 15:29:46.367995:<br><br>   ------------------------------------------------------------------------<br><br>   SIP/2.0 415 Unsupported Media Type<br><br>   Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e<br><br>   From: &quot;Extension 1001&quot; &lt;sip:1001@y.y.y.y&gt;;tag=H6HrjU4ZH1KjD<br><br>   To: &lt;sip:754617162742492@x.x.x.x&gt;;tag=Ut8ye62NUrQeB<br><br>   Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be<br><br>   CSeq: 79576629 INVITE<br><br>   User-Agent: DNL-Switch<br><br>   Accept: application/sdp<br><br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO<br><br>   Supported: timer<br><br>   Content-Length: 0<br><br> <br><br>   ------------------------------------------------------------------------<br><br>send 343 bytes to udp/[x.x.x.x]:5060 at 15:29:46.368134:<br><br>   ------------------------------------------------------------------------<br><br>   ACK sip:754617162742492@x.x.x.x SIP/2.0<br><br>   Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e<br><br>   Max-Forwards: 69<br><br>   From: &quot;Extension 1001&quot; &lt;sip:1001@y.y.y.y&gt;;tag=H6HrjU4ZH1KjD<br><br>   To: &lt;sip:754617162742492@x.x.x.x&gt;;tag=Ut8ye62NUrQeB<br><br>   Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be<br><br>   CSeq: 79576629 ACK<br><br>   Content-Length: 0<br><br> <br><br>   ------------------------------------------------------------------------<br><br>2015-08-17 15:29:46.361276 [DEBUG] sofia.c:6715 Channel sofia/internal/754617162742492@x.x.x.x entering state [terminated][415]<br><br>2015-08-17 15:29:46.361276 [NOTICE] sofia.c:7631 Hangup sofia/internal/754617162742492@x.x.x.x [CS_CONSUME_MEDIA] [SERVICE_NOT_IMPLEMENTED]<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@x.x.x.x) Running State Change CS_HANGUP<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/754617162742492@x.x.x.x) Callstate Change DOWN -&gt; HANGUP<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/754617162742492@x.x.x.x) State HANGUP<br><br>2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:431 Channel sofia/internal/754617162742492@x.x.x.x hanging up, cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:60 sofia/internal/754617162742492@x.x.x.x Standard HANGUP, cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/754617162742492@x.x.x.x) State HANGUP going to sleep<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/754617162742492@x.x.x.x) State Change CS_HANGUP -&gt; CS_REPORTING<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@x.x.x.x) Running State Change CS_REPORTING<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/754617162742492@x.x.x.x) State REPORTING<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:104 sofia/internal/754617162742492@x.x.x.x Standard REPORTING, cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/754617162742492@x.x.x.x) State REPORTING going to sleep<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/754617162742492@x.x.x.x) State Change CS_REPORTING -&gt; CS_DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_session.c:1639 Session 2 (sofia/internal/754617162742492@x.x.x.x) Locked, Waiting on external entities<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_ivr_originate.c:3727 Originate Resulted in Error Cause: 79 [SERVICE_NOT_IMPLEMENTED]<br><br>2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1657 Session 2 (sofia/internal/754617162742492@x.x.x.x) Ended<br><br>2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/754617162742492@x.x.x.x [CS_DESTROY]<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/754617162742492@x.x.x.x) Running State Change CS_DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/754617162742492@x.x.x.x) State DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:341 sofia/internal/754617162742492@x.x.x.x SOFIA DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:111 sofia/internal/754617162742492@x.x.x.x Standard DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/754617162742492@x.x.x.x) State DESTROY going to sleep<br><br>2015-08-17 15:29:46.361276 [INFO] mod_dptools.c:3333 Originate Failed.  Cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [NOTICE] switch_channel.c:4800 Hangup sofia/internal/1001@y.y.y.y:5060 [CS_EXECUTE] [SERVICE_NOT_IMPLEMENTED]<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_session.c:2926 sofia/internal/1001@y.y.y.y:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@y.y.y.y:5060) State EXECUTE going to sleep<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@y.y.y.y:5060) Running State Change CS_HANGUP<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1001@y.y.y.y:5060) Callstate Change RINGING -&gt; HANGUP<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@y.y.y.y:5060) State HANGUP<br><br>2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:425 sofia/internal/1001@y.y.y.y:5060 Overriding SIP cause 501 with 415 from the other leg<br><br>2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:431 Channel sofia/internal/1001@y.y.y.y:5060 hanging up, cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:568 Responding to INVITE with: 415<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001@y.y.y.y:5060 Standard HANGUP, cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@y.y.y.y:5060) State HANGUP going to sleep<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/1001@y.y.y.y:5060) State Change CS_HANGUP -&gt; CS_REPORTING<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@y.y.y.y:5060) Running State Change CS_REPORTING<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@y.y.y.y:5060) State REPORTING<br><br>send 900 bytes to tcp/[27.38.56.3]:36982 at 15:29:46.376821:<br><br>   ------------------------------------------------------------------------<br><br>   SIP/2.0 415 Unsupported Media Type<br><br>   Via: SIP/2.0/TCP 192.168.1.101:5060;branch=z9hG4bK-524287-1---96ba2f7825316328;rport=36982;received=27.38.56.3<br><br>   Max-Forwards: 70<br><br>   From: &lt;sip:1001@y.y.y.y:5060&gt;;tag=9de53b6c<br><br>   To: &lt;sip:1002@y.y.y.y:5060&gt;;tag=gXrZg0KvmrXZH<br><br>   Call-ID: kVdW6FArCGqcEPe7zR3x4g..<br><br>   CSeq: 2 INVITE<br><br>   User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit<br><br>   Accept: application/sdp<br><br>   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br><br>   Supported: timer, path, replaces<br><br>   Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer<br><br>   Reason: Q.850;cause=79;text=&quot;SERVICE_NOT_IMPLEMENTED&quot;<br><br>   Content-Length: 0<br><br>   Remote-Party-ID: &quot;1002&quot; &lt;sip:1002@y.y.y.y&gt;;party=calling;privacy=off;screen=no<br><br> <br><br>   ------------------------------------------------------------------------<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1001@y.y.y.y:5060 Standard REPORTING, cause: SERVICE_NOT_IMPLEMENTED<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@y.y.y.y:5060) State REPORTING going to sleep<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1001@y.y.y.y:5060) State Change CS_REPORTING -&gt; CS_DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_session.c:1639 Session 1 (sofia/internal/1001@y.y.y.y:5060) Locked, Waiting on external entities<br><br>2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1657 Session 1 (sofia/internal/1001@y.y.y.y:5060) Ended<br><br>2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/1001@y.y.y.y:5060 [CS_DESTROY]<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/1001@y.y.y.y:5060) Running State Change CS_DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@y.y.y.y:5060) State DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:341 sofia/internal/1001@y.y.y.y:5060 SOFIA DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1001@y.y.y.y:5060 Standard DESTROY<br><br>2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@y.y.y.y:5060) State DESTROY going to sleep<br><br>recv 317 bytes from tcp/[27.38.56.3]:36982 at 15:29:46.651249:<br><br>   ------------------------------------------------------------------------<br><br>   ACK sip:1002@y.y.y.y:5060 SIP/2.0<br><br>   Via: SIP/2.0/TCP 192.168.1.101:5060;branch=z9hG4bK-524287-1---96ba2f7825316328;rport<br><br>   Max-Forwards: 70<br><br>  To: &lt;sip:1002@y.y.y.y:5060&gt;;tag=gXrZg0KvmrXZH<br><br>   From: &lt;sip:1001@y.y.y.y:5060&gt;;tag=9de53b6c<br><br>   Call-ID: kVdW6FArCGqcEPe7zR3x4g..<br><br>   CSeq: 2 ACK<br><br>   Content-Length: 0<br><br> <br><br>   ------------------------------------------------------------------------<br></div>