Calls get cut off after 3-5 minutes

I’m using *@home 2.8 with a 4port analog card. I have several issues with *, but this one is really annoying- today all the calls I made have been cut-off after a few minutes of calling. I suddenly stop hearing the other person, and after a few seconds hearing scratching and an echo of myself… Here’s my configs and the log- hopefully someone can see something there… Thanks in advance!

zapata.conf:
[trunkgroups]

[channels]

language=en
context=from-pstn
signalling=fxs_ks
rxwink=300 ; Atlas seems to use long (250ms) winks
;
; Whether or not to do distinctive ring detection on FXO lines
;
;usedistinctiveringdetection=yes
usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
echotraining=800
rxgain=-3.0
txgain=8.0
callprogress=yes
busydetect=yes
group=0
callgroup=1
pickupgroup=1
immediate=no
;faxdetect=both
faxdetect=incoming
;faxdetect=outgoing
;faxdetect=no
;Include genzaptelconf configs
#include zapata-auto.conf
group=1
;Include AMP configs
#include zapata_additional.conf

zaptel.conf:
fxsks=1
fxsks=2
fxsks=3
fxsks=4
loadzone=nz
defaultzone=nz

(nz exists in indications.conf with values from voip-wiki, modprobe.conf was added the options for wctdm/wcfxs opermode=NEWZEALAND)
Logfile:
May 9 00:35:29 DEBUG[2855] chan_sip.c: Setting NAT on RTP to 0
May 9 00:35:29 DEBUG[2855] chan_sip.c: Stopping retransmission on ‘8057be1c-c0a81169-13c4-4460c4ce-6cdf162-5b04@192.168.21.5’ of Response 1: Match Found
May 9 00:35:29 DEBUG[2855] chan_sip.c: Setting NAT on RTP to 0
May 9 00:35:29 DEBUG[2855] chan_sip.c: Checking SIP call limits for device 201
May 9 00:35:29 DEBUG[2855] chan_sip.c: build_route: Contact hop:
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “dialout-trunk|4|3606394||”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?3:2”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-dialout-trunk,s,3)
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “user-callerid”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSER=201”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 DEBUG[6786] db.c: Unable to find key ‘201/emergency_cid’ in family 'DEVICE’
May 9 00:35:29 DEBUG[6786] func_db.c: DB: DEVICE/201/emergency_cid not found in database.
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is ''
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “EMERGENCYCID=”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is 'Chris’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSERCIDNAME=Chris”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?6”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “CALLERID(all)=“Chris” <201>”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “Using CallerID “Chris” <201>”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “record-enable|201|OUT”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0 > 0?2:4”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-record-enable,s,4)
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “recordingcheck|20060509-003529|1147149329.66”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 9 00:35:29 VERBOSE[6786] logger.c: recordingcheck|20060509-003529|1147149329.66: Outbound recording not enabled
May 9 00:35:29 VERBOSE[6786] logger.c: – AGI Script recordingcheck completed, returning 0
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “No recording needed”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “outbound-callerid|4”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is ''
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “USEROUTCID=”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?4”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,4)
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?6”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,6)
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?8”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,8)
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “CallerID set to “Chris” <201>”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “GROUP()=OUT_4”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '1’
May 9 00:35:29 WARNING[6786] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
1 >
^
May 9 00:35:29 WARNING[6786] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?108”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_NUMBER=3606394”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_TRUNK=4”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “fixlocalprefix”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
May 9 00:35:29 VERBOSE[6786] logger.c: fixlocalprefix: Could not parse /etc/asterisk/localprefixes.conf
May 9 00:35:29 VERBOSE[6786] logger.c: – AGI Script fixlocalprefix completed, returning 0
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “OUTNUM=3606394”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is 'ZAP/3’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “custom=ZAP/3”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?16”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Dial(“SIP/201-ef3c”, “ZAP/3/3606394|120|W”) in new stack
May 9 00:35:29 DEBUG[6786] dsp.c: dsp busy pattern set to 0,0
May 9 00:35:29 DEBUG[6786] chan_zap.c: Dialing '3606394’
May 9 00:35:29 DEBUG[6786] chan_zap.c: Deferring dialing…
May 9 00:35:29 VERBOSE[6786] logger.c: – Called 3/3606394
May 9 00:35:30 DEBUG[6786] chan_zap.c: Exception on 20, channel 3
May 9 00:35:30 DEBUG[6786] chan_zap.c: Got event Hook Transition Complete(12) on channel 3 (index 0)
May 9 00:35:31 DEBUG[6786] chan_zap.c: Exception on 20, channel 3
May 9 00:35:31 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 3 (index 0)
May 9 00:35:31 DEBUG[6786] chan_zap.c: Enabled echo cancellation on channel 3
May 9 00:35:31 DEBUG[6786] chan_zap.c: Engaged echo training on channel 3
May 9 00:35:33 DEBUG[2855] chan_sip.c: Auto destroying call '23ad8e504dfd7dbd133424f300a36f14@192.168.21.5’
May 9 00:35:33 DEBUG[6786] chan_zap.c: Exception on 20, channel 3
May 9 00:35:33 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 3 (index 0)
May 9 00:35:33 DEBUG[6786] chan_zap.c: Echo cancellation already on
May 9 00:35:33 DEBUG[6786] chan_zap.c: Done dialing, but waiting for progress detection before doing more…
May 9 00:36:03 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:36:06 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:36:06 DEBUG[2855] chan_sip.c: Auto destroying call '77047f080d3aa27a75e3997502985a07@192.168.21.5’
May 9 00:36:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:36:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:36:46 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:36:50 DEBUG[2855] chan_sip.c: Auto destroying call '3c7ecbe9496df2ab5ad86d283ace1e26@192.168.21.5’
May 9 00:36:54 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:37:27 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:37:34 DEBUG[2855] chan_sip.c: Auto destroying call '6e49f70a1df883d2110d222410398dde@192.168.21.5’
May 9 00:37:36 VERBOSE[6786] logger.c: – Nobody picked up in 120000 ms
May 9 00:37:36 DEBUG[6786] chan_zap.c: Hangup: channel: 3 index = 0, normal = 20, callwait = -1, thirdcall = -1
May 9 00:37:36 DEBUG[6786] chan_zap.c: disabled echo cancellation on channel 3
May 9 00:37:36 DEBUG[6786] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/3-1
May 9 00:37:36 DEBUG[6786] chan_zap.c: Updated conferencing on 3, with 0 conference users
May 9 00:37:36 VERBOSE[6786] logger.c: – Hungup 'Zap/3-1’
May 9 00:37:36 DEBUG[6786] app_dial.c: Exiting with DIALSTATUS=NOANSWER.
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Goto(“SIP/201-ef3c”, “s-NOANSWER|1”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Goto (macro-dialout-trunk,s-NOANSWER,1)
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “Dial failed due to NOANSWER”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “dialout-trunk|3|3606394||”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?3:2”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Goto (macro-dialout-trunk,s,3)
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “user-callerid”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSER=201”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 DEBUG[6786] db.c: Unable to find key ‘201/emergency_cid’ in family 'DEVICE’
May 9 00:37:36 DEBUG[6786] func_db.c: DB: DEVICE/201/emergency_cid not found in database.
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is ''
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “EMERGENCYCID=”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is 'Chris’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSERCIDNAME=Chris”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?6”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “CALLERID(all)=“Chris” <201>”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “Using CallerID “Chris” <201>”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “record-enable|201|OUT”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '0’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0 > 0?2:4”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Goto (macro-record-enable,s,4)
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “recordingcheck|20060509-003736|1147149329.66”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 9 00:37:37 VERBOSE[6786] logger.c: recordingcheck|20060509-003736|1147149329.66: Outbound recording not enabled
May 9 00:37:37 VERBOSE[6786] logger.c: – AGI Script recordingcheck completed, returning 0
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “No recording needed”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “outbound-callerid|3”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is ''
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “USEROUTCID=”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?4”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,4)
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?6”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,6)
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?8”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,8)
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “CallerID set to “Chris” <201>”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “GROUP()=OUT_3”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is '1’
May 9 00:37:37 WARNING[6786] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
1 >
^
May 9 00:37:37 WARNING[6786] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?108”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_NUMBER=3606394”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_TRUNK=3”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “fixlocalprefix”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
May 9 00:37:37 VERBOSE[6786] logger.c: fixlocalprefix: Could not parse /etc/asterisk/localprefixes.conf
May 9 00:37:37 VERBOSE[6786] logger.c: – AGI Script fixlocalprefix completed, returning 0
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “OUTNUM=3606394”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is 'ZAP/2’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “custom=ZAP/2”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?16”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Dial(“SIP/201-ef3c”, “ZAP/2/3606394|120|W”) in new stack
May 9 00:37:37 DEBUG[6786] dsp.c: dsp busy pattern set to 0,0
May 9 00:37:37 DEBUG[6786] chan_zap.c: Dialing '3606394’
May 9 00:37:37 DEBUG[6786] chan_zap.c: Deferring dialing…
May 9 00:37:37 VERBOSE[6786] logger.c: – Called 2/3606394
May 9 00:37:37 DEBUG[6786] chan_zap.c: Exception on 18, channel 2
May 9 00:37:37 DEBUG[6786] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
May 9 00:37:39 DEBUG[6786] chan_zap.c: Exception on 18, channel 2
May 9 00:37:39 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 2 (index 0)
May 9 00:37:39 DEBUG[6786] chan_zap.c: Enabled echo cancellation on channel 2
May 9 00:37:39 DEBUG[6786] chan_zap.c: Engaged echo training on channel 2
May 9 00:37:41 DEBUG[6786] chan_zap.c: Exception on 18, channel 2
May 9 00:37:41 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 2 (index 0)
May 9 00:37:41 DEBUG[6786] chan_zap.c: Echo cancellation already on
May 9 00:37:41 DEBUG[6786] chan_zap.c: Done dialing, but waiting for progress detection before doing more…
May 9 00:37:44 DEBUG[2855] chan_sip.c: Auto destroying call ‘c0a81175-13c4-14-531b-420f’
May 9 00:37:47 DEBUG[6786] chan_zap.c: Hangup: channel: 2 index = 0, normal = 18, callwait = -1, thirdcall = -1
May 9 00:37:47 DEBUG[6786] chan_zap.c: disabled echo cancellation on channel 2
May 9 00:37:47 DEBUG[6786] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/2-1
May 9 00:37:47 DEBUG[6786] chan_zap.c: Updated conferencing on 2, with 0 conference users
May 9 00:37:47 VERBOSE[6786] logger.c: – Hungup ‘Zap/2-1’
May 9 00:37:47 DEBUG[6786] app_dial.c: Exiting with DIALSTATUS=CANCEL.
May 9 00:37:47 VERBOSE[6786] logger.c: == Spawn extension (macro-dialout-trunk, s, 14) exited non-zero on ‘SIP/201-ef3c’ in macro ‘dialout-trunk’
May 9 00:37:47 VERBOSE[6786] logger.c: == Spawn extension (macro-dialout-trunk, s, 14) exited non-zero on ‘SIP/201-ef3c’
May 9 00:37:47 DEBUG[6786] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
May 9 00:37:47 DEBUG[6786] 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-05-09 00:35:29’,’“Chris” <201>’,‘201’,‘3606394’,‘from-internal’, ‘SIP/201-ef3c’,‘Zap/2-1’,‘Dial’,‘ZAP/2/3606394|120|W’,138,0,‘NO ANSWER’,3,’’,‘1147149329.66’)
May 9 00:37:47 DEBUG[6786] chan_sip.c: update_call_counter(201) - decrement call limit counter
May 9 00:37:47 DEBUG[2855] chan_sip.c: Stopping retransmission on ‘8057be1c-c0a81169-13c4-4460c4ce-6cdf162-5b04@192.168.21.5’ of Response 2: Match Found
May 9 00:38:08 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:38:18 DEBUG[2855] chan_sip.c: Auto destroying call '42063bc21386e7113703a07f35a3491f@192.168.21.5’
May 9 00:38:34 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:38:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:38:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:38:48 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:38:51 DEBUG[2855] chan_sip.c: Auto destroying call '46fe11d44ae1799d41e5f8a54f209b20@192.168.21.5’
May 9 00:39:25 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:39:29 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:39:35 DEBUG[2855] chan_sip.c: Auto destroying call '134749b76e1fb6df28edd50515190a60@192.168.21.5’
May 9 00:40:09 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:40:15 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:40:19 DEBUG[2855] chan_sip.c: Auto destroying call '46617b2d576e9d5167a82b2f6d005193@192.168.21.5’
May 9 00:40:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:40:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:40:50 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:40:52 DEBUG[2855] chan_sip.c: Auto destroying call '1d5f544537cdceaa79d40a6d0d5af17e@192.168.21.5’
May 9 00:41:05 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:41:31 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:41:36 DEBUG[2855] chan_sip.c: Auto destroying call '68d4ffa716e3e7915de1f96528c37303@192.168.21.5’
May 9 00:41:55 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:42:11 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:42:20 DEBUG[2855] chan_sip.c: Auto destroying call '56d9f28520b3499133fa9348221a4a27@192.168.21.5’
May 9 00:42:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:42:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:42:46 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:42:52 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:42:53 DEBUG[2855] chan_sip.c: Auto destroying call '4f2d32f877962a533df7a581156642d2@192.168.21.5’
May 9 00:43:32 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:43:36 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:43:37 DEBUG[2855] chan_sip.c: Auto destroying call '0751ddc00125e82d0e80d9ab52df6ba8@192.168.21.5’
May 9 00:44:13 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:44:21 DEBUG[2855] chan_sip.c: Auto destroying call '73951f5a442149122cf648b943da304b@192.168.21.5’
May 9 00:44:26 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:44:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:44:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:44:54 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:44:54 DEBUG[2855] chan_sip.c: Auto destroying call '07cfd2d2514f3a3528292cbb48dc764c@192.168.21.5’
May 9 00:45:17 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:45:35 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:45:38 DEBUG[2855] chan_sip.c: Auto destroying call '0055dd0d15640fb5649142ad5c276d01@192.168.21.5’
May 9 00:45:38 DEBUG[2855] chan_sip.c: Auto destroying call '0055dd0d15640fb5649142ad5c276d

[quote=“Chris911”]I’m using *@home 2.8 with a 4port analog card. I have several issues with *, but this one is really annoying- today all the calls I made have been cut-off after a few minutes of calling. I suddenly stop hearing the other person, and after a few seconds hearing scratching and an echo of myself… Here’s my configs and the log- hopefully someone can see something there… Thanks in advance!

zapata.conf:
[trunkgroups]

[channels]

language=en
context=from-pstn
signalling=fxs_ks
rxwink=300 ; Atlas seems to use long (250ms) winks
;
; Whether or not to do distinctive ring detection on FXO lines
;
;usedistinctiveringdetection=yes
usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
echotraining=800
rxgain=-3.0
txgain=8.0
callprogress=yes
busydetect=yes
group=0
callgroup=1
pickupgroup=1
immediate=no
;faxdetect=both
faxdetect=incoming
;faxdetect=outgoing
;faxdetect=no
;Include genzaptelconf configs
#include zapata-auto.conf
group=1
;Include AMP configs
#include zapata_additional.conf

zaptel.conf:
fxsks=1
fxsks=2
fxsks=3
fxsks=4
loadzone=nz
defaultzone=nz

(nz exists in indications.conf with values from voip-wiki, modprobe.conf was added the options for wctdm/wcfxs opermode=NEWZEALAND)
Logfile:
May 9 00:35:29 DEBUG[2855] chan_sip.c: Setting NAT on RTP to 0
May 9 00:35:29 DEBUG[2855] chan_sip.c: Stopping retransmission on ‘8057be1c-c0a81169-13c4-4460c4ce-6cdf162-5b04@192.168.21.5’ of Response 1: Match Found
May 9 00:35:29 DEBUG[2855] chan_sip.c: Setting NAT on RTP to 0
May 9 00:35:29 DEBUG[2855] chan_sip.c: Checking SIP call limits for device 201
May 9 00:35:29 DEBUG[2855] chan_sip.c: build_route: Contact hop:
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “dialout-trunk|4|3606394||”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?3:2”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-dialout-trunk,s,3)
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “user-callerid”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSER=201”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 DEBUG[6786] db.c: Unable to find key ‘201/emergency_cid’ in family 'DEVICE’
May 9 00:35:29 DEBUG[6786] func_db.c: DB: DEVICE/201/emergency_cid not found in database.
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is ''
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “EMERGENCYCID=”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is 'Chris’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSERCIDNAME=Chris”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?6”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “CALLERID(all)=“Chris” <201>”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “Using CallerID “Chris” <201>”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “record-enable|201|OUT”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0 > 0?2:4”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-record-enable,s,4)
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “recordingcheck|20060509-003529|1147149329.66”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 9 00:35:29 VERBOSE[6786] logger.c: recordingcheck|20060509-003529|1147149329.66: Outbound recording not enabled
May 9 00:35:29 VERBOSE[6786] logger.c: – AGI Script recordingcheck completed, returning 0
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “No recording needed”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “outbound-callerid|4”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is ''
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “USEROUTCID=”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?4”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,4)
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?6”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,6)
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?8”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,8)
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “CallerID set to “Chris” <201>”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “GROUP()=OUT_4”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is '1’
May 9 00:35:29 WARNING[6786] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
1 >
^
May 9 00:35:29 WARNING[6786] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?108”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_NUMBER=3606394”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_TRUNK=4”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “fixlocalprefix”) in new stack
May 9 00:35:29 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
May 9 00:35:29 VERBOSE[6786] logger.c: fixlocalprefix: Could not parse /etc/asterisk/localprefixes.conf
May 9 00:35:29 VERBOSE[6786] logger.c: – AGI Script fixlocalprefix completed, returning 0
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “OUTNUM=3606394”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Function result is 'ZAP/3’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “custom=ZAP/3”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?16”) in new stack
May 9 00:35:29 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:35:29 VERBOSE[6786] logger.c: – Executing Dial(“SIP/201-ef3c”, “ZAP/3/3606394|120|W”) in new stack
May 9 00:35:29 DEBUG[6786] dsp.c: dsp busy pattern set to 0,0
May 9 00:35:29 DEBUG[6786] chan_zap.c: Dialing '3606394’
May 9 00:35:29 DEBUG[6786] chan_zap.c: Deferring dialing…
May 9 00:35:29 VERBOSE[6786] logger.c: – Called 3/3606394
May 9 00:35:30 DEBUG[6786] chan_zap.c: Exception on 20, channel 3
May 9 00:35:30 DEBUG[6786] chan_zap.c: Got event Hook Transition Complete(12) on channel 3 (index 0)
May 9 00:35:31 DEBUG[6786] chan_zap.c: Exception on 20, channel 3
May 9 00:35:31 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 3 (index 0)
May 9 00:35:31 DEBUG[6786] chan_zap.c: Enabled echo cancellation on channel 3
May 9 00:35:31 DEBUG[6786] chan_zap.c: Engaged echo training on channel 3
May 9 00:35:33 DEBUG[2855] chan_sip.c: Auto destroying call '23ad8e504dfd7dbd133424f300a36f14@192.168.21.5’
May 9 00:35:33 DEBUG[6786] chan_zap.c: Exception on 20, channel 3
May 9 00:35:33 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 3 (index 0)
May 9 00:35:33 DEBUG[6786] chan_zap.c: Echo cancellation already on
May 9 00:35:33 DEBUG[6786] chan_zap.c: Done dialing, but waiting for progress detection before doing more…
May 9 00:36:03 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:36:06 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:36:06 DEBUG[2855] chan_sip.c: Auto destroying call '77047f080d3aa27a75e3997502985a07@192.168.21.5’
May 9 00:36:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:36:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:36:46 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:36:50 DEBUG[2855] chan_sip.c: Auto destroying call '3c7ecbe9496df2ab5ad86d283ace1e26@192.168.21.5’
May 9 00:36:54 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:37:27 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:37:34 DEBUG[2855] chan_sip.c: Auto destroying call '6e49f70a1df883d2110d222410398dde@192.168.21.5’
May 9 00:37:36 VERBOSE[6786] logger.c: – Nobody picked up in 120000 ms
May 9 00:37:36 DEBUG[6786] chan_zap.c: Hangup: channel: 3 index = 0, normal = 20, callwait = -1, thirdcall = -1
May 9 00:37:36 DEBUG[6786] chan_zap.c: disabled echo cancellation on channel 3
May 9 00:37:36 DEBUG[6786] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/3-1
May 9 00:37:36 DEBUG[6786] chan_zap.c: Updated conferencing on 3, with 0 conference users
May 9 00:37:36 VERBOSE[6786] logger.c: – Hungup 'Zap/3-1’
May 9 00:37:36 DEBUG[6786] app_dial.c: Exiting with DIALSTATUS=NOANSWER.
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Goto(“SIP/201-ef3c”, “s-NOANSWER|1”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Goto (macro-dialout-trunk,s-NOANSWER,1)
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “Dial failed due to NOANSWER”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “dialout-trunk|3|3606394||”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?3:2”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Goto (macro-dialout-trunk,s,3)
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “user-callerid”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSER=201”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 DEBUG[6786] db.c: Unable to find key ‘201/emergency_cid’ in family 'DEVICE’
May 9 00:37:36 DEBUG[6786] func_db.c: DB: DEVICE/201/emergency_cid not found in database.
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is ''
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “EMERGENCYCID=”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is 'Chris’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “AMPUSERCIDNAME=Chris”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?6”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “CALLERID(all)=“Chris” <201>”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “Using CallerID “Chris” <201>”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “record-enable|201|OUT”) in new stack
May 9 00:37:36 DEBUG[6786] pbx.c: Function result is '0’
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0 > 0?2:4”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Goto (macro-record-enable,s,4)
May 9 00:37:36 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “recordingcheck|20060509-003736|1147149329.66”) in new stack
May 9 00:37:36 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
May 9 00:37:37 VERBOSE[6786] logger.c: recordingcheck|20060509-003736|1147149329.66: Outbound recording not enabled
May 9 00:37:37 VERBOSE[6786] logger.c: – AGI Script recordingcheck completed, returning 0
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “No recording needed”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Macro(“SIP/201-ef3c”, “outbound-callerid|3”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is '201’
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is ''
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “USEROUTCID=”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?4”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,4)
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?6”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,6)
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '1’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “1?8”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Goto (macro-outbound-callerid,s,8)
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is '“Chris” <201>'
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing NoOp(“SIP/201-ef3c”, “CallerID set to “Chris” <201>”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “GROUP()=OUT_3”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is '1’
May 9 00:37:37 WARNING[6786] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
1 >
^
May 9 00:37:37 WARNING[6786] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?108”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_NUMBER=3606394”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “DIAL_TRUNK=3”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing AGI(“SIP/201-ef3c”, “fixlocalprefix”) in new stack
May 9 00:37:37 VERBOSE[6786] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
May 9 00:37:37 VERBOSE[6786] logger.c: fixlocalprefix: Could not parse /etc/asterisk/localprefixes.conf
May 9 00:37:37 VERBOSE[6786] logger.c: – AGI Script fixlocalprefix completed, returning 0
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “OUTNUM=3606394”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Function result is 'ZAP/2’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Set(“SIP/201-ef3c”, “custom=ZAP/2”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Expression result is '0’
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing GotoIf(“SIP/201-ef3c”, “0?16”) in new stack
May 9 00:37:37 DEBUG[6786] pbx.c: Not taking any branch
May 9 00:37:37 VERBOSE[6786] logger.c: – Executing Dial(“SIP/201-ef3c”, “ZAP/2/3606394|120|W”) in new stack
May 9 00:37:37 DEBUG[6786] dsp.c: dsp busy pattern set to 0,0
May 9 00:37:37 DEBUG[6786] chan_zap.c: Dialing '3606394’
May 9 00:37:37 DEBUG[6786] chan_zap.c: Deferring dialing…
May 9 00:37:37 VERBOSE[6786] logger.c: – Called 2/3606394
May 9 00:37:37 DEBUG[6786] chan_zap.c: Exception on 18, channel 2
May 9 00:37:37 DEBUG[6786] chan_zap.c: Got event Hook Transition Complete(12) on channel 2 (index 0)
May 9 00:37:39 DEBUG[6786] chan_zap.c: Exception on 18, channel 2
May 9 00:37:39 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 2 (index 0)
May 9 00:37:39 DEBUG[6786] chan_zap.c: Enabled echo cancellation on channel 2
May 9 00:37:39 DEBUG[6786] chan_zap.c: Engaged echo training on channel 2
May 9 00:37:41 DEBUG[6786] chan_zap.c: Exception on 18, channel 2
May 9 00:37:41 DEBUG[6786] chan_zap.c: Got event Dial Complete(9) on channel 2 (index 0)
May 9 00:37:41 DEBUG[6786] chan_zap.c: Echo cancellation already on
May 9 00:37:41 DEBUG[6786] chan_zap.c: Done dialing, but waiting for progress detection before doing more…
May 9 00:37:44 DEBUG[2855] chan_sip.c: Auto destroying call ‘c0a81175-13c4-14-531b-420f’
May 9 00:37:47 DEBUG[6786] chan_zap.c: Hangup: channel: 2 index = 0, normal = 18, callwait = -1, thirdcall = -1
May 9 00:37:47 DEBUG[6786] chan_zap.c: disabled echo cancellation on channel 2
May 9 00:37:47 DEBUG[6786] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/2-1
May 9 00:37:47 DEBUG[6786] chan_zap.c: Updated conferencing on 2, with 0 conference users
May 9 00:37:47 VERBOSE[6786] logger.c: – Hungup ‘Zap/2-1’
May 9 00:37:47 DEBUG[6786] app_dial.c: Exiting with DIALSTATUS=CANCEL.
May 9 00:37:47 VERBOSE[6786] logger.c: == Spawn extension (macro-dialout-trunk, s, 14) exited non-zero on ‘SIP/201-ef3c’ in macro ‘dialout-trunk’
May 9 00:37:47 VERBOSE[6786] logger.c: == Spawn extension (macro-dialout-trunk, s, 14) exited non-zero on ‘SIP/201-ef3c’
May 9 00:37:47 DEBUG[6786] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
May 9 00:37:47 DEBUG[6786] 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-05-09 00:35:29’,’“Chris” <201>’,‘201’,‘3606394’,‘from-internal’, ‘SIP/201-ef3c’,‘Zap/2-1’,‘Dial’,‘ZAP/2/3606394|120|W’,138,0,‘NO ANSWER’,3,’’,‘1147149329.66’)
May 9 00:37:47 DEBUG[6786] chan_sip.c: update_call_counter(201) - decrement call limit counter
May 9 00:37:47 DEBUG[2855] chan_sip.c: Stopping retransmission on ‘8057be1c-c0a81169-13c4-4460c4ce-6cdf162-5b04@192.168.21.5’ of Response 2: Match Found
May 9 00:38:08 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:38:18 DEBUG[2855] chan_sip.c: Auto destroying call '42063bc21386e7113703a07f35a3491f@192.168.21.5’
May 9 00:38:34 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:38:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:38:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:38:48 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:38:51 DEBUG[2855] chan_sip.c: Auto destroying call '46fe11d44ae1799d41e5f8a54f209b20@192.168.21.5’
May 9 00:39:25 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:39:29 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:39:35 DEBUG[2855] chan_sip.c: Auto destroying call '134749b76e1fb6df28edd50515190a60@192.168.21.5’
May 9 00:40:09 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:40:15 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:40:19 DEBUG[2855] chan_sip.c: Auto destroying call '46617b2d576e9d5167a82b2f6d005193@192.168.21.5’
May 9 00:40:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:40:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:40:50 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:40:52 DEBUG[2855] chan_sip.c: Auto destroying call '1d5f544537cdceaa79d40a6d0d5af17e@192.168.21.5’
May 9 00:41:05 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:41:31 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:41:36 DEBUG[2855] chan_sip.c: Auto destroying call '68d4ffa716e3e7915de1f96528c37303@192.168.21.5’
May 9 00:41:55 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:42:11 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:42:20 DEBUG[2855] chan_sip.c: Auto destroying call '56d9f28520b3499133fa9348221a4a27@192.168.21.5’
May 9 00:42:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:42:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:42:46 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:42:52 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:42:53 DEBUG[2855] chan_sip.c: Auto destroying call '4f2d32f877962a533df7a581156642d2@192.168.21.5’
May 9 00:43:32 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:43:36 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:43:37 DEBUG[2855] chan_sip.c: Auto destroying call '0751ddc00125e82d0e80d9ab52df6ba8@192.168.21.5’
May 9 00:44:13 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:44:21 DEBUG[2855] chan_sip.c: Auto destroying call '73951f5a442149122cf648b943da304b@192.168.21.5’
May 9 00:44:26 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:44:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:44:41 DEBUG[3224] manager.c: Manager received command 'Command’
May 9 00:44:54 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:44:54 DEBUG[2855] chan_sip.c: Auto destroying call '07cfd2d2514f3a3528292cbb48dc764c@192.168.21.5’
May 9 00:45:17 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81175-13c4-14-531b-420f’
May 9 00:45:35 DEBUG[2855] chan_sip.c: Auto destroying call 'c0a81169-13c4-445f06f6-6743-229e’
May 9 00:45:38 DEBUG[2855] chan_sip.c: Auto destroying call '0055dd0d15640fb5649142ad5c276d01@192.168.21.5’
May 9 00:45:38 DEBUG[2855] chan_sip.c: Auto destroying call '0055dd0d15640fb5649142ad5c276d[/quote]

I am having the same issue, have you resolved yours? This is the only thing that jumps out at me from my logs…

[code]May 10 12:55:24 DEBUG[13301] chan_zap.c: Requested indication -1 on channel Zap/2-1

May 10 12:56:46 DEBUG[13301] chan_zap.c: Exception on 21, channel 2
May 10 12:56:46 DEBUG[13301] chan_zap.c: Got event On hook(1) on channel 2 (index 0)
May 10 12:56:46 DEBUG[13301] chan_zap.c: disabled echo cancellation on channel 2
May 10 12:56:46 DEBUG[13301] channel.c: Didn’t get a frame from channel: Zap/2-1[/code]

anyone have any idea as to why these errors are coming up, and if they have caused the call to drop?

Thanks for any help!

Do what it says over and over

May 9 00:37:37 WARNING[6786] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.