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 <[EMAIL PROTECTED]> 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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [ [EMAIL PROTECTED]:3] WaitExten("Zap/4-1", "20") in new 
> stack
>   == CDR updated on Zap/4-1
>     -- Executing [EMAIL PROTECTED]:1] Macro("Zap/4-1", 
> "stdexten|101|SIP/vli|t")
> in new stack
>      -- Executing [EMAIL PROTECTED]: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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [EMAIL PROTECTED]:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [EMAIL PROTECTED]: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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [EMAIL PROTECTED]:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [EMAIL PROTECTED]: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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [EMAIL PROTECTED]:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [EMAIL PROTECTED]:1] Macro("Zap/4-1", 
> "stdexten|101|SIP/vli|t")
> in new stack
>     -- Executing [EMAIL PROTECTED]: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 [ [EMAIL PROTECTED]:2] Goto("Zap/4-1", "s-NOANSWER|1") in
> new stack
>     -- Goto (macro-stdexten,s-NOANSWER,1)
>     -- Executing [EMAIL PROTECTED]: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 [EMAIL PROTECTED]: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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [EMAIL PROTECTED]:3] WaitExten("Zap/4-1", "20") in new stack
>   == CDR updated on Zap/4-1
>     -- Executing [EMAIL PROTECTED]: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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [EMAIL PROTECTED]: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 [EMAIL PROTECTED]:1] Answer("Zap/4-1", "") in new stack
>     -- Executing [EMAIL PROTECTED]:2] BackGround("Zap/4-1", 
> "enter-ext-of-person")
> in new stack
>     -- <Zap/4-1> Playing 'enter-ext-of-person' (language 'en')
>     -- Executing [EMAIL PROTECTED]: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
>

_______________________________________________
--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

Reply via email to