<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 TRANSITIONAL//EN">
<HTML>
<HEAD>
  <META HTTP-EQUIV="Content-Type" CONTENT="text/html; CHARSET=UTF-8">
  <META NAME="GENERATOR" CONTENT="GtkHTML/3.16.1">
</HEAD>
<BODY>
I have a trixbox 2.2 and Nortel santral that are speak each other. I use digium TDM100M 2 fxs-2fxo. After I made yum update I had met with some problems when I want to make any call from extension of trixbox to extension of nortel. When I attend to log (/var/log/messages) I meet with these messages as you see below. <BR>
When I try to make any call from trixbox extension the call seems established but I never take any signal from nortel extension. Does anyone meet with problem like this. If you help me I will be happy so much.<BR>
I <BR>
Yavuzhan<BR>
<BR>
---------------------------------------------------------------------------------------------------------------------------<BR>
Apr&nbsp; 4 17:44:52 DEBUG[6161] chan_sip.c: Stopping retransmission on '736e8c4e4b567b8e442308f35a0abfea@10.10.1.46' of Request 102: Match Found<BR>
Apr&nbsp; 4 17:45:52 DEBUG[6161] chan_sip.c: Stopping retransmission on '69211bcb56cbad5a1c608599076cba3a@10.10.1.46' of Request 102: Match Found<BR>
Apr&nbsp; 4 17:46:01 DEBUG[6208] manager.c: Manager received command 'Command'<BR>
Apr&nbsp; 4 17:46:01 DEBUG[6208] manager.c: Manager received command 'Command'<BR>
Apr&nbsp; 4 17:46:01 DEBUG[6208] manager.c: Manager received command 'Command'<BR>
Apr&nbsp; 4 17:46:52 DEBUG[6161] chan_sip.c: Stopping retransmission on '3fb206497b71c23352b8404f549df813@10.10.1.46' of Request 102: Match Found<BR>
Apr&nbsp; 4 17:47:52 DEBUG[6161] chan_sip.c: Stopping retransmission on '4ab9a4454abc6bc02733aa883a835645@10.10.1.46' of Request 102: Match Found<BR>
Apr&nbsp; 4 17:48:01 DEBUG[6208] manager.c: Manager received command 'Command'<BR>
Apr&nbsp; 4 17:48:01 DEBUG[6208] manager.c: Manager received command 'Command'<BR>
Apr&nbsp; 4 17:48:01 DEBUG[6208] manager.c: Manager received command 'Command'<BR>
Apr&nbsp; 4 17:48:52 DEBUG[6161] chan_sip.c: Stopping retransmission on '3f2aceb80d6b6ff23ed25e8f3fe9a201@10.10.1.46' of Request 102: Match Found<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6161] chan_sip.c: Setting NAT on RTP to 524288<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6161] chan_sip.c: Stopping retransmission on '3065acdf-92ffb5c4@10.10.1.50' of Response 101: Match Found<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6161] chan_sip.c: Setting NAT on RTP to 524288<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6161] chan_sip.c: Checking SIP call limits for device 5002<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6161] chan_sip.c: build_route: Contact hop: &quot;Cem Aktas&quot; &lt;<A HREF="sip:3549@10.10.1.50:5060">sip:3549@10.10.1.50:5060</A>&gt;<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6153] channel.c: Avoiding initial deadlock for 'SIP/5002-09195d70'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is 'device'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Noop<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is 'Cem Aktas'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Noop<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '&quot;Cem Aktas&quot; &lt;5002&gt;'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Macro<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '20080404-174914'<BR>
Apr&nbsp; 4 17:49:14 VERBOSE[6271] logger.c:&nbsp;&nbsp; recordingcheck|20080404-174914|1207320554.10: Outbound recording not enabled<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: AGI<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Noop<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Macro<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is ''<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] db.c: Unable to find key '5002/emergency_cid' in family 'DEVICE'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] func_db.c: DB: DEVICE/5002/emergency_cid not found in database.<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is ''<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is '&quot;Cem Aktas&quot; &lt;5002&gt;'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Macro<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: AGI<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Function result is 'ZAP/g0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] chan_zap.c: Dialing '3549'<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6271] chan_zap.c: Deferring dialing...<BR>
Apr&nbsp; 4 17:49:14 DEBUG[6153] channel.c: Avoiding initial deadlock for 'Zap/3-1'<BR>
Apr&nbsp; 4 17:49:15 DEBUG[6271] chan_zap.c: Exception on 20, channel 3<BR>
Apr&nbsp; 4 17:49:15 DEBUG[6271] chan_zap.c: Got event Hook Transition Complete(12) on channel 3 (index 0)<BR>
Apr&nbsp; 4 17:49:15 DEBUG[6271] chan_zap.c: Exception on 20, channel 3<BR>
Apr&nbsp; 4 17:49:15 DEBUG[6271] chan_zap.c: Got event Dial Complete(9) on channel 3 (index 0)<BR>
Apr&nbsp; 4 17:49:15 DEBUG[6271] chan_zap.c: Enabled echo cancellation on channel 3<BR>
Apr&nbsp; 4 17:49:15 DEBUG[6271] chan_zap.c: Engaged echo training on channel 3<BR>
Apr&nbsp; 4 17:49:18 DEBUG[6271] chan_zap.c: Exception on 20, channel 3<BR>
Apr&nbsp; 4 17:49:18 DEBUG[6271] chan_zap.c: Got event Dial Complete(9) on channel 3 (index 0)<BR>
Apr&nbsp; 4 17:49:18 DEBUG[6271] chan_zap.c: Echo cancellation already on<BR>
Apr&nbsp; 4 17:49:18 DEBUG[6153] channel.c: Avoiding initial deadlock for 'Zap/3-1'<BR>
Apr&nbsp; 4 17:49:18 DEBUG[6161] chan_sip.c: Stopping retransmission on '3065acdf-92ffb5c4@10.10.1.50' of Response 102: Match Found<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] channel.c: Didn't get a frame from channel: SIP/5002-09195d70<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] channel.c: Bridge stops bridging channels SIP/5002-09195d70 and Zap/3-1<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] chan_zap.c: Hangup: channel: 3 index = 0, normal = 20, callwait = -1, thirdcall = -1<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] chan_zap.c: disabled echo cancellation on channel 3<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/3-1<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] chan_zap.c: Updated conferencing on 3, with 0 conference users<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] app_dial.c: Exiting with DIALSTATUS=ANSWER.<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] 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 ('2008-04-04 17:49:14','\&quot;Cem Aktas\&quot; &lt;5002&gt;','5002','93549','from-internal', 'SIP/5002-09195d70','Zap/3-1','Dial','ZAP/g0/3549|300|',8,4,'ANSWERED',3,'','1207320554.10')<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] app_macro.c: Executed application: ResetCDR<BR>
Apr&nbsp; 4 17:49:22 NOTICE[6271] cdr.c: CDR on channel 'SIP/5002-09195d70' not posted<BR>
Apr&nbsp; 4 17:49:22 NOTICE[6271] cdr.c: CDR on channel 'SIP/5002-09195d70' lacks end<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] app_macro.c: Executed application: NoCDR<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] pbx.c: Expression result is '1'<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] app_macro.c: Executed application: GotoIf<BR>
Apr&nbsp; 4 17:49:22 DEBUG[6271] chan_sip.c: update_call_counter(5002) - decrement call limit counter<BR>
---------------------------------------------------------------------------------------------------------------------------<BR>
<BR>
<BR>
</BODY>
</HTML>