We are having an issue where DTMF is not being sent out right away and the tone duration is inconsistent. For a test we send a '5', then a second later we send a '9', and then five seconds later we send a '5'. If you look at the logs below you can see the first '5' is played right away, then the '9' comes in and gets queued, but it doesn't start playing until five seconds later and it plays for six seconds. Then the last '5' is played.
<br><br>The DTMF is coming in as only 'end' packets and we can't change that. For this reason we have turned on rfc2833compensate. Using Asterisk 1.4.11.<br><br>Any ideas?<br><br><br>asteriskpri04*CLI><br>
< Protocol Discriminator: Q.931 (8) len=5<br>< Call Ref: len= 2 (reference 499/0x1F3) (Terminator)<br>< Message type: CONNECT (7)<br>q931.c:3371 q931_receive: call 33267 on channel 3 enters state 10 (Active)<br>
> Protocol Discriminator: Q.931 (8) len=5<br>> Call Ref: len= 2 (reference 499/0x1F3) (Originator)<br>> Message type: CONNECT ACKNOWLEDGE (15)<br>[Oct 23 10:39:56] DEBUG[6136]: chan_zap.c:1413 zt_enable_ec: Echo cancellation already on
<br> -- Zap/3-1 answered SIP/test.com-08dc1ef8<br><br>[Oct 23 10:39:58] DTMF[13914]: channel.c:2346 __ast_read: DTMF end '5' received on SIP/test.com-08dc1ef8, duration 0 ms<br>[Oct 23 10:39:58] DTMF[13914]: channel.c
:2382 __ast_read: DTMF begin emulation of '5' with duration 100 queued on SIP/test.com-08dc1ef8<br>[Oct 23 10:39:58] DEBUG[13914]: chan_zap.c:1048 zt_digit_begin: Started VLDTMF digit '5'<br><br>[Oct 23 10:39:59] DTMF[13914]:
channel.c:2346 __ast_read: DTMF end '9' received on SIP/test.com-08dc1ef8, duration 0 ms<br>[Oct 23 10:39:59] DTMF[13914]: channel.c:2352 __ast_read: DTMF end '9' put into dtmf queue on SIP/test.com-08dc1ef8
<br><br>[Oct 23 10:39:59] DTMF[13914]: channel.c:2434 __ast_read: DTMF end emulation of '5' queued on SIP/test.com-08dc1ef8<br>[Oct 23 10:39:59] DEBUG[13914]: chan_zap.c:1083 zt_digit_end: Ending VLDTMF digit '5'
<br><br>[Oct 23 10:40:04] DTMF[13914]: channel.c:2215 __ast_read: DTMF begin emulation of '9' with duration 100 queued on SIP/test.com-08dc1ef8<br>[Oct 23 10:40:04] DEBUG[13914]: chan_zap.c:1048 zt_digit_begin: Started VLDTMF digit '9'
<br>[Oct 23 10:40:04] DTMF[13914]: channel.c:2346 __ast_read: DTMF end '5' received on SIP/test.com-08dc1ef8, duration 0 ms<br>[Oct 23 10:40:04] DTMF[13914]: channel.c:2352 __ast_read: DTMF end '5' put into dtmf queue on SIP/test.com-08dc1ef8
<br><br>[Oct 23 10:40:10] DTMF[13914]: channel.c:2465 __ast_read: DTMF end emulation of '9' queued on SIP/test.com-08dc1ef8<br>[Oct 23 10:40:10] DEBUG[13914]: chan_zap.c:1083 zt_digit_end: Ending VLDTMF digit '9'
<br>[Oct 23 10:40:10] DTMF[13914]: channel.c:2215 __ast_read: DTMF begin emulation of '5' with duration 100 queued on SIP/test.com-08dc1ef8<br>[Oct 23 10:40:10] DEBUG[13914]: chan_zap.c:1048 zt_digit_begin: Started VLDTMF digit '5'
<br><br>[Oct 23 10:40:10] DTMF[13914]: channel.c:2465 __ast_read: DTMF end emulation of '5' queued on SIP/test.com-08dc1ef8<br>[Oct 23 10:40:10] DEBUG[13914]: chan_zap.c:1083 zt_digit_end: Ending VLDTMF digit '5'
<br><br><br>Thanks,<br>Jason<br><br>