Debugging Some DTMF Weirdness.

Home » Asterisk Users » Debugging Some DTMF Weirdness.
Asterisk Users 1 Comment

I’m attempting to find where my extra long DTMF Tones are coming from.

I’m dialing from my sip handset through my proxy to my Asterisk box which is my PSTN Gateway.

I’m pressing 4 to select a menu and everything is fine.

[Feb 12 16:58:18] DTMF[29762] channel.c: DTMF begin ‘4’ received on SIP/trunk-0a02dee0
[Feb 12 16:58:18] DTMF[29762] channel.c: DTMF begin passthrough ‘4’ on SIP/trunk-0a02dee0
[Feb 12 16:58:18] DTMF[29762] channel.c: DTMF end ‘4’ received on SIP/trunk-0a02dee0, duration 150 ms
[Feb 12 16:58:18] DTMF[29762] channel.c: DTMF end accepted with begin ‘4’
on SIP/trunk-0a02dee0
[Feb 12 16:58:18] DTMF[29762] channel.c: DTMF end passthrough ‘4’ on SIP/trunk-0a02dee0
[Feb 12 16:58:19] DTMF[29760] channel.c: DTMF begin ‘4’ received on SIP/trunk-0a03aaa0
[Feb 12 16:58:19] DTMF[29760] channel.c: DTMF begin passthrough ‘4’ on SIP/trunk-0a03aaa0
[Feb 12 16:58:19] DTMF[29760] channel.c: DTMF end ‘4’ received on SIP/trunk-0a03aaa0, duration 170 ms
[Feb 12 16:58:19] DTMF[29760] channel.c: DTMF end accepted with begin ‘4’
on SIP/trunk-0a03aaa0
[Feb 12 16:58:19] DTMF[29760] channel.c: DTMF end passthrough ‘4’ on SIP/trunk-0a03aaa0

I’m, pressing 9 to select an option and I hear an extra long DTMF burst from my handset.

[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF begin ‘9’ received on SIP/trunk-0a02dee0
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF begin passthrough ‘9’ on SIP/trunk-0a02dee0
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF begin ‘9’ received on Zap/59-1
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF begin passthrough ‘9’ on Zap/59-1
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end ‘9’ received on SIP/trunk-0a02dee0, duration 1700 ms
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end accepted with begin ‘9’
on SIP/trunk-0a02dee0
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end passthrough ‘9’ on SIP/trunk-0a02dee0
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end ‘9’ received on Zap/59-1, duration 32 ms
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end accepted with begin ‘9’
on Zap/59-1
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end ‘9’ has duration 32 but want minimum 80, emulating on Zap/59-1
[Feb 12 16:58:20] DTMF[29762] channel.c: DTMF end emulation of ‘9’ queued on Zap/59-1

Can someone explain the received passthrough parts of my output here?

If I send my call out through a different Asterisk box I have my calls are working fine, Looking at the two boxes I have the same version of asterisk but the machine with the extra long DTMF is using hardware DTMF decoding where the working machine is using software only.

One thought on - Debugging Some DTMF Weirdness.

  • DQpJcyBpdCBwb3NzaWJsZSB5b3VyIHRyYW5zbWl0IG9yIHJlY2VpdmUgZ2FpbiBpcyB0b28gaGln aCBhbmQgQXN0ZXJpc2sgaXMgZGV0ZWN0aW5nIHRoZSBlY2hvIG9mIGEgRFRNRiBhcyBhIG5ldyBk aWdpdCBjYXVzZSBieSBhbiBhbmFsb2cgbGVnIG9mIHRoZSBjYWxsIHNvbWV3aGVyZT8NCg0KDQpG
    cm9tOiBhc3Rlcmlzay11c2Vycy1ib3VuY2VzQGxpc3RzLmRpZ2l1bS5jb20gW21haWx0bzphc3Rl cmlzay11c2Vycy1ib3VuY2VzQGxpc3RzLmRpZ2l1bS5jb21dIE9uIEJlaGFsZiBPZiBKb2huIEtp bmlzdG9uDQpTZW50OiBUaHVyc2RheSwgRmVicnVhcnkgMTIsIDIwMTUgODowMSBQTQ0KVG86IEFz dGVyaXNrIFVzZXJzIE1haWxpbmcgTGlzdCAtIE5vbi1Db21tZXJjaWFsIERpc2N1c3Npb24NClN1
    YmplY3Q6IFthc3Rlcmlzay11c2Vyc10gRGVidWdnaW5nIHNvbWUgRFRNRiBXZWlyZG5lc3MuDQoN
    CkknbSBhdHRlbXB0aW5nIHRvIGZpbmQgd2hlcmUgbXkgZXh0cmEgbG9uZyBEVE1GICBUb25lcyBh cmUgY29taW5nIGZyb20uDQoNCkknbSBkaWFsaW5nIGZyb20gbXkgc2lwIGhhbmRzZXQgdGhyb3Vn aCBteSBwcm94eSB0byBteSBBc3RlcmlzayBib3ggd2hpY2ggaXMgbXkgUFNUTiBHYXRld2F5Lg0K
    SSdtIHByZXNzaW5nIDQgdG8gc2VsZWN0IGEgbWVudSBhbmQgZXZlcnl0aGluZyBpcyBmaW5lLg0K
    DQpbRmViIDEyIDE2OjU4OjE4XSBEVE1GWzI5NzYyXSBjaGFubmVsLmM6IERUTUYgYmVnaW4gJzQn IHJlY2VpdmVkIG9uIFNJUC90cnVuay0wYTAyZGVlMA0KW0ZlYiAxMiAxNjo1ODoxOF0gRFRNRlsy OTc2Ml0gY2hhbm5lbC5jOiBEVE1GIGJlZ2luIHBhc3N0aHJvdWdoICc0JyBvbiBTSVAvdHJ1bmst MGEwMmRlZTANCltGZWIgMTIgMTY6NTg6MThdIERUTUZbMjk3NjJdIGNoYW5uZWwuYzogRFRNRiBl bmQgJzQnIHJlY2VpdmVkIG9uIFNJUC90cnVuay0wYTAyZGVlMCwgZHVyYXRpb24gMTUwIG1zDQpb RmViIDEyIDE2OjU4OjE4XSBEVE1GWzI5NzYyXSBjaGFubmVsLmM6IERUTUYgZW5kIGFjY2VwdGVk IHdpdGggYmVnaW4gJzQnIG9uIFNJUC90cnVuay0wYTAyZGVlMA0KW0ZlYiAxMiAxNjo1ODoxOF0g RFRNRlsyOTc2Ml0gY2hhbm5lbC5jOiBEVE1GIGVuZCBwYXNzdGhyb3VnaCAnNCcgb24gU0lQL3Ry dW5rLTBhMDJkZWUwDQpbRmViIDEyIDE2OjU4OjE5XSBEVE1GWzI5NzYwXSBjaGFubmVsLmM6IERU
    TUYgYmVnaW4gJzQnIHJlY2VpdmVkIG9uIFNJUC90cnVuay0wYTAzYWFhMA0KW0ZlYiAxMiAxNjo1
    ODoxOV0gRFRNRlsyOTc2MF0gY2hhbm5lbC5jOiBEVE1GIGJlZ2luIHBhc3N0aHJvdWdoICc0JyBv biBTSVAvdHJ1bmstMGEwM2FhYTANCltGZWIgMTIgMTY6NTg6MTldIERUTUZbMjk3NjBdIGNoYW5u ZWwuYzogRFRNRiBlbmQgJzQnIHJlY2VpdmVkIG9uIFNJUC90cnVuay0wYTAzYWFhMCwgZHVyYXRp b24gMTcwIG1zDQpbRmViIDEyIDE2OjU4OjE5XSBEVE1GWzI5NzYwXSBjaGFubmVsLmM6IERUTUYg ZW5kIGFjY2VwdGVkIHdpdGggYmVnaW4gJzQnIG9uIFNJUC90cnVuay0wYTAzYWFhMA0KW0ZlYiAx MiAxNjo1ODoxOV0gRFRNRlsyOTc2MF0gY2hhbm5lbC5jOiBEVE1GIGVuZCBwYXNzdGhyb3VnaCAn NCcgb24gU0lQL3RydW5rLTBhMDNhYWEwDQpJJ20sIHByZXNzaW5nIDkgdG8gc2VsZWN0IGFuIG9w dGlvbiBhbmQgSSBoZWFyIGFuIGV4dHJhIGxvbmcgRFRNRiBidXJzdCBmcm9tIG15IGhhbmRzZXQu DQoNCltGZWIgMTIgMTY6NTg6MjBdIERUTUZbMjk3NjJdIGNoYW5uZWwuYzogRFRNRiBiZWdpbiAn OScgcmVjZWl2ZWQgb24gU0lQL3RydW5rLTBhMDJkZWUwDQpbRmViIDEyIDE2OjU4OjIwXSBEVE1G
    WzI5NzYyXSBjaGFubmVsLmM6IERUTUYgYmVnaW4gcGFzc3Rocm91Z2ggJzknIG9uIFNJUC90cnVu ay0wYTAyZGVlMA0KW0ZlYiAxMiAxNjo1ODoyMF0gRFRNRlsyOTc2Ml0gY2hhbm5lbC5jOiBEVE1G
    IGJlZ2luICc5JyByZWNlaXZlZCBvbiBaYXAvNTktMQ0KW0ZlYiAxMiAxNjo1ODoyMF0gRFRNRlsy OTc2Ml0gY2hhbm5lbC5jOiBEVE1GIGJlZ2luIHBhc3N0aHJvdWdoICc5JyBvbiBaYXAvNTktMQ0K
    W0ZlYiAxMiAxNjo1ODoyMF0gRFRNRlsyOTc2Ml0gY2hhbm5lbC5jOiBEVE1GIGVuZCAnOScgcmVj ZWl2ZWQgb24gU0lQL3RydW5rLTBhMDJkZWUwLCBkdXJhdGlvbiAxNzAwIG1zDQpbRmViIDEyIDE2
    OjU4OjIwXSBEVE1GWzI5NzYyXSBjaGFubmVsLmM6IERUTUYgZW5kIGFjY2VwdGVkIHdpdGggYmVn aW4gJzknIG9uIFNJUC90cnVuay0wYTAyZGVlMA0KW0ZlYiAxMiAxNjo1ODoyMF0gRFRNRlsyOTc2
    Ml0gY2hhbm5lbC5jOiBEVE1GIGVuZCBwYXNzdGhyb3VnaCAnOScgb24gU0lQL3RydW5rLTBhMDJk ZWUwDQpbRmViIDEyIDE2OjU4OjIwXSBEVE1GWzI5NzYyXSBjaGFubmVsLmM6IERUTUYgZW5kICc5
    JyByZWNlaXZlZCBvbiBaYXAvNTktMSwgZHVyYXRpb24gMzIgbXMNCltGZWIgMTIgMTY6NTg6MjBd IERUTUZbMjk3NjJdIGNoYW5uZWwuYzogRFRNRiBlbmQgYWNjZXB0ZWQgd2l0aCBiZWdpbiAnOScg b24gWmFwLzU5LTENCltGZWIgMTIgMTY6NTg6MjBdIERUTUZbMjk3NjJdIGNoYW5uZWwuYzogRFRN
    RiBlbmQgJzknIGhhcyBkdXJhdGlvbiAzMiBidXQgd2FudCBtaW5pbXVtIDgwLCBlbXVsYXRpbmcg b24gWmFwLzU5LTENCltGZWIgMTIgMTY6NTg6MjBdIERUTUZbMjk3NjJdIGNoYW5uZWwuYzogRFRN
    RiBlbmQgZW11bGF0aW9uIG9mICc5JyBxdWV1ZWQgb24gWmFwLzU5LTENCkNhbiBzb21lb25lIGV4
    cGxhaW4gdGhlIHJlY2VpdmVkIHBhc3N0aHJvdWdoIHBhcnRzIG9mIG15IG91dHB1dCBoZXJlPw0K
    SWYgSSBzZW5kIG15IGNhbGwgb3V0IHRocm91Z2ggYSBkaWZmZXJlbnQgQXN0ZXJpc2sgYm94IEkg aGF2ZSBteSBjYWxscyBhcmUgd29ya2luZyBmaW5lLCBMb29raW5nIGF0IHRoZSB0d28gYm94ZXMg SSBoYXZlIHRoZSBzYW1lIHZlcnNpb24gb2YgYXN0ZXJpc2sgYnV0IHRoZSBtYWNoaW5lIHdpdGgg dGhlIGV4dHJhIGxvbmcgRFRNRiBpcyB1c2luZyBoYXJkd2FyZSBEVE1GIGRlY29kaW5nIHdoZXJl IHRoZSB3b3JraW5nIG1hY2hpbmUgaXMgdXNpbmcgc29mdHdhcmUgb25seS4NCi0tDQpBIGh1bWFu IGJlaW5nIHNob3VsZCBiZSBhYmxlIHRvIGNoYW5nZSBhIGRpYXBlciwgcGxhbiBhbiBpbnZhc2lv biwgYnV0Y2hlciBhIGhvZywgY29ubiBhIHNoaXAsIGRlc2lnbiBhIGJ1aWxkaW5nLCB3cml0ZSBh IHNvbm5ldCwgYmFsYW5jZSBhY2NvdW50cywgYnVpbGQgYSB3YWxsLCBzZXQgYSBib25lLCBjb21m b3J0IHRoZSBkeWluZywgdGFrZSBvcmRlcnMsIGdpdmUgb3JkZXJzLCBjb29wZXJhdGUsIGFjdCBh bG9uZSwgc29sdmUgZXF1YXRpb25zLCBhbmFseXplIGEgbmV3IHByb2JsZW0sIHBpdGNoIG1hbnVy ZSwgcHJvZ3JhbSBhIGNvbXB1dGVyLCBjb29rIGEgdGFzdHkgbWVhbCwgZmlnaHQgZWZmaWNpZW50
    bHksIGRpZSBnYWxsYW50bHkuIFNwZWNpYWxpemF0aW9uIGlzIGZvciBpbnNlY3RzLg0KLS0tSGVp bmxlaW4NCg=