[asterisk-users] Problem about calling from atrixbox to pbx extension

Yavuzhan Canli ycanli at tekfen.com.tr
Fri Apr 4 10:02:21 CDT 2008


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. 
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.
I 
Yavuzhan

---------------------------------------------------------------------------------------------------------------------------
Apr  4 17:44:52 DEBUG[6161] chan_sip.c: Stopping retransmission on
'736e8c4e4b567b8e442308f35a0abfea at 10.10.1.46' of Request 102: Match
Found
Apr  4 17:45:52 DEBUG[6161] chan_sip.c: Stopping retransmission on
'69211bcb56cbad5a1c608599076cba3a at 10.10.1.46' of Request 102: Match
Found
Apr  4 17:46:01 DEBUG[6208] manager.c: Manager received command
'Command'
Apr  4 17:46:01 DEBUG[6208] manager.c: Manager received command
'Command'
Apr  4 17:46:01 DEBUG[6208] manager.c: Manager received command
'Command'
Apr  4 17:46:52 DEBUG[6161] chan_sip.c: Stopping retransmission on
'3fb206497b71c23352b8404f549df813 at 10.10.1.46' of Request 102: Match
Found
Apr  4 17:47:52 DEBUG[6161] chan_sip.c: Stopping retransmission on
'4ab9a4454abc6bc02733aa883a835645 at 10.10.1.46' of Request 102: Match
Found
Apr  4 17:48:01 DEBUG[6208] manager.c: Manager received command
'Command'
Apr  4 17:48:01 DEBUG[6208] manager.c: Manager received command
'Command'
Apr  4 17:48:01 DEBUG[6208] manager.c: Manager received command
'Command'
Apr  4 17:48:52 DEBUG[6161] chan_sip.c: Stopping retransmission on
'3f2aceb80d6b6ff23ed25e8f3fe9a201 at 10.10.1.46' of Request 102: Match
Found
Apr  4 17:49:14 DEBUG[6161] chan_sip.c: Setting NAT on RTP to 524288
Apr  4 17:49:14 DEBUG[6161] chan_sip.c: Stopping retransmission on
'3065acdf-92ffb5c4 at 10.10.1.50' of Response 101: Match Found
Apr  4 17:49:14 DEBUG[6161] chan_sip.c: Setting NAT on RTP to 524288
Apr  4 17:49:14 DEBUG[6161] chan_sip.c: Checking SIP call limits for
device 5002
Apr  4 17:49:14 DEBUG[6161] chan_sip.c: build_route: Contact hop: "Cem
Aktas" <sip:3549 at 10.10.1.50:5060>
Apr  4 17:49:14 DEBUG[6153] channel.c: Avoiding initial deadlock for
'SIP/5002-09195d70'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is 'device'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Noop
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is 'Cem Aktas'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '1'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Noop
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '"Cem Aktas"
<5002>'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Macro
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '5002'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '20080404-174914'
Apr  4 17:49:14 VERBOSE[6271] logger.c:   recordingcheck|
20080404-174914|1207320554.10: Outbound recording not enabled
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: AGI
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Noop
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Macro
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is ''
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] db.c: Unable to find key
'5002/emergency_cid' in family 'DEVICE'
Apr  4 17:49:14 DEBUG[6271] func_db.c: DB: DEVICE/5002/emergency_cid not
found in database.
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is ''
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is '"Cem Aktas"
<5002>'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: NoOp
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Macro
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: AGI
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Function result is 'ZAP/g0'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: Set
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] pbx.c: Expression result is '0'
Apr  4 17:49:14 DEBUG[6271] pbx.c: Not taking any branch
Apr  4 17:49:14 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:14 DEBUG[6271] chan_zap.c: Dialing '3549'
Apr  4 17:49:14 DEBUG[6271] chan_zap.c: Deferring dialing...
Apr  4 17:49:14 DEBUG[6153] channel.c: Avoiding initial deadlock for
'Zap/3-1'
Apr  4 17:49:15 DEBUG[6271] chan_zap.c: Exception on 20, channel 3
Apr  4 17:49:15 DEBUG[6271] chan_zap.c: Got event Hook Transition
Complete(12) on channel 3 (index 0)
Apr  4 17:49:15 DEBUG[6271] chan_zap.c: Exception on 20, channel 3
Apr  4 17:49:15 DEBUG[6271] chan_zap.c: Got event Dial Complete(9) on
channel 3 (index 0)
Apr  4 17:49:15 DEBUG[6271] chan_zap.c: Enabled echo cancellation on
channel 3
Apr  4 17:49:15 DEBUG[6271] chan_zap.c: Engaged echo training on channel
3
Apr  4 17:49:18 DEBUG[6271] chan_zap.c: Exception on 20, channel 3
Apr  4 17:49:18 DEBUG[6271] chan_zap.c: Got event Dial Complete(9) on
channel 3 (index 0)
Apr  4 17:49:18 DEBUG[6271] chan_zap.c: Echo cancellation already on
Apr  4 17:49:18 DEBUG[6153] channel.c: Avoiding initial deadlock for
'Zap/3-1'
Apr  4 17:49:18 DEBUG[6161] chan_sip.c: Stopping retransmission on
'3065acdf-92ffb5c4 at 10.10.1.50' of Response 102: Match Found
Apr  4 17:49:22 DEBUG[6271] channel.c: Didn't get a frame from channel:
SIP/5002-09195d70
Apr  4 17:49:22 DEBUG[6271] channel.c: Bridge stops bridging channels
SIP/5002-09195d70 and Zap/3-1
Apr  4 17:49:22 DEBUG[6271] chan_zap.c: Hangup: channel: 3 index = 0,
normal = 20, callwait = -1, thirdcall = -1
Apr  4 17:49:22 DEBUG[6271] chan_zap.c: disabled echo cancellation on
channel 3
Apr  4 17:49:22 DEBUG[6271] chan_zap.c: Set option TDD MODE, value:
OFF(0) on Zap/3-1
Apr  4 17:49:22 DEBUG[6271] chan_zap.c: Updated conferencing on 3, with
0 conference users
Apr  4 17:49:22 DEBUG[6271] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Apr  4 17:49:22 DEBUG[6271] cdr_addon_mysql.c: cdr_mysql: inserting a
CDR record.
Apr  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','\"Cem Aktas\" <5002>','5002','93549','from-internal', 'SIP/5002-09195d70','Zap/3-1','Dial','ZAP/g0/3549|300|',8,4,'ANSWERED',3,'','1207320554.10')
Apr  4 17:49:22 DEBUG[6271] app_macro.c: Executed application: ResetCDR
Apr  4 17:49:22 NOTICE[6271] cdr.c: CDR on channel 'SIP/5002-09195d70'
not posted
Apr  4 17:49:22 NOTICE[6271] cdr.c: CDR on channel 'SIP/5002-09195d70'
lacks end
Apr  4 17:49:22 DEBUG[6271] app_macro.c: Executed application: NoCDR
Apr  4 17:49:22 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:22 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:22 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:22 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:22 DEBUG[6271] pbx.c: Expression result is '1'
Apr  4 17:49:22 DEBUG[6271] app_macro.c: Executed application: GotoIf
Apr  4 17:49:22 DEBUG[6271] chan_sip.c: update_call_counter(5002) -
decrement call limit counter
---------------------------------------------------------------------------------------------------------------------------


-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20080404/502339cb/attachment-0001.htm 


More information about the asterisk-users mailing list