core set debug channel SIP/2400-7631e3d8 Debugging enabled on channel SIP/2400-7631e3d8 Debugging on new channels is enabled [Aug 23 11:42:55] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '1' received on SIP/2400-7631e3d8 [Aug 23 11:42:55] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '1' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 1 (49) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:55] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '1' received on SIP/2400-7631e3d8, duration 150 ms [Aug 23 11:42:55] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '1' on SIP/2400-7631e3d8 [Aug 23 11:42:55] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '1' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 1 (49) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '2' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '2' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 2 (50) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '2' received on SIP/2400-7631e3d8, duration 90 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '2' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '2' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 2 (50) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '3' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '3' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 3 (51) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '3' received on SIP/2400-7631e3d8, duration 90 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '3' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '3' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 3 (51) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '4' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '4' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 4 (52) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '4' received on SIP/2400-7631e3d8, duration 120 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '4' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '4' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 4 (52) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '5' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '5' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 5 (53) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '5' received on SIP/2400-7631e3d8, duration 100 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '5' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '5' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 5 (53) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '6' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '6' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 6 (54) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '6' received on SIP/2400-7631e3d8, duration 100 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '6' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '6' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 6 (54) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '7' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '7' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 7 (55) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '7' received on SIP/2400-7631e3d8, duration 130 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '7' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '7' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 7 (55) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '8' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '8' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 8 (56) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '8' received on SIP/2400-7631e3d8, duration 90 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '8' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '8' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 8 (56) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '9' received on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '9' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 9 (57) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:56] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '9' received on SIP/2400-7631e3d8, duration 90 ms [Aug 23 11:42:56] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '9' on SIP/2400-7631e3d8 [Aug 23 11:42:56] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '9' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 9 (57) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:57] DTMF[25951]: channel.c:2444 __ast_read: DTMF begin '0' received on SIP/2400-7631e3d8 [Aug 23 11:42:57] DTMF[25951]: channel.c:2454 __ast_read: DTMF begin passthrough '0' on SIP/2400-7631e3d8 << [ TYPE: DTMF Begin (12) SUBCLASS: 0 (48) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] [Aug 23 11:42:57] DTMF[25951]: channel.c:2382 __ast_read: DTMF end '0' received on SIP/2400-7631e3d8, duration 100 ms [Aug 23 11:42:57] DTMF[25951]: channel.c:2423 __ast_read: DTMF end accepted with begin '0' on SIP/2400-7631e3d8 [Aug 23 11:42:57] DTMF[25951]: channel.c:2438 __ast_read: DTMF end passthrough '0' on SIP/2400-7631e3d8 << [ TYPE: DTMF End (1) SUBCLASS: 0 (48) ] [SIP/2400-7631e3d8] -- User entered '1234567890' -- Executing [8888@sip-internal:2] NoOp("SIP/2400-7631e3d8", "number: 1234567890") in new stack -- Executing [8888@sip-internal:3] SayDigits("SIP/2400-7631e3d8", "1234567890") in new stack -- Playing 'digits/1' << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] -- Playing 'digits/2' -- Playing 'digits/3' -- Playing 'digits/4' -- Playing 'digits/5' -- Playing 'digits/6' << [ TYPE: Null Frame (5) SUBCLASS: N/A (0) ] [SIP/2400-7631e3d8] -- Playing 'digits/7' -- Playing 'digits/8' -- Playing 'digits/9' -- Playing 'digits/0' -- Executing [8888@sip-internal:4] Hangup("SIP/2400-7631e3d8", "") in new stack == Spawn extension (sip-internal, 8888, 4) exited non-zero on 'SIP/2400-7631e3d8'