E&M wink trunk DID detection ( DTMF ) broken after 1.2.2

i tested a system on the e&m wink trunk ( our sprint LD circuit )

works with 1.2.21

fails on 1.2.22
and fails on 1.2.23

whats the best way to communicate this to development

the CLI simply shows the digits not being interpreted correctly and is reproducable 100% of the time …

http://bugs.digium.com

If its a Digium card you could also contact support at support@digium.com

i also reported it to bugs and sent an email to digium support as suggested …

the case in point i have is with a dedicated sprint t1 for our inbound toll free and outbound long distance – the provider sends DNIS digits down the pipe which we then have to interpret and route based on the digits we see … ie 800 215-6911 should be translated to 1652; specifically the traslations is

<10 digit ANI>*

so a call from 4235551212 to 800-215-6911 with an assigned DNIS of 1652 should look like

42355512121652*

instead it interprerts garbage and plays “no-service”

here is the output from 4 failed inbound calls a row with 1.2.23 followed by 4 successful inbound calls with 1.2.21.1 - nothing changes but the asterisk v ersion …

failed calls:
Aug 1 10:57:01 VERBOSE[12797] logger.c: – Remote UNIX connection
Aug 1 10:57:23 VERBOSE[12864] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 10:57:24 VERBOSE[12866] logger.c: – Starting simple switch on 'Zap/2-1’
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Exception on 14, channel 1
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Exception on 14, channel 1
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Exception on 14, channel 1
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:57:25 WARNING[12864] chan_zap.c: getdtmf on channel 1: Operation now in progress
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 10:57:25 DEBUG[12864] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 10:57:25 VERBOSE[12864] logger.c: – Hungup 'Zap/1-1’
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Got event On hook(1) on channel 2 (index 0)
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: disabled echo cancellation on channel 2
Aug 1 10:57:26 WARNING[12866] chan_zap.c: getdtmf on channel 2: Operation now in progress
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Hangup: channel: 2 index = 0, normal = 15, callwait = -1, thirdcall = -1
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: disabled echo cancellation on channel 2
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/2-1
Aug 1 10:57:26 DEBUG[12866] chan_zap.c: Updated conferencing on 2, with 0 conference users
Aug 1 10:57:26 VERBOSE[12866] logger.c: – Hungup 'Zap/2-1’
Aug 1 10:57:52 VERBOSE[12872] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 10:57:53 VERBOSE[12874] logger.c: – Starting simple switch on 'Zap/2-1’
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Exception on 14, channel 1
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Exception on 14, channel 1
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Exception on 14, channel 1
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:57:54 WARNING[12872] chan_zap.c: getdtmf on channel 1: Operation now in progress
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 10:57:54 DEBUG[12872] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 10:57:54 VERBOSE[12872] logger.c: – Hungup 'Zap/1-1’
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: DTMF digit: 2 on Zap/2-1
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Exception on 15, channel 2
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Sent deferred digit string:
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: DTMF digit: * on Zap/2-1
Aug 1 10:57:55 DEBUG[12874] chan_zap.c: Enabled echo cancellation on channel 2
Aug 1 10:57:55 VERBOSE[12874] logger.c: == Unknown extension ‘2*’ in context ‘from-pstn’ requested
Aug 1 10:57:58 DEBUG[12874] channel.c: Scheduling timer at 160 sample intervals
Aug 1 10:57:58 VERBOSE[12874] logger.c: – Playing ‘ss-noservice’ (language ‘en’)
Aug 1 10:58:03 DEBUG[12874] channel.c: Scheduling timer at 0 sample intervals
Aug 1 10:58:03 DEBUG[12874] channel.c: Scheduling timer at 0 sample intervals
Aug 1 10:58:03 DEBUG[12874] chan_zap.c: Hangup: channel: 2 index = 0, normal = 15, callwait = -1, thirdcall = -1
Aug 1 10:58:03 DEBUG[12874] chan_zap.c: disabled echo cancellation on channel 2
Aug 1 10:58:03 DEBUG[12874] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/2-1
Aug 1 10:58:03 DEBUG[12874] chan_zap.c: Updated conferencing on 2, with 0 conference users
Aug 1 10:58:03 VERBOSE[12874] logger.c: – Hungup 'Zap/2-1’
Aug 1 10:58:03 DEBUG[12808] chan_zap.c: disabled echo cancellation on channel 2
Aug 1 10:58:10 VERBOSE[12878] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 10:58:11 VERBOSE[12880] logger.c: – Starting simple switch on 'Zap/2-1’
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:58:12 WARNING[12878] chan_zap.c: getdtmf on channel 1: Operation now in progress
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 10:58:12 DEBUG[12878] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 10:58:12 VERBOSE[12878] logger.c: – Hungup 'Zap/1-1’
Aug 1 10:58:12 VERBOSE[12883] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Exception on 15, channel 2
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Exception on 15, channel 2
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Exception on 15, channel 2
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Got event On hook(1) on channel 2 (index 0)
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: disabled echo cancellation on channel 2
Aug 1 10:58:13 WARNING[12880] chan_zap.c: getdtmf on channel 2: Operation now in progress
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Hangup: channel: 2 index = 0, normal = 15, callwait = -1, thirdcall = -1
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: disabled echo cancellation on channel 2
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/2-1
Aug 1 10:58:13 DEBUG[12880] chan_zap.c: Updated conferencing on 2, with 0 conference users
Aug 1 10:58:13 VERBOSE[12880] logger.c: – Hungup 'Zap/2-1’
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Got event Hook Transition Complete(12) on channel 1 (index 0)
Aug 1 10:58:14 DEBUG[12883] chan_zap.c: Sent deferred digit string:
Aug 1 10:58:19 DEBUG[12883] chan_zap.c: Enabled echo cancellation on channel 1
Aug 1 10:58:19 VERBOSE[12883] logger.c: – Executing NoOp(“Zap/1-1”, “No DID or CID Match”) in new stack
Aug 1 10:58:19 VERBOSE[12883] logger.c: – Executing Answer(“Zap/1-1”, “”) in new stack
Aug 1 10:58:19 DEBUG[12799] channel.c: Avoiding initial deadlock for 'Zap/1-1’
Aug 1 10:58:19 DEBUG[12883] chan_zap.c: Took Zap/1-1 off hook
Aug 1 10:58:19 VERBOSE[12883] logger.c: – Executing Wait(“Zap/1-1”, “2”) in new stack
Aug 1 10:58:20 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:20 DEBUG[12883] chan_zap.c: Got event Wink/Flash(3) on channel 1 (index 0)
Aug 1 10:58:20 DEBUG[12883] chan_zap.c: Got wink in weird state 6 on channel 1
Aug 1 10:58:21 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:21 DEBUG[12883] chan_zap.c: Got event Ring/Answered(2) on channel 1 (index 0)
Aug 1 10:58:21 WARNING[12883] chan_zap.c: Ring/Off-hook in strange state 6 on channel 1
Aug 1 10:58:21 VERBOSE[12883] logger.c: – Executing Playback(“Zap/1-1”, “ss-noservice”) in new stack
Aug 1 10:58:21 DEBUG[12883] channel.c: Scheduling timer at 160 sample intervals
Aug 1 10:58:21 VERBOSE[12883] logger.c: – Playing ‘ss-noservice’ (language ‘en’)
Aug 1 10:58:22 DEBUG[12883] chan_zap.c: Exception on 14, channel 1
Aug 1 10:58:22 DEBUG[12883] chan_zap.c: Got event Alarm(4) on channel 1 (index 0)
Aug 1 10:58:22 WARNING[12883] chan_zap.c: Detected alarm on channel 1: Red Alarm
Aug 1 10:58:22 DEBUG[12883] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:58:22 DEBUG[12883] channel.c: Scheduling timer at 0 sample intervals
Aug 1 10:58:22 V
ERBOSE[12883] logger.c: == Spawn extension (from-pstn, s, 4) exited non-zero on 'Zap/1-1’
Aug 1 10:58:22 DEBUG[12883] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 10:58:22 DEBUG[12883] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 10:58:22 DEBUG[12883] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1

successful calls:
Aug 1 11:31:01 VERBOSE[19096] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 11:31:02 DEBUG[19096] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:02 DEBUG[19096] chan_zap.c: DTMF digit: 4 on Zap/1-1
Aug 1 11:31:02 DEBUG[19096] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:02 DEBUG[19096] chan_zap.c: DTMF digit: 3 on Zap/1-1
Aug 1 11:31:02 DEBUG[19096] chan_zap.c: DTMF digit: 9 on Zap/1-1
Aug 1 11:31:02 DEBUG[19096] chan_zap.c: DTMF digit: 5 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 7 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 1 on Zap/1-1
Aug 1 11:31:03 DEBUG[19096] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:04 DEBUG[19096] chan_zap.c: DTMF digit: 5 on Zap/1-1
Aug 1 11:31:04 DEBUG[19096] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:04 DEBUG[19096] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:04 DEBUG[19096] chan_zap.c: Enabled echo cancellation on channel 1
Aug 1 11:31:04 VERBOSE[19096] logger.c: – Executing Set(“Zap/1-1”, “__FROM_DID=1652”) in new stack
Aug 1 11:31:04 VERBOSE[19096] logger.c: – Executing Set(“Zap/1-1”, “FAX_RX=system”) in new stack
Aug 1 11:31:04 VERBOSE[19096] logger.c: – Executing Set(“Zap/1-1”, "FAX_RX_EMAIL=aheaton@landair.com") in new stack
Aug 1 11:31:04 VERBOSE[19096] logger.c: – Executing Answer(“Zap/1-1”, “”) in new stack
Aug 1 11:31:04 DEBUG[19096] chan_zap.c: Took Zap/1-1 off hook
Aug 1 11:31:04 VERBOSE[19096] logger.c: – Executing Wait(“Zap/1-1”, “5”) in new stack
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: Exception on 14, channel 1
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:08 VERBOSE[19096] logger.c: == Spawn extension (from-pstn, 1652, 5) exited non-zero on 'Zap/1-1’
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 11:31:08 DEBUG[19096] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 11:31:08 VERBOSE[19096] logger.c: – Hungup 'Zap/1-1’
Aug 1 11:31:15 VERBOSE[19102] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 4 on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 3 on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 9 on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 5 on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:16 DEBUG[19102] chan_zap.c: DTMF digit: 7 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 1 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 5 on Zap/1-1
Aug 1 11:31:17 DEBUG[19102] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:18 DEBUG[19102] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:18 DEBUG[19102] chan_zap.c: Enabled echo cancellation on channel 1
Aug 1 11:31:18 VERBOSE[19102] logger.c: – Executing Set(“Zap/1-1”, “__FROM_DID=1652”) in new stack
Aug 1 11:31:18 VERBOSE[19102] logger.c: – Executing Set(“Zap/1-1”, “FAX_RX=system”) in new stack
Aug 1 11:31:18 VERBOSE[19102] logger.c: – Executing Set(“Zap/1-1”, "FAX_RX_EMAIL=aheaton@landair.com") in new stack
Aug 1 11:31:18 VERBOSE[19102] logger.c: – Executing Answer(“Zap/1-1”, “”) in new stack
Aug 1 11:31:18 DEBUG[19102] chan_zap.c: Took Zap/1-1 off hook
Aug 1 11:31:18 VERBOSE[19102] logger.c: – Executing Wait(“Zap/1-1”, “5”) in new stack
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: Exception on 14, channel 1
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:22 VERBOSE[19102] logger.c: == Spawn extension (from-pstn, 1652, 5) exited non-zero on 'Zap/1-1’
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 11:31:22 DEBUG[19102] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 11:31:22 VERBOSE[19102] logger.c: – Hungup 'Zap/1-1’
Aug 1 11:31:29 VERBOSE[19106] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: 4 on Zap/1-1
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: 3 on Zap/1-1
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:30 DEBUG[19106] chan_zap.c: DTMF digit: 0 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 9 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 3 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 7 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 4 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 1 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:31 DEBUG[19106] chan_zap.c: DTMF digit: 5 on Zap/1-1
Aug 1 11:31:32 DEBUG[19106] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:32 DEBUG[19106] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:32 DEBUG[19106] chan_zap.c: Enabled echo cancellation on channel 1
Aug 1 11:31:32 VERBOSE[19106] logger.c: – Executing Set(“Zap/1-1”, “__FROM_DID=1652”) in new stack
Aug 1 11:31:32 VERBOSE[19106] logger.c: – Executing Set(“Zap/1-1”, “FAX_RX=system”) in new stack
Aug 1 11:31:32 VERBOSE[19106] logger.c: – Executing Set(“Zap/1-1”, "FAX_RX_EMAIL=aheaton@landair.com") in new stack
Aug 1 11:31:32 VERBOSE[19106] logger.c: – Executing Answer(“Zap/1-1”, “”) in new stack
Aug 1 11:31:32 DEBUG[19106] chan_zap.c: Took Zap/1-1 off hook
Aug 1 11:31:32 VERBOSE[19106] logger.c: – Executing Wait(“Zap/1-1”, “5”) in new stack
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: Exception on 14, channel 1
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:36 VERBOSE[19106] logger.c: == Spawn extension (from-pstn, 1652, 5) exited non-zero on 'Zap/1-1’
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 11:31:36 DEBUG[19106] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 11:31:36 VERBOSE[19106] logger.c: – Hungup 'Zap/1-1’
Aug 1 11:31:42 VERBOSE[19110] logger.c: – Starting simple switch on 'Zap/1-1’
Aug 1 11:31:42 DEBUG[19110] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:42 DEBUG[19110] chan_zap.c: DTMF digit: 4 on Zap/1-1
Aug 1 11:31:42 DEBUG[19110] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:42 DEBUG[19110] chan_zap.c: DTMF digit: 3 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 0 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 9 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 3 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 7 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: 4 on Zap/1-1
Aug 1 11:31:43 DEBUG[19110] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: DTMF digit: 1 on Zap/1-1
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: DTMF digit: 6 on Zap/1-1
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: DTMF digit: 5 on Zap/1-1
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: DTMF digit: 2 on Zap/1-1
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: DTMF digit: * on Zap/1-1
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: Enabled echo cancellation on channel 1
Aug 1 11:31:44 VERBOSE[19110] logger.c: – Executing Set(“Zap/1-1”, “__FROM_DID=1652”) in new stack
Aug 1 11:31:44 VERBOSE[19110] logger.c: – Executing Set(“Zap/1-1”, “FAX_RX=system”) in new stack
Aug 1 11:31:44 VERBOSE[19110] logger.c: – Executing Set(“Zap/1-1”, "FAX_RX_EMAIL=aheaton@landair.com") in new stack
Aug 1 11:31:44 VERBOSE[19110] logger.c: – Executing Answer(“Zap/1-1”, “”) in new stack
Aug 1 11:31:44 DEBUG[19110] chan_zap.c: Took Zap/1-1 off hook
Aug 1 11:31:44 VERBOSE[19110] logger.c: – Executing Wait(“Zap/1-1”, “5”) in new stack
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: Exception on 14, channel 1
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: Got event On hook(1) on channel 1 (index 0)
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:47 VERBOSE[19110] logger.c: == Spawn extension (from-pstn, 1652, 5) exited non-zero on 'Zap/1-1’
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: disabled echo cancellation on channel 1
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Aug 1 11:31:47 DEBUG[19110] chan_zap.c: Updated conferencing on 1, with 0 conference users
Aug 1 11:31:47 VERBOSE[19110] logger.c: – Hungup ‘Zap/1-1’

i have a test box i could allow access to

the same results are received with version 1.2.22

The same problem occurs in asterisk 1.4.8 (version 1.4.7.1 works just fine). It’s on XO T1 DID trunks. A following line appears in logs when you dial in

[Aug 2 09:45:28] WARNING[12763] chan_zap.c: getdtmf on channel 2: Success

The net effect is for the channel to be hanged-up quickly after answering the inbound call. XO’s system tries to connect on the next sequential DID trun, which fails in the same manner, and then the caller hears “all circuits are busy – please try you call again later”.

#zaptel.conf
span=1,1,0,esf,b8zs
e&m=1-6

#zapata.conf
signalling=em_w
channel=>1-6