[Freeswitch-users] Getting issue with audio

Anurag Mishra anuraagmishra92 at gmail.com
Fri Apr 4 08:06:06 MSD 2014


Hi All,

I am new to Freeswitch and I have setup the Freeswitch server but, I got an
issue when I am trying to make call within a network or LAN the call is
working for only 30 seconds. But when I made a call outside from the LAN
from within the LAN, then the call is working for only 30 seconds as well.
And If I tried to call from outside the network into the LAN then this time
audio is not working anymore, this same issue with the call was made
outside to outside from the network. I have enter the Public IP in the
field of Ext-RTP-IP and Ext-SIP-IP.

I am pasting the logs, when I made a call outside from the LAN into the LAN.


recv 1302 bytes from udp/[172.28.129.249]:5060 at 13:14:41.435126:
>    ------------------------------------------------------------------------
>    INVITE sip:1001 at sip.difbroker.com SIP/2.0
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bKabe6.2d9f8c12.0
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjxWGCj7y2jEBuztIUAgR0hcX9pmZwi2rj
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>
>    Contact: <sip:user3 at 112.196.33.74:4713;ob>
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27966 INVITE
>    Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
> NOTIFY, REFER, MESSAGE, OPTIONS
>    Supported: replaces, 100rel, timer, norefersub
>    Session-Expires: 1800
>    Min-SE: 90
>    User-Agent: CSipSimple_A89-15/r2330
>    Content-Type: application/sdp
>    Content-Length:   475
>    X-AUTH-IP: 112.196.33.74
>
>    v=0
>    o=- 3605519857 3605519857 IN IP4 112.196.33.74
>    s=pjmedia
>    c=IN IP4 112.196.33.74
>    t=0 0
>    m=audio 4006 RTP/AVP 99 0 8 9 3 101
>    c=IN IP4 112.196.33.74
>    a=rtcp:4007 IN IP4 192.168.1.107
>    a=sendrecv
>    a=rtpmap:99 SILK/24000
>    a=fmtp:99 useinbandfec=0
>    a=rtpmap:0 PCMU/8000
>    a=rtpmap:8 PCMA/8000
>    a=rtpmap:9 G722/8000
>    a=rtpmap:3 GSM/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-15
>    a=oldmediaip:192.168.1.107
>    a=oldmediaip:192.168.1.107
>    a=oldmediaip:192.168.1.107
>    ------------------------------------------------------------------------
> send 525 bytes to udp/[172.28.129.249]:5060 at 13:14:41.435612:
>    ------------------------------------------------------------------------
>    SIP/2.0 100 Trying
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKabe6.2d9f8c12.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjxWGCj7y2jEBuztIUAgR0hcX9pmZwi2rj
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27966 INVITE
>    User-Agent: 2600hz
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.436572 [NOTICE] switch_channel.c:1055 New Channel
> sofia/sipinterface_1/user3 at sip.difbroker.com[jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE]
> 2014-04-03 14:14:41.436572 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.436572 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.436572 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change CS_NEW
> 2014-04-03 14:14:41.436572 [DEBUG] sofia.c:8186 1 acls to check for proxy
> 2014-04-03 14:14:41.436572 [DEBUG] sofia.c:8191 checking 172.28.129.249
> against acl authoritative
> 2014-04-03 14:14:41.436572 [INFO] sofia.c:8193 172.28.129.249 is a proxy
> according to the authoritative acl
> 2014-04-03 14:14:41.436572 [DEBUG] sofia.c:8203 network ip is a proxy
> 2014-04-03 14:14:41.436572 [DEBUG] sofia.c:8207 found auth ip [X-AUTH-IP]
> header of [112.196.33.74]
> 2014-04-03 14:14:41.436572 [DEBUG] sofia.c:8231 IP 172.28.129.249 Rejected
> by acl "trusted". Falling back to Digest auth.
> 2014-04-03 14:14:41.436572 [WARNING] sofia_reg.c:1634 SIP auth challenge
> (INVITE) on sofia profile 'sipinterface_1' for [1001 at sip.difbroker.com]
> from ip 172.28.129.249
> 2014-04-03 14:14:41.436572 [DEBUG] switch_core_state_machine.c:486
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State NEW
> send 960 bytes to udp/[172.28.129.249]:5060 at 13:14:41.437737:
>    ------------------------------------------------------------------------
>    SIP/2.0 407 Proxy Authentication Required
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKabe6.2d9f8c12.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjxWGCj7y2jEBuztIUAgR0hcX9pmZwi2rj
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=pjpUeS2B67apD
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27966 INVITE
>    User-Agent: 2600hz
>    Accept: application/sdp
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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
>    Proxy-Authenticate: Digest realm="sip.difbroker.com",
> nonce="ea906dc2-bb31-11e3-bc8c-35dd2b4be3da", algorithm=MD5, qop="auth"
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.436572 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.436572 [DEBUG] sofia.c:1845 detaching session
> jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
> recv 315 bytes from udp/[172.28.129.249]:5060 at 13:14:41.438998:
>    ------------------------------------------------------------------------
>    ACK sip:1001 at sip.difbroker.com SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bKabe6.2d9f8c12.0
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=pjpUeS2B67apD
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27966 ACK
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> recv 1581 bytes from udp/[172.28.129.249]:5060 at 13:14:41.656438:
>    ------------------------------------------------------------------------
>    INVITE sip:1001 at sip.difbroker.com SIP/2.0
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bKbbe6.305cc383.0
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>
>    Contact: <sip:user3 at 112.196.33.74:4713;ob>
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
> NOTIFY, REFER, MESSAGE, OPTIONS
>    Supported: replaces, 100rel, timer, norefersub
>    Session-Expires: 1800
>    Min-SE: 90
>    User-Agent: CSipSimple_A89-15/r2330
>    Proxy-Authorization: Digest username="user3", realm="sip.difbroker.com",
> nonce="ea906dc2-bb31-11e3-bc8c-35dd2b4be3da", uri="
> sip:1001 at sip.difbroker.com", response="93986330c155dd769e347f0299a9d0dc",
> algorithm=MD5, cnonce="UoEHUKZhVkQTVk-nz8CZuqOnwbqksAfy", qop=auth,
> nc=00000001
>    Content-Type: application/sdp
>    Content-Length:   475
>    X-AUTH-IP: 112.196.33.74
>
>    v=0
>    o=- 3605519857 3605519857 IN IP4 112.196.33.74
>    s=pjmedia
>    c=IN IP4 112.196.33.74
>    t=0 0
>    m=audio 4006 RTP/AVP 99 0 8 9 3 101
>    c=IN IP4 112.196.33.74
>    a=rtcp:4007 IN IP4 192.168.1.107
>    a=sendrecv
>    a=rtpmap:99 SILK/24000
>    a=fmtp:99 useinbandfec=0
>    a=rtpmap:0 PCMU/8000
>    a=rtpmap:8 PCMA/8000
>    a=rtpmap:9 G722/8000
>    a=rtpmap:3 GSM/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-15
>    a=oldmediaip:192.168.1.107
>    a=oldmediaip:192.168.1.107
>    a=oldmediaip:192.168.1.107
>    ------------------------------------------------------------------------
> send 525 bytes to udp/[172.28.129.249]:5060 at 13:14:41.656879:
>    ------------------------------------------------------------------------
>    SIP/2.0 100 Trying
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    User-Agent: 2600hz
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:1937 Re-attaching to session
> jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:8186 1 acls to check for proxy
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:8191 checking 172.28.129.249
> against acl authoritative
> 2014-04-03 14:14:41.657240 [INFO] sofia.c:8193 172.28.129.249 is a proxy
> according to the authoritative acl
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:8203 network ip is a proxy
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:8207 found auth ip [X-AUTH-IP]
> header of [112.196.33.74]
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:8231 IP 172.28.129.249 Rejected
> by acl "trusted". Falling back to Digest auth.
> 2014-04-03 14:14:41.657240 [DEBUG] switch_xml.c:1999 Cache Info
> Time Now:    1396530881657240
> Expires:    1396530849802816
> 2014-04-03 14:14:41.657240 [DEBUG] switch_xml.c:2001 Cache expired for
> user3 at sip.difbroker.com, doing fresh lookup
> 2014-04-03 14:14:41.657240 [DEBUG] kazoo_fetch_agent.c:216 Sending
> directory XML request (eab24212-bb31-11e3-bc8d-35dd2b4be3da) to
> ecallmgr at pbx.difbroker.com <2.1034.0>
> 2014-04-03 14:14:41.657240 [DEBUG] kazoo_node.c:1091 Sent erlang message
> to ecallmgr at pbx.difbroker.com <2.1034.0>
> 2014-04-03 14:14:41.657240 [DEBUG] kazoo_fetch_agent.c:277 Received
> directory XML (eab24212-bb31-11e3-bc8d-35dd2b4be3da) after 0ms: <document
> type="freeswitch/xml"><section name="directory"><domain name="
> sip.difbroker.com"><user id="user3"
> cacheable="3600000000"><variables><variable name="ecallmgr_Inception"
> value="on-net"/><variable name="ecallmgr_Authorizing-Type"
> value="device"/><variable name="ecallmgr_Authorizing-ID"
> value="49855e170e1cb8aa38ff5a831d194904"/><variable
> name="ecallmgr_Account-ID"
> value="eb94496d34bab9865a73b35ad452a03c"/><variable name="ecallmgr_Realm"
> value="sip.difbroker.com"/><variable name="ecallmgr_Username"
> value="user3"/></variables><params><param name="password"
> value="user3"/></params></user></domain></section></document>
> 2014-04-03 14:14:41.657240 [DEBUG] switch_xml.c:2077 caching lookup for
> user user3 at sip.difbroker.com for -694967296 milliseconds
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user3 at sip.difbroker.com entering state
> [received][100]
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:5899 Remote SDP:
> v=0
> o=- 3605519857 3605519857 IN IP4 112.196.33.74
> s=pjmedia
> c=IN IP4 112.196.33.74
> t=0 0
> m=audio 4006 RTP/AVP 99 0 8 9 3 101
> c=IN IP4 112.196.33.74
> a=rtpmap:99 SILK/24000
> a=fmtp:99 useinbandfec=0
> a=rtpmap:0 PCMU/8000
> a=rtpmap:8 PCMA/8000
> a=rtpmap:9 G722/8000
> a=rtpmap:3 GSM/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-15
> a=rtcp:4007 IN IP4 192.168.1.107
> a=oldmediaip:192.168.1.107
> a=oldmediaip:192.168.1.107
> a=oldmediaip:192.168.1.107
>
> 2014-04-03 14:14:41.657240 [DEBUG] sofia.c:6144 (sofia/sipinterface_1/
> user3 at sip.difbroker.com) State Change CS_NEW -> CS_INIT
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_INIT
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:507
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State INIT
> 2014-04-03 14:14:41.657240 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/
> user3 at sip.difbroker.com SOFIA INIT
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:40
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard INIT
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:48
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State Change CS_INIT ->
> CS_ROUTING
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:507
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State INIT going to sleep
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_ROUTING
> 2014-04-03 14:14:41.657240 [DEBUG] switch_channel.c:2179
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Callstate Change DOWN ->
> RINGING
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:523
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State ROUTING
> 2014-04-03 14:14:41.657240 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/
> user3 at sip.difbroker.com SOFIA ROUTING
> 2014-04-03 14:14:41.657240 [DEBUG] switch_core_state_machine.c:164
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard ROUTING
> 2014-04-03 14:14:41.657240 [INFO] mod_dialplan_xml.c:558 Processing user3
> <user3>->1001 in context context_2
> 2014-04-03 14:14:41.657240 [DEBUG] kazoo_fetch_agent.c:216 Sending
> dialplan XML request (eab2c5ac-bb31-11e3-bc8f-35dd2b4be3da) to
> ecallmgr at pbx.difbroker.com <2.1035.0>
> 2014-04-03 14:14:41.657240 [DEBUG] kazoo_node.c:1091 Sent erlang message
> to ecallmgr at pbx.difbroker.com <2.1035.0>
> 2014-04-03 14:14:41.676550 [DEBUG] kazoo_fetch_agent.c:277 Received
> dialplan XML (eab2c5ac-bb31-11e3-bc8f-35dd2b4be3da) after 19ms: <document
> type="freeswitch/xml"><section name="dialplan" description="Route Park
> Response"><context name="context_2"><extension
> name="park"><condition><action application="log" data="NOTICE log|${uuid}|
> ecallmgr at pbx.difbroker.com won call control"/><action
> application="export" data="ecallmgr_Ecallmgr-Node=
> ecallmgr at pbx.difbroker.com"/><condition
> field="variable_ecallmgr_Bridge-ID" expression="^$"><action
> application="export" data="ecallmgr_Bridge-ID=${UUID}"/></condition><action
> application="set" data="ringback=%(2000,4000,440,480)"/><action
> application="set" data="transfer_ringback=%(2000,4000,440,480)"/><action
> application="park"/></condition></extension></context></section></document>
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com parsing
> [context_2->park] continue=false
> |--- Dialplan: Processing recursive conditions level:1 [park_recur_1]
> require-nested=TRUE
> |--- Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Regex (PASS)
> [park_recur_1] variable_ecallmgr_Bridge-ID() =~ /^$/ break=on-false
> |--- Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Action
> export(ecallmgr_Bridge-ID=${UUID})
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Absolute Condition
> [park]
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Action log(NOTICE
> log|${uuid}|ecallmgr at pbx.difbroker.com won call control)
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Action
> export(ecallmgr_Ecallmgr-Node=ecallmgr at pbx.difbroker.com)
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Action
> set(ringback=%(2000,4000,440,480))
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Action
> set(transfer_ringback=%(2000,4000,440,480))
> Dialplan: sofia/sipinterface_1/user3 at sip.difbroker.com Action park()
> 2014-04-03 14:14:41.676550 [DEBUG] switch_core_state_machine.c:214
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State Change CS_ROUTING ->
> CS_EXECUTE
> 2014-04-03 14:14:41.676550 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.676550 [DEBUG] switch_core_state_machine.c:523
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State ROUTING going to
> sleep
> 2014-04-03 14:14:41.676550 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_EXECUTE
> 2014-04-03 14:14:41.676550 [DEBUG] switch_core_state_machine.c:530
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State EXECUTE
> 2014-04-03 14:14:41.676550 [DEBUG] mod_sofia.c:178 sofia/sipinterface_1/
> user3 at sip.difbroker.com SOFIA EXECUTE
> 2014-04-03 14:14:41.676550 [DEBUG] switch_core_state_machine.c:256
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard EXECUTE
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.comexport(ecallmgr_Bridge-ID=jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE)
> 2014-04-03 14:14:41.676550 [DEBUG] switch_channel.c:1247 EXPORT
> (export_vars) [ecallmgr_Bridge-ID]=[jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE]
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.com log(NOTICE
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|ecallmgr at pbx.difbroker.com won call
> control)
> 2014-04-03 14:14:41.676550 [NOTICE] mod_dptools.c:1634
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|ecallmgr at pbx.difbroker.com won call
> control
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.comexport(ecallmgr_Ecallmgr-Node=
> ecallmgr at pbx.difbroker.com)
> 2014-04-03 14:14:41.676550 [DEBUG] switch_channel.c:1247 EXPORT
> (export_vars) [ecallmgr_Ecallmgr-Node]=[ecallmgr at pbx.difbroker.com]
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.comset(ringback=%(2000,4000,440,480))
> 2014-04-03 14:14:41.676550 [DEBUG] mod_dptools.c:1402 sofia/sipinterface_1/
> user3 at sip.difbroker.com SET [ringback]=[%(2000,4000,440,480)]
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.comset(transfer_ringback=%(2000,4000,440,480))
> 2014-04-03 14:14:41.676550 [DEBUG] mod_dptools.c:1402 sofia/sipinterface_1/
> user3 at sip.difbroker.com SET [transfer_ringback]=[%(2000,4000,440,480)]
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.com park()
> 2014-04-03 14:14:41.676550 [DEBUG] kazoo_node.c:1091 Sent erlang message
> to ecallmgr at pbx.difbroker.com <2.2946.0>
> 2014-04-03 14:14:41.698999 [INFO] kazoo_node.c:627 exec:
> uuid_setvar_multi(jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
> effective_caller_id_name=user3;effective_caller_id_number=user3;ecallmgr_Username=user3;ecallmgr_Realm=
> sip.difbroker.com
> ;ecallmgr_Account-ID=eb94496d34bab9865a73b35ad452a03c;ecallmgr_Authorizing-ID=49855e170e1cb8aa38ff5a831d194904;ecallmgr_Authorizing-Type=device;ecallmgr_Inception=on-net;ecallmgr_Fetch-ID=eab2c5ac-bb31-11e3-bc8f-35dd2b4be3da)
> 2014-04-03 14:14:41.722675 [DEBUG] kazoo_node.c:1091 Sent erlang message
> to ecallmgr at pbx.difbroker.com <2.2963.0>
> 2014-04-03 14:14:41.722675 [NOTICE] kazoo_node.c:302
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|building xferext extension: set
> continue_on_fail=true
> 2014-04-03 14:14:41.722675 [NOTICE] kazoo_node.c:302
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|building xferext extension: export
> sip_redirect_context=context_2
> 2014-04-03 14:14:41.722675 [NOTICE] kazoo_node.c:302
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|building xferext extension: bridge
> {call_timeout=20,originate_timeout=20,local_var_clobber='true'}[ignore_completed_elsewhere='false',ecallmgr_Authorizing-ID='d1639ecfdc0f31d42cbb9f0f5d185d13',ecallmgr_Account-ID='eb94496d34bab9865a73b35ad452a03c',t38_passthrough='true',sdp_secure_savp_only='true',sip_invite_domain='
> sip.difbroker.com',presence_id='user1 at sip.difbroker.com
> ',absolute_codec_string='^^:PCMU:PCMA',leg_timeout='20',effective_callee_id_number='1001',effective_callee_id_name='Test1',origination_callee_id_number='1001',origination_callee_id_name='Test1',ecallmgr_Realm='
> sip.difbroker.com
> ',ecallmgr_Username='user1']sofia/sipinterface_1/user1 at 172.28.129.231:56260
> ;fs_path=sip:172.28.129.249:5060;lr;received='sip:172.28.129.231:56260'
> 2014-04-03 14:14:41.722675 [NOTICE] kazoo_node.c:302
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|building xferext extension: event
> Event-Name=CUSTOM,Event-Subclass=whistle::masquerade,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=bridge
> 2014-04-03 14:14:41.722675 [NOTICE] kazoo_node.c:302
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|building xferext extension: park
> 2014-04-03 14:14:41.722675 [NOTICE] kazoo_node.c:305
> log|jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE|transfered call to xferext extension
> 2014-04-03 14:14:41.722675 [DEBUG] switch_core_session.c:1183 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_channel.c:3098
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State Change CS_EXECUTE ->
> CS_ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:530
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State EXECUTE going to
> sleep
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:523
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/
> user3 at sip.difbroker.com SOFIA ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:164
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:184
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State Change CS_ROUTING ->
> CS_EXECUTE
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:523
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State ROUTING going to
> sleep
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_EXECUTE
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:530
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State EXECUTE
> 2014-04-03 14:14:41.736551 [DEBUG] mod_sofia.c:178 sofia/sipinterface_1/
> user3 at sip.difbroker.com SOFIA EXECUTE
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:256
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard EXECUTE
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.comset(continue_on_fail=true)
> 2014-04-03 14:14:41.736551 [DEBUG] mod_dptools.c:1402 sofia/sipinterface_1/
> user3 at sip.difbroker.com SET [continue_on_fail]=[true]
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.comexport(sip_redirect_context=context_2)
> 2014-04-03 14:14:41.736551 [DEBUG] switch_channel.c:1247 EXPORT
> (export_vars) [sip_redirect_context]=[context_2]
> EXECUTE sofia/sipinterface_1/user3 at sip.difbroker.combridge({call_timeout=20,originate_timeout=20,local_var_clobber='true'}[ignore_completed_elsewhere='false',ecallmgr_Authorizing-ID='d1639ecfdc0f31d42cbb9f0f5d185d13',ecallmgr_Account-ID='eb94496d34bab9865a73b35ad452a03c',t38_passthrough='true',sdp_secure_savp_only='true',sip_invite_domain='
> sip.difbroker.com',presence_id='user1 at sip.difbroker.com
> ',absolute_codec_string='^^:PCMU:PCMA',leg_timeout='20',effective_callee_id_number='1001',effective_callee_id_name='Test1',origination_callee_id_number='1001',origination_callee_id_name='Test1',ecallmgr_Realm='
> sip.difbroker.com
> ',ecallmgr_Username='user1']sofia/sipinterface_1/user1 at 172.28.129.231:56260
> ;fs_path=sip:172.28.129.249:5060;lr;received='sip:172.28.129.231:56260')
> 2014-04-03 14:14:41.736551 [DEBUG] switch_channel.c:1201
> sofia/sipinterface_1/user3 at sip.difbroker.com EXPORTING[export_vars]
> [ecallmgr_Bridge-ID]=[jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE] to event
> 2014-04-03 14:14:41.736551 [DEBUG] switch_channel.c:1201
> sofia/sipinterface_1/user3 at sip.difbroker.com EXPORTING[export_vars]
> [ecallmgr_Ecallmgr-Node]=[ecallmgr at pbx.difbroker.com] to event
> 2014-04-03 14:14:41.736551 [DEBUG] switch_channel.c:1201
> sofia/sipinterface_1/user3 at sip.difbroker.com EXPORTING[export_vars]
> [sip_redirect_context]=[context_2] to event
> 2014-04-03 14:14:41.736551 [DEBUG] switch_ivr_originate.c:2071 Parsing
> global variables
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [call_timeout]=[20]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [originate_timeout]=[20]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [local_var_clobber]=[true]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_ivr_originate.c:2518 Parsing
> session specific variables
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [ignore_completed_elsewhere]=[false]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [ecallmgr_Authorizing-ID]=[d1639ecfdc0f31d42cbb9f0f5d185d13]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [ecallmgr_Account-ID]=[eb94496d34bab9865a73b35ad452a03c]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [t38_passthrough]=[true]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [sdp_secure_savp_only]=[true]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [sip_invite_domain]=[sip.difbroker.com]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [presence_id]=[user1 at sip.difbroker.com]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [absolute_codec_string]=[^^:PCMU:PCMA]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [leg_timeout]=[20]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [effective_callee_id_number]=[1001]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [effective_callee_id_name]=[Test1]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [origination_callee_id_number]=[1001]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [origination_callee_id_name]=[Test1]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [ecallmgr_Realm]=[sip.difbroker.com]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_event.c:1687 Parsing variable
> [ecallmgr_Username]=[user1]
> 2014-04-03 14:14:41.736551 [NOTICE] switch_channel.c:1055 New Channel
> sofia/sipinterface_1/user1 at 172.28.129.231:56260[eac00fdc-bb31-11e3-bc9c-35dd2b4be3da]
> 2014-04-03 14:14:41.736551 [DEBUG] mod_sofia.c:4456 (sofia/sipinterface_1/
> user1 at 172.28.129.231:56260) State Change CS_NEW -> CS_INIT
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_ivr_originate.c:2812
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 Setting leg timeout to 20
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_INIT
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:507
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State INIT
> 2014-04-03 14:14:41.736551 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/
> user1 at 172.28.129.231:56260 SOFIA INIT
> 2014-04-03 14:14:41.736551 [DEBUG] sofia_glue.c:1200 sip:
> 172.28.129.249:5060 Setting proxy route to sofia/sipinterface_1/
> user1 at 172.28.129.231:56260
> 2014-04-03 14:14:41.736551 [DEBUG] sofia_glue.c:1229 Local SDP:
> v=0
> o=FreeSWITCH 1396506509 1396506510 IN IP4 172.28.129.249
> s=FreeSWITCH
> c=IN IP4 172.28.129.249
> t=0 0
> m=audio 24372 RTP/AVP 0 8 101 13
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=ptime:20
> a=sendrecv
>
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:40
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 Standard INIT
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:48
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State Change CS_INIT ->
> CS_ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:507
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State INIT going to
> sleep
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:523
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/
> user1 at 172.28.129.231:56260 SOFIA ROUTING
> 2014-04-03 14:14:41.736551 [DEBUG] switch_ivr_originate.c:67
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State Change CS_ROUTING
> -> CS_CONSUME_MEDIA
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:523
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State ROUTING going to
> sleep
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_CONSUME_MEDIA
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:542
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State CONSUME_MEDIA
> send 1182 bytes to udp/[172.28.129.249]:5060 at 13:14:41.755233:
>    ------------------------------------------------------------------------
>    INVITE sip:user1 at 172.28.129.231:56260 SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKHeB5026mSQFeN
>    Route: <sip:172.28.129.249:5060>
>    Max-Forwards: 70
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231:56260>
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    CSeq: 57929376 INVITE
>    Contact: <sip:mod_sofia at 80.251.161.254:11000>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 207
>    X-AUTH-IP: 112.196.33.74
>    X-FS-Support: update_display,send_info
>    Remote-Party-ID: "user3" <sip:user3 at sip.difbroker.com
> >;party=calling;screen=yes;privacy=off
>
>    v=0
>    o=FreeSWITCH 1396506509 1396506510 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 24372 RTP/AVP 0 8 101 13
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.756711 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> recv 340 bytes from udp/[172.28.129.249]:5060 at 13:14:41.758132:
>    ------------------------------------------------------------------------
>    SIP/2.0 100 Attempting to connect your call
>    Via: SIP/2.0/UDP 80.251.161.254:11000
> ;rport=11000;branch=z9hG4bKHeB5026mSQFeN;received=172.28.129.249
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231:56260>
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    CSeq: 57929376 INVITE
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.736551 [DEBUG] switch_core_state_machine.c:542
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State CONSUME_MEDIA
> going to sleep
> 2014-04-03 14:14:41.756711 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 entering state
> [calling][0]
> recv 550 bytes from udp/[172.28.129.249]:5060 at 13:14:41.917022:
>    ------------------------------------------------------------------------
>    SIP/2.0 180 Ringing
>    Via: SIP/2.0/UDP 80.251.161.254:11000
> ;rport=11000;received=172.28.129.249;branch=z9hG4bKHeB5026mSQFeN
>    Record-Route: <sip:80.251.161.254;lr;ftag=r48cjF4j0SQUm>
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231>;tag=PF74LQuHxsMZkOqSXrWYfqf.MYX9Cpbh
>    CSeq: 57929376 INVITE
>    Contact: <sip:user1 at 172.28.129.231:56260;ob>
>    Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
> NOTIFY, REFER, MESSAGE, OPTIONS
>    Content-Length:  0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.917112 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:41.917112 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:41.917112 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 entering state
> [proceeding][180]
> 2014-04-03 14:14:41.917112 [NOTICE] sofia.c:5979 Ring-Ready
> sofia/sipinterface_1/user1 at 172.28.129.231:56260!
> 2014-04-03 14:14:41.936581 [DEBUG] switch_channel.c:3267
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Callstate Change DOWN
> -> RINGING
> 2014-04-03 14:14:41.936581 [INFO] switch_ivr_originate.c:1191 Sending
> early media
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[G7221:115:32000:20:48000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[G7221:107:16000:20:32000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[G722:9:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[PCMU:0:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[PCMA:8:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[GSM:3:8000:20:13200]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[opus:116:48000:20:0]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [SILK:99:24000:20:0]/[SPEEX:99:8000:20:24600]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[G7221:115:32000:20:48000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[G7221:107:16000:20:32000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3223 Audio Codec
> Compare [PCMU:0:8000:20:64000] ++++ is saved as a match
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[PCMA:8:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[GSM:3:8000:20:13200]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[opus:116:48000:20:0]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[SPEEX:99:8000:20:24600]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[G7221:115:32000:20:48000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[G7221:107:16000:20:32000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3223 Audio Codec
> Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[GSM:3:8000:20:13200]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[opus:116:48000:20:0]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMA:8:8000:20:64000]/[SPEEX:99:8000:20:24600]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[G7221:115:32000:20:48000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[G7221:107:16000:20:32000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[G722:9:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3223 Audio Codec
> Compare [G722:9:8000:20:64000] ++++ is saved as a match
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[PCMU:0:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[PCMA:8:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[GSM:3:8000:20:13200]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[opus:116:48000:20:0]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [G722:9:8000:20:64000]/[SPEEX:99:8000:20:24600]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[G7221:115:32000:20:48000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[G7221:107:16000:20:32000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[G722:9:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[PCMU:0:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[PCMA:8:8000:20:64000]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[GSM:3:8000:20:13200]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3223 Audio Codec
> Compare [GSM:3:8000:20:13200] ++++ is saved as a match
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[opus:116:48000:20:0]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [GSM:3:8000:20:13200]/[SPEEX:99:8000:20:24600]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3095 Set
> telephone-event payload to 101
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:2126 Set Codec
> sofia/sipinterface_1/user3 at sip.difbroker.com G722/8000 20 ms 160 samples
> 64000 bits
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_codec.c:111
> sofia/sipinterface_1/user3 at sip.difbroker.com Original read codec set to
> G722:9
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:3401 Set 2833 dtmf
> send/recv payload to 101
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:4589 AUDIO RTP
> [sofia/sipinterface_1/user3 at sip.difbroker.com] 172.28.129.249 port 20354
> -> 112.196.33.74 port 4006 codec: 9 ms: 20
> 2014-04-03 14:14:41.956548 [DEBUG] switch_rtp.c:3068 Starting timer [soft]
> 160 bytes per 20ms
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:4933 Set 2833 dtmf
> send payload to 101
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_media.c:4939 Set 2833 dtmf
> receive payload to 101
> 2014-04-03 14:14:41.956548 [NOTICE] sofia_media.c:92 Pre-Answer
> sofia/sipinterface_1/user3 at sip.difbroker.com!
> 2014-04-03 14:14:41.956548 [DEBUG] switch_channel.c:3405
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Callstate Change RINGING
> -> EARLY
> 2014-04-03 14:14:41.956548 [DEBUG] mod_sofia.c:2099 Ring SDP:
> v=0
> o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
> s=FreeSWITCH
> c=IN IP4 172.28.129.249
> t=0 0
> m=audio 20354 RTP/AVP 9 101
> a=rtpmap:9 G722/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=ptime:20
> a=sendrecv
>
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_session.c:903 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.956548 [DEBUG] switch_ivr_originate.c:1248 Raw Codec
> Activation Success L16 at 16000hz 1 channel 20ms
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_codec.c:221
> sofia/sipinterface_1/user3 at sip.difbroker.com Push codec L16:70
> 2014-04-03 14:14:41.956548 [DEBUG] switch_ivr_originate.c:1316 Play
> Ringback Tone [%(2000,4000,440,480)]
> send 1333 bytes to udp/[172.28.129.249]:5060 at 13:14:41.960838:
>    ------------------------------------------------------------------------
>    SIP/2.0 183 Session Progress
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Accept: application/sdp
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "1001" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:41.956548 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:41.976550 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user3 at sip.difbroker.com entering state [early][183]
> recv 898 bytes from udp/[172.28.129.249]:5060 at 13:14:46.937232:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:11000
> ;rport=11000;received=172.28.129.249;branch=z9hG4bKHeB5026mSQFeN
>    Record-Route: <sip:80.251.161.254;lr;ftag=r48cjF4j0SQUm>
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231>;tag=PF74LQuHxsMZkOqSXrWYfqf.MYX9Cpbh
>    CSeq: 57929376 INVITE
>    Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
> NOTIFY, REFER, MESSAGE, OPTIONS
>    Contact: <sip:user1 at 172.28.129.231:56260;ob>
>    Supported: replaces, 100rel, timer, norefersub
>    Content-Type: application/sdp
>    Content-Length:   271
>
>    v=0
>    o=- 3605519858 3605519859 IN IP4 172.28.129.231
>    s=pjmedia
>    c=IN IP4 172.28.129.231
>    t=0 0
>    m=audio 4004 RTP/AVP 0 101
>    c=IN IP4 172.28.129.231
>    a=rtcp:4005 IN IP4 172.28.129.231
>    a=sendrecv
>    a=rtpmap:0 PCMU/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-15
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:46.936629 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 entering state
> [completing][200]
> 2014-04-03 14:14:46.936629 [DEBUG] sofia.c:5899 Remote SDP:
> v=0
> o=- 3605519858 3605519859 IN IP4 172.28.129.231
> s=pjmedia
> c=IN IP4 172.28.129.231
> t=0 0
> m=audio 4004 RTP/AVP 0 101
> c=IN IP4 172.28.129.231
> a=rtpmap:0 PCMU/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-15
> a=rtcp:4005 IN IP4 172.28.129.231
>
> send 462 bytes to udp/[172.28.129.249]:5060 at 13:14:46.939587:
>    ------------------------------------------------------------------------
>    ACK sip:user1 at 172.28.129.231:56260;ob SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKjQ4X2XQrp050g
>    Route: <sip:80.251.161.254;lr;ftag=r48cjF4j0SQUm>
>    Max-Forwards: 70
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231:56260
> >;tag=PF74LQuHxsMZkOqSXrWYfqf.MYX9Cpbh
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    CSeq: 57929376 ACK
>    Contact: <sip:mod_sofia at 80.251.161.254:11000>
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:46.936629 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 entering state
> [ready][200]
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:3223 Audio Codec
> Compare [PCMU:0:8000:20:64000] ++++ is saved as a match
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:3169 Audio Codec
> Compare [PCMU:0:8000:20:64000]/[PCMA:8:8000:20:64000]
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:3095 Set
> telephone-event payload to 101
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:2126 Set Codec
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 PCMU/8000 20 ms 160
> samples 64000 bits
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_codec.c:111
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 Original read codec set
> to PCMU:0
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:3392 Set 2833 dtmf
> send payload to 101
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:4589 AUDIO RTP
> [sofia/sipinterface_1/user1 at 172.28.129.231:56260] 172.28.129.249 port
> 24372 -> 172.28.129.231 port 4004 codec: 0 ms: 20
> 2014-04-03 14:14:46.936629 [DEBUG] switch_rtp.c:3068 Starting timer [soft]
> 160 bytes per 20ms
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:4933 Set 2833 dtmf
> send payload to 101
> 2014-04-03 14:14:46.936629 [DEBUG] switch_core_media.c:4939 Set 2833 dtmf
> receive payload to 101
> 2014-04-03 14:14:46.936629 [DEBUG] switch_channel.c:3640 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:46.936629 [NOTICE] sofia.c:6678 Channel
> [sofia/sipinterface_1/user1 at 172.28.129.231:56260] has been answered
> 2014-04-03 14:14:46.936629 [DEBUG] switch_channel.c:3686
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Callstate Change
> RINGING -> ACTIVE
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_codec.c:246
> sofia/sipinterface_1/user3 at sip.difbroker.com Restore previous codec
> G722:9.
> 2014-04-03 14:14:46.956550 [DEBUG] mod_sofia.c:782 Local SDP
> sofia/sipinterface_1/user3 at sip.difbroker.com:
> v=0
> o=FreeSWITCH 1396510527 1396510529 IN IP4 172.28.129.249
> s=FreeSWITCH
> c=IN IP4 172.28.129.249
> t=0 0
> m=audio 20354 RTP/AVP 9 101
> a=rtpmap:9 G722/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=ptime:20
> a=sendrecv
>
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_session.c:903 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:46.956550 [NOTICE] switch_ivr_originate.c:3476 Channel
> [sofia/sipinterface_1/user3 at sip.difbroker.com] has been answered
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:14:46.958679:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:46.956550 [DEBUG] switch_channel.c:3686
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Callstate Change EARLY ->
> ACTIVE
> 2014-04-03 14:14:46.956550 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user3 at sip.difbroker.com entering state
> [completed][200]
> 2014-04-03 14:14:46.956550 [DEBUG] switch_ivr_originate.c:3534 Originate
> Resulted in Success: [sofia/sipinterface_1/user1 at 172.28.129.231:56260]
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_session.c:903 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_session.c:903 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:14:46.956550 [DEBUG] switch_ivr_bridge.c:1440
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State Change
> CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_EXCHANGE_MEDIA
> 2014-04-03 14:14:46.956550 [DEBUG] switch_core_state_machine.c:533
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State EXCHANGE_MEDIA
> 2014-04-03 14:14:46.956550 [DEBUG] mod_sofia.c:599 SOFIA EXCHANGE_MEDIA
> 2014-04-03 14:14:46.976549 [DEBUG] switch_rtp.c:5191 Correct ip/port
> confirmed.
> recv 322 bytes from udp/[172.28.129.249]:5060 at 13:14:47.141279:
>    ------------------------------------------------------------------------
>    OPTIONS sip:172.28.129.249:11000 SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bK56be.20a73e31.0
>    To: sip:172.28.129.249:11000
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-dbb4
>    CSeq: 10 OPTIONS
>    Call-ID: 45d8465e1d1f9616-31626 at 172.28.129.249
>    Max-Forwards: 70
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> send 726 bytes to udp/[172.28.129.249]:5060 at 13:14:47.141770:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bK56be.20a73e31.0;received=172.28.129.249
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-dbb4
>    To: <sip:172.28.129.249:11000>;tag=SD25KaNpX2Deg
>    Call-ID: 45d8465e1d1f9616-31626 at 172.28.129.249
>    CSeq: 10 OPTIONS
>    Contact: <sip:80.251.161.254:11000>
>    User-Agent: 2600hz
>    Accept: application/sdp
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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-Length: 0
>
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:14:47.460342:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:14:48.462889:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:14:50.464388:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:14:54.465349:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> recv 322 bytes from udp/[172.28.129.249]:5060 at 13:14:57.128308:
>    ------------------------------------------------------------------------
>    OPTIONS sip:172.28.129.249:11000 SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bK66be.23a4aeb4.0
>    To: sip:172.28.129.249:11000
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-0e2e
>    CSeq: 10 OPTIONS
>    Call-ID: 45d8465e1d1f9617-31626 at 172.28.129.249
>    Max-Forwards: 70
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> send 726 bytes to udp/[172.28.129.249]:5060 at 13:14:57.128685:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bK66be.23a4aeb4.0;received=172.28.129.249
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-0e2e
>    To: <sip:172.28.129.249:11000>;tag=tpUyN55StB40B
>    Call-ID: 45d8465e1d1f9617-31626 at 172.28.129.249
>    CSeq: 10 OPTIONS
>    Contact: <sip:80.251.161.254:11000>
>    User-Agent: 2600hz
>    Accept: application/sdp
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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-Length: 0
>
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:14:58.465792:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:15:02.466909:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:15:06.467707:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> recv 322 bytes from udp/[172.28.129.249]:5060 at 13:15:07.141292:
>    ------------------------------------------------------------------------
>    OPTIONS sip:172.28.129.249:11000 SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bK47be.90dc90e6.0
>    To: sip:172.28.129.249:11000
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-df6c
>    CSeq: 10 OPTIONS
>    Call-ID: 45d8465e1d1f9618-31626 at 172.28.129.249
>    Max-Forwards: 70
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> send 726 bytes to udp/[172.28.129.249]:5060 at 13:15:07.141673:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bK47be.90dc90e6.0;received=172.28.129.249
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-df6c
>    To: <sip:172.28.129.249:11000>;tag=UZmQQ0pXQmtKQ
>    Call-ID: 45d8465e1d1f9618-31626 at 172.28.129.249
>    CSeq: 10 OPTIONS
>    Contact: <sip:80.251.161.254:11000>
>    User-Agent: 2600hz
>    Accept: application/sdp
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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-Length: 0
>
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:15:10.469755:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:15:14.471390:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> recv 322 bytes from udp/[172.28.129.249]:5060 at 13:15:17.128326:
>    ------------------------------------------------------------------------
>    OPTIONS sip:172.28.129.249:11000 SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:5060;branch=z9hG4bK37be.7292ed87.0
>    To: sip:172.28.129.249:11000
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-0af6
>    CSeq: 10 OPTIONS
>    Call-ID: 45d8465e1d1f9619-31626 at 172.28.129.249
>    Max-Forwards: 70
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> send 726 bytes to udp/[172.28.129.249]:5060 at 13:15:17.128660:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bK37be.7292ed87.0;received=172.28.129.249
>    From: sip:sipcheck at 172.28.129.249
> ;tag=53cd539e79aca6726a386a78d00cf06a-0af6
>    To: <sip:172.28.129.249:11000>;tag=v8DgSU70mXg6j
>    Call-ID: 45d8465e1d1f9619-31626 at 172.28.129.249
>    CSeq: 10 OPTIONS
>    Contact: <sip:80.251.161.254:11000>
>    User-Agent: 2600hz
>    Accept: application/sdp
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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-Length: 0
>
>    ------------------------------------------------------------------------
> send 1295 bytes to udp/[172.28.129.249]:5060 at 13:15:18.473572:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:5060
> ;branch=z9hG4bKbbe6.305cc383.0;received=172.28.129.249
>    Via: SIP/2.0/UDP 192.168.1.107:51281
> ;received=112.196.33.74;rport=4713;branch=z9hG4bKPjQanHWvyRMlaJSg8Q10iOVqNPAO6WiO0x
>    Record-Route:
> <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    From: <sip:user3 at sip.difbroker.com
> >;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    To: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 27967 INVITE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, 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: 224
>    Remote-Party-ID: "Test1" <sip:1001 at sip.difbroker.com
> >;party=calling;privacy=off;screen=no
>
>    v=0
>    o=FreeSWITCH 1396510527 1396510528 IN IP4 172.28.129.249
>    s=FreeSWITCH
>    c=IN IP4 172.28.129.249
>    t=0 0
>    m=audio 20354 RTP/AVP 9 101
>    a=rtpmap:9 G722/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=ptime:20
>    ------------------------------------------------------------------------
> 2014-04-03 14:15:18.956546 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> send 688 bytes to udp/[80.251.161.254]:5060 at 13:15:18.960410:
>    ------------------------------------------------------------------------
>    BYE sip:user3 at 112.196.33.74:4713;ob SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKK0Xp4r8UK9UKc
>    Route: <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    Max-Forwards: 70
>    From: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    To: <sip:user3 at sip.difbroker.com>;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 57929395 BYE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, path, replaces
>    Reason: SIP;cause=408;text="ACK Timeout"
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:15:18.956546 [DEBUG] switch_core_session.c:1048 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] sofia.c:5889 Channel
> sofia/sipinterface_1/user3 at sip.difbroker.com entering state
> [terminating][0]
> 2014-04-03 14:15:18.976545 [NOTICE] sofia.c:6733 Hangup
> sofia/sipinterface_1/user3 at sip.difbroker.com [CS_EXECUTE]
> [NORMAL_UNSPECIFIED]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_channel.c:3212 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [KILL]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD
> DONE [sofia/sipinterface_1/user3 at sip.difbroker.com]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:672 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:566
> sofia/sipinterface_1/user3 at sip.difbroker.com ending bridge by request
> from write function
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD
> DONE [sofia/sipinterface_1/user1 at 172.28.129.231:56260]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:672 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:15:18.976545 [NOTICE] switch_ivr_bridge.c:735 Hangup
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [CS_EXCHANGE_MEDIA]
> [NORMAL_CLEARING]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_channel.c:3212 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [KILL]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:533
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State EXCHANGE_MEDIA
> going to sleep
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_HANGUP
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:731
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State HANGUP
> 2014-04-03 14:15:18.976545 [DEBUG] mod_sofia.c:413 Channel
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 hanging up, cause:
> NORMAL_CLEARING
> 2014-04-03 14:15:18.976545 [DEBUG] mod_sofia.c:471 Sending BYE to
> sofia/sipinterface_1/user1 at 172.28.129.231:56260
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:58
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 Standard HANGUP, cause:
> NORMAL_CLEARING
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:731
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State HANGUP going to
> sleep
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:744
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Callstate Change ACTIVE
> -> HANGUP
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:499
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State Change CS_HANGUP
> -> CS_REPORTING
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_REPORTING
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:816
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State REPORTING
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:102
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 Standard REPORTING,
> cause: NORMAL_CLEARING
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:816
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State REPORTING going
> to sleep
> send 680 bytes to udp/[172.28.129.249]:5060 at 13:15:18.983374:
>    ------------------------------------------------------------------------
>    BYE sip:user1 at 172.28.129.231:56260;ob SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKm9pF6KSZgjj6Q
>    Route: <sip:80.251.161.254;lr;ftag=r48cjF4j0SQUm>
>    Max-Forwards: 70
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231:56260
> >;tag=PF74LQuHxsMZkOqSXrWYfqf.MYX9Cpbh
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    CSeq: 57929377 BYE
>    Contact: <sip:mod_sofia at 80.251.161.254:11000>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, path, replaces
>    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:1538
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 skip receive message
> [UNBRIDGE] (channel is hungup already)
> 2014-04-03 14:15:18.976545 [DEBUG] switch_ivr_bridge.c:1541
> sofia/sipinterface_1/user3 at sip.difbroker.com skip receive message
> [UNBRIDGE] (channel is hungup already)
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:493
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State Change
> CS_REPORTING -> CS_DESTROY
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:1591 Session 15
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Locked, Waiting on
> external entities
> 2014-04-03 14:15:18.976545 [NOTICE] switch_core_session.c:1609 Session 15
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Ended
> 2014-04-03 14:15:18.976545 [NOTICE] switch_core_session.c:1613 Close
> Channel sofia/sipinterface_1/user1 at 172.28.129.231:56260 [CS_DESTROY]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:618
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Callstate Change HANGUP
> -> DOWN
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:621
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) Running State Change
> CS_DESTROY
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:2852
> sofia/sipinterface_1/user3 at sip.difbroker.com skip receive message
> [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:530
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State EXECUTE going to
> sleep
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_HANGUP
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:631
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State DESTROY
> 2014-04-03 14:15:18.976545 [DEBUG] mod_sofia.c:323 sofia/sipinterface_1/
> user1 at 172.28.129.231:56260 SOFIA DESTROY
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:109
> sofia/sipinterface_1/user1 at 172.28.129.231:56260 Standard DESTROY
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:631
> (sofia/sipinterface_1/user1 at 172.28.129.231:56260) State DESTROY going to
> sleep
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:731
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State HANGUP
> 2014-04-03 14:15:18.976545 [DEBUG] mod_sofia.c:413 Channel
> sofia/sipinterface_1/user3 at sip.difbroker.com hanging up, cause:
> NORMAL_UNSPECIFIED
> recv 340 bytes from udp/[172.28.129.249]:5060 at 13:15:18.996214:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 OK
>    Via: SIP/2.0/UDP 80.251.161.254:11000
> ;rport=11000;received=172.28.129.249;branch=z9hG4bKm9pF6KSZgjj6Q
>    Call-ID: eac00fdc-bb31-11e3-bc9c-35dd2b4be3da
>    From: "user3" <sip:user3 at sip.difbroker.com>;tag=r48cjF4j0SQUm
>    To: <sip:user1 at 172.28.129.231>;tag=PF74LQuHxsMZkOqSXrWYfqf.MYX9Cpbh
>    CSeq: 57929377 BYE
>    Content-Length:  0
>
>    ------------------------------------------------------------------------
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:58
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard HANGUP, cause:
> NORMAL_UNSPECIFIED
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:731
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State HANGUP going to sleep
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:744
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Callstate Change ACTIVE ->
> HANGUP
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:499
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State Change CS_HANGUP ->
> CS_REPORTING
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:15:18.976545 [DEBUG] switch_core_state_machine.c:467
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_REPORTING
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:816
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State REPORTING
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:102
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard REPORTING, cause:
> NORMAL_UNSPECIFIED
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:816
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State REPORTING going to
> sleep
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:493
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State Change CS_REPORTING
> -> CS_DESTROY
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_session.c:1383 Send signal
> sofia/sipinterface_1/user3 at sip.difbroker.com [BREAK]
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_session.c:1591 Session 14
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Locked, Waiting on
> external entities
> 2014-04-03 14:15:19.000649 [NOTICE] switch_core_session.c:1609 Session 14
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Ended
> 2014-04-03 14:15:19.000649 [NOTICE] switch_core_session.c:1613 Close
> Channel sofia/sipinterface_1/user3 at sip.difbroker.com [CS_DESTROY]
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:618
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Callstate Change HANGUP ->
> DOWN
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:621
> (sofia/sipinterface_1/user3 at sip.difbroker.com) Running State Change
> CS_DESTROY
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:631
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State DESTROY
> 2014-04-03 14:15:19.000649 [DEBUG] mod_sofia.c:323 sofia/sipinterface_1/
> user3 at sip.difbroker.com SOFIA DESTROY
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:109
> sofia/sipinterface_1/user3 at sip.difbroker.com Standard DESTROY
> 2014-04-03 14:15:19.000649 [DEBUG] switch_core_state_machine.c:631
> (sofia/sipinterface_1/user3 at sip.difbroker.com) State DESTROY going to
> sleep
> send 688 bytes to udp/[80.251.161.254]:5060 at 13:15:19.965638:
>    ------------------------------------------------------------------------
>    BYE sip:user3 at 112.196.33.74:4713;ob SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKK0Xp4r8UK9UKc
>    Route: <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    Max-Forwards: 70
>    From: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    To: <sip:user3 at sip.difbroker.com>;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 57929395 BYE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, path, replaces
>    Reason: SIP;cause=408;text="ACK Timeout"
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> send 688 bytes to udp/[80.251.161.254]:5060 at 13:15:21.968199:
>    ------------------------------------------------------------------------
>    BYE sip:user3 at 112.196.33.74:4713;ob SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKK0Xp4r8UK9UKc
>    Route: <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    Max-Forwards: 70
>    From: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    To: <sip:user3 at sip.difbroker.com>;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 57929395 BYE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, path, replaces
>    Reason: SIP;cause=408;text="ACK Timeout"
>    Content-Length: 0
>
>    ------------------------------------------------------------------------
> send 688 bytes to udp/[80.251.161.254]:5060 at 13:15:25.971941:
>    ------------------------------------------------------------------------
>    BYE sip:user3 at 112.196.33.74:4713;ob SIP/2.0
>    Via: SIP/2.0/UDP 80.251.161.254:11000;rport;branch=z9hG4bKK0Xp4r8UK9UKc
>    Route: <sip:80.251.161.254;lr=on;ftag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u>
>    Max-Forwards: 70
>    From: <sip:1001 at sip.difbroker.com>;tag=QUFmgmKF3g18r
>    To: <sip:user3 at sip.difbroker.com>;tag=a93uzpsvf1lldFdAo.iO.ILqQH-P9U9u
>    Call-ID: jU74CGX9gw-rGt1yebJQeDjRfsi-WKBE
>    CSeq: 57929395 BYE
>    Contact: <sip:1001 at 80.251.161.254:11000;transport=udp>
>    User-Agent: 2600hz
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE,
> REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
>    Supported: precondition, path, replaces
>    Reason: SIP;cause=408;text="ACK Timeout"
>    Content-Length: 0
>

Please can anyone give me some suggestions to get rid of this problem.

Thanks,
Anurag Mishra
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140404/03b81e12/attachment-0001.html 


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