[asterisk-users] Silent Calls (Ghost Calls) When Picking Up Queue Calls

[Sascha]

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 at 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 at from-internal-5928,1 to write format slin
Aug 23 12:25:11 DEBUG[13218] channel.c: Set channel 
Local/102 at 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 at 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 at 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 at 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 at 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