[asterisk-users] A simple IVR extension problem

voiplist gotvoip at gmail.com
Fri Aug 3 00:45:19 CDT 2007


Might want to start by proving out your DTMF by just sending the calls
to something like VoiceMailMain().

When going into the voicemail system, see if you can reliably get DTMF
to work while entering mailbox numbers and password and moving around
the VM system..

At first glance it sure sounds to me like a DTMF issue of some sort.

Regards,
 Todd R.

--
Prestige Messaging
Live Answering Services
SIP or Toll-Free Connectivity
Light Accounts From $14.95/mo
http://www.PrestigeMessaging.com


On 8/2/07, Vincent Li <vincent.mc.li at gmail.com> wrote:
> Hi list,
>
> I am running TDM11b + Asterisk-1.4.9 + Zaptel-1.4.4 + Libpri-1.4.1 on CentOS
> 5.
>
> I am having trouble to make my simple IVR extension work, here is relevant
> config:
>
> zapata.conf
> ----
> context=incoming
> signalling=fxs_ks
> channel => 4
>
> context=internal
> signalling=fxo_ks
> channel => 1
> -----
>
> extensions.conf:
> ----
>
> [office]
> exten => s,1,Dial(Zap/1,30)
>
> [home]
> exten => s,1,Macro(stdexten,106,SIP/ht286,t)
>
>
>
> [incoming]
>
> ; incoming calls from the FXO port are directed to this context from
> zapata.conf
>
> exten => s,1,Answer
> exten => s,1,Background(enter-ext-of-person)
> exten => s,n,WaitExten(20)
> exten => 100,1,Dial(Zap/1,30)
> exten => 106,1,Macro(stdexten,106,SIP/ht286)
> exten => 101,1,Macro(stdexten,101,SIP/vli)
> exten => 107,1,AGI(math.agi)
> exten => 108,1,Playback(12)
> ;exten => s,1,GotoIfTime(9:00-16:30|mon-fri|*|*?office,s,1)
> ;exten => s,n,GotoIfTime(17:00-9:00|*|*|*?home,s,1)
>
> When I call my PSTN number, I can hear the "enter-ext-of-person" message,
> but once I press any one of the extension number, Asterisk sometime  execute
> the relevant extension application, sometime not at all.  If I  comment  the
>  IVR  extensions config and simply use :
>
> exten => s,1,GotoIfTime(9:00-16:30|mon-fri|*|*?office,s,1)
>  exten => s,n,GotoIfTime(17:00-9:00|*|*|*?home,s,1)
>
> I can always get call
>
>
> My console  message: ( Asterisk did not execute relevant extension in the
> last two call after I entered the extension digit)
>
> ----------------------------
>    -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:46:38] NOTICE[4429]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:46:40] NOTICE[4429]: chan_zap.c:6373 ss_thread: Got event 2
> (Ring/Answered)...
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [ s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [101 at incoming:1] Macro("Zap/4-1", "stdexten|101|SIP/vli|t")
> in new stack
>      -- Executing [s at macro-stdexten:1] Dial("Zap/4-1", "SIP/vli|20") in new
> stack
>     -- Called vli
>     -- SIP/vli-08353298 is ringing
>     -- SIP/vli-08353298 answered Zap/4-1
>   == Spawn extension (macro-stdexten, s, 1) exited non-zero on 'Zap/4-1' in
> macro 'stdexten'
>   == Spawn extension (macro-stdexten, s, 1) exited non-zero on 'Zap/4-1'
>     -- Hungup 'Zap/4-1'
>     -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:47:32] NOTICE[4437]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:47:33] ERROR[4437]: callerid.c:564 callerid_feed: fsk_serie made
> mylen < 0 (-168)
> [Aug  2 13:47:33] WARNING[4437]: chan_zap.c:6405 ss_thread: CallerID feed
> failed: Success
> [Aug  2 13:47:33] WARNING[4437]: chan_zap.c:6505 ss_thread: CallerID
> returned with error on channel 'Zap/4-1'
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [100 at incoming:1] Dial("Zap/4-1", "Zap/1|30") in new stack
>     -- Called 1
>     -- Zap/1-1 is ringing
>     -- Zap/1-1 is ringing
>     -- Zap/1-1 answered Zap/4-1
>     -- Native bridging Zap/4-1 and Zap/1-1
>     -- Hungup 'Zap/1-1'
>   == Spawn extension (incoming, 100, 1) exited non-zero on 'Zap/4-1'
>     -- Hungup 'Zap/4-1'
>     -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:48:22] NOTICE[4444]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:48:23] ERROR[4444]: callerid.c :564 callerid_feed: fsk_serie made
> mylen < 0 (-9)
> [Aug  2 13:48:23] WARNING[4444]: chan_zap.c:6405 ss_thread: CallerID feed
> failed: Success
> [Aug  2 13:48:23] WARNING[4444]: chan_zap.c:6505 ss_thread: CallerID
> returned with error on channel 'Zap/4-1'
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [107 at incoming:1] AGI("Zap/4-1", "math.agi") in new stack
>     -- Launched AGI Script
> /var/lib/asterisk/agi-bin/math.agi
>     -- Playing 'math-game-welcome' (escape_digits=) (sample_offset 0)
>     -- Playing 'math-game-next' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/17' (language 'en')
>     -- Playing 'add' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/15' (language 'en')
>     -- <Zap/4-1> Playing 'equals' (language 'en')
>     -- Playing 'math-game-wrong' (escape_digits=) (sample_offset 0)
>     -- Playing 'math-game-your-answer' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/0' (language 'en')
>     -- Playing 'math-game-right-answer' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/30' (language 'en')
>     -- <Zap/4-1> Playing 'digits/2' (language 'en')
>     -- Playing 'math-game-next' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/11' (language 'en')
>     -- Playing 'minus' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/2' (language 'en')
>     -- <Zap/4-1> Playing 'equals' (language 'en')
>     -- Playing 'math-game-wrong' (escape_digits=) (sample_offset 0)
>     -- Playing 'math-game-your-answer' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/1' (language 'en')
>     -- Playing 'math-game-right-answer' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/9' (language 'en')
>     -- Playing 'math-game-timesup' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/0' (language 'en')
>     -- Playing 'math-game-right' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/2' (language 'en')
>     -- Playing 'math-game-pct' (escape_digits=) (sample_offset 0)
>     -- <Zap/4-1> Playing 'digits/0' (language 'en')
>     -- AGI Script math.agi completed, returning 0
>   == Auto fallthrough, channel 'Zap/4-1' status is 'UNKNOWN'
>     -- Hungup 'Zap/4-1'
>     -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:49:56] NOTICE[4451]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:49:56] ERROR[4451]: callerid.c :564 callerid_feed: fsk_serie made
> mylen < 0 (-8)
> [Aug  2 13:49:56] WARNING[4451]: chan_zap.c:6405 ss_thread: CallerID feed
> failed: Success
> [Aug  2 13:49:56] WARNING[4451]: chan_zap.c:6505 ss_thread: CallerID
> returned with error on channel 'Zap/4-1'
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [101 at incoming:1] Macro("Zap/4-1", "stdexten|101|SIP/vli|t")
> in new stack
>     -- Executing [s at macro-stdexten:1] Dial("Zap/4-1", "SIP/vli|20") in new
> stack
>     -- Called vli
>     -- SIP/vli-08353638 is ringing
>     -- Nobody picked up in 20000 ms
>     -- Executing [ s at macro-stdexten:2] Goto("Zap/4-1", "s-NOANSWER|1") in
> new stack
>     -- Goto (macro-stdexten,s-NOANSWER,1)
>     -- Executing [s-NOANSWER at macro-stdexten:1] VoiceMail("Zap/4-1", "101|u")
> in new stack
>     -- <Zap/4-1> Playing 'vm-theperson' (language 'en')
>     -- <Zap/4-1> Playing 'digits/1' (language 'en')
>     -- <Zap/4-1> Playing 'digits/0' (language 'en')
>     -- <Zap/4-1> Playing 'digits/1' (language 'en')
>     -- <Zap/4-1> Playing 'vm-isunavail' (language 'en')
>     -- <Zap/4-1> Playing 'vm-intro' (language 'en')
>     -- <Zap/4-1> Playing 'beep' (language 'en')
>     -- Recording the message
>     -- x=0, open writing:
> /var/spool/asterisk/voicemail/default/101/tmp/9ZgqbM
> format: wav49, 0x8352580
>     -- Recording automatically stopped after a silence of 6 seconds
>     -- <Zap/4-1> Playing 'auth-thankyou' (language 'en')
>     -- Recording was 7 seconds long but needs to be at least 10 - abandoning
>     -- Executing [s-NOANSWER at macro-stdexten:2] Goto("Zap/4-1",
> "default|s|1") in new stack
>     -- Goto (default,s,1)
>   == Channel 'Zap/4-1' jumping out of macro 'stdexten'
> [Aug  2 13:50:46] WARNING[4451]: pbx.c:2450 __ast_pbx_run: Channel 'Zap/4-1'
> sent into invalid extension 's' in context 'default', but no invalid handler
>     -- Hungup 'Zap/4-1'
>     -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:51:21] NOTICE[4458]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:51:22] ERROR[4458]: callerid.c :564 callerid_feed: fsk_serie made
> mylen < 0 (-7)
> [Aug  2 13:51:22] WARNING[4458]: chan_zap.c:6405 ss_thread: CallerID feed
> failed: Success
> [Aug  2 13:51:22] WARNING[4458]: chan_zap.c:6505 ss_thread: CallerID
> returned with error on channel 'Zap/4-1'
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [100 at incoming:1] Dial("Zap/4-1", "Zap/1|30") in new stack
>     -- Called 1
>     -- Zap/1-1 is ringing
>     -- Zap/1-1 is ringing
>     -- Zap/1-1 answered Zap/4-1
>     -- Native bridging Zap/4-1 and Zap/1-1
>     -- Hungup 'Zap/1-1'
>   == Spawn extension (incoming, 100, 1) exited non-zero on 'Zap/4-1'
>     -- Hungup 'Zap/4-1'
>     -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:52:05] NOTICE[4465]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:52:05] ERROR[4465]: callerid.c :564 callerid_feed: fsk_serie made
> mylen < 0 (-4)
> [Aug  2 13:52:05] WARNING[4465]: chan_zap.c:6405 ss_thread: CallerID feed
> failed: Success
> [Aug  2 13:52:05] WARNING[4465]: chan_zap.c:6505 ss_thread: CallerID
> returned with error on channel 'Zap/4-1'
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
> [Aug  2 13:52:29] WARNING[4465]: pbx.c:5609 pbx_builtin_waitexten: Timeout
> but no rule 't' in context 'incoming'
>   == Spawn extension (incoming, s, 3) exited non-zero on 'Zap/4-1'
>     -- Hungup 'Zap/4-1'
>     -- Starting simple switch on 'Zap/4-1'
> [Aug  2 13:54:29] NOTICE[4472]: chan_zap.c:6373 ss_thread: Got event 18
> (Ring Begin)...
> [Aug  2 13:54:30] ERROR[4472]: callerid.c:564 callerid_feed: fsk_serie made
> mylen < 0 (-18)
> [Aug  2 13:54:30] WARNING[4472]: chan_zap.c:6405 ss_thread: CallerID feed
> failed: Success
> [Aug  2 13:54:30] WARNING[4472]: chan_zap.c:6505 ss_thread: CallerID
> returned with error on channel 'Zap/4-1'
>     -- Executing [s at incoming:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [s at incoming:2] BackGround("Zap/4-1", "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [s at incoming:3] WaitExten("Zap/4-1", "20") in new stack
> [Aug  2 13:54:53] WARNING[4472]: pbx.c:5609 pbx_builtin_waitexten: Timeout
> but no rule 't' in context 'incoming'
>   == Spawn extension (incoming, s, 3) exited non-zero on 'Zap/4-1'
>     -- Hungup 'Zap/4-1
>
>
> --------------------------------
>
> _______________________________________________
> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>
> asterisk-users mailing list
> To UNSUBSCRIBE or update options visit:
>
> http://lists.digium.com/mailman/listinfo/asterisk-users
>



More information about the asterisk-users mailing list