[Freeswitch-users] Need help to convert RTP/SAVP to RTP/AVP

Pete Kay petedao at gmail.com
Sun Aug 23 22:08:39 MSD 2015


Hi Michael

Thank you for your comment.  My outbound gateway is a public IP voip
gateway.  It does not have any nat in it.   Could you help to take a look
at the log attached?

------------------------------------------------------------------------

recv 3546 bytes from tcp/[163.125.130.79]:26869 at 16:38:06.597828:

   ------------------------------------------------------------------------

   INVITE sip:1002 at 108.165.22.32: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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
1001 at 108.165.22.32:5060"

   To: <sip:1002 at 108.165.22.32:5060>

   From: <sip:1001 at 108.165.22.32: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="108.165.22.32",nonce="54896b80-49b5-11e5-ba06-3bd1ff35cbfe",uri="
sip:1002 at 108.165.22.32: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 at 108.165.22.32:5060>;tag=e090b871

   To: <sip:1002 at 108.165.22.32: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 at 108.165.22.32: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 at 108.165.22.32: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 at 108.165.22.32:5060) State Change CS_NEW -> CS_INIT

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/1001 at 108.165.22.32:5060) Running State Change CS_INIT

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:516
(sofia/internal/1001 at 108.165.22.32:5060) State INIT

2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:88 sofia/internal/
1001 at 108.165.22.32:5060 SOFIA INIT

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:40
sofia/internal/1001 at 108.165.22.32:5060 Standard INIT

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:48
(sofia/internal/1001 at 108.165.22.32:5060) State Change CS_INIT -> CS_ROUTING

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:516
(sofia/internal/1001 at 108.165.22.32:5060) State INIT going to sleep

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/1001 at 108.165.22.32:5060) Running State Change CS_ROUTING

2015-08-23 16:38:06.590319 [DEBUG] switch_channel.c:2239 (sofia/internal/
1001 at 108.165.22.32:5060) Callstate Change DOWN -> RINGING

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:532
(sofia/internal/1001 at 108.165.22.32:5060) State ROUTING

2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:141 sofia/internal/
1001 at 108.165.22.32:5060 SOFIA ROUTING

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:166
sofia/internal/1001 at 108.165.22.32: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 at 108.165.22.32:5060 parsing
[default->incoming_calls] continue=false

Dialplan: sofia/internal/1001 at 108.165.22.32:5060 Regex (PASS)
[incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false

Dialplan: sofia/internal/1001 at 108.165.22.32: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/75468613802573728 at 69.22.33.40)

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:216
(sofia/internal/1001 at 108.165.22.32:5060) State Change CS_ROUTING ->
CS_EXECUTE

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:532
(sofia/internal/1001 at 108.165.22.32:5060) State ROUTING going to sleep

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/1001 at 108.165.22.32:5060) Running State Change CS_EXECUTE

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:539
(sofia/internal/1001 at 108.165.22.32:5060) State EXECUTE

2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:196 sofia/internal/
1001 at 108.165.22.32:5060 SOFIA EXECUTE

2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:258
sofia/internal/1001 at 108.165.22.32:5060 Standard EXECUTE

EXECUTE sofia/internal/1001 at 108.165.22.32: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/75468613802573728 at 69.22.33.40)

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/75468613802573728 at 69.22.33.40
[54d94e84-49b5-11e5-ba0c-3bd1ff35cbfe]

2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:4735 (sofia/internal/
75468613802573728 at 69.22.33.40) 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 at 8000h@20i at 64000b
,CORE_PCM_MODULE.PCMU at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMA at 8000h@20i at 64000b
'

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/75468613802573728 at 69.22.33.40) Running State Change CS_INIT

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:516
(sofia/internal/75468613802573728 at 69.22.33.40) State INIT

2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:88 sofia/internal/
75468613802573728 at 69.22.33.40 SOFIA INIT

2015-08-23 16:38:06.610302 [DEBUG] sofia_glue.c:1257 sofia/internal/
75468613802573728 at 69.22.33.40 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 108.165.22.32

s=FreeSWITCH

c=IN IP4 108.165.22.32

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/75468613802573728 at 69.22.33.40 Standard INIT

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:48
(sofia/internal/75468613802573728 at 69.22.33.40) State Change CS_INIT ->
CS_ROUTING

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:516
(sofia/internal/75468613802573728 at 69.22.33.40) State INIT going to sleep

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/75468613802573728 at 69.22.33.40) Running State Change
CS_ROUTING

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:532
(sofia/internal/75468613802573728 at 69.22.33.40) State ROUTING

2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:141 sofia/internal/
75468613802573728 at 69.22.33.40 SOFIA ROUTING

2015-08-23 16:38:06.610302 [DEBUG] switch_ivr_originate.c:67
(sofia/internal/75468613802573728 at 69.22.33.40) State Change CS_ROUTING ->
CS_CONSUME_MEDIA

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:532
(sofia/internal/75468613802573728 at 69.22.33.40) State ROUTING going to sleep

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/75468613802573728 at 69.22.33.40) Running State Change
CS_CONSUME_MEDIA

send 1281 bytes to udp/[69.22.33.40]:5060 at 16:38:06.611312:

   ------------------------------------------------------------------------

   INVITE sip:75468613802573728 at 69.22.33.40 SIP/2.0

   Via: SIP/2.0/UDP 108.165.22.32;rport;branch=z9hG4bKevaDa1tKZ99Uc

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:551
(sofia/internal/75468613802573728 at 69.22.33.40) State CONSUME_MEDIA

   Max-Forwards: 69

   From: "Extension 1001" <sip:17185345433 at 108.165.22.32>;tag=j0D5DB23gpjve

   To: <sip:75468613802573728 at 69.22.33.40>

2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:551
(sofia/internal/75468613802573728 at 69.22.33.40) State CONSUME_MEDIA going to
sleep

   Call-ID: 2c37ae78-c458-1233-8384-60eb698211be

   CSeq: 79837879 INVITE

   Contact: <sip:mod_sofia at 108.165.22.32: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 at 108.165.22.32
>;party=calling;screen=yes;privacy=off



   v=0

   o=FreeSWITCH 1440321260 1440321261 IN IP4 108.165.22.32

   s=FreeSWITCH

   c=IN IP4 108.165.22.32

   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/
75468613802573728 at 69.22.33.40 entering state [calling][0]

recv 317 bytes from udp/[69.22.33.40]:5060 at 16:38:06.612398:

   ------------------------------------------------------------------------

   SIP/2.0 100 Trying

   Via: SIP/2.0/UDP 108.165.22.32;rport;branch=z9hG4bKevaDa1tKZ99Uc

   From: "Extension 1001" <sip:17185345433 at 108.165.22.32>;tag=j0D5DB23gpjve

   To: <sip:75468613802573728 at 69.22.33.40>

   Call-ID: 2c37ae78-c458-1233-8384-60eb698211be

   CSeq: 79837879 INVITE

   User-Agent: DNL-Switch

   Content-Length: 0



   ------------------------------------------------------------------------

recv 674 bytes from udp/[69.22.33.40]:5060 at 16:38:07.210825:

   ------------------------------------------------------------------------

   SIP/2.0 183 Session Progress

   Via: SIP/2.0/UDP 108.165.22.32;rport;branch=z9hG4bKevaDa1tKZ99Uc

   From: "Extension 1001" <sip:17185345433 at 108.165.22.32>;tag=j0D5DB23gpjve

   To: <sip:75468613802573728 at 69.22.33.40>;tag=1Xmp97vgtp22K

   Call-ID: 2c37ae78-c458-1233-8384-60eb698211be

   CSeq: 79837879 INVITE

   Contact: <sip:75468613802573728 at 69.22.33.40: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/
75468613802573728 at 69.22.33.40 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/75468613802573728 at 69.22.33.40 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/
75468613802573728 at 69.22.33.40 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/75468613802573728 at 69.22.33.40] 108.165.22.32 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/
75468613802573728 at 69.22.33.40 Set rtp dtmf delay to 40

2015-08-23 16:38:07.210310 [NOTICE] sofia_media.c:92 Pre-Answer
sofia/internal/75468613802573728 at 69.22.33.40!

2015-08-23 16:38:07.210310 [DEBUG] switch_channel.c:3460 (sofia/internal/
75468613802573728 at 69.22.33.40) Callstate Change DOWN -> EARLY

2015-08-23 16:38:07.230314 [DEBUG] switch_ivr_originate.c:413 Setting codec
string on sofia/internal/1001 at 108.165.22.32:5060 to PCMA at 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 at 8000

2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:2871 Set Codec
sofia/internal/1001 at 108.165.22.32: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 at 108.165.22.32: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 at 108.165.22.32: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 at 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 at 108.165.22.32:5060] 108.165.22.32 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 at 108.165.22.32: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 at 108.165.22.32:5060!

2015-08-23 16:38:07.230314 [DEBUG] switch_channel.c:3460 (sofia/internal/
1001 at 108.165.22.32: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 108.165.22.32

s=FreeSWITCH

c=IN IP4 108.165.22.32

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 108.165.22.32

a=ice-ufrag:lxhtm2fsdIETo71R

a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW

a=candidate:4917377022 1 udp 659136 108.165.22.32 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/75468613802573728 at 69.22.33.40]

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 at 108.165.22.32:5060>;tag=e090b871

   To: <sip:1002 at 108.165.22.32:5060>;tag=HQmccgH0KDv9j

   Call-ID: YEXqB4WY4KZUOfmDabppqg..

   CSeq: 2 INVITE

   Contact: <sip:1002 at 108.165.22.32: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:75468613802573728 at 108.165.22.32
>;party=calling;privacy=off;screen=no



   v=0

   o=FreeSWITCH 1440326053 1440326054 IN IP4 108.165.22.32

   s=FreeSWITCH

   c=IN IP4 108.165.22.32

   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 108.165.22.32

   a=ice-ufrag:lxhtm2fsdIETo71R

   a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW

   a=candidate:4917377022 1 udp 659136 108.165.22.32 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 at 108.165.22.32:5060 entering state [early][183]

2015-08-23 16:38:07.230314 [DEBUG] switch_ivr_bridge.c:1584 (sofia/internal/
75468613802573728 at 69.22.33.40) State Change CS_CONSUME_MEDIA ->
CS_EXCHANGE_MEDIA

2015-08-23 16:38:07.230314 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/75468613802573728 at 69.22.33.40) Running State Change
CS_EXCHANGE_MEDIA

2015-08-23 16:38:07.230314 [DEBUG] switch_core_state_machine.c:542
(sofia/internal/75468613802573728 at 69.22.33.40) 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/[69.22.33.40]:5060 at 16:38:16.729400:

   ------------------------------------------------------------------------

   SIP/2.0 200 OK

   Via: SIP/2.0/UDP 108.165.22.32;rport;branch=z9hG4bKevaDa1tKZ99Uc

   From: "Extension 1001" <sip:17185345433 at 108.165.22.32>;tag=j0D5DB23gpjve

   To: <sip:75468613802573728 at 69.22.33.40>;tag=1Xmp97vgtp22K

   Call-ID: 2c37ae78-c458-1233-8384-60eb698211be

   CSeq: 79837879 INVITE

   Contact: <sip:75468613802573728 at 69.22.33.40: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/
75468613802573728 at 69.22.33.40 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/[69.22.33.40]:5060 at 16:38:16.733500:

   ------------------------------------------------------------------------

   ACK sip:75468613802573728 at 69.22.33.40:5060;transport=udp SIP/2.0

   Via: SIP/2.0/UDP 108.165.22.32;rport;branch=z9hG4bKF535BvBQvj0er

   Max-Forwards: 70

   From: "Extension 1001" <sip:17185345433 at 108.165.22.32>;tag=j0D5DB23gpjve

   To: <sip:75468613802573728 at 69.22.33.40>;tag=1Xmp97vgtp22K

   Call-ID: 2c37ae78-c458-1233-8384-60eb698211be

   CSeq: 79837879 ACK

   Contact: <sip:mod_sofia at 108.165.22.32:5060>

   Content-Length: 0



   ------------------------------------------------------------------------

2015-08-23 16:38:16.750300 [DEBUG] sofia.c:6715 Channel sofia/internal/
75468613802573728 at 69.22.33.40 entering state [ready][200]

2015-08-23 16:38:16.750300 [NOTICE] sofia.c:7517 Channel [sofia/internal/
75468613802573728 at 69.22.33.40] has been answered

2015-08-23 16:38:16.750300 [DEBUG] switch_channel.c:3759 (sofia/internal/
75468613802573728 at 69.22.33.40) Callstate Change EARLY -> ACTIVE

2015-08-23 16:38:16.750300 [DEBUG] mod_sofia.c:799 Local SDP sofia/internal/
1001 at 108.165.22.32:5060:

v=0

o=FreeSWITCH 1440326053 1440326055 IN IP4 108.165.22.32

s=FreeSWITCH

c=IN IP4 108.165.22.32

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 108.165.22.32

a=ice-ufrag:lxhtm2fsdIETo71R

a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW

a=candidate:9014549722 1 udp 659136 108.165.22.32 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 at 108.165.22.32:5060>;tag=e090b871

   To: <sip:1002 at 108.165.22.32:5060>;tag=HQmccgH0KDv9j

   Call-ID: YEXqB4WY4KZUOfmDabppqg..

   CSeq: 2 INVITE

   Contact: <sip:1002 at 108.165.22.32: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:75468613802573728 at 108.165.22.32
>;party=calling;privacy=off;screen=no



   v=0

   o=FreeSWITCH 1440326053 1440326054 IN IP4 108.165.22.32

   s=FreeSWITCH

   c=IN IP4 108.165.22.32

   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 108.165.22.32

   a=ice-ufrag:lxhtm2fsdIETo71R

   a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW

   a=candidate:4917377022 1 udp 659136 108.165.22.32 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 at 108.165.22.32: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 at 108.165.22.32:5060>;tag=e090b871

   To: <sip:1002 at 108.165.22.32:5060>;tag=HQmccgH0KDv9j

   Call-ID: YEXqB4WY4KZUOfmDabppqg..

   CSeq: 2 INVITE

   Contact: <sip:1002 at 108.165.22.32: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:75468613802573728 at 108.165.22.32
>;party=calling;privacy=off;screen=no



   v=0

   o=FreeSWITCH 1440326053 1440326054 IN IP4 108.165.22.32

   s=FreeSWITCH

   c=IN IP4 108.165.22.32

   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 108.165.22.32

   a=ice-ufrag:lxhtm2fsdIETo71R

   a=ice-pwd:pITF92vzI9QFEuRPSZ94SemW

   a=candidate:4917377022 1 udp 659136 108.165.22.32 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 at 108.165.22.32: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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
1001 at 108.165.22.32:5060"

   To: <sip:1002 at 108.165.22.32:5060>;tag=HQmccgH0KDv9j

   From: <sip:1001 at 108.165.22.32: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 at 108.165.22.32: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 at 108.165.22.32: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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
1001 at 108.165.22.32:5060"

   To: <sip:1002 at 108.165.22.32:5060>;tag=HQmccgH0KDv9j

   From: <sip:1001 at 108.165.22.32: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 at 108.165.22.32:5060] has been answered

2015-08-23 16:38:19.510341 [DEBUG] switch_channel.c:3759 (sofia/internal/
1001 at 108.165.22.32:5060) Callstate Change EARLY -> ACTIVE


freeswitch at switch3>

freeswitch at switch3>

freeswitch at switch3>

freeswitch at switch3>

freeswitch at switch3> recv 737 bytes from tcp/[163.125.130.79]:26869 at
16:38:29.607614:

   ------------------------------------------------------------------------

   BYE sip:1002 at 108.165.22.32: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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
1001 at 108.165.22.32:5060"

   To: <sip:1002 at 108.165.22.32:5060>;tag=HQmccgH0KDv9j

   From: <sip:1001 at 108.165.22.32:5060>;tag=e090b871

   Call-ID: YEXqB4WY4KZUOfmDabppqg..

   CSeq: 3 BYE

   Proxy-Authorization: Digest
username="1001",realm="108.165.22.32",nonce="54896b80-49b5-11e5-ba06-3bd1ff35cbfe",uri="sip:1002 at 108.165.22.32: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 at 108.165.22.32: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 at 108.165.22.32:5060>;tag=e090b871

   To: <sip:1002 at 108.165.22.32: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 at 108.165.22.32:5060]

2015-08-23 16:38:29.630370 [DEBUG] switch_ivr_bridge.c:771 BRIDGE THREAD
DONE [sofia/internal/75468613802573728 at 69.22.33.40]

2015-08-23 16:38:29.630370 [NOTICE] switch_ivr_bridge.c:874 Hangup
sofia/internal/75468613802573728 at 69.22.33.40 [CS_EXCHANGE_MEDIA]
[NORMAL_CLEARING]

2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:542
(sofia/internal/75468613802573728 at 69.22.33.40) State EXCHANGE_MEDIA going
to sleep

2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:473
(sofia/internal/75468613802573728 at 69.22.33.40) Running State Change
CS_HANGUP

2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:739
(sofia/internal/75468613802573728 at 69.22.33.40) Callstate Change ACTIVE ->
HANGUP

2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:741
(sofia/internal/75468613802573728 at 69.22.33.40) State HANGUP

2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:425 sofia/internal/
75468613802573728 at 69.22.33.40 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


On Sun, Aug 23, 2015 at 10:23 AM, Michael Jerris <mike at jerris.com> wrote:

> This has nothing at all to do with encryption.... in fact:
>
> Dialplan: sofia/internal/1001 at 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 at y.y.y.y)
>
>
> you don't need ANY of these vars:
> rtp_secure_media=false,sip_secure_mediai_outbound=false
> sip_secure_media_outbound=false,sdp_secure_savp_only=false
>
> and 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 at gmail.com> wrote:
>
> Hi
>
> Thanks 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.
> My scenario is   WebRTC  client ->  Freeswitch -> Voip gateway -> mobile
> phone
>
> WebRTC client can hear audio but mobile phone hear nothing.
>
> Is it because of some decryption not set correct?
>
> Here is my log:
>
>
>    ------------------------------------------------------------------------
>
> recv 3546 bytes from tcp/[163.125.130.79]:26869 at 16:38:06.597828:
>
>    ------------------------------------------------------------------------
>
>    INVITE sip:1002 at 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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
> 1001 at x.x.x.x:5060"
>
>    To: <sip:1002 at x.x.x.x:5060>
>
>    From: <sip:1001 at 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 at 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 at x.x.x.x:5060>;tag=e090b871
>
>    To: <sip:1002 at 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 at 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 at 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 at 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 at 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 at x.x.x.x:5060) State INIT
>
> 2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:88
> sofia/internal/1001 at x.x.x.x:5060 SOFIA INIT
>
> 2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:40
> sofia/internal/1001 at x.x.x.x:5060 Standard INIT
>
> 2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:48 (
> sofia/internal/1001 at 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 at 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 at 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 at 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 at x.x.x.x:5060) State ROUTING
>
> 2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:141
> sofia/internal/1001 at x.x.x.x:5060 SOFIA ROUTING
>
> 2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:166
> sofia/internal/1001 at 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 at x.x.x.x:5060 parsing
> [default->incoming_calls] continue=false
>
> Dialplan: sofia/internal/1001 at x.x.x.x:5060 Regex (PASS) [incoming_calls]
> ${destination_number}(1002) =~ /1002/ break=on-false
>
> Dialplan: sofia/internal/1001 at 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 at y.y.y.y)
>
> 2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:216 (
> sofia/internal/1001 at 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 at 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 at 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 at x.x.x.x:5060) State EXECUTE
>
> 2015-08-23 16:38:06.590319 [DEBUG] mod_sofia.c:196
> sofia/internal/1001 at x.x.x.x:5060 SOFIA EXECUTE
>
> 2015-08-23 16:38:06.590319 [DEBUG] switch_core_state_machine.c:258
> sofia/internal/1001 at x.x.x.x:5060 Standard EXECUTE
>
> EXECUTE sofia/internal/1001 at 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 at 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 at y.y.y.y
> [54d94e84-49b5-11e5-ba0c-3bd1ff35cbfe]
>
> 2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:4735 (
> sofia/internal/754617702573728 at 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 at 8000h@20i at 64000b
> ,CORE_PCM_MODULE.PCMU at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMA at 8000h
> @20i at 64000b'
>
> 2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:473 (
> sofia/internal/754617702573728 at 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 at y.y.y.y) State INIT
>
> 2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:88
> sofia/internal/754617702573728 at y.y.y.y SOFIA INIT
>
> 2015-08-23 16:38:06.610302 [DEBUG] sofia_glue.c:1257
> sofia/internal/754617702573728 at 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 at y.y.y.y Standard INIT
>
> 2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:48 (
> sofia/internal/754617702573728 at 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 at 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 at 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 at y.y.y.y) State ROUTING
>
> 2015-08-23 16:38:06.610302 [DEBUG] mod_sofia.c:141
> sofia/internal/754617702573728 at y.y.y.y SOFIA ROUTING
>
> 2015-08-23 16:38:06.610302 [DEBUG] switch_ivr_originate.c:67 (
> sofia/internal/754617702573728 at 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 at 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 at 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 at 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 at y.y.y.y) State CONSUME_MEDIA
>
>    Max-Forwards: 69
>
>    From: "Extension 1001" <sip:17185345433 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at y.y.y.y>
>
> 2015-08-23 16:38:06.610302 [DEBUG] switch_core_state_machine.c:551 (
> sofia/internal/754617702573728 at y.y.y.y) State CONSUME_MEDIA going to sleep
>
>    Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
>
>    CSeq: 79837879 INVITE
>
>    Contact: <sip:mod_sofia at 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 at 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 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at 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 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at y.y.y.y>;tag=1Xmp97vgtp22K
>
>    Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
>
>    CSeq: 79837879 INVITE
>
>    Contact: <sip:754617702573728 at 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 at 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 at 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 at 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 at 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 at 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 at y.y.y.y!
>
> 2015-08-23 16:38:07.210310 [DEBUG] switch_channel.c:3460 (
> sofia/internal/754617702573728 at 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 at x.x.x.x:5060 to PCMA at 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 at 8000
>
> 2015-08-23 16:38:07.230314 [DEBUG] switch_core_media.c:2871 Set Codec
> sofia/internal/1001 at 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 at 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 at 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 at 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 at 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 at 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 at x.x.x.x:5060!
>
> 2015-08-23 16:38:07.230314 [DEBUG] switch_channel.c:3460 (
> sofia/internal/1001 at 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 at 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 at x.x.x.x:5060>;tag=e090b871
>
>    To: <sip:1002 at x.x.x.x:5060>;tag=HQmccgH0KDv9j
>
>    Call-ID: YEXqB4WY4KZUOfmDabppqg..
>
>    CSeq: 2 INVITE
>
>    Contact: <sip:1002 at 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 at 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 at 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 at 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 at 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 at 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 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at y.y.y.y>;tag=1Xmp97vgtp22K
>
>    Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
>
>    CSeq: 79837879 INVITE
>
>    Contact: <sip:754617702573728 at 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 at 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 at 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 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at y.y.y.y>;tag=1Xmp97vgtp22K
>
>    Call-ID: 2c37ae78-c458-1233-8384-60eb698211be
>
>    CSeq: 79837879 ACK
>
>    Contact: <sip:mod_sofia at x.x.x.x:5060>
>
>    Content-Length: 0
>
>
>    ------------------------------------------------------------------------
>
> 2015-08-23 16:38:16.750300 [DEBUG] sofia.c:6715 Channel
> sofia/internal/754617702573728 at y.y.y.y entering state [ready][200]
>
> 2015-08-23 16:38:16.750300 [NOTICE] sofia.c:7517 Channel [
> sofia/internal/754617702573728 at y.y.y.y] has been answered
>
> 2015-08-23 16:38:16.750300 [DEBUG] switch_channel.c:3759 (
> sofia/internal/754617702573728 at 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 at 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 at x.x.x.x:5060>;tag=e090b871
>
>    To: <sip:1002 at x.x.x.x:5060>;tag=HQmccgH0KDv9j
>
>    Call-ID: YEXqB4WY4KZUOfmDabppqg..
>
>    CSeq: 2 INVITE
>
>    Contact: <sip:1002 at 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 at 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 at 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 at x.x.x.x:5060>;tag=e090b871
>
>    To: <sip:1002 at x.x.x.x:5060>;tag=HQmccgH0KDv9j
>
>    Call-ID: YEXqB4WY4KZUOfmDabppqg..
>
>    CSeq: 2 INVITE
>
>    Contact: <sip:1002 at 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 at 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 at 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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
> 1001 at x.x.x.x:5060"
>
>    To: <sip:1002 at x.x.x.x:5060>;tag=HQmccgH0KDv9j
>
>    From: <sip:1001 at 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 at 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 at 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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
> 1001 at x.x.x.x:5060"
>
>    To: <sip:1002 at x.x.x.x:5060>;tag=HQmccgH0KDv9j
>
>    From: <sip:1001 at 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 at x.x.x.x:5060] has been answered
>
> 2015-08-23 16:38:19.510341 [DEBUG] switch_channel.c:3759 (
> sofia/internal/1001 at x.x.x.x:5060) Callstate Change EARLY -> ACTIVE
>
>
> freeswitch at switch3>
>
> freeswitch at switch3>
>
> freeswitch at switch3>
>
> freeswitch at switch3>
>
> freeswitch at switch3> recv 737 bytes from tcp/[163.125.130.79]:26869 at
> 16:38:29.607614:
>
>    ------------------------------------------------------------------------
>
>    BYE sip:1002 at 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 at 192.168.1.100:5060;transport=tcp>;+sip.instance="
> 1001 at x.x.x.x:5060"
>
>    To: <sip:1002 at x.x.x.x:5060>;tag=HQmccgH0KDv9j
>
>    From: <sip:1001 at 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 at 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 at 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 at x.x.x.x:5060>;tag=e090b871
>
>    To: <sip:1002 at 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 at x.x.x.x:5060]
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_ivr_bridge.c:771 BRIDGE THREAD
> DONE [sofia/internal/754617702573728 at y.y.y.y]
>
> 2015-08-23 16:38:29.630370 [NOTICE] switch_ivr_bridge.c:874 Hangup
> sofia/internal/754617702573728 at 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 at 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 at 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 at 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 at y.y.y.y) State HANGUP
>
> 2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:425
> sofia/internal/754617702573728 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at y.y.y.y
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:60
> sofia/internal/754617702573728 at 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 at 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 at 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 at 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 at 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 at y.y.y.y) State REPORTING
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:104
> sofia/internal/754617702573728 at 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 at 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 at x.x.x.x:5060) State HANGUP
>
> 2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:431 Channel
> sofia/internal/1001 at 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 at 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 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at 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 at 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 at 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 at y.y.y.y) Ended
>
> 2015-08-23 16:38:29.630370 [NOTICE] switch_core_session.c:1661 Close
> Channel sofia/internal/754617702573728 at y.y.y.y [CS_DESTROY]
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:60
> sofia/internal/1001 at 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 at 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 at 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 at 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 at 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 at y.y.y.y) State DESTROY
>
> 2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:341
> sofia/internal/754617702573728 at y.y.y.y SOFIA DESTROY
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:827 (
> sofia/internal/1001 at x.x.x.x:5060) State REPORTING
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:111
> sofia/internal/754617702573728 at y.y.y.y Standard DESTROY
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:640 (
> sofia/internal/754617702573728 at 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 at 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 at 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 at 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 at 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 at x.x.x.x:5060) Ended
>
> 2015-08-23 16:38:29.630370 [NOTICE] switch_core_session.c:1661 Close
> Channel sofia/internal/1001 at 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 at x.x.x.x>;tag=j0D5DB23gpjve
>
>    To: <sip:754617702573728 at 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 at 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 at x.x.x.x:5060) State DESTROY
>
> 2015-08-23 16:38:29.630370 [DEBUG] mod_sofia.c:341
> sofia/internal/1001 at x.x.x.x:5060 SOFIA DESTROY
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:111
> sofia/internal/1001 at x.x.x.x:5060 Standard DESTROY
>
> 2015-08-23 16:38:29.630370 [DEBUG] switch_core_state_machine.c:640 (
> sofia/internal/1001 at x.x.x.x:5060) State DESTROY going to sleep
>
>
> On Sun, Aug 23, 2015 at 9:56 AM, Anthony Minessale <
> anthony.minessale at 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 at 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 at lists.freeswitch.org [mailto:
>>> freeswitch-users-bounces at lists.freeswitch.org] *On Behalf Of *Pete Kay
>>> *Sent:* Sunday, August 23, 2015 10:41 AM
>>> *To:* FreeSWITCH Users Help <freeswitch-users at 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 at 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 at x.x.x.x:5060 parsing
>>> [default->incoming_calls] continue=false
>>>
>>> Dialplan: sofia/internal/1001 at x.x.x.x:5060 Regex (PASS)
>>> [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
>>>
>>> Dialplan: sofia/internal/1001 at 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 at y.y.y.y)
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:216 (
>>> sofia/internal/1001 at 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 at 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 at 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 at x.x.x.x:5060) State EXECUTE
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:196
>>> sofia/internal/1001 at x.x.x.x:5060 SOFIA EXECUTE
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:258
>>> sofia/internal/1001 at x.x.x.x:5060 Standard EXECUTE
>>>
>>> EXECUTE sofia/internal/1001 at 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 at 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 at y.y.y.y
>>> [68de50a4-49ac-11e5-b118-6fcd62a30179]
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:4735 (
>>> sofia/internal/754617162742492 at 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 at 8000h@20i at 64000b
>>> ,CORE_PCM_MODULE.PCMU at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMA at 8000h
>>> @20i at 64000b'
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:473 (
>>> sofia/internal/754617162742492 at 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 at y.y.y.y) State INIT
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:88
>>> sofia/internal/754617162742492 at y.y.y.y SOFIA INIT
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_core_media.c:8667
>>> sofia/internal/754617162742492 at 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 at 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 at y.y.y.y Standard INIT
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:48 (
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at y.y.y.y) State ROUTING
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] mod_sofia.c:141
>>> sofia/internal/754617162742492 at y.y.y.y SOFIA ROUTING
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_ivr_originate.c:67 (
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at y.y.y.y) State CONSUME_MEDIA
>>>
>>> 2015-08-23 15:34:14.714657 [DEBUG] switch_core_state_machine.c:551 (
>>> sofia/internal/754617162742492 at 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 at 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 at x.x.x.x>;tag=Q3F772K7rmctc
>>>
>>>    To: <sip:754617162742492 at y.y.y.y>
>>>
>>>    Call-ID: 403cbc44-c44f-1233-ba8f-60eb698211be
>>>
>>>    CSeq: 79835963 INVITE
>>>
>>>    Contact: <sip:mod_sofia at 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 at 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 at 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 at x.x.x.x>;tag=Q3F772K7rmctc
>>>
>>>    To: <sip:754617162742492 at 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 at x.x.x.x>;tag=Q3F772K7rmctc
>>>
>>>    To: <sip:754617162742492 at 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 at 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 at 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 at y.y.y.y:5060 parsing
>>> [default->incoming_calls] continue=false
>>>
>>> Dialplan: sofia/internal/1001 at y.y.y.y:5060 Regex (PASS)
>>> [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
>>>
>>> Dialplan: sofia/internal/1001 at 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 at x.x.x.x)
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:216 (
>>> sofia/internal/1001 at 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 at 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 at 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 at y.y.y.y:5060) State EXECUTE
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:196
>>> sofia/internal/1001 at y.y.y.y:5060 SOFIA EXECUTE
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:258
>>> sofia/internal/1001 at y.y.y.y:5060 Standard EXECUTE
>>>
>>> EXECUTE sofia/internal/1001 at 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 at 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 at x.x.x.x
>>> [2ff7c01e-48b6-11e5-ac58-01226f03e80c]
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:4735 (
>>> sofia/external/754617162742492 at 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 at 8000h@20i at 64000b
>>> ,CORE_PCM_MODULE.PCMU at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMA at 8000h
>>> @20i at 64000b'
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:473 (
>>> sofia/external/754617162742492 at 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 at x.x.x.x) State INIT
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] mod_sofia.c:88
>>> sofia/external/754617162742492 at x.x.x.x SOFIA INIT
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] sofia_glue.c:1257
>>> sofia/external/754617162742492 at 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 at x.x.x.x Standard INIT
>>>
>>> 2015-08-22 10:11:43.049286 [DEBUG] switch_core_state_machine.c:48 (
>>> sofia/external/754617162742492 at 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 at 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 at 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 at x.x.x.x) State ROUTING
>>>
>>> 2015-08-22 10:11:43.069228 [DEBUG] mod_sofia.c:141
>>> sofia/external/754617162742492 at x.x.x.x SOFIA ROUTING
>>>
>>> 2015-08-22 10:11:43.069228 [DEBUG] switch_ivr_originate.c:67 (
>>> sofia/external/754617162742492 at 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 at 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 at 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 at x.x.x.x) State CONSUME_MEDIA
>>>
>>> 2015-08-22 10:11:43.069228 [DEBUG] switch_core_state_machine.c:551 (
>>> sofia/external/754617162742492 at 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 at 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 at y.y.y.y>;tag=51SKgXr23XK9K
>>>
>>>    To: <sip:754617162742492 at x.x.x.x>
>>>
>>>    Call-ID: 075638a9-c359-1233-81a7-60eb698211be
>>>
>>>    CSeq: 79783087 INVITE
>>>
>>>    Contact: <sip:mod_sofia at 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 at 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 at gmail.com> wrote:
>>>
>>> Its not the same tey harder.
>>>
>>>
>>>
>>> On Friday, August 21, 2015, Pete Kay <petedao at 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 at 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 18
>>>
>>> On Aug 21, 2015 6:43 AM, "Pete Kay" <petedao at 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 at 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 at x.x.x.x)
>>>
>>>
>>>
>>> send 2700 bytes to udp/[69.27.168.50]:5060 at 04:01:47.286175:
>>>
>>>
>>> ------------------------------------------------------------------------
>>>
>>>    INVITE sip:754617162742492 at 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 at y.y.y.y>;tag=grg241BNtgDtN
>>>
>>>    To: <sip:754617162742492 at x.x.x.x>
>>>
>>>    Call-ID: 2f34abd4-c25c-1233-ffbc-60eb698211be
>>>
>>>    CSeq: 79728789 INVITE
>>>
>>>    Contact: <sip:mod_sofia at 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 at 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 at freeswitch.org>
>>> wrote:
>>>
>>> rtp_secure_media=false is the variable name.
>>>
>>>
>>>
>>> On Mon, Aug 17, 2015 at 11:06 AM, Pete Kay <petedao at 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 at y.y.y.y:5060 parsing
>>> [default->incoming_calls] continue=false
>>>
>>> Dialplan: sofia/internal/1001 at y.y.y.y:5060 Regex (PASS)
>>> [incoming_calls] ${destination_number}(1002) =~ /1002/ break=on-false
>>>
>>> Dialplan: sofia/internal/1001 at y.y.y.y:5060 Action
>>> bridge({sip_secure_media=false}[sip_secure_media=false]
>>> sofia/internal/754617162742492 at x.x.x.x)
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:216 (
>>> sofia/internal/1001 at 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 at 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 at 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 at y.y.y.y:5060) State EXECUTE
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:196
>>> sofia/internal/1001 at y.y.y.y:5060 SOFIA EXECUTE
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:258
>>> sofia/internal/1001 at y.y.y.y:5060 Standard EXECUTE
>>>
>>> EXECUTE sofia/internal/1001 at y.y.y.y:5060
>>> bridge({sip_secure_media=false}[sip_secure_media=false]
>>> sofia/internal/754617162742492 at 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 at x.x.x.x
>>> [ca6d5930-44f4-11e5-9cc9-c9574f94e170]
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:4735 (
>>> sofia/internal/754617162742492 at 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 at 8000h@20i at 64000b
>>> ,CORE_PCM_MODULE.PCMU at 8000h@20i at 64000b,CORE_PCM_MODULE.PCMA at 8000h
>>> @20i at 64000b'
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:473 (
>>> sofia/internal/754617162742492 at 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 at x.x.x.x) State INIT
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:88
>>> sofia/internal/754617162742492 at x.x.x.x SOFIA INIT
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] sofia_glue.c:1257
>>> sofia/internal/754617162742492 at 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 at x.x.x.x Standard INIT
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:48 (
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at x.x.x.x) State ROUTING
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] mod_sofia.c:141
>>> sofia/internal/754617162742492 at x.x.x.x SOFIA ROUTING
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] switch_ivr_originate.c:67 (
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at x.x.x.x) State CONSUME_MEDIA
>>>
>>> 2015-08-17 15:29:46.341244 [DEBUG] switch_core_state_machine.c:551 (
>>> sofia/internal/754617162742492 at 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 at 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 at y.y.y.y>;tag=H6HrjU4ZH1KjD
>>>
>>>   To: <sip:754617162742492 at x.x.x.x>
>>>
>>>    Call-ID: a1cbcf13-bf97-1233-84b6-60eb698211be
>>>
>>>    CSeq: 79576629 INVITE
>>>
>>>    Contact: <sip:mod_sofia at 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 at 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 at 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 at y.y.y.y>;tag=H6HrjU4ZH1KjD
>>>
>>>    To: <sip:754617162742492 at 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 at y.y.y.y>;tag=H6HrjU4ZH1KjD
>>>
>>>    To: <sip:754617162742492 at 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 at 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 at y.y.y.y>;tag=H6HrjU4ZH1KjD
>>>
>>>    To: <sip:754617162742492 at 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 at x.x.x.x entering state [terminated][415]
>>>
>>> 2015-08-17 15:29:46.361276 [NOTICE] sofia.c:7631 Hangup
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at x.x.x.x) State HANGUP
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:431 Channel
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at 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 at 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 at x.x.x.x) State REPORTING
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:104
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at 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 at x.x.x.x) Ended
>>>
>>> 2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1661 Close
>>> Channel sofia/internal/754617162742492 at x.x.x.x [CS_DESTROY]
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:630 (
>>> sofia/internal/754617162742492 at 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 at x.x.x.x) State DESTROY
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:341
>>> sofia/internal/754617162742492 at x.x.x.x SOFIA DESTROY
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:111
>>> sofia/internal/754617162742492 at x.x.x.x Standard DESTROY
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (
>>> sofia/internal/754617162742492 at 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 at 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 at 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 at 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 at 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 at 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 at y.y.y.y:5060) State HANGUP
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:425
>>> sofia/internal/1001 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at y.y.y.y:5060>;tag=9de53b6c
>>>
>>>    To: <sip:1002 at 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 at 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 at 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 at 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 at 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 at 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 at y.y.y.y:5060) Ended
>>>
>>> 2015-08-17 15:29:46.361276 [NOTICE] switch_core_session.c:1661 Close
>>> Channel sofia/internal/1001 at y.y.y.y:5060 [CS_DESTROY]
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:630 (
>>> sofia/internal/1001 at 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 at y.y.y.y:5060) State DESTROY
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] mod_sofia.c:341
>>> sofia/internal/1001 at y.y.y.y:5060 SOFIA DESTROY
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:111
>>> sofia/internal/1001 at y.y.y.y:5060 Standard DESTROY
>>>
>>> 2015-08-17 15:29:46.361276 [DEBUG] switch_core_state_machine.c:640 (
>>> sofia/internal/1001 at 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 at 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 at y.y.y.y:5060>;tag=gXrZg0KvmrXZH
>>>
>>>    From: <sip:1001 at y.y.y.y:5060>;tag=9de53b6c
>>>
>>>    Call-ID: kVdW6FArCGqcEPe7zR3x4g..
>>>
>>>    CSeq: 2 ACK
>>>
>>>    Content-Length: 0
>>>
>>>
>>>
>>>
>>> ------------------------------------------------------------------------
>>>
>>>
>>>
>>> _________________________________________________________________________
>>> Professional FreeSWITCH Consulting Services:
>>> consulting at 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 at 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 at freeswitch.org
>>>
>>> *Twitter: @FreeSWITCH , @briankwest*
>>> http://www.freeswitchbook.com
>>> http://www.freeswitchcookbook.com
>>>
>>> Got Bugs? Report them here <https://freeswitch.org/jira>! | Reddit:
>>> /r/freeswitch <https://www.reddit.com/r/freeswitch>
>>>
>>> *T:*+19184209001 | *F:*+19184209002 | *M:*+1918424WEST (9378)
>>> *iNUM:*+883 5100 1420 9001 | *ISN:*410*543 | *Skype:*briankwest
>>>
>>>
>>> _________________________________________________________________________
>>> Professional FreeSWITCH Consulting Services:
>>> consulting at 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 at 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 at 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 at 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 at 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 at 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  ♬
>>>
>>>
>>>
>>>http://freeswitch.org/http://cluecon.com/>>> http://twitter.com/FreeSWITCH
>>>
>>> ☞ irc.freenode.net #freeswitch ☞ *http://freeswitch.org/g+
>>> <http://freeswitch.org/g+>*
>>>
>>> ClueCon Weekly Development Call
>>>
>>> ☎ sip:888 at conference.freeswitch.org  ☎ +19193869900
>>>
>>>
>>>
>>> ClueCon Testimonials <https://www.youtube.com/watch?v=9XXgW34t40s>
>>>
>>> ClueCon This Summer <https://www.youtube.com/watch?v=NLaDpGQuZDA>
>>>
>>>
>>>
>>>
>>> _________________________________________________________________________
>>> Professional FreeSWITCH Consulting Services:
>>> consulting at 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 at 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  ♬
>>>
>>>
>>>
>>>http://freeswitch.org/http://cluecon.com/>>> http://twitter.com/FreeSWITCH
>>>
>>> ☞ irc.freenode.net #freeswitch ☞ *http://freeswitch.org/g+
>>> <http://freeswitch.org/g+>*
>>>
>>> ClueCon Weekly Development Call
>>>
>>> ☎ sip:888 at conference.freeswitch.org  ☎ +19193869900
>>>
>>>
>>>
>>> https://www.youtube.com/watch?v=9XXgW34t40s
>>>
>>> https://www.youtube.com/watch?v=NLaDpGQuZDA
>>>
>>>
>>>
>>>
>>> _________________________________________________________________________
>>> Professional FreeSWITCH Consulting Services:
>>> consulting at 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 at 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 at 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 at 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  ♬
>>
>>http://freeswitch.org/http://cluecon.com/>> http://twitter.com/FreeSWITCH
>> ☞ irc.freenode.net #freeswitch ☞ *http://freeswitch.org/g+
>> <http://freeswitch.org/g+>*
>>
>> ClueCon Weekly Development Call
>> ☎ sip:888 at conference.freeswitch.org  ☎ +19193869900
>>
>> https://www.youtube.com/watch?v=9XXgW34t40s
>> https://www.youtube.com/watch?v=NLaDpGQuZDA
>>
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at 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 at 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 at 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 at 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 at 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 at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20150823/466d4044/attachment-0001.html 


Join us at ClueCon 2016 Aug 8-12, 2016
More information about the FreeSWITCH-users mailing list