[Freeswitch-users] No ringback tone for google voice calls

[Y. Aydogan]

Hi,

I am having some issues with ringback tones. I configured google voice
and I don't hear any ringback tone for outgoing calls through google
voice.

Attached is a capture which shows an outgoing call. I replaced my
destination number with 5555555555 in the logs for privacy.

Thanks in advance.
Yucel


freeswitch at internal> 2012-04-29 12:49:51.258713 [DEBUG] sofia.c:6288
IP 192.168.0.101 Rejected by acl "net_list_5". Falling back to Digest
auth.
2012-04-29 12:49:51.284881 [DEBUG] sofia.c:6288 IP 192.168.0.101
Rejected by acl "net_list_5". Falling back to Digest auth.
2012-04-29 12:49:51.289720 [NOTICE] switch_channel.c:784 New Channel
sofia/sipinterface_1/yu... at 192.168.0.112 [27a51939-
dda7-42db-8210-3aa643ebc7e6]
2012-04-29 12:49:51.289720 [DEBUG] switch_core_state_machine.c:318
(sofia/sipinterface_1/yu... at 192.168.0.112) Running State Change CS_NEW
2012-04-29 12:49:51.289720 [DEBUG] switch_core_state_machine.c:324
(sofia/sipinterface_1/yu... at 192.168.0.112) State NEW
2012-04-29 12:49:51.305713 [DEBUG] sofia.c:4559 Channel sofia/
sipinterface_1/yu... at 192.168.0.112 entering state [received][100]
2012-04-29 12:49:51.305713 [DEBUG] sofia.c:4570 Remote SDP:
v=0
o=- 22714590 22714590 IN IP4 192.168.0.101
s=-
c=IN IP4 192.168.0.101
t=0 0
m=audio 16416 RTP/AVP 0 2 4 8 18 96 97 98 100 101
a=rtpmap:0 PCMU/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:4 G723/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729a/8000
a=rtpmap:96 G726-40/8000
a=rtpmap:97 G726-24/8000
a=rtpmap:98 G726-16/8000
a=rtpmap:100 NSE/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:30

2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4353 Audio Codec
Compare [PCMU:0:8000:30:64000]/[G7221:115:32000:20:48000]
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4353 Audio Codec
Compare [PCMU:0:8000:30:64000]/[G7221:107:16000:20:32000]
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4353 Audio Codec
Compare [PCMU:0:8000:30:64000]/[G722:9:8000:20:64000]
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4353 Audio Codec
Compare [PCMU:0:8000:30:64000]/[PCMU:0:8000:20:64000]
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4353 Audio Codec
Compare [PCMU:0:8000:30:64000]/[PCMA:8:8000:20:64000]
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4353 Audio Codec
Compare [PCMU:0:8000:30:64000]/[GSM:3:8000:20:13200]
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:4406 Substituting
codec PCMU at 30i@8000h
2012-04-29 12:49:51.305713 [DEBUG] sofia_glue.c:2721 Set Codec sofia/
sipinterface_1/yu... at 192.168.0.112 PCMU/8000 30 ms 240 samples 64000
bits
2012-04-29 12:49:51.307729 [DEBUG] sofia_glue.c:4457 Set 2833 dtmf
send/recv payload to 101
2012-04-29 12:49:51.307729 [DEBUG] sofia.c:4732 (sofia/sipinterface_1/
yu... at 192.168.0.112) State Change CS_NEW -> CS_INIT
2012-04-29 12:49:51.307729 [DEBUG] switch_core_session.c:1057 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:49:51.307729 [DEBUG] switch_core_state_machine.c:318
(sofia/sipinterface_1/yu... at 192.168.0.112) Running State Change
CS_INIT
2012-04-29 12:49:51.307729 [DEBUG] switch_core_state_machine.c:342
(sofia/sipinterface_1/yu... at 192.168.0.112) State INIT
2012-04-29 12:49:51.307729 [DEBUG] mod_sofia.c:83 sofia/sipinterface_1/
yu... at 192.168.0.112 SOFIA INIT
2012-04-29 12:49:51.307729 [DEBUG] mod_sofia.c:123 (sofia/
sipinterface_1/yu... at 192.168.0.112) State Change CS_INIT -> CS_ROUTING
2012-04-29 12:49:51.307729 [DEBUG] switch_core_session.c:1057 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:49:51.307729 [DEBUG] switch_core_state_machine.c:342
(sofia/sipinterface_1/yu... at 192.168.0.112) State INIT going to sleep
2012-04-29 12:49:51.307729 [DEBUG] switch_core_state_machine.c:318
(sofia/sipinterface_1/yu... at 192.168.0.112) Running State Change
CS_ROUTING
2012-04-29 12:49:51.307729 [DEBUG] switch_channel.c:1615 (sofia/
sipinterface_1/yu... at 192.168.0.112) Callstate Change DOWN -> RINGING
2012-04-29 12:49:51.307729 [DEBUG] switch_core_state_machine.c:345
(sofia/sipinterface_1/yu... at 192.168.0.112) State ROUTING
2012-04-29 12:49:51.307729 [DEBUG] mod_sofia.c:146 sofia/
sipinterface_1/yu... at 192.168.0.112 SOFIA ROUTING
2012-04-29 12:49:51.307729 [DEBUG] switch_core_state_machine.c:77
sofia/sipinterface_1/yu... at 192.168.0.112 Standard ROUTING
2012-04-29 12:49:51.307729 [INFO] mod_dialplan_xml.c:331 Processing
Yucel Aydogan <yucel>->5555555555 in context context_1
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>dingaling_2_pattern_1] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (PASS)
[dingaling_2_pattern_1] destination_number(5555555555) =~ /^1{0,1}
([2-9][0-8][0-9][2-9][0-9]{6})$/ break=on-false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action
set(prepend=1)
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action
set(hangup_after_bridge=true)
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action
bridge(dingaling/GVOICE/+${prepend}5555555... at voice.google.com)
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>conditioning_callerid] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (PASS)
[conditioning_callerid] ${internal_caller_id_number}(8309) =~ /^.+$/
break=on-false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action
set(effective_caller_id_name=${internal_caller_id_name})
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action
set(effective_caller_id_number=${internal_caller_id_number})
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>postroute_global] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Absolute Condition
[postroute_global]
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action hash(insert/$
{domain_name}-spymap/${caller_id_number}/${uuid})
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action hash(insert/$
{domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action hash(insert/$
{domain_name}-last_dial/global/${uuid})
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Action
set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>preanswer_gtalk] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (FAIL)
[preanswer_gtalk] source(mod_sofia) =~ /^mod_dingaling$/ break=on-
false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>main_number_9] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (FAIL)
[main_number_9] destination_number(5555555555) =~ /^978nxxxxxx$/
break=on-false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>main_number_8] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (FAIL)
[main_number_8] destination_number(5555555555) =~ /^6000$/ break=on-
false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>main_number_7] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (FAIL)
[main_number_7] destination_number(5555555555) =~ /^1039$/ break=on-
false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>main_number_2] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (FAIL)
[main_number_2] destination_number(5555555555) =~ /^8309$/ break=on-
false
Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 parsing [context_1-
>main_number_3] continue=true

Dialplan: sofia/sipinterface_1/yu... at 192.168.0.112 Regex (FAIL)
[main_number_3] destination_number(5555555555) =~ /^8310$/ break=on-
false
2012-04-29 12:49:51.309717 [DEBUG] switch_core_state_machine.c:119
(sofia/sipinterface_1/yu... at 192.168.0.112) State Change CS_ROUTING ->
CS_EXECUTE
2012-04-29 12:49:51.309717 [DEBUG] switch_core_session.c:1057 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:49:51.309717 [DEBUG] switch_core_state_machine.c:345
(sofia/sipinterface_1/yu... at 192.168.0.112) State ROUTING going to
sleep
2012-04-29 12:49:51.309717 [DEBUG] switch_core_state_machine.c:318
(sofia/sipinterface_1/yu... at 192.168.0.112) Running State Change
CS_EXECUTE
2012-04-29 12:49:51.309717 [DEBUG] switch_core_state_machine.c:352
(sofia/sipinterface_1/yu... at 192.168.0.112) State EXECUTE
2012-04-29 12:49:51.309717 [DEBUG] mod_sofia.c:239 sofia/
sipinterface_1/yu... at 192.168.0.112 SOFIA EXECUTE
2012-04-29 12:49:51.309717 [DEBUG] switch_core_state_machine.c:157
sofia/sipinterface_1/yu... at 192.168.0.112 Standard EXECUTE
EXECUTE sofia/sipinterface_1/yu... at 192.168.0.112 set(prepend=1)
2012-04-29 12:49:51.309717 [DEBUG] mod_dptools.c:1028 sofia/
sipinterface_1/yu... at 192.168.0.112 SET [prepend]=[1]
EXECUTE sofia/sipinterface_1/yu... at 192.168.0.112
set(hangup_after_bridge=true)
2012-04-29 12:49:51.309717 [DEBUG] mod_dptools.c:1028 sofia/
sipinterface_1/yu... at 192.168.0.112 SET [hangup_after_bridge]=[true]
EXECUTE sofia/sipinterface_1/yu... at 192.168.0.112 bridge(dingaling/
GVOICE/+15555555... at voice.google.com)
2012-04-29 12:49:51.309717 [NOTICE] switch_channel.c:784 New Channel
dingaling/GVOICE/+15555555... at voice.google.com [92032331-e330-4269-
b1fe-062de435aa78]
2012-04-29 12:49:51.309717 [DEBUG] mod_dingaling.c:1818 (dingaling/
GVOICE/+15555555... at voice.google.com) State Change CS_NEW -> CS_INIT
2012-04-29 12:49:51.309717 [DEBUG] switch_core_session.c:1057 Send
signal dingaling/GVOICE/+15555555... at voice.google.com [BREAK]
2012-04-29 12:49:51.309717 [DEBUG] mod_dingaling.c:1342 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL KILL
2012-04-29 12:49:51.311724 [DEBUG] switch_core_state_machine.c:318
(dingaling/GVOICE/+15555555... at voice.google.com) Running State Change
CS_INIT
2012-04-29 12:49:51.311724 [DEBUG] switch_core_state_machine.c:342
(dingaling/GVOICE/+15555555... at voice.google.com) State INIT
2012-04-29 12:49:51.311724 [NOTICE] mod_dingaling.c:1104 Ring-Ready
dingaling/GVOICE/+15555555... at voice.google.com!
2012-04-29 12:49:51.311724 [DEBUG] mod_dingaling.c:1057 Don't have my
codec yet here's one
2012-04-29 12:49:51.311724 [DEBUG] mod_dingaling.c:1077 Send Describe
[PCMU at 8000]
2012-04-29 12:49:51.359973 [DEBUG] mod_dingaling.c:2935 using Existing
session for 6160946247
2012-04-29 12:49:51.359973 [DEBUG] mod_dingaling.c:1077 Send Describe
[PCMU at 8000]
2012-04-29 12:49:51.544699 [DEBUG] mod_dingaling.c:2935 using Existing
session for 6160946247
2012-04-29 12:49:51.544699 [DEBUG] mod_dingaling.c:1002 Send Candidate
192.168.0.112:28560 [3FFPxUKMcoG72pKD]
2012-04-29 12:49:51.777702 [DEBUG] mod_dingaling.c:2935 using Existing
session for 6160946247
2012-04-29 12:49:51.777702 [DEBUG] mod_dingaling.c:3273 1 candidates
2012-04-29 12:49:51.777702 [DEBUG] mod_dingaling.c:3293 candidate
173.194.76.127:19305 PASS ACL wan.auto
2012-04-29 12:49:51.777702 [DEBUG] mod_dingaling.c:3345 Acceptable
Candidate 173.194.76.127:19305
2012-04-29 12:50:04.139089 [DEBUG] mod_dingaling.c:2935 using Existing
session for 6160946247
2012-04-29 12:50:04.139089 [DEBUG] mod_dingaling.c:3187 Already
decided on a codec
2012-04-29 12:50:04.141096 [DEBUG] mod_dingaling.c:859 Set Read Codec
to PCMU at 8000
2012-04-29 12:50:04.141096 [DEBUG] mod_dingaling.c:874 Set Write Codec
to PCMU at 8000
2012-04-29 12:50:05.193038 [DEBUG] switch_nat.c:500 mapped public port
28560 protocol UDP to localport 28560
2012-04-29 12:50:05.193038 [DEBUG] mod_dingaling.c:886 SETUP RTP
192.168.0.112:28560 -> 173.194.76.127:19305
2012-04-29 12:50:05.193038 [DEBUG] switch_rtp.c:1426 Not using a timer
2012-04-29 12:50:05.195316 [DEBUG] switch_rtp.c:3570 Activate VAD
codec PCMU 20ms
2012-04-29 12:50:05.195316 [DEBUG] switch_channel.c:2694 (dingaling/
GVOICE/+15555555... at voice.google.com) Callstate Change DOWN -> ACTIVE
2012-04-29 12:50:05.195316 [DEBUG] switch_channel.c:2706 Send signal
sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:50:05.195316 [NOTICE] mod_dingaling.c:1196 Channel
[dingaling/GVOICE/+15555555... at voice.google.com] has been answered
2012-04-29 12:50:05.195316 [DEBUG] mod_dingaling.c:1199 (dingaling/
GVOICE/+15555555... at voice.google.com) State Change CS_INIT ->
CS_ROUTING
2012-04-29 12:50:05.195316 [DEBUG] switch_core_session.c:1057 Send
signal dingaling/GVOICE/+15555555... at voice.google.com [BREAK]
2012-04-29 12:50:05.195316 [DEBUG] mod_dingaling.c:1342 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL KILL
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:342
(dingaling/GVOICE/+15555555... at voice.google.com) State INIT going to
sleep
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:318
(dingaling/GVOICE/+15555555... at voice.google.com) Running State Change
CS_ROUTING
2012-04-29 12:50:05.195316 [DEBUG] switch_channel.c:1615 (dingaling/
GVOICE/+15555555... at voice.google.com) Callstate Change ACTIVE ->
RINGING
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:345
(dingaling/GVOICE/+15555555... at voice.google.com) State ROUTING
2012-04-29 12:50:05.195316 [DEBUG] mod_dingaling.c:1213 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL ROUTING
2012-04-29 12:50:05.195316 [DEBUG] switch_ivr_originate.c:66
(dingaling/GVOICE/+15555555... at voice.google.com) State Change
CS_ROUTING -> CS_CONSUME_MEDIA
2012-04-29 12:50:05.195316 [DEBUG] switch_core_session.c:1057 Send
signal dingaling/GVOICE/+15555555... at voice.google.com [BREAK]
2012-04-29 12:50:05.195316 [DEBUG] mod_dingaling.c:1342 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL KILL
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:345
(dingaling/GVOICE/+15555555... at voice.google.com) State ROUTING going
to sleep
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:318
(dingaling/GVOICE/+15555555... at voice.google.com) Running State Change
CS_CONSUME_MEDIA
2012-04-29 12:50:05.195316 [DEBUG] switch_channel.c:1617 (dingaling/
GVOICE/+15555555... at voice.google.com) Callstate Change RINGING ->
ACTIVE
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:364
(dingaling/GVOICE/+15555555... at voice.google.com) State CONSUME_MEDIA
2012-04-29 12:50:05.195316 [DEBUG] switch_core_state_machine.c:364
(dingaling/GVOICE/+15555555... at voice.google.com) State CONSUME_MEDIA
going to sleep
2012-04-29 12:50:05.198143 [NOTICE] mod_sofia.c:2096 Ring-Ready sofia/
sipinterface_1/yu... at 192.168.0.112!
2012-04-29 12:50:05.198143 [DEBUG] switch_core_session.c:676 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:50:05.198143 [NOTICE] switch_ivr_originate.c:472 Ring
Ready sofia/sipinterface_1/yu... at 192.168.0.112!
2012-04-29 12:50:05.198143 [DEBUG] sofia.c:4559 Channel sofia/
sipinterface_1/yu... at 192.168.0.112 entering state [early][180]
2012-04-29 12:50:05.225311 [DEBUG] sofia_glue.c:2961 AUDIO RTP [sofia/
sipinterface_1/yu... at 192.168.0.112] 192.168.0.112 port 19702 ->
192.168.0.101 port 16416 codec: 0 ms: 30
2012-04-29 12:50:05.225311 [DEBUG] switch_rtp.c:1418 Starting timer
[soft] 240 bytes per 30ms
2012-04-29 12:50:05.227308 [DEBUG] sofia_glue.c:3179 Set 2833 dtmf
send payload to 101
2012-04-29 12:50:05.227308 [DEBUG] sofia_glue.c:3184 Set 2833 dtmf
receive payload to 101
2012-04-29 12:50:05.227308 [DEBUG] mod_sofia.c:680 Local SDP sofia/
sipinterface_1/yu... at 192.168.0.112:
v=0
o=FreeSWITCH 1335709303 1335709304 IN IP4 192.168.0.112
s=FreeSWITCH
c=IN IP4 192.168.0.112
t=0 0
m=audio 19702 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:30
a=sendrecv

2012-04-29 12:50:05.227308 [DEBUG] switch_core_session.c:676 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:50:05.227308 [DEBUG] switch_channel.c:2694 (sofia/
sipinterface_1/yu... at 192.168.0.112) Callstate Change RINGING -> ACTIVE
2012-04-29 12:50:05.227308 [NOTICE] switch_ivr_originate.c:3288
Channel [sofia/sipinterface_1/yu... at 192.168.0.112] has been answered
2012-04-29 12:50:05.227308 [DEBUG] switch_ivr_originate.c:3333
Originate Resulted in Success: [dingaling/GVOICE/
+15555555... at voice.google.com]
2012-04-29 12:50:05.227308 [DEBUG] switch_core_session.c:676 Send
signal dingaling/GVOICE/+15555555... at voice.google.com [BREAK]
2012-04-29 12:50:05.227308 [DEBUG] mod_dingaling.c:1342 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL KILL
2012-04-29 12:50:05.227308 [DEBUG] switch_core_session.c:676 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:50:05.227308 [DEBUG] switch_ivr_bridge.c:1226 (dingaling/
GVOICE/+15555555... at voice.google.com) State Change CS_CONSUME_MEDIA ->
CS_EXCHANGE_MEDIA
2012-04-29 12:50:05.227308 [DEBUG] switch_core_session.c:1057 Send
signal dingaling/GVOICE/+15555555... at voice.google.com [BREAK]
2012-04-29 12:50:05.227308 [DEBUG] mod_dingaling.c:1342 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL KILL
2012-04-29 12:50:05.230264 [DEBUG] switch_core_state_machine.c:318
(dingaling/GVOICE/+15555555... at voice.google.com) Running State Change
CS_EXCHANGE_MEDIA
2012-04-29 12:50:05.230264 [DEBUG] switch_core_state_machine.c:355
(dingaling/GVOICE/+15555555... at voice.google.com) State EXCHANGE_MEDIA
2012-04-29 12:50:05.230264 [DEBUG] mod_dingaling.c:1350 CHANNEL
LOOPBACK
2012-04-29 12:50:05.230264 [DEBUG] sofia.c:4559 Channel sofia/
sipinterface_1/yu... at 192.168.0.112 entering state [completed][200]
2012-04-29 12:50:05.242302 [DEBUG] sofia.c:4559 Channel sofia/
sipinterface_1/yu... at 192.168.0.112 entering state [ready][200]
2012-04-29 12:50:05.244336 [DEBUG] switch_rtp.c:2544 Correct ip/port
confirmed.
2012-04-29 12:50:05.258274 [DEBUG] switch_core_io.c:970 Engaging Write
Buffer at 480 bytes to accommodate 320->480
2012-04-29 12:50:05.267313 [DEBUG] switch_core_session.c:738 Send
signal dingaling/GVOICE/+15555555... at voice.google.com [BREAK]
2012-04-29 12:50:05.267313 [DEBUG] mod_dingaling.c:1342 dingaling/
GVOICE/+15555555... at voice.google.com CHANNEL KILL
2012-04-29 12:50:05.267313 [DEBUG] switch_core_session.c:738 Send
signal sofia/sipinterface_1/yu... at 192.168.0.112 [BREAK]
2012-04-29 12:50:05.358039 [DEBUG] switch_rtp.c:2544 Correct ip/port
confirmed.
2012-04-29 12:50:05.358039 [DEBUG] switch_core_io.c:970 Engaging Write
Buffer at 320 bytes to accommodate 480->320