thr3ads.net - asterisk users - [asterisk-users] A simple IVR extension problem [Aug 2007]

If this information is useful, please help other people find it:
Share via:

Vincent Li

2007-Aug-02 21:02 UTC

[asterisk-users] A simple IVR extension problem

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

voiplist

2007-Aug-03 05:45 UTC

head link

[asterisk-users] A simple IVR extension problem

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
>

Possibly Parallel Threads

Search for more apparently analagous threads

asterisk users - Aug 2007 - A simple IVR extension problem

[asterisk-users] A simple IVR extension problem

[asterisk-users] A simple IVR extension problem

Possibly Parallel Threads