[asterisk-bugs] [Asterisk 0016113]: Auto-fallthrough when attempting to enter DTMF using Background() in a Macro()

Asterisk Bug Tracker noreply at bugs.digium.com
Tue Dec 8 15:08:38 CST 2009


A NOTE has been added to this issue. 
====================================================================== 
https://issues.asterisk.org/view.php?id=16113 
====================================================================== 
Reported By:                OrNix
Assigned To:                tilghman
====================================================================== 
Project:                    Asterisk
Issue ID:                   16113
Category:                   General
Reproducibility:            always
Severity:                   minor
Priority:                   normal
Status:                     assigned
Target Version:             1.6.1.13
Asterisk Version:           SVN 
JIRA:                       SWP-440 
Regression:                 Yes 
Reviewboard Link:            
SVN Branch (only for SVN checkouts, not tarball releases): N/A 
SVN Revision (number only!):  
Request Review:              
====================================================================== 
Date Submitted:             2009-10-22 03:59 CDT
Last Modified:              2009-12-08 15:08 CST
====================================================================== 
Summary:                    Auto-fallthrough when attempting to enter DTMF using
Background() in a Macro()
Description: 
Hello, All.

Asterisk calls me using a call-file, then i make call with the following
macro:

[macro-internalcall-with-redirect-callback]
exten => s,1,Dial(SIP/${ARG1},20,jgtedH)
exten => s,n,Goto(s-${DIALSTATUS},1)
exten => s-BUSY,1,Background(busy-cycl0)
exten => s-BUSY,2,Goto(${CONTEXT},s,1)

In ${MACRO_CONTEXT} i have extensions:
exten => *,1,ResetCDR(w)
exten => *,n,Goto(${CONTEXT},s,5) 

I make a call to _XXX, recieve "BUSY". While busy-cycl0 is playing, i hit
the "*"-key.

1.6.1.7rc2 - Strange behavior:
[Oct 16 18:03:19] -- Executing
[s at macro-internalcall-with-redirect-callback:3] Goto("H323/sibirtelecom-1",
"s-BUSY,1") in new stack
[Oct 16 18:03:19] -- Goto
(macro-internalcall-with-redirect-callback,s-BUSY,1)
[Oct 16 18:03:19] -- Executing
[s-BUSY at macro-internalcall-with-redirect-callback:1]
BackGround("H323/sibirtelecom-1", "busy-cycl0") in new stack
[Oct 16 18:03:19] -- <H323/sibirtelecom-1> Playing 'busy-cycl0.alaw'
(language 'en')
[Oct 16 18:03:20] -- Auto fallthrough, channel 'H323/sibirtelecom-1'
status is 'BUSY'
[Oct 16 18:03:24] DEBUG[9435]: pbx_spool.c:405 scan_service: Delaying
retry since we're currently running
'/var/spool/asterisk/outgoing/32631.call'
[Oct 16 18:03:27] NOTICE[9475]: pbx_spool.c:348 attempt_thread: Call
completed to Local/2487305 at qqq


1.6.1.4 - Normal behavior:
[Oct 16 18:06:43] -- Executing
[s at macro-internalcall-with-redirect-callback:3] Goto("H323/sibirtelecom-1",
"s-BUSY,1") in new stack
[Oct 16 18:06:43] -- Goto
(macro-internalcall-with-redirect-callback,s-BUSY,1)
[Oct 16 18:06:43] -- Executing
[s-BUSY at macro-internalcall-with-redirect-callback:1]
BackGround("H323/sibirtelecom-1", "busy-cycl0") in new stack
[Oct 16 18:06:43] -- <H323/sibirtelecom-1> Playing 'busy-cycl0.alaw'
(language 'en')
[Oct 16 18:06:44] == CDR updated on H323/sibirtelecom-1
[Oct 16 18:06:44] -- Executing [*@callback:1]
ResetCDR("H323/sibirtelecom-1", "w") in new stack
[Oct 16 18:06:44] -- Executing [*@callback:2] Goto("H323/sibirtelecom-1",
"callback,s,5") in new stack
[Oct 16 18:06:44] -- Goto (callback,s,5)
[Oct 16 18:06:44] -- Executing [s at callback:5]
WaitExten("H323/sibirtelecom-1", "1") in new stack

This error occurs both with chan_h323 and with chan_ooh323.

P.S. I don't know, what category should i select in this case, please move
 the topic to the correct one.
====================================================================== 

---------------------------------------------------------------------- 
 (0114950) tilghman (administrator) - 2009-12-08 15:08
 https://issues.asterisk.org/view.php?id=16113#c114950 
---------------------------------------------------------------------- 
I haven't been able to reproduce.  I reproduced your dialplan, except that
I'm using SIP, because I haven't got an H323 channel to test with:

    -- Attempting call on Local/103 at qqq for s at callback:1 (Retry 1)
    -- Executing [103 at qqq:1] Macro("Local/103 at qqq-b498;2", "cb-sip,103")
in new stack
    -- Executing [s at macro-cb-sip:1] NoCDR("Local/103 at qqq-b498;2", "") in
new stack
    -- Executing [s at macro-cb-sip:2] Set("Local/103 at qqq-b498;2",
"CALLERID(num)=3833540661") in new stack
    -- Executing [s at macro-cb-sip:3] Dial("Local/103 at qqq-b498;2",
"SIP/103,,Tg") in new stack
  == Using SIP RTP CoS mark 5
  == Using SIP VRTP CoS mark 6
    -- Called 103
    -- SIP/103-00000000 is ringing
    -- SIP/103-00000000 answered Local/103 at qqq-b498;2
       > Channel Local/103 at qqq-b498;1 was answered.
    -- Executing [s at callback:1] Answer("Local/103 at qqq-b498;1", "") in new
stack
    -- Executing [s at callback:2] Set("Local/103 at qqq-b498;1",
"CLID=2487305") in new stack
    -- Executing [s at callback:3] Set("Local/103 at qqq-b498;1",
"CALLERID(name)=2487305") in new stack
    -- Executing [s at callback:4] Set("Local/103 at qqq-b498;1",
"TIMEOUT(digit)=6") in new stack
    -- Digit timeout set to 6.000
    -- Executing [s at callback:5] WaitExten("Local/103 at qqq-b498;1", "1") in
new stack
[Dec  8 15:05:16] WARNING[3828]: channel.c:2445 ast_waitfordigit_full:
Unexpected control subclass '-1'
  == Spawn extension (macro-cb-sip, s, 3) exited non-zero on
'Local/103 at qqq-b498;2' in macro 'cb-sip'
  == Spawn extension (qqq, 103, 1) exited non-zero on
'Local/103 at qqq-b498;2'
    -- Timeout on SIP/103-00000000, continuing...
    -- Executing [s at callback:6] BackGround("SIP/103-00000000",
"tt-weasels") in new stack
    -- <SIP/103-00000000> Playing 'tt-weasels.gsm' (language 'en')
    -- Executing [s at callback:7] WaitExten("SIP/103-00000000", "30") in new
stack
  == CDR updated on SIP/103-00000000
    -- Executing [*@callback:1] ResetCDR("SIP/103-00000000", "w") in new
stack
    -- Executing [*@callback:2] Goto("SIP/103-00000000", "callback,s,5")
in new stack
    -- Goto (callback,s,5)
    -- Executing [s at callback:5] WaitExten("SIP/103-00000000", "1") in new
stack
    -- Timeout on SIP/103-00000000, continuing...
    -- Executing [s at callback:6] BackGround("SIP/103-00000000",
"tt-weasels") in new stack
    -- <SIP/103-00000000> Playing 'tt-weasels.gsm' (language 'en')
    -- Executing [s at callback:7] WaitExten("SIP/103-00000000", "30") in new
stack
  == CDR updated on SIP/103-00000000
    -- Executing [*@callback:1] ResetCDR("SIP/103-00000000", "w") in new
stack
    -- Executing [*@callback:2] Goto("SIP/103-00000000", "callback,s,5")
in new stack
    -- Goto (callback,s,5)
    -- Executing [s at callback:5] WaitExten("SIP/103-00000000", "1") in new
stack
    -- Timeout on SIP/103-00000000, continuing...
    -- Executing [s at callback:6] BackGround("SIP/103-00000000",
"tt-weasels") in new stack
    -- <SIP/103-00000000> Playing 'tt-weasels.gsm' (language 'en')
[Dec  8 15:05:31] DEBUG[3765]: pbx_spool.c:405 scan_service: Delaying
retry since we're currently running
'/var/spool/asterisk/outgoing/callfile'
    -- Executing [s at callback:7] WaitExten("SIP/103-00000000", "30") in new
stack
  == Spawn extension (callback, s, 7) exited non-zero on
'SIP/103-00000000'
[Dec  8 15:05:32] NOTICE[3828]: pbx_spool.c:348 attempt_thread: Call
completed to Local/103 at qqq

What am I missing? 

Issue History 
Date Modified    Username       Field                    Change               
====================================================================== 
2009-12-08 15:08 tilghman       Note Added: 0114950                          
======================================================================




More information about the asterisk-bugs mailing list