   ------------------------------------------------------------------------
recv 770 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.086330:
   ------------------------------------------------------------------------
   INVITE sip:0834898423@sip.server.com:5060 SIP/2.0
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 1 INVITE
   Max-Forwards: 70
   Contact: 27816011943 <sip:27816011943@XXX.XXX.XXX.XXX:266>
   Expires: 240
   User-Agent: iTelMobileDialer-2.10
   Content-Length: 229
   Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS
   Content-Type: application/sdp
   
   v=0
   o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
   s=iTelMobileDialer-2.10
   c=IN IP4 XXX.XXX.XXX.XXX
   t=0 0
   m=audio 28422 RTP/AVP 18 101
   a=rtpmap:18 G729a/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   a=ptime:40
   a=sendrecv
   ------------------------------------------------------------------------
send 377 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.086973:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 1 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:11.078710 [DEBUG] sofia_reg.c:1396 Send challenge for [0834898423@sip.server.com]
2011-10-27 00:02:11.078710 [WARNING] sofia_reg.c:1400 SIP auth challenge (INVITE) on sofia profile 'digestauth' for [0834898423@sip.server.com] from ip XXX.XXX.XXX.XXX
send 869 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.088217:
   ------------------------------------------------------------------------
   SIP/2.0 407 Proxy Authentication Required
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=N57DjtF13QjcF
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 1 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Proxy-Authenticate: Digest realm="sip.server.com", nonce="279448c8-001e-11e1-9326-851ab5c8ac90", algorithm=MD5, qop="auth"
   Content-Length: 0
   
  
   ------------------------------------------------------------------------
2011-10-27 00:02:11.318684 [WARNING] sofia.c:4458 Ping failed sipCodecTranslator with code 503 - count -1/-1/1, state DOWN
recv 401 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.524351:
   ------------------------------------------------------------------------
   ACK sip:0834898423@sip.server.com:5060 SIP/2.0
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;rport;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=N57DjtF13QjcF
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 1 ACK
   Max-Forwards: 70
   User-Agent: iTelMobileDialer-2.10
   Content-Length: 0
   
   ------------------------------------------------------------------------
recv 977 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.534311:
   ------------------------------------------------------------------------
   INVITE sip:0834898423@sip.server.com:5060 SIP/2.0
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 2 INVITE
   Max-Forwards: 70
   Proxy-Authorization: Digest username="27816011943", realm="sip.server.com", nonce="279448c8-001e-11e1-9326-851ab5c8ac90", uri="sip:0834898423@XXX.XXX.XXX.XXX:290", response="4014354c23f33269e4d3e15968212b06"
   Contact: 27816011943 <sip:27816011943@XXX.XXX.XXX.XXX:266>
   Expires: 240
   User-Agent: iTelMobileDialer-2.10
   Content-Length: 229
   Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS
   Content-Type: application/sdp
   
   v=0
   o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
   s=iTelMobileDialer-2.10
   c=IN IP4 XXX.XXX.XXX.XXX
   t=0 0
   m=audio 28422 RTP/AVP 18 101
   a=rtpmap:18 G729a/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   a=ptime:40
   a=sendrecv
   ------------------------------------------------------------------------
send 377 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.534926:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 2 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:11.558890 [DEBUG] sofia_reg.c:2669 event_add_header -> 'radauth' = '4014354c23f33269e4d3e15968212b06;sip.server.com;279448c8-001e-11e1-9326-851ab5c8ac90;INVITE;27816011943;sip:0834898423@XXX.XXX.XXX.XXX:290;;;'
2011-10-27 00:02:11.558890 [NOTICE] switch_channel.c:908 New Channel sofia/digestauth/27816011943@sip.server.com:5060 [27dc9740-001e-11e1-9328-851ab5c8ac90]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_NEW
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:354 (sofia/digestauth/27816011943@sip.server.com:5060) State NEW
2011-10-27 00:02:11.558890 [DEBUG] sofia.c:5156 Channel sofia/digestauth/27816011943@sip.server.com:5060 entering state [received][100]
2011-10-27 00:02:11.558890 [DEBUG] sofia.c:5167 Remote SDP:
v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40

2011-10-27 00:02:11.558890 [DEBUG] sofia.c:5331 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_NEW -> CS_INIT
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_INIT
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:375 (sofia/digestauth/27816011943@sip.server.com:5060) State INIT
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:85 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA INIT
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:125 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_INIT -> CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:375 (sofia/digestauth/27816011943@sip.server.com:5060) State INIT going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_channel.c:1837 (sofia/digestauth/27816011943@sip.server.com:5060) Callstate Change DOWN -> RINGING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:148 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:78 sofia/digestauth/27816011943@sip.server.com:5060 Standard ROUTING
2011-10-27 00:02:11.558890 [INFO] mod_dialplan_xml.c:336 Processing 27816011943 <27816011943>->0834898423 in context digestauth
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->unloop] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->info] continue=true
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [info] destination_number(0834898423) =~ /\d+$/ break=never
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action log(INFO Useragent pre-dial: ${sip_user_agent}) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->billbery_aaa_load_billberry_top_up] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (FAIL) [billbery_aaa_load_billberry_top_up] destination_number(0834898423) =~ /(\*101\*\d{12}#)$/ break=always
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->billbery_aaa_load_ukash] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (FAIL) [billbery_aaa_load_ukash] destination_number(0834898423) =~ /(\*\d{19}\*\d+)[#]*$/ break=always
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->reformat_to_e164_int] continue=true
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (FAIL) [reformat_to_e164_int] destination_number(0834898423) =~ /^00(\d+)$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->reformat_to_e164_plus] continue=true
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (FAIL) [reformat_to_e164_plus] destination_number(0834898423) =~ /^\+(\d+)$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->reformat_to_e164_local] continue=true
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [reformat_to_e164_local] destination_number(0834898423) =~ /^0(\d+)$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action log(INFO Reformatting a local number to e164) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action set(destination_number=27834898643) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action transfer(27834898643 XML ua_routing) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [digestauth->reformat_to_e164_pass_through] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [reformat_to_e164_pass_through] destination_number(0834898423) =~ /^(\d+)$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action log(INFO Already in  e164) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action transfer(0834898423 XML ua_routing) 
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:128 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_ROUTING -> CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:241 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:166 sofia/digestauth/27816011943@sip.server.com:5060 Standard EXECUTE
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 log(INFO Useragent pre-dial: iTelMobileDialer-2.10)
2011-10-27 00:02:11.558890 [INFO] mod_dptools.c:1306 Useragent pre-dial: iTelMobileDialer-2.10
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 log(INFO Reformatting a local number to e164)
2011-10-27 00:02:11.558890 [INFO] mod_dptools.c:1306 Reformatting a local number to e164
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(destination_number=27834898643)
2011-10-27 00:02:11.558890 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [destination_number]=[27834898643]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 transfer(27834898643 XML ua_routing)
2011-10-27 00:02:11.558890 [DEBUG] switch_ivr.c:1693 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_EXECUTE -> CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [NOTICE] switch_ivr.c:1699 Transfer sofia/digestauth/27816011943@sip.server.com:5060 to XML[27834898643@ua_routing]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:148 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:78 sofia/digestauth/27816011943@sip.server.com:5060 Standard ROUTING
2011-10-27 00:02:11.558890 [INFO] mod_dialplan_xml.c:336 Processing 27816011943 <27816011943>->27834898643 in context ua_routing
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [ua_routing->billbery_aaa_blackberry] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (FAIL) [billbery_aaa_blackberry] ${cond(${sip_user_agent} == BlackberryVoipDialer ? YES : NO)}(NO) =~ /^YES$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [ua_routing->billbery_aaa_generic_ua] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [billbery_aaa_generic_ua] destination_number(27834898643) =~ /^(\d+)$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action log(INFO Useragent: ${sip_user_agent}) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action transfer(27834898643 XML generic_ua) 
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:128 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_ROUTING -> CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:241 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:166 sofia/digestauth/27816011943@sip.server.com:5060 Standard EXECUTE
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 log(INFO Useragent: iTelMobileDialer-2.10)
2011-10-27 00:02:11.558890 [INFO] mod_dptools.c:1306 Useragent: iTelMobileDialer-2.10
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 transfer(27834898643 XML generic_ua)
2011-10-27 00:02:11.558890 [DEBUG] switch_ivr.c:1693 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_EXECUTE -> CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [NOTICE] switch_ivr.c:1699 Transfer sofia/digestauth/27816011943@sip.server.com:5060 to XML[27834898643@generic_ua]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:148 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:78 sofia/digestauth/27816011943@sip.server.com:5060 Standard ROUTING
2011-10-27 00:02:11.558890 [INFO] mod_dialplan_xml.c:336 Processing 27816011943 <27816011943>->27834898643 in context generic_ua
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [generic_ua->g729_sdp_mangler] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [g729_sdp_mangler] destination_number(27834898643) =~ /^(.+)$/ break=on-false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action set(transfer_to=${destination_number} XML fail) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [g729_sdp_mangler] ${switch_r_sdp}(v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40
) =~ //(.*)(m=audio \d+ RTP\/AVP)(?=[ \d]+18|18[ \d]+)([ \d]*)(.*)/s/ break=never
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action set(codec_mangle= 18) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action set(transfer_to=${destination_number} XML billbery_aaa_generic_ua) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [g729_sdp_mangler] ${switch_r_sdp}(v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40
) =~ //(.*)(m=audio \d+ RTP\/AVP)(?=[ \d]+0|0[ \d]+)([ \d]*)(.*)/s/ break=never
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action set(codec_mangle=${codec_mangle} 0) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [g729_sdp_mangler] ${switch_r_sdp}(v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40
) =~ //(.*)(m=audio \d+ RTP\/AVP)([ \d]+)(.*)/s/ break=never
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action set(switch_r_sdp=v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP${codec_mangle} 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40
) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Absolute Condition [g729_sdp_mangler]
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action transfer(${transfer_to}) 
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:128 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_ROUTING -> CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:241 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:166 sofia/digestauth/27816011943@sip.server.com:5060 Standard EXECUTE
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(transfer_to=27834898643 XML fail)
2011-10-27 00:02:11.558890 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [transfer_to]=[27834898643 XML fail]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(codec_mangle= 18)
2011-10-27 00:02:11.558890 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [codec_mangle]=[ 18]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(transfer_to=27834898643 XML billbery_aaa_generic_ua)
2011-10-27 00:02:11.558890 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [transfer_to]=[27834898643 XML billbery_aaa_generic_ua]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(codec_mangle= 18 0)
2011-10-27 00:02:11.558890 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [codec_mangle]=[ 18 0]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(switch_r_sdp=v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 0 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40
)
2011-10-27 00:02:11.558890 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [switch_r_sdp]=[v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 0 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40
]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 transfer(27834898643 XML billbery_aaa_generic_ua)
2011-10-27 00:02:11.558890 [DEBUG] switch_ivr.c:1693 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_EXECUTE -> CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [NOTICE] switch_ivr.c:1699 Transfer sofia/digestauth/27816011943@sip.server.com:5060 to XML[27834898643@billbery_aaa_generic_ua]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:148 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA ROUTING
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:78 sofia/digestauth/27816011943@sip.server.com:5060 Standard ROUTING
2011-10-27 00:02:11.558890 [INFO] mod_dialplan_xml.c:336 Processing 27816011943 <27816011943>->27834898643 in context billbery_aaa_generic_ua
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 parsing [billbery_aaa_generic_ua->billbery_aaa] continue=false
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Regex (PASS) [billbery_aaa] destination_number(27834898643) =~ /^(.*)$/ break=always
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action log(INFO Generic UA context) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action log(INFO Useragent: ${sip_user_agent}) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action export(absolute_codec_string=G729) 
Dialplan: sofia/digestauth/27816011943@sip.server.com:5060 Action socket(127.0.0.1:8084 async) 
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:128 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_ROUTING -> CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:384 (sofia/digestauth/27816011943@sip.server.com:5060) State ROUTING going to sleep
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] mod_sofia.c:241 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA EXECUTE
2011-10-27 00:02:11.558890 [DEBUG] switch_core_state_machine.c:166 sofia/digestauth/27816011943@sip.server.com:5060 Standard EXECUTE
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 log(INFO Generic UA context)
2011-10-27 00:02:11.558890 [INFO] mod_dptools.c:1306 Generic UA context
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 log(INFO Useragent: iTelMobileDialer-2.10)
2011-10-27 00:02:11.558890 [INFO] mod_dptools.c:1306 Useragent: iTelMobileDialer-2.10
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 export(absolute_codec_string=G729)
2011-10-27 00:02:11.558890 [DEBUG] switch_channel.c:1075 EXPORT (export_vars) [absolute_codec_string]=[G729]
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 socket(127.0.0.1:8084 async)

2011-10-27 00:02:11.718724 [DEBUG] switch_core_session.c:1007 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.718724 [DEBUG] switch_ivr.c:577 sofia/digestauth/27816011943@sip.server.com:5060 Command Execute sched_hangup(+228)
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 sched_hangup(+228)
2011-10-27 00:02:11.718724 [DEBUG] switch_scheduler.c:214 Added task 34 switch_ivr_schedule_hangup (27dc9740-001e-11e1-9328-851ab5c8ac90) to run at 1319666759
2011-10-27 00:02:11.718724 [DEBUG] switch_core_session.c:1007 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.718724 [DEBUG] switch_core_session.c:1007 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:1007 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:1007 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr.c:577 sofia/digestauth/27816011943@sip.server.com:5060 Command Execute set(hangup_after_bridge=true)
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(hangup_after_bridge=true)
2011-10-27 00:02:11.738731 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [hangup_after_bridge]=[true]
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr.c:577 sofia/digestauth/27816011943@sip.server.com:5060 Command Execute set(uuid_bridge_continue_on_cancel=true)
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(uuid_bridge_continue_on_cancel=true)
2011-10-27 00:02:11.738731 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [uuid_bridge_continue_on_cancel]=[true]
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr.c:577 sofia/digestauth/27816011943@sip.server.com:5060 Command Execute set(continue_on_fail=true)
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 set(continue_on_fail=true)
2011-10-27 00:02:11.738731 [DEBUG] mod_dptools.c:1167 sofia/digestauth/27816011943@sip.server.com:5060 SET [continue_on_fail]=[true]
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr.c:577 sofia/digestauth/27816011943@sip.server.com:5060 Command Execute bridge([origination_uuid=27f4f146-001e-11e1-b9ce-0014221086ec,origination_caller_id_number=27816011943]sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ)
EXECUTE sofia/digestauth/27816011943@sip.server.com:5060 bridge([origination_uuid=27f4f146-001e-11e1-b9ce-0014221086ec,origination_caller_id_number=27816011943]sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ)
2011-10-27 00:02:11.738731 [DEBUG] switch_channel.c:1029 sofia/digestauth/27816011943@sip.server.com:5060 EXPORTING[export_vars] [absolute_codec_string]=[G729] to event
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr_originate.c:1873 Parsing global variables
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr_originate.c:2288 Parsing session specific variables
2011-10-27 00:02:11.738731 [DEBUG] switch_event.c:1416 Parsing variable [origination_uuid]=[27f4f146-001e-11e1-b9ce-0014221086ec]
2011-10-27 00:02:11.738731 [DEBUG] switch_event.c:1416 Parsing variable [origination_caller_id_number]=[27816011943]
2011-10-27 00:02:11.738731 [NOTICE] switch_channel.c:908 New Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [27f8d93c-001e-11e1-9329-851ab5c8ac90]
2011-10-27 00:02:11.738731 [DEBUG] mod_sofia.c:4491 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State Change CS_NEW -> CS_INIT
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:506 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ set UUID=27f4f146-001e-11e1-b9ce-0014221086ec
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:336 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_INIT
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:375 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State INIT
2011-10-27 00:02:11.738731 [DEBUG] mod_sofia.c:85 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ SOFIA INIT
2011-10-27 00:02:11.738731 [DEBUG] sofia_glue.c:1817 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ Patched SDP
---
v=0
o=- 22469580 22469580 IN IP4 XXX.XXX.XXX.XXX
s=iTelMobileDialer-2.10
c=IN IP4 XXX.XXX.XXX.XXX
t=0 0
m=audio 28422 RTP/AVP 18 0 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40

+++
v=0
o=FreeSWITCH 1213443808 1213443809 IN IP4 YYY.YYY.YYY.YYY
s=FreeSWITCH
c=IN IP4 YYY.YYY.YYY.YYY
t=0 0
m=audio 16890 RTP/AVP 18 0 101
a=rtpmap:18 G729a/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:40

2011-10-27 00:02:11.738731 [DEBUG] mod_sofia.c:125 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State Change CS_INIT -> CS_ROUTING
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:375 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State INIT going to sleep
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:336 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_ROUTING
2011-10-27 00:02:11.738731 [DEBUG] switch_channel.c:1837 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Callstate Change DOWN -> RINGING
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:384 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State ROUTING
2011-10-27 00:02:11.738731 [DEBUG] mod_sofia.c:148 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ SOFIA ROUTING
2011-10-27 00:02:11.738731 [DEBUG] switch_ivr_originate.c:66 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:384 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State ROUTING going to sleep
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:336 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_CONSUME_MEDIA
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:403 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State CONSUME_MEDIA
2011-10-27 00:02:11.738731 [DEBUG] switch_core_state_machine.c:403 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State CONSUME_MEDIA going to sleep
send 1030 bytes to udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:11.749354:
   ------------------------------------------------------------------------
   INVITE sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport;branch=z9hG4bKZya69ca53FXrS
   Max-Forwards: 66
   From: "27816011943" <sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437D
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 INVITE
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5062>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 221
   X-FS-Support: update_display
   Remote-Party-ID: "27816011943" <sip:27816011943@YYY.YYY.YYY.YYY>;party=calling;screen=yes;privacy=off
   
   v=0
   o=FreeSWITCH 1213443808 1213443809 IN IP4 YYY.YYY.YYY.YYY
   s=FreeSWITCH
   c=IN IP4 YYY.YYY.YYY.YYY
   t=0 0
   m=audio 16890 RTP/AVP 18 0 101
   a=rtpmap:18 G729a/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   a=ptime:40
   ------------------------------------------------------------------------
2011-10-27 00:02:11.738731 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:11.738731 [DEBUG] sofia.c:5156 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ entering state [calling][0]
recv 286 bytes from udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:11.774218:
   ------------------------------------------------------------------------
   SIP/2.0 100 Trying
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport=5062;branch=z9hG4bKZya69ca53FXrS
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>
   From: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437D
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 INVITE
   Content-Length: 0
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:11.798220:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509000
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111000
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=N57DjtF13QjcF
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497194 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------

freeswitch@internal> send 706 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:12.392980:
   ------------------------------------------------------------------------
   SIP/2.0 487 Request Terminated
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450902027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11101027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=320FjK01QQ1Ue
   Call-ID: 27816011943420565956@192.168.21.120
   CSeq: 4 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Content-Length: 0
   
   ------------------------------------------------------------------------
recv 413 bytes from udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:12.548744:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport=5062;branch=z9hG4bKZya69ca53FXrS
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ:5071;lr>
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ;lr>
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=jkcthd7ucmlgheqc.i
   From: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437D
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 INVITE
   Server: Sippy
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:12.538702 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:12.538702 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:12.538702 [DEBUG] sofia.c:5156 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ entering state [proceeding][183]
2011-10-27 00:02:12.538702 [NOTICE] sofia.c:5235 Ring-Ready sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ!
2011-10-27 00:02:12.538702 [NOTICE] mod_sofia.c:2388 Ring-Ready sofia/digestauth/27816011943@sip.server.com:5060!
send 875 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:12.550185:
   ------------------------------------------------------------------------
   SIP/2.0 180 Ringing
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=S9cHS6jFrUBQD
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 2 INVITE
   Contact: <sip:0834898423@YYY.YYY.YYY.YYY:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Accept: application/sdp
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Content-Length: 0
   Remote-Party-ID: "Outbound Call" <sip:0834898423@YYY.YYY.YYY.YYY>;party=calling;privacy=off;screen=no
   
   ------------------------------------------------------------------------
2011-10-27 00:02:12.538702 [DEBUG] switch_core_session.c:870 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.538702 [DEBUG] sofia.c:5156 Channel sofia/digestauth/27816011943@sip.server.com:5060 entering state [early][180]
2011-10-27 00:02:12.538702 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.538702 [NOTICE] switch_ivr_originate.c:481 Ring Ready sofia/digestauth/27816011943@sip.server.com:5060!
recv 436 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:12.551227:
   ------------------------------------------------------------------------
   ACK sip:0834898423@XXX.XXX.XXX.XXX:290 SIP/2.0
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;rport;branch=z9hG4bK450902027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11101027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=320FjK01QQ1Ue
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 4 ACK
   Contact: <sip:27816011943@XXX.XXX.XXX.XXX:290>
   Max-Forwards: 70
   User-Agent: iTelMobileDialer-2.10
   Content-Length: 0
   
   ------------------------------------------------------------------------
recv 609 bytes from udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:12.561746:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport=5062;branch=z9hG4bKZya69ca53FXrS
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ:5071;lr>
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ;lr>
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=jkcthd7ucmlgheqc.i
   From: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437D
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 INVITE
   Content-Type: application/sdp
   Server: Sippy
   Content-Length: 163
   
   v=0
   o=Sippy 825135544 1 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
   s=-
   t=0 0
   m=audio 62432 RTP/AVP 18 101
   c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] sofia.c:5156 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ entering state [proceeding][183]
2011-10-27 00:02:12.558700 [DEBUG] sofia.c:5167 Remote SDP:
v=0
o=Sippy 825135544 1 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
s=-
t=0 0
m=audio 62432 RTP/AVP 18 101
c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2011-10-27 00:02:12.558700 [NOTICE] sofia.c:5250 Pre-Answer sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ!
2011-10-27 00:02:12.558700 [DEBUG] switch_channel.c:2874 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Callstate Change RINGING -> EARLY
2011-10-27 00:02:12.558700 [DEBUG] switch_channel.c:2916 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:2857 Set Codec sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ PROXY/8000 20 ms 160 samples 0 bits
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3174 PROXY AUDIO RTP [sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ] YYY.YYY.YYY.YYY:16890->ZZZ.ZZZ.ZZZ.ZZZ:62432 codec: 0 ms: 20
2011-10-27 00:02:12.558700 [DEBUG] switch_rtp.c:1648 Not using a timer
2011-10-27 00:02:12.558700 [INFO] switch_ivr_originate.c:3189 Sending early media
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:1817 sofia/digestauth/27816011943@sip.server.com:5060 Patched SDP
---
v=0
o=Sippy 825135544 1 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
s=-
t=0 0
m=audio 62432 RTP/AVP 18 101
c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

+++
v=0
o=FreeSWITCH 1213475629 1213475630 IN IP4 YYY.YYY.YYY.YYY
s=FreeSWITCH
t=0 0
m=audio 28080 RTP/AVP 18 101
c=IN IP4 YYY.YYY.YYY.YYY
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:2857 Set Codec sofia/digestauth/27816011943@sip.server.com:5060 PROXY/8000 20 ms 160 samples 0 bits
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3174 PROXY AUDIO RTP [sofia/digestauth/27816011943@sip.server.com:5060] YYY.YYY.YYY.YYY:28080->XXX.XXX.XXX.XXX:28422 codec: 0 ms: 20
2011-10-27 00:02:12.558700 [DEBUG] switch_rtp.c:1648 Not using a timer
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3372 Set 2833 dtmf send payload to 101
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3377 Set 2833 dtmf receive payload to 101
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3395 Set comfort noise payload to 13
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:786 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3372 Set 2833 dtmf send payload to 101
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3377 Set 2833 dtmf receive payload to 101
2011-10-27 00:02:12.558700 [DEBUG] sofia_glue.c:3395 Set comfort noise payload to 13
2011-10-27 00:02:12.558700 [NOTICE] mod_sofia.c:2461 Pre-Answer sofia/digestauth/27816011943@sip.server.com:5060!
2011-10-27 00:02:12.558700 [DEBUG] switch_channel.c:2874 (sofia/digestauth/27816011943@sip.server.com:5060) Callstate Change RINGING -> EARLY
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] switch_ivr_originate.c:3243 Originate Resulted in Success: [sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ]
send 1124 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:12.568981:
   ------------------------------------------------------------------------
   SIP/2.0 183 Session Progress
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=S9cHS6jFrUBQD
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 2 INVITE
   Contact: <sip:0834898423@YYY.YYY.YYY.YYY:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 202
   Remote-Party-ID: "Outbound Call" <sip:0834898423@YYY.YYY.YYY.YYY>;party=calling;privacy=off;screen=no
   
   v=0
   o=FreeSWITCH 1213475629 1213475630 IN IP4 YYY.YYY.YYY.YYY
   s=FreeSWITCH
   c=IN IP4 YYY.YYY.YYY.YYY
   t=0 0
   m=audio 0 RTP/AVP 96 101
   a=rtpmap:96 G729/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:724 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:870 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] sofia.c:5149 Channel sofia/digestauth/27816011943@sip.server.com:5060 skipping state [early][183]
2011-10-27 00:02:12.558700 [DEBUG] mod_sofia.c:1564 sofia/digestauth/27816011943@sip.server.com:5060 activate passthru 2833 mode.
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] switch_ivr_bridge.c:1257 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2011-10-27 00:02:12.558700 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:12.558700 [DEBUG] switch_core_state_machine.c:336 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_EXCHANGE_MEDIA
2011-10-27 00:02:12.558700 [DEBUG] switch_core_state_machine.c:394 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State EXCHANGE_MEDIA
2011-10-27 00:02:12.558700 [DEBUG] mod_sofia.c:566 SOFIA EXCHANGE_MEDIA
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:12.612889:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011010@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK9Q42aK2j51jar
   Max-Forwards: 70
   From: <sip:27816011010@YYY.YYY.YYY.YYY>;tag=9rr4vN5p6c7Bm
   To: <sip:27816011010@YYY.YYY.YYY.YYY>
   Call-ID: f48814f7-7ac0-122f-0391-0014221086ec
   CSeq: 19497192 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011010@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------

freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
recv 600 bytes from udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:13.206374:
   ------------------------------------------------------------------------
freeswitch@internal>    SIP/2.0 180 Ringing
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport=5062;branch=z9hG4bKZya69ca53FXrS
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ:5071;lr>
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ;lr>
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=jkcthd7ucmlgheqc.i
   From: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437D
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 INVITE
   Content-Type: application/sdp
   Server: Sippy
   Content-Length: 163
   
   v=0

freeswitch@internal>    o=Sippy 825135544 2 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
   s=-
   t=0 0
   m=audio 62432 RTP/AVP 18 101
   c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
2011-10-27 00:02:13.198689 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:13.198689 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:13.198689 [DEBUG] sofia.c:5156 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ entering state [proceeding][180]
2011-10-27 00:02:13.198689 [DEBUG] sofia.c:5167 Remote SDP:
v=0
o=Sippy 825135544 2 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
s=-
t=0 0
m=audio 62432 RTP/AVP 18 101
c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2011-10-27 00:02:13.198689 [DEBUG] sofia_glue.c:3079 Audio params are unchanged for sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ.
2011-10-27 00:02:13.198689 [DEBUG] sofia_glue.c:3089 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ Setting audio receive payload in Re-INVITE to 0
2011-10-27 00:02:13.198689 [DEBUG] switch_core_session.c:786 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]

freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:13.521924:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011002@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKa1XUceKp2a9vK
   Max-Forwards: 70
   From: <sip:27816011002@YYY.YYY.YYY.YYY>;tag=DXX73184tg0pj
   To: <sip:27816011002@YYY.YYY.YYY.YYY>
   Call-ID: f5120da0-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011002@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------

freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:14.012878:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011008@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK8eBa9QHF8rvQc
   Max-Forwards: 70
   From: <sip:27816011008@YYY.YYY.YYY.YYY>;tag=6XctQ4jcFj4KH
   To: <sip:27816011008@YYY.YYY.YYY.YYY>
   Call-ID: f2fa5fe0-7ac0-122f-0391-0014221086ec
   CSeq: 19497191 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500

freeswitch@internal>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011008@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------

freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> recv 664 bytes from udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:14.270709:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport=5062;branch=z9hG4bKZya69ca53FXrS
   Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ:5071;lr>

freeswitch@internal>    Record-Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ;lr>
   Contact: "Anonymous"<sip:ZZZ.ZZZ.ZZZ.ZZZ:5061>
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=jkcthd7ucmlgheqc.i
   From: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437D
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 INVITE
   Content-Type: application/sdp
   Server: Sippy
   H323-credit-time: 7200
   Content-Length: 163
   
   v=0
   o=Sippy 825135544 3 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ

   s=-freeswitch@internal> 
   t=0 0
   m=audio 62432 RTP/AVP 18 101
   c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] sofia.c:5156 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ entering state [completing][200]
2011-10-27 00:02:14.258680 [DEBUG] sofia.c:5167 Remote SDP:
v=0
o=Sippy 825135544 3 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
s=-
t=0 0
m=audio 62432 RTP/AVP 18 101
c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

send 442 bytes to udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:14.271848:
   ------------------------------------------------------------------------
   ACK sip:ZZZ.ZZZ.ZZZ.ZZZ:5061 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY:5062;rport;branch=z9hG4bK073yB8t80rKBN
   Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ;lr>
   Route: <sip:ZZZ.ZZZ.ZZZ.ZZZ:5071;lr>
   Max-Forwards: 70

   From: "27816011943" <sip:27816011943@YYY.YYY.YYY.YYY>;tag=3BFg34UNp437Dfreeswitch@internal> 
   To: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=jkcthd7ucmlgheqc.i
   Call-ID: ff5771fa-7ac0-122f-0391-0014221086ec
   CSeq: 19497201 ACK
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5062>
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] sofia.c:5156 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ entering state [ready][200]
2011-10-27 00:02:14.258680 [DEBUG] switch_channel.c:3132 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Callstate Change EARLY -> ACTIVE
2011-10-27 00:02:14.258680 [DEBUG] switch_channel.c:3144 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.258680 [NOTICE] sofia.c:5764 Channel [sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ] has been answered
2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:786 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] sofia_glue.c:1817 sofia/digestauth/27816011943@sip.server.com:5060 Patched SDP
---
v=0
o=Sippy 825135544 3 IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
s=-
t=0 0
m=audio 62432 RTP/AVP 18 101
c=IN IP4 ZZZ.ZZZ.ZZZ.ZZZ
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

+++
v=0
o=FreeSWITCH 1213475629 1213475631 IN IP4 YYY.YYY.YYY.YYY
s=FreeSWITCH
t=0 0
m=audio 28080 RTP/AVP 18 101
c=IN IP4 YYY.YYY.YYY.YYY
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] switch_channel.c:3132 (sofia/digestauth/27816011943@sip.server.com:5060) Callstate Change EARLY -> ACTIVE
send 1110 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:14.275044:
   ------------------------------------------------------------------------

   SIP/2.0 200 OKfreeswitch@internal> 
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=S9cHS6jFrUBQD
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 2 INVITE
   Contact: <sip:0834898423@YYY.YYY.YYY.YYY:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Content-Type: application/sdp
   Content-Disposition: session
   Content-Length: 202
   Remote-Party-ID: "Outbound Call" <sip:0834898423@YYY.YYY.YYY.YYY>;party=calling;privacy=off;screen=no
   
   v=0
   o=FreeSWITCH 1213475629 1213475630 IN IP4 YYY.YYY.YYY.YYY
   s=FreeSWITCH
   c=IN IP4 YYY.YYY.YYY.YYY
   t=0 0
   m=audio 0 RTP/AVP 96 1012011-10-27 00:02:14.258680 [NOTICE] switch_ivr_bridge.c:417 Channel [sofia/digestauth/27816011943@sip.server.com:5060] has been answered

   a=rtpmap:96 G729/8000
   a=rtpmap:101 telephone-event/8000
   a=fmtp:101 0-15
   ------------------------------------------------------------------------
2011-10-27 00:02:14.258680 [DEBUG] switch_core_session.c:870 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.258680 [DEBUG] sofia.c:5156 Channel sofia/digestauth/27816011943@sip.server.com:5060 entering state [completed][200]
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:14.420894:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011001@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKBaQme93SZKZFF
   Max-Forwards: 70
   From: <sip:27816011001@YYY.YYY.YYY.YYY>;tag=gr9H9jUFjB3eN
   To: <sip:27816011001@YYY.YYY.YYY.YYY>
   Call-ID: f59be89a-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011001@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 444 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:14.458965:
   ------------------------------------------------------------------------
   ACK sip:0834898423@sip.server.com:5060 SIP/2.0
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;rport;branch=z9hG4bK450900027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11100027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=S9cHS6jFrUBQD
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 2 ACK
   Contact: <sip:27816011943@XXX.XXX.XXX.XXX:290>
   Max-Forwards: 70
   User-Agent: iTelMobileDialer-2.10
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:14.458692 [DEBUG] switch_core_session.c:870 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.458692 [DEBUG] switch_core_session.c:870 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.458692 [DEBUG] switch_core_session.c:870 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:14.458692 [DEBUG] sofia.c:5156 Channel sofia/digestauth/27816011943@sip.server.com:5060 entering state [ready][200]
2011-10-27 00:02:14.458692 [DEBUG] switch_core_session.c:786 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:14.458692 [DEBUG] switch_core_session.c:786 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:14.458692 [DEBUG] switch_core_session.c:786 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]

freeswitch@internal> 
freeswitch@internal> send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:14.623865:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKcKgDg4mXvvN2a
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=jav3c9vpcXFmc
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:14.741692:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509000
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111000
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=S9cHS6jFrUBQD
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497193 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:15.629878:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKDv95HZ50S5BNp
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=mveNgZyX6evSK
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   CSeq: 19497194 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:15.690850:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509000
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111000
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=S9cHS6jFrUBQD
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497194 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 706 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:16.392983:
   ------------------------------------------------------------------------
   SIP/2.0 487 Request Terminated
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;branch=z9hG4bK450902027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11101027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=320FjK01QQ1Ue
   Call-ID: 27816011943420565956@192.168.21.120
   CSeq: 4 INVITE
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Content-Length: 0
   
   ------------------------------------------------------------------------
recv 436 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:16.518622:
   ------------------------------------------------------------------------
   ACK sip:0834898423@XXX.XXX.XXX.XXX:290 SIP/2.0
   Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:266;rport;branch=z9hG4bK450902027816011943
   From: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11101027816011943
   To: <sip:0834898423@sip.server.com:5060>;tag=320FjK01QQ1Ue
   Call-ID: 27816011943423843320@192.168.21.120
   CSeq: 4 ACK
   Contact: <sip:27816011943@XXX.XXX.XXX.XXX:290>
   Max-Forwards: 70
   User-Agent: iTelMobileDialer-2.10
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:16.613010:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011010@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK9Q42aK2j51jar
   Max-Forwards: 70
   From: <sip:27816011010@YYY.YYY.YYY.YYY>;tag=9rr4vN5p6c7Bm
   To: <sip:27816011010@YYY.YYY.YYY.YYY>
   Call-ID: f48814f7-7ac0-122f-0391-0014221086ec
   CSeq: 19497192 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011010@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:17.523070:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011002@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKa1XUceKp2a9vK
   Max-Forwards: 70
   From: <sip:27816011002@YYY.YYY.YYY.YYY>;tag=DXX73184tg0pj
   To: <sip:27816011002@YYY.YYY.YYY.YYY>
   Call-ID: f5120da0-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011002@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:18.013883:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011008@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK8eBa9QHF8rvQc
   Max-Forwards: 70
   From: <sip:27816011008@YYY.YYY.YYY.YYY>;tag=6XctQ4jcFj4KH
   To: <sip:27816011008@YYY.YYY.YYY.YYY>
   Call-ID: f2fa5fe0-7ac0-122f-0391-0014221086ec
   CSeq: 19497191 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011008@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------

freeswitch@internal> send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:18.421252:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011001@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKBaQme93SZKZFF
   Max-Forwards: 70
   From: <sip:27816011001@YYY.YYY.YYY.YYY>;tag=gr9H9jUFjB3eN
   To: <sip:27816011001@YYY.YYY.YYY.YYY>
   Call-ID: f59be89a-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011001@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:18.624629:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKcKgDg4mXvvN2a
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=jav3c9vpcXFmc
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:18.812263:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509020
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111010
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=320FjK01QQ1Ue
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497193 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------

freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> 
freeswitch@internal> send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:19.629957:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKDv95HZ50S5BNp
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=mveNgZyX6evSK
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   CSeq: 19497194 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:19.677759:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509020
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111010
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=320FjK01QQ1Ue
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497194 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:20.613909:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011010@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK9Q42aK2j51jar
   Max-Forwards: 70
   From: <sip:27816011010@YYY.YYY.YYY.YYY>;tag=9rr4vN5p6c7Bm
   To: <sip:27816011010@YYY.YYY.YYY.YYY>
   Call-ID: f48814f7-7ac0-122f-0391-0014221086ec
   CSeq: 19497192 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011010@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:21.523887:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011002@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKa1XUceKp2a9vK
   Max-Forwards: 70
   From: <sip:27816011002@YYY.YYY.YYY.YYY>;tag=DXX73184tg0pj
   To: <sip:27816011002@YYY.YYY.YYY.YYY>
   Call-ID: f5120da0-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011002@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:22.014894:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011008@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK8eBa9QHF8rvQc
   Max-Forwards: 70
   From: <sip:27816011008@YYY.YYY.YYY.YYY>;tag=6XctQ4jcFj4KH
   To: <sip:27816011008@YYY.YYY.YYY.YYY>
   Call-ID: f2fa5fe0-7ac0-122f-0391-0014221086ec
   CSeq: 19497191 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011008@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:22.421281:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011001@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKBaQme93SZKZFF
   Max-Forwards: 70
   From: <sip:27816011001@YYY.YYY.YYY.YYY>;tag=gr9H9jUFjB3eN
   To: <sip:27816011001@YYY.YYY.YYY.YYY>
   Call-ID: f59be89a-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011001@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:22.625646:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKcKgDg4mXvvN2a
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=jav3c9vpcXFmc
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:22.672719:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509020
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111010
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=320FjK01QQ1Ue
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497193 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:23.629759:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKDv95HZ50S5BNp
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=mveNgZyX6evSK
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   CSeq: 19497194 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:23.711129:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509020
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111010
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=320FjK01QQ1Ue
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497194 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:24.613923:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011010@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK9Q42aK2j51jar
   Max-Forwards: 70
   From: <sip:27816011010@YYY.YYY.YYY.YYY>;tag=9rr4vN5p6c7Bm
   To: <sip:27816011010@YYY.YYY.YYY.YYY>
   Call-ID: f48814f7-7ac0-122f-0391-0014221086ec
   CSeq: 19497192 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011010@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:25.523988:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011002@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKa1XUceKp2a9vK
   Max-Forwards: 70
   From: <sip:27816011002@YYY.YYY.YYY.YYY>;tag=DXX73184tg0pj
   To: <sip:27816011002@YYY.YYY.YYY.YYY>
   Call-ID: f5120da0-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011002@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 919 bytes to udp/[10.0.0.4]:5060 at 22:02:26.421046:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011001@10.0.0.4:5060 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKBaQme93SZKZFF
   Max-Forwards: 70
   From: <sip:27816011001@YYY.YYY.YYY.YYY>;tag=gr9H9jUFjB3eN
   To: <sip:27816011001@YYY.YYY.YYY.YYY>
   Call-ID: f59be89a-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011001@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:26.626459:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKcKgDg4mXvvN2a
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=jav3c9vpcXFmc
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   CSeq: 19497193 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:26.890230:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509020
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111010
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=320FjK01QQ1Ue
   Call-ID: f5bacbf5-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497193 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
send 920 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:27.629653:
   ------------------------------------------------------------------------
   NOTIFY sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.0
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKDv95HZ50S5BNp
   Max-Forwards: 70
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=mveNgZyX6evSK
   To: <sip:27816011943@YYY.YYY.YYY.YYY>
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   CSeq: 19497194 NOTIFY
   Contact: <sip:mod_sofia@YYY.YYY.YYY.YYY:5060>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Event: message-summary
   Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
   Subscription-State: terminated;reason=timeout
   Content-Type: application/simple-message-summary
   Content-Length: 69
   
   Messages-Waiting: no
   Message-Account: sip:27816011943@YYY.YYY.YYY.YYY
   
   ------------------------------------------------------------------------
recv 341 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:27.744737:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bK4509020
   From: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=111010
   To: <sip:27816011943@YYY.YYY.YYY.YYY>;tag=320FjK01QQ1Ue
   Call-ID: f653f90a-7ac0-122f-0391-0014221086ec
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497194 NOTIFY
   Content-Length: 0
   
   ------------------------------------------------------------------------
recv 615 bytes from udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:28.154248:
   ------------------------------------------------------------------------
   BYE sip:mod_sofia@YYY.YYY.YYY.YYY:5062 SIP/2.0
   Via: SIP/2.0/UDP ZZZ.ZZZ.ZZZ.ZZZ:5060;branch=z9hG4bK-d8754z-ee6f355e5077994b-1---d8754z-;rport
   Via: SIP/2.0/UDP ZZZ.ZZZ.ZZZ.ZZZ:5071;rport=5071;branch=z9hG4bK-psqdtkotjlsotsxb
   Max-Forwards: 69
   Contact: "Anonymous"<sip:ZZZ.ZZZ.ZZZ.ZZZ:5071>
   To: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=1SvyZetevjQ2p
   From: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=ltvuy7dljmd2z25k.i
   Call-ID: 88a97630-7ac0-122f-0391-0014221086ec
   CSeq: 654 BYE
   User-Agent: Sippy
   h323-conf-id: 4145093482-1774049-2891710484-1341606108
   cisco-GUID: 4145093482-1774049-2891710484-1341606108
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:28.138675 [DEBUG] switch_core_session.c:870 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:28.138675 [DEBUG] switch_channel.c:2797 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Callstate Change ACTIVE -> HANGUP
2011-10-27 00:02:28.138675 [NOTICE] sofia.c:560 Hangup sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2011-10-27 00:02:28.138675 [DEBUG] switch_channel.c:2813 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [KILL]
2011-10-27 00:02:28.138675 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:28.138675 [DEBUG] switch_ivr_bridge.c:586 BRIDGE THREAD DONE [sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ]
2011-10-27 00:02:28.138675 [DEBUG] switch_ivr_bridge.c:606 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:394 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State EXCHANGE_MEDIA going to sleep
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:336 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_HANGUP
2011-10-27 00:02:28.138675 [DEBUG] switch_ivr_bridge.c:586 BRIDGE THREAD DONE [sofia/digestauth/27816011943@sip.server.com:5060]
2011-10-27 00:02:28.138675 [DEBUG] switch_ivr_bridge.c:606 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
send 620 bytes to udp/[ZZZ.ZZZ.ZZZ.ZZZ]:5060 at 22:02:28.155890:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP ZZZ.ZZZ.ZZZ.ZZZ:5060;branch=z9hG4bK-d8754z-ee6f355e5077994b-1---d8754z-;rport=5060
   Via: SIP/2.0/UDP ZZZ.ZZZ.ZZZ.ZZZ:5071;rport=5071;branch=z9hG4bK-psqdtkotjlsotsxb
   From: <sip:0834898423@ZZZ.ZZZ.ZZZ.ZZZ>;tag=ltvuy7dljmd2z25k.i
   To: "27816011943"<sip:27816011943@YYY.YYY.YYY.YYY>;tag=1SvyZetevjQ2p
   Call-ID: 88a97630-7ac0-122f-0391-0014221086ec
   CSeq: 654 BYE
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -0500
   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY
   Supported: timer, precondition, path, replaces
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:576 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State HANGUP
2011-10-27 00:02:28.138675 [DEBUG] mod_sofia.c:452 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ Overriding SIP cause 480 with 200 from the other leg
2011-10-27 00:02:28.138675 [DEBUG] mod_sofia.c:458 Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ hanging up, cause: NORMAL_CLEARING
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:46 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ Standard HANGUP, cause: NORMAL_CLEARING
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:576 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State HANGUP going to sleep
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:367 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State Change CS_HANGUP -> CS_REPORTING
2011-10-27 00:02:28.138675 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:336 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_REPORTING
2011-10-27 00:02:28.138675 [DEBUG] switch_core_state_machine.c:636 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State REPORTING
2011-10-27 00:02:28.138675 [DEBUG] switch_ivr_bridge.c:1332 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ skip receive message [UNBRIDGE] (channel is hungup already)
2011-10-27 00:02:28.138675 [DEBUG] mod_sofia.c:1622 sofia/digestauth/27816011943@sip.server.com:5060 deactivate passthru 2833 mode.
2011-10-27 00:02:28.138675 [DEBUG] switch_core_session.c:724 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:28.138675 [DEBUG] switch_channel.c:2797 (sofia/digestauth/27816011943@sip.server.com:5060) Callstate Change ACTIVE -> HANGUP
2011-10-27 00:02:28.138675 [NOTICE] switch_ivr_bridge.c:1355 Hangup sofia/digestauth/27816011943@sip.server.com:5060 [CS_EXECUTE] [NORMAL_CLEARING]
2011-10-27 00:02:28.138675 [DEBUG] switch_channel.c:2813 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [KILL]
2011-10-27 00:02:28.138675 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:28.138675 [DEBUG] switch_core_session.c:2209 sofia/digestauth/27816011943@sip.server.com:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2011-10-27 00:02:28.159293 [DEBUG] switch_core_session.c:2209 sofia/digestauth/27816011943@sip.server.com:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:391 (sofia/digestauth/27816011943@sip.server.com:5060) State EXECUTE going to sleep
2011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_HANGUP
2011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:576 (sofia/digestauth/27816011943@sip.server.com:5060) State HANGUP
2011-10-27 00:02:28.159293 [DEBUG] mod_sofia.c:452 sofia/digestauth/27816011943@sip.server.com:5060 Overriding SIP cause 480 with 200 from the other leg
2011-10-27 00:02:28.159293 [DEBUG] mod_sofia.c:458 Channel sofia/digestauth/27816011943@sip.server.com:5060 hanging up, cause: NORMAL_CLEARING
2011-10-27 00:02:28.159293 [DEBUG] mod_sofia.c:501 Sending BYE to sofia/digestauth/27816011943@sip.server.com:5060
2011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:46 sofia/digestauth/27816011943@sip.server.com:5060 Standard HANGUP, cause: NORMAL_CLEARING
send 700 bytes to udp/[XXX.XXX.XXX.XXX]:266 at 22:02:28.162654:
   ------------------------------------------------------------------------
   BYE sip:27816011943@XXX.XXX.XXX.XXX:266 SIP/2.02011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:576 (sofia/digestauth/27816011943@sip.server.com:5060) State HANGUP going to sleep

   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKgQNgQgrBH0eDS
   Max-Forwards: 70
   From: <sip:0834898423@sip.server.com:5060>;tag=j70Q23B415mHm
   To: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11101027816011943
   Call-ID: 27816011943420565955@192.168.21.120
   CSeq: 19497210 BYE
   Contact: <sip:0834898423@YYY.YYY.YYY.YYY:5060;transport=udp>
   User-Agent: FreeSWITCH-mod_sofia/1.0.head-git-10d2e80 2011-09-08 22-35-20 -05002011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:367 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_HANGUP -> CS_REPORTING

   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
   Supported: timer, precondition, path, replaces
   Reason: Q.850;cause=16;text="NORMAL_CLEARING"
2011-10-27 00:02:28.159293 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:336 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_REPORTING
2011-10-27 00:02:28.159293 [DEBUG] switch_core_state_machine.c:636 (sofia/digestauth/27816011943@sip.server.com:5060) State REPORTING
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:53 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ Standard REPORTING, cause: NORMAL_CLEARING
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:636 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State REPORTING going to sleep
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:361 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State Change CS_REPORTING -> CS_DESTROY
2011-10-27 00:02:28.198715 [DEBUG] switch_core_session.c:1175 Send signal sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [BREAK]
2011-10-27 00:02:28.198715 [DEBUG] switch_core_session.c:1349 Session 86 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Locked, Waiting on external entities
2011-10-27 00:02:28.198715 [NOTICE] switch_core_session.c:1367 Session 86 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Ended
2011-10-27 00:02:28.198715 [NOTICE] switch_core_session.c:1369 Close Channel sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ [CS_DESTROY]
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:465 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Callstate Change HANGUP -> DOWN
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:468 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) Running State Change CS_DESTROY
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:478 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State DESTROY
2011-10-27 00:02:28.198715 [DEBUG] mod_sofia.c:363 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ SOFIA DESTROY
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:60 sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ Standard DESTROY
2011-10-27 00:02:28.198715 [DEBUG] switch_core_state_machine.c:478 (sofia/outbound/0834898423@ZZZ.ZZZ.ZZZ.ZZZ) State DESTROY going to sleep
recv 389 bytes from udp/[XXX.XXX.XXX.XXX]:266 at 22:02:28.780129:
   ------------------------------------------------------------------------
   SIP/2.0 200 OK
   Via: SIP/2.0/UDP YYY.YYY.YYY.YYY;rport;branch=z9hG4bKgQNgQgrBH0eDS
   From: <sip:0834898423@sip.server.com:5060>;tag=j70Q23B415mHm
   To: 27816011943 <sip:27816011943@sip.server.com:5060>;tag=11101027816011943
   Call-ID: 27816011943420565955@192.168.21.120
   Contact: 27816011943 <sip:27816011943@192.168.21.120:3319>
   Max-Forwards: 70
   CSeq: 19497210 BYE
   Content-Length: 0
   
   ------------------------------------------------------------------------
2011-10-27 00:02:28.878709 [DEBUG] switch_core_state_machine.c:53 sofia/digestauth/27816011943@sip.server.com:5060 Standard REPORTING, cause: NORMAL_CLEARING
2011-10-27 00:02:28.878709 [DEBUG] switch_core_state_machine.c:636 (sofia/digestauth/27816011943@sip.server.com:5060) State REPORTING going to sleep
2011-10-27 00:02:28.898704 [DEBUG] switch_core_state_machine.c:361 (sofia/digestauth/27816011943@sip.server.com:5060) State Change CS_REPORTING -> CS_DESTROY
2011-10-27 00:02:28.898704 [DEBUG] switch_core_session.c:1175 Send signal sofia/digestauth/27816011943@sip.server.com:5060 [BREAK]
2011-10-27 00:02:28.898704 [DEBUG] switch_core_session.c:1349 Session 85 (sofia/digestauth/27816011943@sip.server.com:5060) Locked, Waiting on external entities
2011-10-27 00:02:28.898704 [NOTICE] switch_core_session.c:1367 Session 85 (sofia/digestauth/27816011943@sip.server.com:5060) Ended
2011-10-27 00:02:28.898704 [NOTICE] switch_core_session.c:1369 Close Channel sofia/digestauth/27816011943@sip.server.com:5060 [CS_DESTROY]
2011-10-27 00:02:28.898704 [DEBUG] switch_core_state_machine.c:465 (sofia/digestauth/27816011943@sip.server.com:5060) Callstate Change HANGUP -> DOWN
2011-10-27 00:02:28.898704 [DEBUG] switch_core_state_machine.c:468 (sofia/digestauth/27816011943@sip.server.com:5060) Running State Change CS_DESTROY
2011-10-27 00:02:28.898704 [DEBUG] switch_core_state_machine.c:478 (sofia/digestauth/27816011943@sip.server.com:5060) State DESTROY
2011-10-27 00:02:28.898704 [DEBUG] mod_sofia.c:363 sofia/digestauth/27816011943@sip.server.com:5060 SOFIA DESTROY
2011-10-27 00:02:28.898704 [DEBUG] switch_core_state_machine.c:60 sofia/digestauth/27816011943@sip.server.com:5060 Standard DESTROY
2011-10-27 00:02:28.898704 [DEBUG] switch_core_state_machine.c:478 (sofia/digestauth/27816011943@sip.server.com:5060) State DESTROY going to sleep
2011-10-27 00:02:29.098694 [DEBUG] switch_scheduler.c:138 Deleting task 32 switch_ivr_schedule_hangup (b12922b2-001d-11e1-92e3-851ab5c8ac90)


