This has nothing at all to do with encryption.... in fact:Dialplan: sofia/internal/1001@x.x.x.x:5060 Action bridge({rtp_secure_media=false,sip_secure_mediai_outbound=false}[,sip_secure_media_outbound=false,sdp_secure_savp_only=false,origination_caller_id_number=17185345433]sofia/internal/754617702573728@y.y.y.y)
you don't need ANY of these vars:rtp_secure_media=false,sip_secure_mediai_outbound=falsesip_secure_media_outbound=false,sdp_secure_savp_only=falseand you have other typos in there like leading , that I think doesn't matter, but NONE of that is necessary.It sounds like your issue has everything to do with the outbound call, and nothing at all to do with encryption or anything from the inbound call. Is there any nat in play on the outbound call?You have edited the trace to remove IP addresses, and I have found that this is typically where the problem is whenever anyone edits traces to remove this information, so I as a policy will not review any edited logs. Look for nat issues and I suspect you will find the problem.On Aug 23, 2015, at 1:12 PM, Pete Kay <petedao@gmail.com> wrote:Here is my log:Is it because of some decryption not set correct?WebRTC client can hear audio but mobile phone hear nothing.My scenario is WebRTC client -> Freeswitch -> Voip gateway -> mobile phoneHiThanks alot for the help. The call is not able to ing the remote end. However, from the webrtc side, I can hear audio, but the remote end, there is no audio.------------------------------------------------------------------------
recv 3546 bytes from tcp/[163.125.130.79]:26869 at 16:38:06.597828:
------------------------------------------------------------------------
INVITE sip:1002@x.x.x.x:5060 SIP/2.0
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---e4f7b616f75a9478;rport
Max-Forwards: 70
Contact: <sip:1001@192.168.1.100:5060;transport=tcp>;+sip.instance="1001@x.x.x.x:5060"
To: <sip:1002@x.x.x.x:5060>
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 INVITE
Session-Expires: 1800
Min-SE: 90
Accept-Language: en
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, NOTIFY, SUBSCRIBE, INFO, MESSAGE, PRACK
Content-Type: application/sdp
Proxy-Authorization: Digest username="1001",realm="x.x.x.x",nonce="54896b80-49b5-11e5-ba06-3bd1ff35cbfe",uri="sip:1002@x.x.x.x:5060",response="0afd4be94eedc61fadc74712a1376486",cnonce="55b6411c482ea7487d4a9c4496371213",nc=00000001,qop=auth,algorithm=MD5
Supported: timer, 100rel
Content-Length: 2681
v=0
o=- 7694721001483168063 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:PfQS5mTk8DdU0wfL
a=ice-pwd:/LwkxiZgwC7MiwSbG1Ypx5hJ
a=fingerprint:sha-1 0F:6D:76:5D:16:F5:37:8F:F9:80:1C:CC:54:F0:3E:61:13:A0:87:17
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=maxptime:60
a=ssrc:718599481 cname:DOUxo2z76LkE5KZX
a=ssrc:718599481 msid:media_stream audio_track
a=ssrc:718599481 mslabel:media_stream
a=ssrc:718599481 label:audio_track
a=candidate:3013953624 1 udp 2122260223 192.168.1.100 55457 typ host generation 0
a=candidate:2117845908 1 udp 2122194687 10.162.22.234 50345 typ host generation 0
a=candidate:3013953624 2 udp 2122260222 192.168.1.100 52690 typ host generation 0
a=candidate:2117845908 2 udp 2122194686 10.162.22.234 53413 typ host generation 0
a=candidate:4247172264 1 tcp 1518280447 192.168.1.100 49472 typ host tcptype passive generation 0
a=candidate:817381220 1 tcp 1518214911 10.162.22.234 49473 typ host tcptype passive generation 0
a=candidate:4247172264 2 tcp 1518280446 192.168.1.100 49474 typ host tcptype passive generation 0
a=candidate:817381220 2 tcp 1518214910 10.162.22.234 49475 typ host tcptype passive generation 0
a=candidate:854413036 1 udp 1686052607 163.125.130.79 26990 typ srflx raddr 192.168.1.100 rport 55457 generation 0
a=candidate:854413036 2 udp 1686052606 163.125.130.79 26991 typ srflx raddr 192.168.1.100 rport 52690 generation 0
a=candidate:4285777184 1 udp 1685987071 112.97.55.70 59693 typ srflx raddr 10.162.22.234 rport 50345 generation 0
a=candidate:4285777184 2 udp 1685987070 112.97.55.70 59694 typ srflx raddr 10.162.22.234 rport 53413 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 60858 typ relay raddr 163.125.130.79 rport 26990 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 62660 typ relay raddr 163.125.130.79 rport 26991 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 61723 typ relay raddr 112.97.51.70 rport 42163 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 63902 typ relay raddr 112.97.51.70 rport 42162 generation 0
------------------------------------------------------------------------
send 371 bytes to tcp/[163.125.130.79]:26869 at 16:38:06.598163:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---e4f7b616f75a9478;rport=26869;received=163.125.130.79
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
To: <sip:1002@x.x.x.x:5060>
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:2255 Re-attaching to session 54895f1e-49b5-11e5-ba05-3bd1ff35cbfe
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:9093 sofia/internal/1001@x.x.x.x:5060 receiving invite from 163.125.130.79:26869 version: 1.7.0 git 58f1272 2015-08-14 17:51:12Z 64bit
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:9260 IP 163.125.130.79 Rejected by acl "domains". Falling back to Digest auth.
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:10392 Setting NAT mode based on nat.auto
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:6715 Channel sofia/internal/1001@x.x.x.x:5060 entering state [received][100]
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:6725 Remote SDP:
v=0
o=- 7694721001483168063 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:PfQS5mTk8DdU0wfL
a=ice-pwd:/LwkxiZgwC7MiwSbG1Ypx5hJ
a=fingerprint:sha-1 0F:6D:76:5D:16:F5:37:8F:F9:80:1C:CC:54:F0:3E:61:13:A0:87:17
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:718599481 cname:DOUxo2z76LkE5KZX
a=ssrc:718599481 msid:media_stream audio_track
a=ssrc:718599481 mslabel:media_stream
a=ssrc:718599481 label:audio_track
a=candidate:3013953624 1 udp 2122260223 192.168.1.100 55457 typ host generation 0
a=candidate:2117845908 1 udp 2122194687 10.162.22.234 50345 typ host generation 0
a=candidate:3013953624 2 udp 2122260222 192.168.1.100 52690 typ host generation 0
a=candidate:2117845908 2 udp 2122194686 10.162.22.234 53413 typ host generation 0
a=candidate:4247172264 1 tcp 1518280447 192.168.1.100 49472 typ host tcptype passive generation 0
a=candidate:817381220 1 tcp 1518214911 10.162.22.234 49473 typ host tcptype passive generation 0
a=candidate:4247172264 2 tcp 1518280446 192.168.1.100 49474 typ host tcptype passive generation 0
a=candidate:817381220 2 tcp 1518214910 10.162.22.234 49475 typ host tcptype passive generation 0
a=candidate:854413036 1 udp 1686052607 163.125.130.79 26990 typ srflx raddr 192.168.1.100 rport 55457 generation 0
a=candidate:854413036 2 udp 1686052606 163.125.130.79 26991 typ srflx raddr 192.168.1.100 rport 52690 generation 0
a=candidate:4285777184 1 udp 1685987071 112.97.55.70 59693 typ srflx raddr 10.162.22.234 rport 50345 generation 0
a=candidate:4285777184 2 udp 1685987070 112.97.55.70 59694 typ srflx raddr 10.162.22.234 rport 53413 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 60858 typ relay raddr 163.125.130.79 rport 26990 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 62660 typ relay raddr 163.125.130.79 rport 26991 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 61723 typ relay raddr 112.97.51.70 rport 42163 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 63902 typ relay raddr 112.97.51.70 rport 42162 generation 0
2015-08-23 16:38:06.590319 [DEBUG] sofia.c:6991 (sofia/internal/1001@x.x.x.x:5060) State Change CS_NEW -> CS_INIT
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_INIT
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1001@x.x.x.x:5060) State INIT
2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:88 sofia/internal/1001@x.x.x.x:5060 SOFIA INIT
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001@x.x.x.x:5060 Standard INIT
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001@x.x.x.x:5060) State Change CS_INIT -> CS_ROUTING
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1001@x.x.x.x:5060) State INIT going to sleep
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_ROUTING
2015-08-23 16:38:06.590319 [DEBUG] switch_channel.c:2239 (sofia/internal/1001@x.x.x.x:5060) Callstate Change DOWN -> RINGING
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@x.x.x.x:5060) State ROUTING
2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:141 sofia/internal/1001@x.x.x.x:5060 SOFIA ROUTING
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:166 sofia/internal/1001@x.x.x.x:5060 Standard ROUTING
2015-08-23 16:38:06.590319 [INFO] mod_dialplan_xml.c:637 Processing 1001 <1001>->1002 in context default
Dialplan: sofia/internal/1001@x.x.x.x:5060 parsing [default->incoming_calls] continue=false
Dialplan: sofia/internal/1001@x.x.x.x:5060 Regex (PASS) [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
Dialplan: sofia/internal/1001@x.x.x.x:5060 Action bridge({rtp_secure_media=false,sip_secure_mediai_outbound=false}[,sip_secure_media_outbound=false,sdp_secure_savp_only=false,origination_caller_id_number=17185345433]sofia/internal/754617702573728@y.y.y.y)
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1001@x.x.x.x:5060) State Change CS_ROUTING -> CS_EXECUTE
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@x.x.x.x:5060) State ROUTING going to sleep
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_EXECUTE
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@x.x.x.x:5060) State EXECUTE
2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:196 sofia/internal/1001@x.x.x.x:5060 SOFIA EXECUTE
2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1001@x.x.x.x:5060 Standard EXECUTE
EXECUTE sofia/internal/1001@x.x.x.x:5060 bridge({rtp_secure_media=false,sip_secure_mediai_outbound=false}[,sip_secure_media_outbound=false,sdp_secure_savp_only=false,origination_caller_id_number=17185345433]sofia/internal/754617702573728@y.y.y.y)
2015-08-23 16:38:06.610302 [DEBUG] switch_ivr_originate.c:2104 Parsing global variables
2015-08-23 16:38:06.610302 [DEBUG] switch_ivr_originate.c:2557 Parsing session specific variables
2015-08-23 16:38:06.610302 [NOTICE] switch_channel.c:1089 New Channel sofia/internal/754617702573728@y.y.y.y [54d94e84-49b5-11e5-ba0c-3bd1ff35cbfe]
2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:4735 (sofia/internal/754617702573728@y.y.y.y) State Change CS_NEW -> CS_INIT
2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:4805 [zrtp_passthru] Setting a-leg inherit_codec=true
2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:4808 [zrtp_passthru] Setting b-leg absolute_codec_string='mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMU@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_INIT
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617702573728@y.y.y.y) State INIT
2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:88 sofia/internal/754617702573728@y.y.y.y SOFIA INIT
2015-08-23 16:38:06.610302 [DEBUG] sofia_glue.c:1257 sofia/internal/754617702573728@y.y.y.y sending invite version: 1.7.0 git 58f1272 2015-08-14 17:51:12Z 64bit
Local SDP:
v=0
o=FreeSWITCH 1440321260 1440321261 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
m=audio 26626 RTP/AVP 9 0 8 101 13
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
a=sendrecv
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:40 sofia/internal/754617702573728@y.y.y.y Standard INIT
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/754617702573728@y.y.y.y) State Change CS_INIT -> CS_ROUTING
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617702573728@y.y.y.y) State INIT going to sleep
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_ROUTING
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617702573728@y.y.y.y) State ROUTING
2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:141 sofia/internal/754617702573728@y.y.y.y SOFIA ROUTING
2015-08-23 16:38:06.610302 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/754617702573728@y.y.y.y) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617702573728@y.y.y.y) State ROUTING going to sleep
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_CONSUME_MEDIA
send 1281 bytes to udp/[y.y.y.y]:5060 at 16:38:06.611312:
------------------------------------------------------------------------
INVITE sip:754617702573728@y.y.y.y SIP/2.0
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKevaDa1tKZ99Uc
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617702573728@y.y.y.y) State CONSUME_MEDIA
Max-Forwards: 69
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>
2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617702573728@y.y.y.y) State CONSUME_MEDIA going to sleep
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837879 INVITE
Contact: <sip:mod_sofia@x.x.x.x:5060>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 294
X-FS-Support: update_display,send_info
Remote-Party-ID: "Extension 1001" <sip:17185345433@x.x.x.x>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1440321260 1440321261 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
m=audio 26626 RTP/AVP 9 0 8 101 13
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
2015-08-23 16:38:06.610302 [DEBUG] sofia.c:6715 Channel sofia/internal/754617702573728@y.y.y.y entering state [calling][0]
recv 317 bytes from udp/[y.y.y.y]:5060 at 16:38:06.612398:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKevaDa1tKZ99Uc
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837879 INVITE
User-Agent: DNL-Switch
Content-Length: 0
------------------------------------------------------------------------
recv 674 bytes from udp/[y.y.y.y]:5060 at 16:38:07.210825:
------------------------------------------------------------------------
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKevaDa1tKZ99Uc
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>;tag=1Xmp97vgtp22K
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837879 INVITE
Contact: <sip:754617702573728@y.y.y.y:5060;transport=udp>
User-Agent: DNL-Switch
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO
Supported: timer
Content-Type: application/sdp
Content-Length: 139
v=0
o=- 1440347904 1440347904 IN IP4 218.16.64.24
s=VOS2009
c=IN IP4 218.16.64.24
t=0 0
m=audio 8722 RTP/AVP 8
a=rtpmap:8 PCMA/8000
------------------------------------------------------------------------
2015-08-23 16:38:07.210310 [DEBUG] sofia.c:6715 Channel sofia/internal/754617702573728@y.y.y.y entering state [proceeding][183]
2015-08-23 16:38:07.210310 [DEBUG] sofia.c:6725 Remote SDP:
v=0
o=- 1440347904 1440347904 IN IP4 218.16.64.24
s=VOS2009
c=IN IP4 218.16.64.24
t=0 0
m=audio 8722 RTP/AVP 8
a=rtpmap:8 PCMA/8000
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:4142 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:2871 Set Codec sofia/internal/754617702573728@y.y.y.y PCMA/8000 20 ms 160 samples 64000 bits 1 channels
2015-08-23 16:38:07.210310 [DEBUG] switch_core_codec.c:111 sofia/internal/754617702573728@y.y.y.y Original read codec set to PCMA:8
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:4407 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:5947 AUDIO RTP [sofia/internal/754617702573728@y.y.y.y] x.x.x.x port 26626 -> 218.16.64.24 port 8722 codec: 8 ms: 20
2015-08-23 16:38:07.210310 [DEBUG] switch_rtp.c:3694 Starting timer [soft] 160 bytes per 20ms
2015-08-23 16:38:07.210310 [DEBUG] switch_core_media.c:6274 sofia/internal/754617702573728@y.y.y.y Set rtp dtmf delay to 40
2015-08-23 16:38:07.210310 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/754617702573728@y.y.y.y!
2015-08-23 16:38:07.210310 [DEBUG] switch_channel.c:3460 (sofia/internal/754617702573728@y.y.y.y) Callstate Change DOWN -> EARLY
2015-08-23 16:38:07.230314 [DEBUG] switch_ivr_originate.c:413 Setting codec string on sofia/internal/1001@x.x.x.x:5060 to PCMA@8000h@20i
2015-08-23 16:38:07.230314 [INFO] switch_ivr_originate.c:3533 Sending early media
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [opus:111:48000:60:0:2]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [G722:9:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [ILBC:102:8000:30:13330:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4142 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [CN:105:16000:60:0:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [CN:13:8000:60:0:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4087 Audio Codec Compare [red:127:8000:60:0:1]/[PCMA:8:8000:20:64000:1]
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4003 Set telephone-event payload to 126@8000
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:2871 Set Codec sofia/internal/1001@x.x.x.x:5060 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
2015-08-23 16:38:07.230314 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@x.x.x.x:5060 Original read codec set to PCMA:8
2015-08-23 16:38:07.230314 [WARNING] switch_core_media.c:3207 NO candidate ACL defined, Defaulting to wan.auto
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.1.100:55457
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 1 proto: udp type: host addr: 10.162.22.234:50345
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.1.100:52690
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 2 proto: udp type: host addr: 10.162.22.234:53413
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 1 proto: udp type: srflx addr: 163.125.130.79:26990
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 2 proto: udp type: srflx addr: 163.125.130.79:26991
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 1 proto: udp type: srflx addr: 112.97.55.70:59693
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 2 proto: udp type: srflx addr: 112.97.55.70:59694
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 1 proto: udp type: relay addr: 146.185.149.11:60858
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 2 proto: udp type: relay addr: 146.185.149.11:62660
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 2 proto: udp type: relay addr: 146.185.149.11:61723
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3236 Save audio Candidate cid: 1 proto: udp type: relay addr: 146.185.149.11:63902
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3276 Searching for rtp candidate.
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3281 Choose rtp candidate, index 2, 163.125.130.79:26990
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3099 sofia/internal/1001@x.x.x.x:5060 choosing family v4
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3292 Choose same candidate, index 6, for rtcp based on rtcp-mux attribute 163.125.130.79:26990
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3337 setting remote audio ice addr to index 2 163.125.130.79:26990 based on candidate
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:3358 Setting remote rtcp audio addr to 163.125.130.79:26990 based on candidate
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4346 Set telephone-event payload to 126@8000
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:4394 Set 2833 dtmf send/recv payload to 126
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:5947 AUDIO RTP [sofia/internal/1001@x.x.x.x:5060] x.x.x.x port 21834 -> 163.125.130.79 port 26990 codec: 8 ms: 20
2015-08-23 16:38:07.230314 [DEBUG] switch_rtp.c:3694 Starting timer [soft] 160 bytes per 20ms
2015-08-23 16:38:07.230314 [INFO] switch_core_media.c:6122 Activating Audio ICE
2015-08-23 16:38:07.230314 [NOTICE] switch_rtp.c:4213 Activating RTP audio ICE: PfQS5mTk8DdU0wfL:lxhtm2fsdIETo71R 163.125.130.79:26990
2015-08-23 16:38:07.230314 [INFO] switch_core_media.c:6165 Activating RTCP PORT 26990
2015-08-23 16:38:07.230314 [DEBUG] switch_rtp.c:4110 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 26990
2015-08-23 16:38:07.230314 [INFO] switch_core_media.c:6173 Skipping RTCP ICE (Same as RTP)
2015-08-23 16:38:07.230314 [INFO] switch_rtp.c:3214 Activate RTP/RTCP audio DTLS client
2015-08-23 16:38:07.230314 [INFO] switch_rtp.c:3343 Changing audio DTLS state from OFF to HANDSHAKE
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:6246 Set 2833 dtmf send payload to 126
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:6252 Set 2833 dtmf receive payload to 126
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:6274 sofia/internal/1001@x.x.x.x:5060 Set rtp dtmf delay to 40
2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:6280 Set comfort noise payload to 13
2015-08-23 16:38:07.230314 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1001@x.x.x.x:5060!
2015-08-23 16:38:07.230314 [DEBUG] switch_channel.c:3460 (sofia/internal/1001@x.x.x.x:5060) Callstate Change RINGING -> EARLY
2015-08-23 16:38:07.230314 [DEBUG] mod_sofia.c:2293 Ring SDP:
v=0
o=FreeSWITCH 1440326053 1440326054 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
a=msid-semantic: WMS CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
m=audio 21834 RTP/SAVPF 8 126 13
a=rtpmap:8 PCMA/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:13 CN/8000
a=ptime:20
a=sendonly
a=fingerprint:sha-1 51:B3:65:D7:5A:E5:EF:90:24:DA:D6:07:BB:2F:AF:A4:73:57:AE:0A
a=setup:active
a=rtcp-mux
a=rtcp:21834 IN IP4 x.x.x.x
a=ice-ufrag:lxhtm2fsdIETo71R
a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW
a=candidate:4917377022 1 udp 659136 x.x.x.x 21834 typ host generation 0
a=ssrc:1306378974 cname:DsRcqAiZAQOr6ENm
a=ssrc:1306378974 msid:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi a0
a=ssrc:1306378974 mslabel:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
a=ssrc:1306378974 label:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDia0
2015-08-23 16:38:07.230314 [DEBUG] switch_ivr_originate.c:3584 Originate Resulted in Success: [sofia/internal/754617702573728@y.y.y.y]
send 1773 bytes to tcp/[163.125.130.79]:26869 at 16:38:07.236989:
------------------------------------------------------------------------
SIP/2.0 183 Session Progress
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---e4f7b616f75a9478;rport=26869;received=163.125.130.79
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 INVITE
Contact: <sip:1002@x.x.x.x:5060;transport=tcp>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 809
Remote-Party-ID: "Outbound Call" <sip:754617702573728@x.x.x.x>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1440326053 1440326054 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
a=msid-semantic: WMS CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
m=audio 21834 RTP/SAVPF 8 126 13
a=rtpmap:8 PCMA/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:13 CN/8000
a=sendonly
a=ptime:20
a=fingerprint:sha-1 51:B3:65:D7:5A:E5:EF:90:24:DA:D6:07:BB:2F:AF:A4:73:57:AE:0A
a=setup:active
a=rtcp-mux
a=rtcp:21834 IN IP4 x.x.x.x
a=ice-ufrag:lxhtm2fsdIETo71R
a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW
a=candidate:4917377022 1 udp 659136 x.x.x.x 21834 typ host generation 0
a=ssrc:1306378974 cname:DsRcqAiZAQOr6ENm
a=ssrc:1306378974 msid:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi a0
a=ssrc:1306378974 mslabel:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
a=ssrc:1306378974 label:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDia0
------------------------------------------------------------------------
2015-08-23 16:38:07.230314 [DEBUG] sofia.c:6715 Channel sofia/internal/1001@x.x.x.x:5060 entering state [early][183]
2015-08-23 16:38:07.230314 [DEBUG] switch_ivr_bridge.c:1584 (sofia/internal/754617702573728@y.y.y.y) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2015-08-23 16:38:07.230314 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_EXCHANGE_MEDIA
2015-08-23 16:38:07.230314 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/754617702573728@y.y.y.y) State EXCHANGE_MEDIA
2015-08-23 16:38:07.230314 [DEBUG] mod_sofia.c:613 SOFIA EXCHANGE_MEDIA
2015-08-23 16:38:09.290278 [DEBUG] switch_rtp.c:6462 Correct audio ip/port confirmed.
recv 635 bytes from udp/[y.y.y.y]:5060 at 16:38:16.729400:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKevaDa1tKZ99Uc
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>;tag=1Xmp97vgtp22K
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837879 INVITE
Contact: <sip:754617702573728@y.y.y.y:5060;transport=udp>
User-Agent: DNL-Switch
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO
Supported: timer
Content-Type: application/sdp
Content-Length: 139
v=0
o=- 1440347904 1440347904 IN IP4 218.16.64.24
s=VOS2009
c=IN IP4 218.16.64.24
t=0 0
m=audio 8722 RTP/AVP 8
a=rtpmap:8 PCMA/8000
------------------------------------------------------------------------
2015-08-23 16:38:16.710530 [DEBUG] sofia.c:6715 Channel sofia/internal/754617702573728@y.y.y.y entering state [completing][200]
2015-08-23 16:38:16.710530 [DEBUG] sofia.c:6722 Duplicate SDP
v=0
o=- 1440347904 1440347904 IN IP4 218.16.64.24
s=VOS2009
c=IN IP4 218.16.64.24
t=0 0
m=audio 8722 RTP/AVP 8
a=rtpmap:8 PCMA/8000
send 418 bytes to udp/[y.y.y.y]:5060 at 16:38:16.733500:
------------------------------------------------------------------------
ACK sip:754617702573728@y.y.y.y:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKF535BvBQvj0er
Max-Forwards: 70
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>;tag=1Xmp97vgtp22K
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837879 ACK
Contact: <sip:mod_sofia@x.x.x.x:5060>
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:16.750300 [DEBUG] sofia.c:6715 Channel sofia/internal/754617702573728@y.y.y.y entering state [ready][200]
2015-08-23 16:38:16.750300 [NOTICE] sofia.c:7517 Channel [sofia/internal/754617702573728@y.y.y.y] has been answered
2015-08-23 16:38:16.750300 [DEBUG] switch_channel.c:3759 (sofia/internal/754617702573728@y.y.y.y) Callstate Change EARLY -> ACTIVE
2015-08-23 16:38:16.750300 [DEBUG] mod_sofia.c:799 Local SDP sofia/internal/1001@x.x.x.x:5060:
v=0
o=FreeSWITCH 1440326053 1440326055 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
a=msid-semantic: WMS CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
m=audio 21834 RTP/SAVPF 8 126 13
a=rtpmap:8 PCMA/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:13 CN/8000
a=ptime:20
a=sendonly
a=fingerprint:sha-1 51:B3:65:D7:5A:E5:EF:90:24:DA:D6:07:BB:2F:AF:A4:73:57:AE:0A
a=setup:active
a=rtcp-mux
a=rtcp:21834 IN IP4 x.x.x.x
a=ice-ufrag:lxhtm2fsdIETo71R
a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW
a=candidate:9014549722 1 udp 659136 x.x.x.x 21834 typ host generation 0
a=ssrc:1306378974 cname:DsRcqAiZAQOr6ENm
a=ssrc:1306378974 msid:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi a0
a=ssrc:1306378974 mslabel:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
a=ssrc:1306378974 label:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDia0
send 1786 bytes to tcp/[163.125.130.79]:26869 at 16:38:16.754777:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---e4f7b616f75a9478;rport=26869;received=163.125.130.79
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 INVITE
Contact: <sip:1002@x.x.x.x:5060;transport=tcp>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Require: timer
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Session-Expires: 120;refresher=uac
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 809
Remote-Party-ID: "Outbound Call" <sip:754617702573728@x.x.x.x>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1440326053 1440326054 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
a=msid-semantic: WMS CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
m=audio 21834 RTP/SAVPF 8 126 13
a=rtpmap:8 PCMA/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:13 CN/8000
a=sendonly
a=ptime:20
a=fingerprint:sha-1 51:B3:65:D7:5A:E5:EF:90:24:DA:D6:07:BB:2F:AF:A4:73:57:AE:0A
a=setup:active
a=rtcp-mux
a=rtcp:21834 IN IP4 x.x.x.x
a=ice-ufrag:lxhtm2fsdIETo71R
a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW
a=candidate:4917377022 1 udp 659136 x.x.x.x 21834 typ host generation 0
a=ssrc:1306378974 cname:DsRcqAiZAQOr6ENm
a=ssrc:1306378974 msid:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi a0
a=ssrc:1306378974 mslabel:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
a=ssrc:1306378974 label:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDia0
------------------------------------------------------------------------
2015-08-23 16:38:16.770314 [DEBUG] sofia.c:6715 Channel sofia/internal/1001@x.x.x.x:5060 entering state [completed][200]
2015-08-23 16:38:16.810331 [DEBUG] switch_rtp.c:6462 Correct audio ip/port confirmed.
send 1786 bytes to tcp/[163.125.130.79]:26869 at 16:38:17.254967:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---e4f7b616f75a9478;rport=26869;received=163.125.130.79
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 INVITE
Contact: <sip:1002@x.x.x.x:5060;transport=tcp>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Require: timer
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Session-Expires: 120;refresher=uac
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 809
Remote-Party-ID: "Outbound Call" <sip:754617702573728@x.x.x.x>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1440326053 1440326054 IN IP4 x.x.x.x
s=FreeSWITCH
c=IN IP4 x.x.x.x
t=0 0
a=msid-semantic: WMS CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
m=audio 21834 RTP/SAVPF 8 126 13
a=rtpmap:8 PCMA/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:13 CN/8000
a=sendonly
a=ptime:20
a=fingerprint:sha-1 51:B3:65:D7:5A:E5:EF:90:24:DA:D6:07:BB:2F:AF:A4:73:57:AE:0A
a=setup:active
a=rtcp-mux
a=rtcp:21834 IN IP4 x.x.x.x
a=ice-ufrag:lxhtm2fsdIETo71R
a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW
a=candidate:4917377022 1 udp 659136 x.x.x.x 21834 typ host generation 0
a=ssrc:1306378974 cname:DsRcqAiZAQOr6ENm
a=ssrc:1306378974 msid:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi a0
a=ssrc:1306378974 mslabel:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDi
a=ssrc:1306378974 label:CWZJJ7SfJaIY0q0wpQU5iYUVflDmPQDia0
------------------------------------------------------------------------
recv 425 bytes from tcp/[163.125.130.79]:26869 at 16:38:17.263429:
------------------------------------------------------------------------
ACK sip:1002@x.x.x.x:5060;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---c562871456b95e64;rport
Max-Forwards: 70
Contact: <sip:1001@192.168.1.100:5060;transport=tcp>;+sip.instance="1001@x.x.x.x:5060"
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 ACK
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:17.270321 [DEBUG] sofia.c:6715 Channel sofia/internal/1001@x.x.x.x:5060 entering state [ready][200]
2015-08-23 16:38:17.670308 [NOTICE] switch_rtp.c:1175 Auto Changing audio stun/rtp/dtls port from 163.125.130.79:26990 to 112.97.55.70:59693
recv 425 bytes from tcp/[163.125.130.79]:26869 at 16:38:17.692357:
------------------------------------------------------------------------
ACK sip:1002@x.x.x.x:5060;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---c562871456b95e64;rport
Max-Forwards: 70
Contact: <sip:1001@192.168.1.100:5060;transport=tcp>;+sip.instance="1001@x.x.x.x:5060"
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 2 ACK
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:19.510341 [INFO] switch_rtp.c:3007 Changing audio DTLS state from HANDSHAKE to SETUP
2015-08-23 16:38:19.510341 [INFO] switch_rtp.c:2916 audio Fingerprint Verified.
2015-08-23 16:38:19.510341 [INFO] switch_rtp.c:3506 Activating Audio Secure RTP SEND
2015-08-23 16:38:19.510341 [INFO] switch_rtp.c:3484 Activating Audio Secure RTP RECV
2015-08-23 16:38:19.510341 [INFO] switch_rtp.c:2956 Changing audio DTLS state from SETUP to READY
2015-08-23 16:38:19.510341 [DEBUG] switch_core_sqldb.c:2607 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
2015-08-23 16:38:19.510341 [DEBUG] switch_core_sqldb.c:2607 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
2015-08-23 16:38:19.510341 [NOTICE] switch_ivr_bridge.c:609 Channel [sofia/internal/1001@x.x.x.x:5060] has been answered
2015-08-23 16:38:19.510341 [DEBUG] switch_channel.c:3759 (sofia/internal/1001@x.x.x.x:5060) Callstate Change EARLY -> ACTIVE
freeswitch@switch3>
freeswitch@switch3>
freeswitch@switch3>
freeswitch@switch3>
freeswitch@switch3> recv 737 bytes from tcp/[163.125.130.79]:26869 at 16:38:29.607614:
------------------------------------------------------------------------
BYE sip:1002@x.x.x.x:5060;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---c2b8e25850437d1d;rport
Max-Forwards: 70
Contact: <sip:1001@192.168.1.100:5060;transport=tcp>;+sip.instance="1001@x.x.x.x:5060"
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 3 BYE
Proxy-Authorization: Digest username="1001",realm="x.x.x.x",nonce="54896b80-49b5-11e5-ba06-3bd1ff35cbfe",uri="sip:1002@x.x.x.x:5060;transport=tcp",response="e01d7fbc84b3375e271c041aac302718",cnonce="061dd974e10e224a6d5cad294f14cf21",nc=00000002,qop=auth,algorithm=MD5
Reason: SIP;text=User Hung Up
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:29.610343 [NOTICE] sofia.c:952 Hangup sofia/internal/1001@x.x.x.x:5060 [CS_EXECUTE] [NORMAL_CLEARING]
send 526 bytes to tcp/[163.125.130.79]:26869 at 16:38:29.615254:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 192.168.1.100:5060;branch=z9hG4bK-524287-1---c2b8e25850437d1d;rport=26869;received=163.125.130.79
From: <sip:1001@x.x.x.x:5060>;tag=e090b871
To: <sip:1002@x.x.x.x:5060>;tag=HQmccgH0KDv9j
Call-ID: YEXqB4WY4KZUOfmDabppqg..
CSeq: 3 BYE
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:29.610343 [DEBUG] switch_ivr_bridge.c:771 BRIDGE THREAD DONE [sofia/internal/1001@x.x.x.x:5060]
2015-08-23 16:38:29.630370 [DEBUG] switch_ivr_bridge.c:771 BRIDGE THREAD DONE [sofia/internal/754617702573728@y.y.y.y]
2015-08-23 16:38:29.630370 [NOTICE] switch_ivr_bridge.c:874 Hangup sofia/internal/754617702573728@y.y.y.y [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:542 (sofia/internal/754617702573728@y.y.y.y) State EXCHANGE_MEDIA going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_HANGUP
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/754617702573728@y.y.y.y) Callstate Change ACTIVE -> HANGUP
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/754617702573728@y.y.y.y) State HANGUP
2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:425 sofia/internal/754617702573728@y.y.y.y Overriding SIP cause 480 with 200 from the other leg
2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:431 Channel sofia/internal/754617702573728@y.y.y.y hanging up, cause: NORMAL_CLEARING
2015-08-23 16:38:29.630370 [DEBUG] switch_ivr_bridge.c:1682 sofia/internal/754617702573728@y.y.y.y skip receive message [UNBRIDGE] (channel is hungup already)
2015-08-23 16:38:29.630370 [DEBUG] switch_ivr_bridge.c:1685 sofia/internal/1001@x.x.x.x:5060 skip receive message [UNBRIDGE] (channel is hungup already)
2015-08-23 16:38:29.630370 [DEBUG] switch_core_session.c:2926 sofia/internal/1001@x.x.x.x:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@x.x.x.x:5060) State EXECUTE going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_HANGUP
2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:484 Sending BYE to sofia/internal/754617702573728@y.y.y.y
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:60 sofia/internal/754617702573728@y.y.y.y Standard HANGUP, cause: NORMAL_CLEARING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/754617702573728@y.y.y.y) State HANGUP going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/754617702573728@y.y.y.y) State Change CS_HANGUP -> CS_REPORTING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_REPORTING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1001@x.x.x.x:5060) Callstate Change ACTIVE -> HANGUP
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/754617702573728@y.y.y.y) State REPORTING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:104 sofia/internal/754617702573728@y.y.y.y Standard REPORTING, cause: NORMAL_CLEARING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/754617702573728@y.y.y.y) State REPORTING going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@x.x.x.x:5060) State HANGUP
2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:431 Channel sofia/internal/1001@x.x.x.x:5060 hanging up, cause: NORMAL_CLEARING
send 642 bytes to udp/[y.y.y.y]:5060 at 16:38:29.633670:
------------------------------------------------------------------------
BYE sip:754617702573728@y.y.y.y:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKgeXyDQvtSUp1K
Max-Forwards: 70
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>;tag=1Xmp97vgtp22K
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837880 BYE
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/754617702573728@y.y.y.y) State Change CS_REPORTING -> CS_DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_session.c:1639 Session 5 (sofia/internal/754617702573728@y.y.y.y) Locked, Waiting on external entities
2015-08-23 16:38:29.630370 [NOTICE] switch_core_session.c:1657 Session 5 (sofia/internal/754617702573728@y.y.y.y) Ended
2015-08-23 16:38:29.630370 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/754617702573728@y.y.y.y [CS_DESTROY]
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001@x.x.x.x:5060 Standard HANGUP, cause: NORMAL_CLEARING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@x.x.x.x:5060) State HANGUP going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/1001@x.x.x.x:5060) State Change CS_HANGUP -> CS_REPORTING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/754617702573728@y.y.y.y) Running State Change CS_DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_REPORTING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/754617702573728@y.y.y.y) State DESTROY
2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:341 sofia/internal/754617702573728@y.y.y.y SOFIA DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@x.x.x.x:5060) State REPORTING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:111 sofia/internal/754617702573728@y.y.y.y Standard DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/754617702573728@y.y.y.y) State DESTROY going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1001@x.x.x.x:5060 Standard REPORTING, cause: NORMAL_CLEARING
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@x.x.x.x:5060) State REPORTING going to sleep
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1001@x.x.x.x:5060) State Change CS_REPORTING -> CS_DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_session.c:1639 Session 4 (sofia/internal/1001@x.x.x.x:5060) Locked, Waiting on external entities
2015-08-23 16:38:29.630370 [NOTICE] switch_core_session.c:1657 Session 4 (sofia/internal/1001@x.x.x.x:5060) Ended
2015-08-23 16:38:29.630370 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/1001@x.x.x.x:5060 [CS_DESTROY]
recv 394 bytes from udp/[y.y.y.y]:5060 at 16:38:29.634664:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKgeXyDQvtSUp1K
From: "Extension 1001" <sip:17185345433@x.x.x.x>;tag=j0D5DB23gpjve
To: <sip:754617702573728@y.y.y.y>;tag=1Xmp97vgtp22K
Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
CSeq: 79837880 BYE
User-Agent: DNL-Switch
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO
Supported: timer
Content-Length: 0
------------------------------------------------------------------------
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@x.x.x.x:5060) State DESTROY
2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:341 sofia/internal/1001@x.x.x.x:5060 SOFIA DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1001@x.x.x.x:5060 Standard DESTROY
2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@x.x.x.x:5060) State DESTROY going to sleep
_________________________________________________________________________On Sun, Aug 23, 2015 at 9:56 AM, Anthony Minessale <anthony.minessale@gmail.com> wrote:Try reverting your config to defaults. You are clearly lost in some config changes.On Sun, Aug 23, 2015 at 10:52 AM, Ken Rice <krice@freeswitch.org> wrote:Don’t set proxy media or bypass media, these are special modes that do not fix up the RTP at all… just use the default modes
From: freeswitch-users-bounces@lists.freeswitch.org [mailto:freeswitch-users-bounces@lists.freeswitch.org] On Behalf Of Pete Kay
Sent: Sunday, August 23, 2015 10:41 AM
To: FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org>
Subject: Re: [Freeswitch-users] Need help to convert RTP/SAVP to RTP/AVP
Hi
I changed the internal profile to proxy media now, and the o= line in the sdp is now showing FREESWITCH, but it is still using SAVPF...
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:166 sofia/internal/1001@x.x.x.x:5060 Standard ROUTING
2015-08-23 15:34:14.714657 [INFO] mod_dialplan_xml.c:637 Processing 1001 <1001>->1002 in context default
Dialplan: sofia/internal/1001@x.x.x.x:5060 parsing [default->incoming_calls] continue=false
Dialplan: sofia/internal/1001@x.x.x.x:5060 Regex (PASS) [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
Dialplan: sofia/internal/1001@x.x.x.x:5060 Action bridge({rtp_allow_crypto_in_avp=false,rtp_secure_media=false,sip_secure_mediai_outbound=false}[rtp_allow_crypto_in_avp=false,sip_secure_media_outbound=false,sdp_secure_savp_only=false]sofia/internal/754617162742492@y.y.y.y)
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1001@x.x.x.x:5060) State Change CS_ROUTING -> CS_EXECUTE
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@x.x.x.x:5060) State ROUTING going to sleep
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@x.x.x.x:5060) Running State Change CS_EXECUTE
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@x.x.x.x:5060) State EXECUTE
2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:196 sofia/internal/1001@x.x.x.x:5060 SOFIA EXECUTE
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1001@x.x.x.x:5060 Standard EXECUTE
EXECUTE sofia/internal/1001@x.x.x.x:5060 bridge({rtp_allow_crypto_in_avp=false,rtp_secure_media=false,sip_secure_mediai_outbound=false}[rtp_allow_crypto_in_avp=false,sip_secure_media_outbound=false,sdp_secure_savp_only=false]sofia/internal/754617162742492@y.y.y.y)
2015-08-23 15:34:14.714657 [DEBUG] switch_ivr_originate.c:2104 Parsing global variables
2015-08-23 15:34:14.714657 [DEBUG] switch_ivr_originate.c:2557 Parsing session specific variables
2015-08-23 15:34:14.714657 [NOTICE] switch_channel.c:1089 New Channel sofia/internal/754617162742492@y.y.y.y [68de50a4-49ac-11e5-b118-6fcd62a30179]
2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:4735 (sofia/internal/754617162742492@y.y.y.y) State Change CS_NEW -> CS_INIT
2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:4805 [zrtp_passthru] Setting a-leg inherit_codec=true
2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:4808 [zrtp_passthru] Setting b-leg absolute_codec_string='mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMU@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@y.y.y.y) Running State Change CS_INIT
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617162742492@y.y.y.y) State INIT
2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:88 sofia/internal/754617162742492@y.y.y.y SOFIA INIT
2015-08-23 15:34:14.714657 [DEBUG] switch_core_media.c:8667 sofia/internal/754617162742492@y.y.y.y Patched SDP
---
v=0
o=- 3653435483206582716 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:duN/nld3Ywx4sKCI
a=ice-pwd:yiG5QkmXTg1NNO5qIUtVLKRk
a=fingerprint:sha-1 84:83:7B:9E:8F:B5:A6:F9:F1:80:F3:DC:60:6E:0A:78:49:46:49:AA
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3490757364 cname:j5lQWpsyZUv+UlSb
a=ssrc:3490757364 msid:media_stream audio_track
a=ssrc:3490757364 mslabel:media_stream
a=ssrc:3490757364 label:audio_track
a=candidate:3013953624 1 udp 2122260223 192.168.1.100 54468 typ host generation 0
a=candidate:2117845908 1 udp 2122194687 10.162.22.234 65466 typ host generation 0
a=candidate:3013953624 2 udp 2122260222 192.168.1.100 64051 typ host generation 0
a=candidate:2117845908 2 udp 2122194686 10.162.22.234 49167 typ host generation 0
a=candidate:4247172264 1 tcp 1518280447 192.168.1.100 49288 typ host tcptype passive generation 0
a=candidate:817381220 1 tcp 1518214911 10.162.22.234 49289 typ host tcptype passive generation 0
a=candidate:4247172264 2 tcp 1518280446 192.168.1.100 49290 typ host tcptype passive generation 0
a=candidate:817381220 2 tcp 1518214910 10.162.22.234 49291 typ host tcptype passive generation 0
a=candidate:4285777184 1 udp 1685987071 112.97.55.70 59590 typ srflx raddr 10.162.22.234 rport 65466 generation 0
a=candidate:4285777184 2 udp 1685987070 112.97.55.70 59591 typ srflx raddr 10.162.22.234 rport 49167 generation 0
a=candidate:854413036 1 udp 1686052607 163.125.130.79 21981 typ srflx raddr 192.168.1.100 rport 54468 generation 0
a=candidate:854413036 2 udp 1686052606 163.125.130.79 21982 typ srflx raddr 192.168.1.100 rport 64051 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 63674 typ relay raddr 112.97.51.70 rport 41768 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 54428 typ relay raddr 163.125.130.79 rport 21981 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 49815 typ relay raddr 112.97.51.70 rport 41769 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 64960 typ relay raddr 163.125.130.79 rport 21982 generation 0
+++
v=0
o=FreeSWITCH 1592140567 1592140568 IN IP4 x.x.x.x
s=FreeSWITCH
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 25336 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 x.x.x.x
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:duN/nld3Ywx4sKCI
a=ice-pwd:yiG5QkmXTg1NNO5qIUtVLKRk
a=fingerprint:sha-1 84:83:7B:9E:8F:B5:A6:F9:F1:80:F3:DC:60:6E:0A:78:49:46:49:AA
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3490757364 cname:j5lQWpsyZUv+UlSb
a=ssrc:3490757364 msid:media_stream audio_track
a=ssrc:3490757364 mslabel:media_stream
a=ssrc:3490757364 label:audio_track
a=candidate:3013953624 1 udp 2122260223 192.168.1.100 54468 typ host generation 0
a=candidate:2117845908 1 udp 2122194687 10.162.22.234 65466 typ host generation 0
a=candidate:3013953624 2 udp 2122260222 192.168.1.100 64051 typ host generation 0
a=candidate:2117845908 2 udp 2122194686 10.162.22.234 49167 typ host generation 0
a=candidate:4247172264 1 tcp 1518280447 192.168.1.100 49288 typ host tcptype passive generation 0
a=candidate:817381220 1 tcp 1518214911 10.162.22.234 49289 typ host tcptype passive generation 0
a=candidate:4247172264 2 tcp 1518280446 192.168.1.100 49290 typ host tcptype passive generation 0
a=candidate:817381220 2 tcp 1518214910 10.162.22.234 49291 typ host tcptype passive generation 0
a=candidate:4285777184 1 udp 1685987071 112.97.55.70 59590 typ srflx raddr 10.162.22.234 rport 65466 generation 0
a=candidate:4285777184 2 udp 1685987070 112.97.55.70 59591 typ srflx raddr 10.162.22.234 rport 49167 generation 0
a=candidate:854413036 1 udp 1686052607 163.125.130.79 21981 typ srflx raddr 192.168.1.100 rport 54468 generation 0
a=candidate:854413036 2 udp 1686052606 163.125.130.79 21982 typ srflx raddr 192.168.1.100 rport 64051 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 63674 typ relay raddr 112.97.51.70 rport 41768 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 54428 typ relay raddr 163.125.130.79 rport 21981 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 49815 typ relay raddr 112.97.51.70 rport 41769 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 64960 typ relay raddr 163.125.130.79 rport 21982 generation 0
2015-08-23 15:34:14.714657 [DEBUG] sofia_glue.c:1257 sofia/internal/754617162742492@y.y.y.y sending invite version: 1.7.0 git 58f1272 2015-08-14 17:51:12Z 64bit
Local SDP:
v=0
o=FreeSWITCH 1592140567 1592140568 IN IP4 x.x.x.x
s=FreeSWITCH
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 25336 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 x.x.x.x
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:duN/nld3Ywx4sKCI
a=ice-pwd:yiG5QkmXTg1NNO5qIUtVLKRk
a=fingerprint:sha-1 84:83:7B:9E:8F:B5:A6:F9:F1:80:F3:DC:60:6E:0A:78:49:46:49:AA
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3490757364 cname:j5lQWpsyZUv+UlSb
a=ssrc:3490757364 msid:media_stream audio_track
a=ssrc:3490757364 mslabel:media_stream
a=ssrc:3490757364 label:audio_track
a=candidate:3013953624 1 udp 2122260223 192.168.1.100 54468 typ host generation 0
a=candidate:2117845908 1 udp 2122194687 10.162.22.234 65466 typ host generation 0
a=candidate:3013953624 2 udp 2122260222 192.168.1.100 64051 typ host generation 0
a=candidate:2117845908 2 udp 2122194686 10.162.22.234 49167 typ host generation 0
a=candidate:4247172264 1 tcp 1518280447 192.168.1.100 49288 typ host tcptype passive generation 0
a=candidate:817381220 1 tcp 1518214911 10.162.22.234 49289 typ host tcptype passive generation 0
a=candidate:4247172264 2 tcp 1518280446 192.168.1.100 49290 typ host tcptype passive generation 0
a=candidate:817381220 2 tcp 1518214910 10.162.22.234 49291 typ host tcptype passive generation 0
a=candidate:4285777184 1 udp 1685987071 112.97.55.70 59590 typ srflx raddr 10.162.22.234 rport 65466 generation 0
a=candidate:4285777184 2 udp 1685987070 112.97.55.70 59591 typ srflx raddr 10.162.22.234 rport 49167 generation 0
a=candidate:854413036 1 udp 1686052607 163.125.130.79 21981 typ srflx raddr 192.168.1.100 rport 54468 generation 0
a=candidate:854413036 2 udp 1686052606 163.125.130.79 21982 typ srflx raddr 192.168.1.100 rport 64051 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 63674 typ relay raddr 112.97.51.70 rport 41768 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 54428 typ relay raddr 163.125.130.79 rport 21981 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 49815 typ relay raddr 112.97.51.70 rport 41769 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 64960 typ relay raddr 163.125.130.79 rport 21982 generation 0
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:40 sofia/internal/754617162742492@y.y.y.y Standard INIT
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/754617162742492@y.y.y.y) State Change CS_INIT -> CS_ROUTING
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617162742492@y.y.y.y) State INIT going to sleep
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@y.y.y.y) Running State Change CS_ROUTING
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617162742492@y.y.y.y) State ROUTING
2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:141 sofia/internal/754617162742492@y.y.y.y SOFIA ROUTING
2015-08-23 15:34:14.714657 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/754617162742492@y.y.y.y) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617162742492@y.y.y.y) State ROUTING going to sleep
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/754617162742492@y.y.y.y) Running State Change CS_CONSUME_MEDIA
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617162742492@y.y.y.y) State CONSUME_MEDIA
2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617162742492@y.y.y.y) State CONSUME_MEDIA going to sleep
send 3675 bytes to udp/[y.y.y.y]:5060 at 15:34:14.728794:
------------------------------------------------------------------------
INVITE sip:754617162742492@y.y.y.y SIP/2.0
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKKQvQ32p77mX3K
Max-Forwards: 69
From: "Extension 1001" <sip:1001@x.x.x.x>;tag=Q3F772K7rmctc
To: <sip:754617162742492@y.y.y.y>
Call-ID: 403cbc44-c44f-1233-ba8f-60eb698211be
CSeq: 79835963 INVITE
Contact: <sip:mod_sofia@x.x.x.x:5060>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 2705
X-FS-Support: update_display,send_info
Remote-Party-ID: "Extension 1001" <sip:1001@x.x.x.x>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 1592140567 1592140568 IN IP4 x.x.x.x
s=FreeSWITCH
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 25336 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 x.x.x.x
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:duN/nld3Ywx4sKCI
a=ice-pwd:yiG5QkmXTg1NNO5qIUtVLKRk
a=fingerprint:sha-1 84:83:7B:9E:8F:B5:A6:F9:F1:80:F3:DC:60:6E:0A:78:49:46:49:AA
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3490757364 cname:j5lQWpsyZUv+UlSb
a=ssrc:3490757364 msid:media_stream audio_track
a=ssrc:3490757364 mslabel:media_stream
a=ssrc:3490757364 label:audio_track
a=candidate:3013953624 1 udp 2122260223 192.168.1.100 54468 typ host generation 0
a=candidate:2117845908 1 udp 2122194687 10.162.22.234 65466 typ host generation 0
a=candidate:3013953624 2 udp 2122260222 192.168.1.100 64051 typ host generation 0
a=candidate:2117845908 2 udp 2122194686 10.162.22.234 49167 typ host generation 0
a=candidate:4247172264 1 tcp 1518280447 192.168.1.100 49288 typ host tcptype passive generation 0
a=candidate:817381220 1 tcp 1518214911 10.162.22.234 49289 typ host tcptype passive generation 0
a=candidate:4247172264 2 tcp 1518280446 192.168.1.100 49290 typ host tcptype passive generation 0
a=candidate:817381220 2 tcp 1518214910 10.162.22.234 49291 typ host tcptype passive generation 0
a=candidate:4285777184 1 udp 1685987071 112.97.55.70 59590 typ srflx raddr 10.162.22.234 rport 65466 generation 0
a=candidate:4285777184 2 udp 1685987070 112.97.55.70 59591 typ srflx raddr 10.162.22.234 rport 49167 generation 0
a=candidate:854413036 1 udp 1686052607 163.125.130.79 21981 typ srflx raddr 192.168.1.100 rport 54468 generation 0
a=candidate:854413036 2 udp 1686052606 163.125.130.79 21982 typ srflx raddr 192.168.1.100 rport 64051 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 63674 typ relay raddr 112.97.51.70 rport 41768 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 54428 typ relay raddr 163.125.130.79 rport 21981 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 49815 typ relay raddr 112.97.51.70 rport 41769 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 64960 typ relay raddr 163.125.130.79 rport 21982 generation 0
------------------------------------------------------------------------
2015-08-23 15:34:14.714657 [DEBUG] sofia.c:6715 Channel sofia/internal/754617162742492@y.y.y.y entering state [calling][0]
recv 308 bytes from udp/[y.y.y.y]:5060 at 15:34:14.730001:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKKQvQ32p77mX3K
From: "Extension 1001" <sip:1001@x.x.x.x>;tag=Q3F772K7rmctc
To: <sip:754617162742492@y.y.y.y>
Call-ID: 403cbc44-c44f-1233-ba8f-60eb698211be
CSeq: 79835963 INVITE
User-Agent: DNL-Switch
Content-Length: 0
------------------------------------------------------------------------
recv 433 bytes from udp/[y.y.y.y]:5060 at 15:34:14.740478:
------------------------------------------------------------------------
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/UDP x.x.x.x;rport;branch=z9hG4bKKQvQ32p77mX3K
From: "Extension 1001" <sip:1001@x.x.x.x>;tag=Q3F772K7rmctc
To: <sip:754617162742492@y.y.y.y>;tag=454F3aHa1Fa5e
Call-ID: 403cbc44-c44f-1233-ba8f-60eb698211be
CSeq: 79835963 INVITE
User-Agent: DNL-Switch
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO
Supported: timer
Content-Length: 0
------------------------------------------------------------------------
On Sun, Aug 23, 2015 at 8:05 AM, Anthony Minessale <anthony.minessale@gmail.com> wrote:
You still have bypass set somehow.
Not the local sdp is not a native FS sdp the bundle and the lack of the word freeswitch in the o line.
Maybe you have bypass enabled as a sofia profile param.
On Saturday, August 22, 2015, Pete Kay <petedao@gmail.com> wrote:Hi
I did anothe test without proxy_media=true, but I am still getting SAVPF in the outgoing INVITE. The problem is my outbound SIP gateway does not accept SAVPF so I am trying to configure Freeswitch to send it out as AVPF.
Here is the log:
2015-08-22 10:11:43.049286 [INFO] mod_dialplan_xml.c:637 Processing 1001 <1001>->1002 in context default
Dialplan: sofia/internal/1001@y.y.y.y:5060 parsing [default->incoming_calls] continue=false
Dialplan: sofia/internal/1001@y.y.y.y:5060 Regex (PASS) [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
Dialplan: sofia/internal/1001@y.y.y.y:5060 Action bridge({rtp_allow_crypto_in_avp=false,rtp_secure_media=false,sip_secure_mediai_outbound=false}[rtp_allow_crypto_in_avp=false,sip_secure_media_outbound=false,sdp_secure_savp_only=false]sofia/external/754617162742492@x.x.x.x)
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1001@y.y.y.y:5060) State Change CS_ROUTING -> CS_EXECUTE
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1001@y.y.y.y:5060) State ROUTING going to sleep
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1001@y.y.y.y:5060) Running State Change CS_EXECUTE
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@y.y.y.y:5060) State EXECUTE
2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:196 sofia/internal/1001@y.y.y.y:5060 SOFIA EXECUTE
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1001@y.y.y.y:5060 Standard EXECUTE
EXECUTE sofia/internal/1001@y.y.y.y:5060 bridge({rtp_allow_crypto_in_avp=false,rtp_secure_media=false,sip_secure_mediai_outbound=false}[rtp_allow_crypto_in_avp=false,sip_secure_media_outbound=false,sdp_secure_savp_only=false]sofia/external/754617162742492@x.x.x.x)
2015-08-22 10:11:43.049286 [DEBUG] switch_ivr_originate.c:2104 Parsing global variables
2015-08-22 10:11:43.049286 [DEBUG] switch_ivr_originate.c:2557 Parsing session specific variables
2015-08-22 10:11:43.049286 [NOTICE] switch_channel.c:1089 New Channel sofia/external/754617162742492@x.x.x.x [2ff7c01e-48b6-11e5-ac58-01226f03e80c]
2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:4735 (sofia/external/754617162742492@x.x.x.x) State Change CS_NEW -> CS_INIT
2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:4805 [zrtp_passthru] Setting a-leg inherit_codec=true
2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:4808 [zrtp_passthru] Setting b-leg absolute_codec_string='mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMU@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:473 (sofia/external/754617162742492@x.x.x.x) Running State Change CS_INIT
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:516 (sofia/external/754617162742492@x.x.x.x) State INIT
2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:88 sofia/external/754617162742492@x.x.x.x SOFIA INIT
2015-08-22 10:11:43.049286 [DEBUG] sofia_glue.c:1257 sofia/external/754617162742492@x.x.x.x sending invite version: 1.7.0 git 58f1272 2015-08-14 17:51:12Z 64bit
Local SDP:
v=0
o=- 327457341635358182 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:IQcKT9rkNCETwhGR
a=ice-pwd:chtzwjBRY3ptPbf/IkcKUO1i
a=fingerprint:sha-1 8A:95:DD:4E:18:85:C6:B9:31:1E:04:90:BC:67:EB:C6:DD:58:4F:B5
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:2501014728 cname:dJGa9dJwxrkwhQkE
a=ssrc:2501014728 msid:media_stream audio_track
a=ssrc:2501014728 mslabel:media_stream
a=ssrc:2501014728 label:audio_track
a=candidate:3027063986 1 udp 2122260223 192.168.1.129 55289 typ host generation 0
a=candidate:19046677 1 udp 2122194687 172.20.10.1 62766 typ host generation 0
a=candidate:3059882106 1 udp 2122129151 10.227.60.222 56279 typ host generation 0
a=candidate:3027063986 2 udp 2122260222 192.168.1.129 51792 typ host generation 0
a=candidate:19046677 2 udp 2122194686 172.20.10.1 61231 typ host generation 0
a=candidate:3059882106 2 udp 2122129150 10.227.60.222 56500 typ host generation 0
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:40 sofia/external/754617162742492@x.x.x.x Standard INIT
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:48 (sofia/external/754617162742492@x.x.x.x) State Change CS_INIT -> CS_ROUTING
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:516 (sofia/external/754617162742492@x.x.x.x) State INIT going to sleep
2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:473 (sofia/external/754617162742492@x.x.x.x) Running State Change CS_ROUTING
2015-08-22 10:11:43.069228 [DEBUG] switch_core_state_machine.c:532 (sofia/external/754617162742492@x.x.x.x) State ROUTING
2015-08-22 10:11:43.069228 [DEBUG] mod_sofia.c:141 sofia/external/754617162742492@x.x.x.x SOFIA ROUTING
2015-08-22 10:11:43.069228 [DEBUG] switch_ivr_originate.c:67 (sofia/external/754617162742492@x.x.x.x) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2015-08-22 10:11:43.069228 [DEBUG] switch_core_state_machine.c:532 (sofia/external/754617162742492@x.x.x.x) State ROUTING going to sleep
2015-08-22 10:11:43.069228 [DEBUG] switch_core_state_machine.c:473 (sofia/external/754617162742492@x.x.x.x) Running State Change CS_CONSUME_MEDIA
2015-08-22 10:11:43.069228 [DEBUG] switch_core_state_machine.c:551 (sofia/external/754617162742492@x.x.x.x) State CONSUME_MEDIA
2015-08-22 10:11:43.069228 [DEBUG] switch_core_state_machine.c:551 (sofia/external/754617162742492@x.x.x.x) State CONSUME_MEDIA going to sleep
send 2347 bytes to udp/[x.x.x.x]:5060 at 10:11:43.070474:
------------------------------------------------------------------------
INVITE sip:754617162742492@x.x.x.x SIP/2.0
Via: SIP/2.0/UDP y.y.y.y:5080;rport;branch=z9hG4bK5Q40Q4Ze2mj0K
Max-Forwards: 69
From: "Extension 1001" <sip:1001@y.y.y.y>;tag=51SKgXr23XK9K
To: <sip:754617162742492@x.x.x.x>
Call-ID: 075638a9-c359-1233-81a7-60eb698211be
CSeq: 79783087 INVITE
Contact: <sip:mod_sofia@y.y.y.y:5080>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 1518
X-FS-Support: update_display,send_info
Remote-Party-ID: "Extension 1001" <sip:1001@y.y.y.y>;party=calling;screen=yes;privacy=off
v=0
o=- 327457341635358182 2 IN IP4 y.y.y.y
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:IQcKT9rkNCETwhGR
a=ice-pwd:chtzwjBRY3ptPbf/IkcKUO1i
a=fingerprint:sha-1 8A:95:DD:4E:18:85:C6:B9:31:1E:04:90:BC:67:EB:C6:DD:58:4F:B5
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:2501014728 cname:dJGa9dJwxrkwhQkE
a=ssrc:2501014728 msid:media_stream audio_track
a=ssrc:2501014728 mslabel:media_stream
a=ssrc:2501014728 label:audio_track
a=candidate:3027063986 1 udp 2122260223 192.168.1.129 55289 typ host generation 0
a=candidate:19046677 1 udp 2122194687 172.20.10.1 62766 typ host generation 0
a=candidate:3059882106 1 udp 2122129151 10.227.60.222 56279 typ host generation 0
a=candidate:3027063986 2 udp 2122260222 192.168.1.129 51792 typ host generation 0
a=candidate:19046677 2 udp 2122194686 172.20.10.1 61231 typ host generation 0
a=candidate:3059882106 2 udp 2122129150 10.227.60.222 56500 typ host generation 0
On Fri, Aug 21, 2015 at 11:06 AM, Anthony Minessale <anthony.minessale@gmail.com> wrote:
Its not the same tey harder.
On Friday, August 21, 2015, Pete Kay <petedao@gmail.com> wrote:Hi
Without proxy media variable it is still the same. My earlier email in this thread had this problem without media proxy set to true.
On Thu, Aug 20, 2015 at 9:55 PM, Giovanni Maruzzelli <gmaruzz@gmail.com> wrote:
Try without mentioning proxy_media at all, no false, no true, just delete it from both occurrences.
sent from my mobile,
Giovanni Maruzzelli
cell: +39 347 266 56 18On Aug 21, 2015 6:43 AM, "Pete Kay" <petedao@gmail.com> wrote:
Hi
I tried to use proxy_media = true but it is still passing RTP/SAVPF instead of RTP/AVPF. Could I ask where is the problem in my configuration?
Dialplan: sofia/internal/1001@y.y.y.y:5060 Action bridge({rtp_allow_crypto_in_avp=false,rtp_secure_media=false,sip_secure_mediai_outbound=false,sdp_secure_savp_only=false,proxy_media=true}[rtp_allow_crypto_in_avp=false,sip_secure_media_outbound=false,sdp_secure_savp_only=false,proxy_media=true]sofia/external/754617162742492@x.x.x.x)
send 2700 bytes to udp/[69.27.168.50]:5060 at 04:01:47.286175:
------------------------------------------------------------------------
INVITE sip:754617162742492@69.27.168.50 SIP/2.0
Via: SIP/2.0/UDP y.y.y.y:5080;rport;branch=z9hG4bKgBt1e63aHX4SD
Max-Forwards: 69
From: "Extension 1001" <sip:1001@y.y.y.y>;tag=grg241BNtgDtN
To: <sip:754617162742492@x.x.x.x>
Call-ID: 2f34abd4-c25c-1233-ffbc-60eb698211be
CSeq: 79728789 INVITE
Contact: <sip:mod_sofia@y.y.y.y:5080>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 1871
X-FS-Support: update_display,send_info
Remote-Party-ID: "Extension 1001" <sip:1001@y.y.y.y>;party=calling;screen=yes;privacy=off
v=0
o=FreeSWITCH 3361339272 3361339273 IN IP4 y.y.y.y
s=FreeSWITCH
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 28246 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 108.165.2.110
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:bmbIvHb6NVeLQBcK
a=ice-pwd:KDvxAfWB8jTfbGrL610/0jtk
a=fingerprint:sha-1 F1:CA:8E:C9:58:A5:00:CB:59:A5:19:90:0A:D0:60:76:33:70:C2:F1
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3858004023 cname:S5akTfRDQvG5IccJ
a=ssrc:3858004023 msid:media_stream audio_track
a=ssrc:3858004023 mslabel:media_stream
a=ssrc:3858004023 label:audio_track
a=candidate:2881221497 1 udp 2122260223 10.227.131.21 55121 typ host generation 0
a=candidate:2881221497 2 udp 2122260222 10.227.131.21 64682 typ host generation 0
a=candidate:3845656457 1 tcp 1518280447 10.227.131.21 57029 typ host tcptype passive generation 0
a=candidate:3845656457 2 tcp 1518280446 10.227.131.21 57030 typ host tcptype passive generation 0
a=candidate:720631245 1 udp 1686052607 112.97.38.2 6734 typ srflx raddr 10.227.131.21 rport 55121 generation 0
a=candidate:720631245 2 udp 1686052606 112.97.38.2 6735 typ srflx raddr 10.227.131.21 rport 64682 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 52800 typ relay raddr 112.97.38.2 rport 34387 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 54764 typ relay raddr 112.97.38.2 rport 34386 generation 0
------------------------------------------------------------------------
On Mon, Aug 17, 2015 at 9:28 AM, Brian West <brian@freeswitch.org> wrote:
rtp_secure_media=false is the variable name.
On Mon, Aug 17, 2015 at 11:06 AM, Pete Kay <petedao@gmail.com> wrote:
Hi
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.
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.
2015-08-17 15:29:46.341244 [INFO] mod_dialplan_xml.c:637 Processing 1001 <1001>->1002 in context default
Dialplan: sofia/internal/1001@y.y.y.y:5060 parsing [default->incoming_calls] continue=false
Dialplan: sofia/internal/1001@y.y.y.y:5060 Regex (PASS) [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
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)
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 -> CS_EXECUTE
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
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
2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1001@y.y.y.y:5060) State EXECUTE
2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:196 sofia/internal/1001@y.y.y.y:5060 SOFIA EXECUTE
2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1001@y.y.y.y:5060 Standard EXECUTE
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)
2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:2104 Parsing global variables
2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:2557 Parsing session specific variables
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]
2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4735 (sofia/internal/754617162742492@x.x.x.x) State Change CS_NEW -> CS_INIT
2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4805 [zrtp_passthru] Setting a-leg inherit_codec=true
2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4808 [zrtp_passthru] Setting b-leg absolute_codec_string='mod_spandsp.G722@8000h@20i@64000b,CORE_PCM_MODULE.PCMU@8000h@20i@64000b,CORE_PCM_MODULE.PCMA@8000h@20i@64000b'
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
2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/754617162742492@x.x.x.x) State INIT
2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:88 sofia/internal/754617162742492@x.x.x.x SOFIA INIT
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
Local SDP:
v=0
o=- 4133111956976529630 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:Gn8CX52vaidE1C73
a=ice-pwd:16VDNSZodn+NJp8u3O1mQrMy
a=fingerprint:sha-1 19:57:5D:7A:BD:7B:42:3B:C9:1B:2F:A6:D2:4F:32:FD:C3:23:14:D9
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3618235845 cname:3hHDnnOtFofiuRz2
a=ssrc:3618235845 msid:media_stream audio_track
a=ssrc:3618235845 mslabel:media_stream
a=ssrc:3618235845 label:audio_track
a=candidate:186199869 1 udp 2122260223 192.168.1.101 60710 typ host generation 0
a=candidate:4049598204 1 udp 2122194687 10.73.229.110 52079 typ host generation 0
a=candidate:186199869 2 udp 2122260222 192.168.1.101 64150 typ host generation 0
a=candidate:4049598204 2 udp 2122194686 10.73.229.110 51909 typ host generation 0
a=candidate:1167774669 1 tcp 1518280447 192.168.1.101 55638 typ host tcptype passive generation 0
a=candidate:3218868748 1 tcp 1518214911 10.73.229.110 55639 typ host tcptype passive generation 0
a=candidate:1167774669 2 tcp 1518280446 192.168.1.101 55640 typ host tcptype passive generation 0
a=candidate:3218868748 2 tcp 1518214910 10.73.229.110 55641 typ host tcptype passive generation 0
a=candidate:2320574857 1 udp 1686052607 27.38.56.3 36782 typ srflx raddr 192.168.1.101 rport 60710 generation 0
a=candidate:2320574857 2 udp 1686052606 27.38.56.3 37553 typ srflx raddr 192.168.1.101 rport 64150 generation 0
a=candidate:1880617032 1 udp 1685987071 112.97.38.179 2308 typ srflx raddr 10.73.229.110 rport 52079 generation 0
a=candidate:1880617032 2 udp 1685987070 112.97.38.179 2307 typ srflx raddr 10.73.229.110 rport 51909 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 55532 typ relay raddr 27.38.56.3 rport 36782 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 54104 typ relay raddr 27.38.56.3 rport 37553 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 63311 typ relay raddr 112.97.38.179 rport 54091 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 49576 typ relay raddr 112.97.38.179 rport 54092 generation 0
2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:40 sofia/internal/754617162742492@x.x.x.x Standard INIT
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 -> CS_ROUTING
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
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
2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/754617162742492@x.x.x.x) State ROUTING
2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:141 sofia/internal/754617162742492@x.x.x.x SOFIA ROUTING
2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/754617162742492@x.x.x.x) State Change CS_ROUTING -> CS_CONSUME_MEDIA
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
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
2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/754617162742492@x.x.x.x) State CONSUME_MEDIA
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
send 3635 bytes to udp/[69.27.168.50]:5060 at 15:29:46.355875:
------------------------------------------------------------------------
INVITE sip:754617162742492@x.x.x.x SIP/2.0
Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e
Max-Forwards: 69
From: "Extension 1001" <sip:1001@y.y.y.y>;tag=H6HrjU4ZH1KjD
To: <sip:754617162742492@x.x.x.x>
Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be
CSeq: 79576629 INVITE
Contact: <sip:mod_sofia@y.y.y.y:5060>
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 2665
X-FS-Support: update_display,send_info
Remote-Party-ID: "Extension 1001" <sip:1001@y.y.y.y>;party=calling;screen=yes;privacy=off
v=0
o=- 4133111956976529630 2 IN IP4 y.y.y.y
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS media_stream
m=audio 9 RTP/SAVPF 111 103 9 102 0 8 106 105 13 127 126
c=IN IP4 0.0.0.0
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10; useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:9 G722/8000
a=rtpmap:102 ILBC/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:127 red/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:Gn8CX52vaidE1C73
a=ice-pwd:16VDNSZodn+NJp8u3O1mQrMy
a=fingerprint:sha-1 19:57:5D:7A:BD:7B:42:3B:C9:1B:2F:A6:D2:4F:32:FD:C3:23:14:D9
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=maxptime:60
a=ssrc:3618235845 cname:3hHDnnOtFofiuRz2
a=ssrc:3618235845 msid:media_stream audio_track
a=ssrc:3618235845 mslabel:media_stream
a=ssrc:3618235845 label:audio_track
a=candidate:186199869 1 udp 2122260223 192.168.1.101 60710 typ host generation 0
a=candidate:4049598204 1 udp 2122194687 10.73.229.110 52079 typ host generation 0
a=candidate:186199869 2 udp 2122260222 192.168.1.101 64150 typ host generation 0
a=candidate:4049598204 2 udp 2122194686 10.73.229.110 51909 typ host generation 0
a=candidate:1167774669 1 tcp 1518280447 192.168.1.101 55638 typ host tcptype passive generation 0
a=candidate:3218868748 1 tcp 1518214911 10.73.229.110 55639 typ host tcptype passive generation 0
a=candidate:1167774669 2 tcp 1518280446 192.168.1.101 55640 typ host tcptype passive generation 0
a=candidate:3218868748 2 tcp 1518214910 10.73.229.110 55641 typ host tcptype passive generation 0
a=candidate:2320574857 1 udp 1686052607 27.38.56.3 36782 typ srflx raddr 192.168.1.101 rport 60710 generation 0
a=candidate:2320574857 2 udp 1686052606 27.38.56.3 37553 typ srflx raddr 192.168.1.101 rport 64150 generation 0
a=candidate:1880617032 1 udp 1685987071 112.97.38.179 2308 typ srflx raddr 10.73.229.110 rport 52079 generation 0
a=candidate:1880617032 2 udp 1685987070 112.97.38.179 2307 typ srflx raddr 10.73.229.110 rport 51909 generation 0
a=candidate:2922827951 1 udp 41885439 146.185.149.11 55532 typ relay raddr 27.38.56.3 rport 36782 generation 0
a=candidate:2922827951 2 udp 41885438 146.185.149.11 54104 typ relay raddr 27.38.56.3 rport 37553 generation 0
a=candidate:2922827951 2 udp 41819902 146.185.149.11 63311 typ relay raddr 112.97.38.179 rport 54091 generation 0
a=candidate:2922827951 1 udp 41819903 146.185.149.11 49576 typ relay raddr 112.97.38.179 rport 54092 generation 0
------------------------------------------------------------------------
2015-08-17 15:29:46.341244 [DEBUG] sofia.c:6715 Channel sofia/internal/754617162742492@x.x.x.x entering state [calling][0]
recv 308 bytes from udp/[x.x.x.x]:5060 at 15:29:46.357317:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e
From: "Extension 1001" <sip:1001@y.y.y.y>;tag=H6HrjU4ZH1KjD
To: <sip:754617162742492@x.x.x.x>
Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be
CSeq: 79576629 INVITE
User-Agent: DNL-Switch
Content-Length: 0
------------------------------------------------------------------------
recv 433 bytes from udp/[x.x.x.x]:5060 at 15:29:46.367995:
------------------------------------------------------------------------
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e
From: "Extension 1001" <sip:1001@y.y.y.y>;tag=H6HrjU4ZH1KjD
To: <sip:754617162742492@x.x.x.x>;tag=Ut8ye62NUrQeB
Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be
CSeq: 79576629 INVITE
User-Agent: DNL-Switch
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO
Supported: timer
Content-Length: 0
------------------------------------------------------------------------
send 343 bytes to udp/[x.x.x.x]:5060 at 15:29:46.368134:
------------------------------------------------------------------------
ACK sip:754617162742492@x.x.x.x SIP/2.0
Via: SIP/2.0/UDP y.y.y.y;rport;branch=z9hG4bKcSe6jHj8QS56e
Max-Forwards: 69
From: "Extension 1001" <sip:1001@y.y.y.y>;tag=H6HrjU4ZH1KjD
To: <sip:754617162742492@x.x.x.x>;tag=Ut8ye62NUrQeB
Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be
CSeq: 79576629 ACK
Content-Length: 0
------------------------------------------------------------------------
2015-08-17 15:29:46.361276 [DEBUG] sofia.c:6715 Channel sofia/internal/754617162742492@x.x.x.x entering state [terminated][415]
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]
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
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/754617162742492@x.x.x.x) Callstate Change DOWN -> HANGUP
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/754617162742492@x.x.x.x) State HANGUP
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
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
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
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 -> CS_REPORTING
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
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/754617162742492@x.x.x.x) State REPORTING
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
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
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 -> CS_DESTROY
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
2015-08-17 15:29:46.361276 [DEBUG] switch_ivr_originate.c:3727 Originate Resulted in Error Cause: 79 [SERVICE_NOT_IMPLEMENTED]
2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1657 Session 2 (sofia/internal/754617162742492@x.x.x.x) Ended
2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1661 Close Channel sofia/internal/754617162742492@x.x.x.x [CS_DESTROY]
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
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/754617162742492@x.x.x.x) State DESTROY
2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:341 sofia/internal/754617162742492@x.x.x.x SOFIA DESTROY
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:111 sofia/internal/754617162742492@x.x.x.x Standard DESTROY
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
2015-08-17 15:29:46.361276 [INFO] mod_dptools.c:3333 Originate Failed. Cause: SERVICE_NOT_IMPLEMENTED
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]
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)
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
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
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 -> HANGUP
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@y.y.y.y:5060) State HANGUP
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
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
2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:568 Responding to INVITE with: 415
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
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
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 -> CS_REPORTING
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
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1001@y.y.y.y:5060) State REPORTING
send 900 bytes to tcp/[27.38.56.3]:36982 at 15:29:46.376821:
------------------------------------------------------------------------
SIP/2.0 415 Unsupported Media Type
Via: SIP/2.0/TCP 192.168.1.101:5060;branch=z9hG4bK-524287-1---96ba2f7825316328;rport=36982;received=27.38.56.3
Max-Forwards: 70
From: <sip:1001@y.y.y.y:5060>;tag=9de53b6c
To: <sip:1002@y.y.y.y:5060>;tag=gXrZg0KvmrXZH
Call-ID: kVdW6FArCGqcEPe7zR3x4g..
CSeq: 2 INVITE
User-Agent: FreeSWITCH-mod_sofia/1.7.0+git~20150814T175112Z~58f1272490~64bit
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Reason: Q.850;cause=79;text="SERVICE_NOT_IMPLEMENTED"
Content-Length: 0
Remote-Party-ID: "1002" <sip:1002@y.y.y.y>;party=calling;privacy=off;screen=no
------------------------------------------------------------------------
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
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
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 -> CS_DESTROY
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
2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1657 Session 1 (sofia/internal/1001@y.y.y.y:5060) Ended
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]
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
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1001@y.y.y.y:5060) State DESTROY
2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:341 sofia/internal/1001@y.y.y.y:5060 SOFIA DESTROY
2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1001@y.y.y.y:5060 Standard DESTROY
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
recv 317 bytes from tcp/[27.38.56.3]:36982 at 15:29:46.651249:
------------------------------------------------------------------------
ACK sip:1002@y.y.y.y:5060 SIP/2.0
Via: SIP/2.0/TCP 192.168.1.101:5060;branch=z9hG4bK-524287-1---96ba2f7825316328;rport
Max-Forwards: 70
To: <sip:1002@y.y.y.y:5060>;tag=gXrZg0KvmrXZH
From: <sip:1001@y.y.y.y:5060>;tag=9de53b6c
Call-ID: kVdW6FArCGqcEPe7zR3x4g..
CSeq: 2 ACK
Content-Length: 0
------------------------------------------------------------------------
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
--
Brian West
brian@freeswitch.org
Twitter: @FreeSWITCH , @briankwest
http://www.freeswitchbook.com
http://www.freeswitchcookbook.comGot Bugs? Report them here! | Reddit: /r/freeswitch
T:+19184209001 | F:+19184209002 | M:+1918424WEST (9378)
iNUM:+883 5100 1420 9001 | ISN:410*543 | Skype:briankwest
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
--
Anthony Minessale II ♬ @anthmfs ♬ @FreeSWITCH ♬
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
--Anthony Minessale II ♬ @anthmfs ♬ @FreeSWITCH ♬
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org--Anthony Minessale II ♬ @anthmfs ♬ @FreeSWITCH ♬ClueCon Weekly Development Call
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
_________________________________________________________________________
Professional FreeSWITCH Consulting Services:
consulting@freeswitch.org
http://www.freeswitchsolutions.com
Official FreeSWITCH Sites
http://www.freeswitch.org
http://confluence.freeswitch.org
http://www.cluecon.com
FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
http://www.freeswitch.org
