Hi,
We are using asterisk 1.4.20 load. We have seen that couple of
times Asterisk fails to convert SIP INFO packet in to Inband tone.
Problem Description:
Asterisk behaves as a media proxy between proxy1 and
proxy2.
Proxy1 transmit DTMF using SIP INFO method while proxy2
works with Inaband Tone. I have provided complete setup descriptions below.
After analyzing the logs we found that when proxy1
transmit 1st DTMF Digit it successfully converts into inband but when we
send next digit chan->generatordata is set to NULL therefore no Inabdn tone
generate further. This remains set to NULL for a while and then it start
converting again into inband.
Here is sip.conf
[general]
Dtmfmode=inband
[peer-proxy1]
type=peer ; we only want to call out, not be called
fromdomain=proxy2.varaha.com ;
host= 71.153.215.73 ;
context=from-proxy1
;dtmfmode=inband
dtmfmode=info
rtpkeepalive=1
port=5045
disallow=all
allow=ulaw
allow=alaw
[peer-proxy2]
type=peer ; we only want to call out, not be called
fromdomain= proxy1.varaha.com
context=from-proxy2
;dtmfmode=auto
;dtmfmode=rfc2833
;rfc2833compensate=yes ; Compensate for pre-1.4 DTMF transmission
from another Asterisk machine.
;dtmfmode=inband
;dtmfmode=info
;rtpkeepalive=1
port=5080
disallow=all
allow=ulaw
allow=alaw
We have seen following logs in message file
[Jul 11 03:58:22] DTMF[32393] chan_sip.c: -Got INFO with: [1] Duration:
[250]
[Jul 11 03:58:22] DTMF[32508] channel.c: DTMF end '1' received on
SIP/trunk.myvtel.com-090f4880, duration 250 ms
[Jul 11 03:58:22] DTMF[32508] channel.c: DTMF begin emulation of '1'
with
duration 250 queued on SIP/trunk.myvtel.com-090f4880
[Jul 11 03:58:22] NOTICE[32508] channel.c: Send DTMF in Inband: [1]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Result of ast_playtones_start:
[0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: Generate DTMF for pointer:
[0x9103E20]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x9103E20] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] DTMF[32508] channel.c: DTMF end emulation of '1'
queued on
SIP/trunk.myvtel.com-090f4880
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:22] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] DTMF[32393] chan_sip.c: -Got INFO with: [2] Duration:
[250]
[Jul 11 03:58:23] DTMF[32508] channel.c: DTMF end '2' received on
SIP/trunk.myvtel.com-090f4880, duration 250 ms
[Jul 11 03:58:23] DTMF[32508] channel.c: DTMF begin emulation of '2'
with
duration 250 queued on SIP/trunk.myvtel.com-090f4880
[Jul 11 03:58:23] NOTICE[32508] channel.c: Send DTMF in Inband: [2]
[Jul 11 03:58:23] NOTICE[32508] channel.c: Result of ast_playtones_start:
[0]
[Jul 11 03:58:23] DTMF[32508] channel.c: DTMF end emulation of '2'
queued on
SIP/trunk.myvtel.com-090f4880
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
[Jul 11 03:58:23] NOTICE[32508] channel.c: ast_read_generator_actions:
chan->generatordata[0x0] ast_internal_timing_enabled(chan): [0]
I'll appreciate your help.
Thanks
Niraj Roy
-------------- next part --------------
An HTML attachment was scrubbed...
URL:
http://lists.digium.com/pipermail/asterisk-users/attachments/20080711/74ad1eba/attachment.htm