[Home]

Summary:ASTERISK-08353: Festival Application Hangs Call
Reporter:Sham Rao (harlequin516)Labels:
Date Opened:2006-12-14 12:58:59.000-0600Date Closed:2011-06-07 14:03:14
Priority:MajorRegression?No
Status:Closed/CompleteComponents:Applications/app_festival
Versions:Frequency of
Occurrence
Related
Issues:
Environment:Attachments:
Description:Dialplan Festival Application hangs on new call.  A Workaround seems to be to call SayDigits('1') before calling the Festival Application.  It seems like as if some initialization needs to happen before calling Festival.
Comments:By: Sham Rao (harlequin516) 2006-12-14 13:15:24.000-0600

Log File Excerpt follows:

Dec 14 12:09:34 DEBUG[8789] chan_sip.c: Allocating new SIP dialog for XXXremovedXXX@sip.broadvoice.com - REGISTER (No RTP)
Dec 14 12:09:34 DEBUG[8789] chan_sip.c: Scheduled a registration timeout for sip.broadvoice.com id  ASTERISK-42
Dec 14 12:09:34 VERBOSE[8789] logger.c: REGISTER attempt 1 to 6027141174@sip.broadvoice.com@sip.broadvoice.com
Dec 14 12:09:34 DEBUG[8789] chan_sip.c: = Found Their Call ID: XXXremovedXXX@sip.broadvoice.com Their Tag  Our tag: as7dbd641b
Dec 14 12:09:34 DEBUG[8789] chan_sip.c: Stopping retransmission on 'XXXremovedXXX@sip.broadvoice.com' of Request 113: Match Found
Dec 14 12:09:34 DEBUG[8789] chan_sip.c: Registration successful
Dec 14 12:09:34 DEBUG[8789] chan_sip.c: Cancelling timeout 46
Dec 14 12:09:39 VERBOSE[8784] logger.c:     -- Accepting UNAUTHENTICATED call from 192.168.0.12:
      > requested format = gsm,
      > requested prefs = (),
      > actual format = gsm,
      > host prefs = (),
      > priority = mine
Dec 14 12:09:39 DEBUG[8774] chan_iax2.c: Checking device state for device 192.168.0.12
Dec 14 12:09:39 DEBUG[8774] devicestate.c: Changing state for IAX2/192.168.0.12:4569 - state 4 (Invalid)
Dec 14 12:09:39 DEBUG[8809] app_queue.c: Device 'IAX2/192.168.0.12:4569' changed to state '4' (Invalid) but we don't care because they're not a member of any queue.
Dec 14 12:09:39 DEBUG[8808] pbx.c: Launching 'Goto'
Dec 14 12:09:39 VERBOSE[8808] logger.c:     -- Executing Goto("IAX2/192.168.0.12:4569-5", "0|1") in new stack
Dec 14 12:09:39 VERBOSE[8808] logger.c:     -- Goto (default,0,1)
Dec 14 12:09:39 DEBUG[8808] pbx.c: Launching 'Wait'
Dec 14 12:09:39 VERBOSE[8808] logger.c:     -- Executing Wait("IAX2/192.168.0.12:4569-5", "0") in new stack
Dec 14 12:09:39 DEBUG[8808] pbx.c: Launching 'SayDigits'
Dec 14 12:09:39 VERBOSE[8808] logger.c:     -- Executing SayDigits("IAX2/192.168.0.12:4569-5", "a") in new stack
Dec 14 12:09:39 DEBUG[8808] pbx.c: Launching 'Festival'
Dec 14 12:09:39 VERBOSE[8808] logger.c:     -- Executing Festival("IAX2/192.168.0.12:4569-5", "This is the operator.  Please dial your desired extension.") in new stack
Dec 14 12:09:39 VERBOSE[8808] logger.c:   == Parsing '/etc/asterisk/festival.conf': Dec 14 12:09:39 DEBUG[8808] config.c: Parsing /etc/asterisk/festival.conf
Dec 14 12:09:39 VERBOSE[8808] logger.c:   == Parsing '/etc/asterisk/festival.conf': Found
Dec 14 12:09:39 DEBUG[8808] app_festival.c: Text passed to festival server : This is the operator.  Please dial your desired extension.
Dec 14 12:09:39 DEBUG[8808] app_festival.c: Cache file exists, strln=58, strlen=58
Dec 14 12:09:39 DEBUG[8808] app_festival.c: Size OK
Dec 14 12:09:39 DEBUG[8808] app_festival.c: Reading from cache...
Dec 14 12:09:39 DEBUG[8808] app_festival.c: Passing data to channel...
Dec 14 12:09:39 DEBUG[8808] app_festival.c: Festival WV command
Dec 14 12:09:39 DEBUG[8784] chan_iax2.c: Ooh, voice format changed to 2
Dec 14 12:09:39 DEBUG[8784] channel.c: Set channel IAX2/192.168.0.12:4569-5 to read format gsm
Dec 14 12:09:39 DEBUG[8808] chan_iax2.c: Answering IAX2 call
Dec 14 12:09:39 DEBUG[8774] chan_iax2.c: Checking device state for device 192.168.0.12
Dec 14 12:09:39 DEBUG[8774] devicestate.c: Changing state for IAX2/192.168.0.12:4569 - state 4 (Invalid)
Dec 14 12:09:39 DEBUG[8810] app_queue.c: Device 'IAX2/192.168.0.12:4569' changed to state '4' (Invalid) but we don't care because they're not a member of any queue.
Dec 14 12:09:39 DEBUG[8808] channel.c: Set channel IAX2/192.168.0.12:4569-5 to write format slin
Dec 14 12:09:39 NOTICE[8808] chan_iax2.c: I should never be called!

==> ./asterisk/messages <==
Dec 14 12:09:39 NOTICE[8808] chan_iax2.c: I should never be called!

==> ./asterisk/full <==
Dec 14 12:09:42 DEBUG[8789] chan_sip.c: Auto destroying call '3c2649ec297f00640ce27ada135706a0@sip.broadvoice.com'
Dec 14 12:09:43 DEBUG[8808] app_festival.c: Last frame
Dec 14 12:09:43 DEBUG[8808] channel.c: Set channel IAX2/192.168.0.12:4569-5 to write format gsm
Dec 14 12:09:43 DEBUG[8808] pbx.c: Launching 'Festival'
Dec 14 12:09:43 VERBOSE[8808] logger.c:     -- Executing Festival("IAX2/192.168.0.12:4569-5", "blah blah") in new stack
Dec 14 12:09:43 VERBOSE[8808] logger.c:   == Parsing '/etc/asterisk/festival.conf': Dec 14 12:09:43 DEBUG[8808] config.c: Parsing /etc/asterisk/festival.conf
Dec 14 12:09:43 VERBOSE[8808] logger.c:   == Parsing '/etc/asterisk/festival.conf': Found
Dec 14 12:09:43 DEBUG[8808] app_festival.c: Text passed to festival server : blah blah
Dec 14 12:09:43 DEBUG[8808] app_festival.c: Cache file exists, strln=9, strlen=9
Dec 14 12:09:43 DEBUG[8808] app_festival.c: Size OK
Dec 14 12:09:43 DEBUG[8808] app_festival.c: Reading from cache...
Dec 14 12:09:43 DEBUG[8808] app_festival.c: Passing data to channel...
Dec 14 12:09:45 DEBUG[8784] channel.c: Dropping voice to exceptionally long queue on IAX2/192.168.0.12:4569-5
Dec 14 12:09:45 DEBUG[8784] channel.c: Dropping voice to exceptionally long queue on IAX2/192.168.0.12:4569-5
Dec 14 12:09:45 DEBUG[8784] channel.c: Dropping voice to exceptionally long queue on IAX2/192.168.0.12:4569-5
Dec 14 12:09:45 DEBUG[8784] channel.c: Dropping voice to exceptionally long queue on IAX2/192.168.0.12:4569-5

...  ad nauseam ...



By: Tilghman Lesher (tilghman) 2007-01-07 15:34:42.000-0600

It's obvious from your log that you have failed to Answer() the channel prior to calling Festival.  Please try that and check to see if it solves your issue.

By: Joshua C. Colp (jcolp) 2007-02-15 20:23:09.000-0600

As mentioned by Corydon, Festival is not an application that will automatically answer the channel - so you need to do it yourself.