Sascha
2006-Aug-23 09:55 UTC
[asterisk-users] Silent Calls (Ghost Calls) When Picking Up Queue Calls
We're having a problem with calls coming in from our TE110P (an E&M wink T1) through to our queues and then when someone picks up the calls goes dead or silent. They are becoming known as "ghost calls" in our organization. It's seems to only have cropped up in the last couple weeks though we had the problem many months ago when the T1 clock timing wasn't set to synchronize with the T1 (that is not the case now). Any body else have this problem or have suggestions on where to start looking to fix? Here's our zapata.conf, zaptel.conf and the excerpt from the call log when the call appears to get hung up on from the T1 circuit. Note: in the log below I saw a line that says "Released clone lock on 'Local/102@from-internal-5928,1<ZOMBIE>'". Could that be part of the problem? Thanks in advance - Sascha [Zapata.conf] ; T1 CARD language=en signalling=em_w context=from-pstn rxwink=300 echocancel=yes echocancelwhenbridged=yes echotraining=800 rxgain=0.0 txgain=0.0 callerid=asreceived group=1 progzone=us channel => 1-24 [Zaptel.conf] span=1,1,0,esf,b8zs e&m=1-24 [Asterisk Log Exerpt] Aug 23 12:23:56 DEBUG[13218] channel.c: Set channel Zap/9-1 to write format slin Aug 23 12:23:56 DEBUG[13218] channel.c: Scheduling timer at 160 sample intervals Aug 23 12:24:20 DEBUG[13218] chan_zap.c: DTMF digit: 2 on Zap/9-1 Aug 23 12:24:20 DEBUG[13218] channel.c: Scheduling timer at 0 sample intervals Aug 23 12:24:20 DEBUG[13218] channel.c: Set channel Zap/9-1 to write format ulaw Aug 23 12:24:20 DEBUG[13218] pbx.c: Oooh, got something to jump out with ('2')! Aug 23 12:24:23 DEBUG[13218] pbx.c: Launching 'Goto' Aug 23 12:24:23 DEBUG[13218] pbx.c: Launching 'Answer' Aug 23 12:24:23 DEBUG[13218] pbx.c: Expression result is '0' Aug 23 12:24:23 DEBUG[13218] pbx.c: Launching 'GotoIf' Aug 23 12:24:23 DEBUG[13218] pbx.c: Launching 'Set' Aug 23 12:24:23 DEBUG[13218] pbx.c: Launching 'Set' Aug 23 12:24:23 DEBUG[13218] pbx.c: Launching 'Queue' Aug 23 12:24:23 DEBUG[13218] app_queue.c: queue: 454, options: t, url: , announce: , expires: 1156350383, priority: 0 Aug 23 12:24:23 DEBUG[13218] app_queue.c: Queue '454' Join, Channel 'Zap/9-1', Position '1' Aug 23 12:24:23 DEBUG[13218] channel.c: Scheduling timer at 160 sample intervals Aug 23 12:24:23 DEBUG[13218] app_queue.c: It's our turn (Zap/9-1). Aug 23 12:24:23 DEBUG[13218] app_queue.c: Zap/9-1 is trying to call a queue member. Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Zap/9-1 to write format ulaw Aug 23 12:25:11 DEBUG[13218] channel.c: Scheduling timer at 0 sample intervals Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Zap/9-1 to read format slin Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Local/102@from-internal-5928,1 to write format slin Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Local/102@from-internal-5928,1 to read format slin Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Zap/9-1 to write format slin Aug 23 12:25:11 DEBUG[13218] channel.c: Got clone lock for masquerade on 'SIP/102-8bd3' at 0x8f21b4c Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel SIP/102-8bd3 to write format slin Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel SIP/102-8bd3 to read format slin Aug 23 12:25:11 DEBUG[13218] channel.c: Putting channel SIP/102-8bd3 in 64/64 formats Aug 23 12:25:11 DEBUG[13218] channel.c: Released clone lock on 'Local/102@from-internal-5928,1<ZOMBIE>' Aug 23 12:25:11 DEBUG[13218] channel.c: Done Masquerading SIP/102-8bd3 (6) Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Zap/9-1 to read format ulaw Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel SIP/102-8bd3 to write format ulaw Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel SIP/102-8bd3 to read format ulaw Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel Zap/9-1 to write format ulaw Aug 23 12:25:11 VERBOSE[13218] logger.c: -- ***[JB LOG]*** fixed jitterbuffer created on channel Zap/9-1 Aug 23 12:25:15 DEBUG[13218] channel.c: Nobody there, continuing... Aug 23 12:25:15 DEBUG[13218] channel.c: Nobody there, continuing... Aug 23 12:25:16 DEBUG[13218] rtp.c: Got RTCP report of 52 bytes ... Aug 23 12:25:18 DEBUG[13218] channel.c: Nobody there, continuing... Aug 23 12:25:18 DEBUG[13218] channel.c: Didn't get a frame from channel: SIP/102-8bd3 Aug 23 12:25:18 DEBUG[13218] channel.c: Bridge stops bridging channels Zap/9-1 and SIP/102-8bd3 Aug 23 12:25:18 DEBUG[13218] channel.c: Hanging up channel 'SIP/102-8bd3' Aug 23 12:25:18 DEBUG[13218] chan_sip.c: Hangup call SIP/102-8bd3, SIP callid 4139d8826b8cf3ff7c0ecb9247952198@192.168.1.205) Aug 23 12:25:18 DEBUG[13218] chan_sip.c: update_call_counter(102) - decrement call limit counter Aug 23 12:25:18 DEBUG[13218] pbx.c: Spawn extension (ext-queues,454,6) exited non-zero on 'Zap/9-1' Aug 23 12:25:18 DEBUG[13511] app_queue.c: Device 'SIP/102' changed to state '1' (Not in use) but we don't care because they're not a member of any queue. Aug 23 12:25:18 DEBUG[13218] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. Aug 23 12:25:18 DEBUG[13218] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid) VALUES ('2006-08-23 12:23:55','\"S1\" <7759010954>','7759010954','454','ext-queues', 'Zap/9-1','Local/102@from-internal-5928,1','Queue','454|t|||120',83,83,'ANSWERED',3,'','1156350233.743') Aug 23 12:25:18 DEBUG[13218] channel.c: Hanging up channel 'Zap/9-1' Aug 23 12:25:18 DEBUG[13218] chan_zap.c: zt_hangup(Zap/9-1) Aug 23 12:25:18 DEBUG[13218] chan_zap.c: Hangup: channel: 9 index = 0, normal = 20, callwait = -1, thirdcall = -1 Aug 23 12:25:18 DEBUG[13218] chan_zap.c: disabled echo cancellation on channel 9 Aug 23 12:25:18 DEBUG[13218] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/9-1 Aug 23 12:25:18 DEBUG[13218] chan_zap.c: Updated conferencing on 9, with 0 conference users Aug 23 12:25:18 VERBOSE[13218] logger.c: -- ***[JB LOG]*** fixed jitterbuffer destroyed on channel Zap/9-1 Aug 23 12:25:18 DEBUG[13512] app_queue.c: Device 'Zap/9' changed to state '0' (Unknown) but we don't care because they're not a member of any queue. Aug 23 12:25:18 DEBUG[2746] chan_sip.c: Stopping retransmission on '3c26700aad57-m8j3bh85uu3m@snom360-0004132301CC' of Request 166: Match Found -- Alternative Energy Store 'Making Renewable Energy Affordable'? www.AltEnergyStore.com Toll Free: +1(877)878-4060 x184 Direct: +1(508)421-6400 x184 Fax: +1(877)242-6718