[asterisk-users] A simple IVR extension problem
Vincent Li
vincent.mc.li at gmail.com
Thu Aug 2 16:02:09 CDT 2007
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
--------------------------------
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20070802/0b56070e/attachment-0001.htm
More information about the asterisk-users
mailing list