from freeswitch:
2013-10-16 15:17:21.920508 [INFO] sofia.c:8180 204.101.1.8 is a proxy according to the authoritative acl
2013-10-16 15:17:21.920508 [WARNING] sofia_reg.c:1457 SIP auth challenge (INVITE) on sofia profile 'sipinterface_1' for [*
674166...@mifone.ca] from ip 204.101.1.8
2013-10-16 15:17:22.030504 [INFO] sofia.c:8180 204.101.1.8 is a proxy according to the authoritative acl
2013-10-16 15:17:22.030504 [NOTICE] switch_channel.c:941 New Channel
sofia/sipinterface_1/use...@mifone.ca:5060 [d7fe5cafcba4b423]
2013-10-16 15:17:22.030504 [INFO] mod_dialplan_xml.c:485 Processing user_zdgwvg <user_zdgwvg>->*674166248187 in context context_2
2013-10-16 15:17:22.060505 [NOTICE] mod_dptools.c:1485
log|d7fe5cafcba4b423|ecal...@app.mifone.ca won call control
2013-10-16 15:17:22.060505 [NOTICE] handle_msg.c:797 log|d7fe5cafcba4b423|executing export ecallmgr_Billing-ID=72dd1cc3de0e0f57508a64c541ffcf9d
2013-10-16 15:17:22.060505 [NOTICE] handle_msg.c:797 log|d7fe5cafcba4b423|executing set ecallmgr_Billing-ID=72dd1cc3de0e0f57508a64c541ffcf9d
2013-10-16 15:17:22.090507 [NOTICE] handle_msg.c:797 log|d7fe5cafcba4b423|executing multiset ^^|effective_caller_id_name=Halex|effective_caller_id_number=9057636529|ecallmgr_Billing-ID=72dd1cc3de0e0f57508a64c541ffcf9d|ecallmgr_Username=user_zdgwvg|ecallmgr_Realm=
mifone.ca|ecallmgr_Account-ID=9fface975564c3cba055a3ff9c7ff593|ecallmgr_Authorizing-ID=041cdfa8cc30bde64160508dbc6839e2|ecallmgr_Authorizing-Type=device|ecallmgr_Owner-ID=46e039f79c3502df43c918b5835f9d7c|ecallmgr_Inception=on-net
2013-10-16 15:17:22.120506 [NOTICE] handle_msg.c:797 log|d7fe5cafcba4b423|executing privacy full
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: export hold_music=${hold_music}
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: set import=hold_music
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: set failure_causes=NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: set continue_on_fail=true
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: bridge {call_timeout=60,ecallmgr_Bridge-ID='e282c9656e3770ddd2e7c162cc808f0e',local_var_clobber='true'}[sip_auth_password='',sip_auth_username='',ecallmgr_Global-Resource='false',ecallmgr_Resource-ID='324111e00dc083446ec140eda7af8fc9',ignore_display_updates='true',sip_from_uri='
sip:90576...@mifone.ca',ecallmgr_Reseller-ID='5abd1c820ce83b9bb314dffdbebf16c1',ecallmgr_Account-ID='9fface975564c3cba055a3ff9c7ff593',absolute_codec_string='^^:PCMU:PCMA',leg_progress_timeout='10',effective_caller_id_number='9057636529',effective_caller_id_name='Halex']sofia/sipinterface_1/
14166...@trunkingserver.com2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: event Event-Name=CUSTOM,Event-Subclass=whistle::masquerade,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=bridge
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:814 log|d7fe5cafcba4b423|building xferext extension: park
2013-10-16 15:17:23.380507 [NOTICE] handle_msg.c:817 log|d7fe5cafcba4b423|transfered call to xferext extension
2013-10-16 15:17:23.390506 [NOTICE] switch_channel.c:941 New Channel
sofia/sipinterface_1/14166...@trunkingserver.com [0ed220d6-3676-11e3-99df-273c0468ce4c]
2013-10-16 15:17:23.390506 [INFO] switch_nat.c:590 NAT port mapping disabled
2013-10-16 15:17:23.390506 [INFO] switch_nat.c:590 NAT port mapping disabled
2013-10-16 15:17:28.230506 [NOTICE] sofia_glue.c:4176 Pre-Answer
sofia/sipinterface_1/14166...@trunkingserver.com!
2013-10-16 15:17:28.230506 [INFO] switch_ivr_originate.c:3309 Sending early media
2013-10-16 15:17:28.230506 [NOTICE] sofia_glue.c:4176 Pre-Answer
sofia/sipinterface_1/use...@mifone.ca:5060!
2013-10-16 15:17:28.830505 [INFO] switch_rtp.c:3577 Auto Changing port from
204.101.1.8:5000 to
204.101.1.3:8960
sip trace:
U 2013/10/16 15:20:30.080669
204.101.104.130:58188 ->
204.101.1.8:5060INVITE sip:*
674166...@mifone.ca:5060 SIP/2.0.
Via: SIP/2.0/UDP 192.168.1.154;branch=z9hG4bK456576609f1ee6272.
Max-Forwards: 70.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 INVITE.
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, UPDATE, PRACK, SUBSCRIBE, INFO.
Allow-Events: talk, hold, conference, LocalModeStatus.
Contact: <sip:user_...@204.101.1.1:58188;transport=udp>;+sip.instance="<urn:uuid:00000000-0000-1000-8000-00085D204DDB>".
Supported: path, 100rel, replaces.
User-Agent: Aastra 53i/3.2.2.3077.
Content-Type: application/sdp.
Content-Length: 306.
.
v=0.
o=MxSIP 0 1 IN IP4 192.168.1.154.
s=SIP Call.
c=IN IP4 192.168.1.154.
t=0 0.
m=audio 5000 RTP/AVP 0 8 18 101.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=silenceSupp:off - - - -.
a=fmtp:18 annexb=no.
a=fmtp:101 0-15.
a=ptime:30.
a=sendrecv.
U 2013/10/16 15:20:30.081055
204.101.1.8:5060 ->
204.101.1.3:58188SIP/2.0 100 Giving a try.
Via: SIP/2.0/UDP 192.168.1.154;branch=z9hG4bK456576609f1ee6272;rport=58188;received=204.101.1.3.
From: <
sip:use...@mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 INVITE.
Server: Mifone Platform.
Content-Length: 0.
.
U 2013/10/16 15:20:30.081090
204.101.1.8:5060 ->
204.101.1.3:5060INVITE sip:*
674166...@204.101.1.3:5060 SIP/2.0.
Record-Route: <sip:204.101.1.8;lr=on;ftag=20b49f01fa>.
Via: SIP/2.0/UDP 204.101.1.8;branch=z9hG4bKa8db.e6beef1.0.
Via: SIP/2.0/UDP 192.168.1.154;rport=58188;received=204.101.1.3;branch=z9hG4bK456576609f1ee6272.
Max-Forwards: 30.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*674166248187@.
mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 INVITE.
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, UPDATE, PRACK, SUBSCRIBE, INFO.
Allow-Events: talk, hold, conference, LocalModeStatus.
Contact: <sip:user_...@204.101.1.3:58188;transport=udp>;+sip.instance="<urn:uuid:00000000-0000-1000-8000-00085D204DDB>".
Supported: path, 100rel, replaces.
User-Agent: Aastra 53i/3.2.2.3077.
Content-Type: application/sdp.
Content-Length: 366.
X-AUTH-IP: 204.101.1.3.
.
v=0.
o=MxSIP 0 1 IN IP4 204.101.1.3.
s=SIP Call.
c=IN IP4 204.101.104.130.
t=0 0.
m=audio 5000 RTP/AVP 0 8 18 101.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=silenceSupp:off - - - -.
a=fmtp:18 annexb=no.
a=fmtp:101 0-15.
a=ptime:30.
a=sendrecv.
a=oldmediaip:192.168.1.154.
a=oldmediaip:192.168.1.154.
U 2013/10/16 15:20:30.081984
204.101.1.3:5060 ->
204.101.1.8:5060SIP/2.0 100 Trying.
Via: SIP/2.0/UDP 204.101.1.8;branch=z9hG4bKa8db.e6beef1.0.
Via: SIP/2.0/UDP 192.168.1.154;rport=58188;received=204.101.1.3;branch=z9hG4bK456576609f1ee6272.
Record-Route: <sip:204.101.104.248;lr=on;ftag=20b49f01fa>.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 INVITE.
User-Agent: 2600hz.
Content-Length: 0.
.
U 2013/10/16 15:20:30.082890
204.101.1.3:5060 ->
204.101.1.8:5060SIP/2.0 407 Proxy Authentication Required.
Via: SIP/2.0/UDP 204.101.1.8;branch=z9hG4bKa8db.e6beef1.0.
Via: SIP/2.0/UDP 192.168.1.154;rport=58188;received=204.101.104.130;branch=z9hG4bK456576609f1ee6272.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>;tag=4vK6g4vSpZD4e.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 INVITE.
User-Agent: 2600hz.
Accept: application/sdp.
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE.
Supported: precondition, path, replaces.
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer.
Proxy-Authenticate: Digest realm="
mifone.ca", nonce="0df22152-3676-11e3-99ca-273c0468ce4c", algorithm=MD5, qop="auth".
Content-Length: 0.
.
U 2013/10/16 15:20:30.083055
204.101.1.8:5060 ->
204.101.1.3:58188SIP/2.0 407 Proxy Authentication Required.
Via: SIP/2.0/UDP 192.168.1.154;rport=58188;received=204.101.1.3;branch=z9hG4bK456576609f1ee6272.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*674166248187@.
mifone.ca:5060>;tag=4vK6g4vSpZD4e.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 INVITE.
User-Agent: 2600hz.
Accept: application/sdp.
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE.
Supported: precondition, path, replaces.
Allow-Events: talk, hold, conference, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer.
Proxy-Authenticate: Digest realm=".
mifone.ca", nonce="0df22152-3676-11e3-99ca-273c0468ce4c", algorithm=MD5, qop="auth".
Content-Length: 0.
.
U 2013/10/16 15:20:30.152024
204.101.1.3:58188 ->
204.101.1.8:5060ACK sip:*
674166...@mifone.ca:5060 SIP/2.0.
Via: SIP/2.0/UDP 192.168.1.154;branch=z9hG4bK456576609f1ee6272.
Max-Forwards: 70.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>;tag=4vK6g4vSpZD4e.
Call-ID: d7fe5cafcba4b423.
CSeq: 9284 ACK.
User-Agent: Aastra 53i/3.2.2.3077.
Content-Length: 0.
.
U 2013/10/16 15:20:30.187076
204.101.1.3:58188 ->
204.101.1.8:5060INVITE sip:*
674166...@mifone.ca:5060 SIP/2.0.
Via: SIP/2.0/UDP 192.168.1.154;branch=z9hG4bKab44af73860d048fc.
Proxy-Authorization: Digest username="user_zdgwvg",realm=".
mifone.ca",nonce="0df22152-3676-11e3-99ca-273c0468ce4c",uri="sip:*
674166...@mifone.ca:5060",response="aea3341e4e6838f9a389c
Max-Forwards: 70.
From: <sip:user_z@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*674166248187@.
mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9285 INVITE.
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, UPDATE, PRACK, SUBSCRIBE, INFO.
Allow-Events: talk, hold, conference, LocalModeStatus.
Contact: <sip:user_...@204.101.104.130:58188;transport=udp>;+sip.instance="<urn:uuid:00000000-0000-1000-8000-00085D204DDB>".
Supported: path, 100rel, replaces.
User-Agent: Aastra 53i/3.2.2.3077.
Content-Type: application/sdp.
Content-Length: 306.
.
v=0.
o=MxSIP 0 1 IN IP4 192.168.1.154.
s=SIP Call.
c=IN IP4 192.168.1.154.
t=0 0.
m=audio 5000 RTP/AVP 0 8 18 101.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=silenceSupp:off - - - -.
a=fmtp:18 annexb=no.
a=fmtp:101 0-15.
a=ptime:30.
a=sendrecv.
U 2013/10/16 15:20:30.187387
204.101.1.8:5060 ->
204.101.1.3:58188SIP/2.0 100 Giving a try.
Via: SIP/2.0/UDP 192.168.1.154;branch=z9hG4bKab44af73860d048fc;rport=58188;received=204.101.1.3.
From: <sip:user_zg@.
mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9285 INVITE.
Server: Mifone Platform.
Content-Length: 0.
.
U 2013/10/16 15:20:30.187433
204.101.1.8:5060 ->
204.101.1.3:5060INVITE sip:*
674166...@204.101.1.3:5060 SIP/2.0.
Record-Route: <sip:204.101.104.248;lr=on;ftag=20b49f01fa>.
Via: SIP/2.0/UDP 204.101.104.248;branch=z9hG4bKb8db.78ed50a1.0.
Via: SIP/2.0/UDP 192.168.1.154;rport=58188;received=204.101.104.130;branch=z9hG4bKab44af73860d048fc.
Proxy-Authorization: Digest username="user_zdgwvg",realm="
mifone.ca",nonce="0df22152-3676-11e3-99ca-273c0468ce4c",uri="sip:*
674166...@mifone.ca:5060",response="aea3341e4e6838f9a389c
Max-Forwards: 30.
From: <
sip:use...@mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9285 INVITE.
Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, OPTIONS, UPDATE, PRACK, SUBSCRIBE, INFO.
Allow-Events: talk, hold, conference, LocalModeStatus.
Contact: <sip:user_...@204.101.104.130:58188;transport=udp>;+sip.instance="<urn:uuid:00000000-0000-1000-8000-00085D204DDB>".
Supported: path, 100rel, replaces.
User-Agent: Aastra 53i/3.2.2.3077.
Content-Type: application/sdp.
Content-Length: 366.
X-AUTH-IP: 204.101.104.130.
.
v=0.
o=MxSIP 0 1 IN IP4 204.101.104.130.
s=SIP Call.
c=IN IP4 204.101.104.130.
t=0 0.
m=audio 5000 RTP/AVP 0 8 18 101.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=silenceSupp:off - - - -.
a=fmtp:18 annexb=no.
a=fmtp:101 0-15.
a=ptime:30.
a=sendrecv.
a=oldmediaip:192.168.1.15
U 2013/10/16 15:20:30.188379
204.101.1.3:5060 ->
204.101.104.248:5060SIP/2.0 100 Trying.
Via: SIP/2.20/UDP 204.101.1.8;branch=z9hG4bKb8db.78ed50a1.0.
Via: SIP/2.0/UDP 192.168.1.4;rport=58188;received=204.101.104.130;branch=z9hG4bKab44af73860d048fc.
Record-Route: <sip:204.101.104.248;lr=on;ftag=20b49f01fa>.
From: <
sip:use...@mifone.ca:5060>;tag=20b49f01fa.
To: <sip:*
674166...@mifone.ca:5060>.
Call-ID: d7fe5cafcba4b423.
CSeq: 9285 INVITE.
User-Agent: 2600hz.
Content-Length: 0.