well, from the beggining I am using SuSE 10.1 x54 distribution,
the asterisk is the lattest: Asterisk 1.2.13
the freebpx is Version 2.1.3
I have installed all this from tabball after the INSTALL file from the freepbx tarball
And the only thing I set up is the 2 sip account for tests.
here is the log of the calling
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: Setting NAT on RTP to 0
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: Stopping retransmission on ‘[email protected]’ of Response 214: Match Found
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: Setting NAT on RTP to 0
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: Checking SIP call limits for device 490
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: build_route: Contact hop: sip:[email protected]
Oct 26 11:52:07 DEBUG[5796] channel.c: Avoiding initial deadlock for 'SIP/490-b49033e0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Macro(“SIP/490-b49033e0”, “exten-vm|novm|491”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Macro(“SIP/490-b49033e0”, “user-callerid”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is '0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GotoIf(“SIP/490-b49033e0”, “0?report”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Not taking any branch
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is '0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GotoIf(“SIP/490-b49033e0”, “0?start”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Not taking any branch
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '490’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “REALCALLERIDNUM=490”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing NoOp(“SIP/490-b49033e0”, “REALCALLERIDNUM is 490”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '490’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “AMPUSER=490”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is 'xxx’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “AMPUSERCIDNAME=xxx”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is '0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GotoIf(“SIP/490-b49033e0”, “0?report”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Not taking any branch
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “CALLERID(all)=xxx <490>”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '“xxx” <490>'
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing NoOp(“SIP/490-b49033e0”, “Using CallerID “xxx” <490>”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “FROMCONTEXT=exten-vm”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “VMBOX=novm”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “EXTTOCALL=491”) in new stack
Oct 26 11:52:07 DEBUG[5900] db.c: Unable to find key ‘491’ in family 'CFU’
Oct 26 11:52:07 DEBUG[5900] func_db.c: DB: CFU/491 not found in database.
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is ''
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “CFUEXT=”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is '0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is '0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is '0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is ''
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Set(“SIP/490-b49033e0”, “RT=”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Macro(“SIP/490-b49033e0”, “record-enable|491|IN”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is ‘0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GotoIf(“SIP/490-b49033e0”, “0 > 0?2:4”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Goto (macro-record-enable,s,4)
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing AGI(“SIP/490-b49033e0”, “recordingcheck|20061026-115207|1161856327.1”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Oct 26 11:52:07 VERBOSE[5900] logger.c: – AGI Script recordingcheck completed, returning 0
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing NoOp(“SIP/490-b49033e0”, “No recording needed”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is ‘0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GotoIf(“SIP/490-b49033e0”, “0?dolocaldial|1”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Not taking any branch
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Macro(“SIP/490-b49033e0”, “dial||tr|491”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing AGI(“SIP/490-b49033e0”, “dialparties.agi”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
Oct 26 11:52:07 VERBOSE[5900] logger.c: – AGI Script dialparties.agi completed, returning 0
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing NoOp(“SIP/490-b49033e0”, “Returned from dialparties with no extensions to call”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing NoOp(“SIP/490-b49033e0”, "DIALSTATUS is ") in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is ‘0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is ‘0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is ‘0’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GosubIf(“SIP/490-b49033e0”, “0?docfu|1”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing NoOp(“SIP/490-b49033e0”, “Voicemail is novm”) in new stack
Oct 26 11:52:07 DEBUG[5900] pbx.c: Expression result is ‘1’
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing GotoIf(“SIP/490-b49033e0”, “1?s-|1”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Goto (macro-exten-vm,s-,1)
Oct 26 11:52:07 VERBOSE[5900] logger.c: – Executing Congestion(“SIP/490-b49033e0”, “”) in new stack
Oct 26 11:52:07 VERBOSE[5900] logger.c: == Spawn extension (macro-exten-vm, s-, 1) exited non-zero on ‘SIP/490-b49033e0’ in macro ‘exten-vm’
Oct 26 11:52:07 VERBOSE[5900] logger.c: == Spawn extension (macro-exten-vm, s-, 1) exited non-zero on ‘SIP/490-b49033e0’
Oct 26 11:52:07 DEBUG[5900] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Oct 26 11:52:07 DEBUG[5900] 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-10-26 11:52:07’,’“xxx” <490>’,‘490’,‘491’,‘from-internal’, ‘SIP/490-b49033e0’,’’,‘Congestion’,’’,0,0,‘NO ANSWER’,3,’’,‘1161856327.1’)
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: Failed to grab lock, trying again…
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '“xxx” <490>'
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '490’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '491’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is 'from-internal’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is 'SIP/490-b49033e0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '(null)'
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is 'Congestion’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '(null)'
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '2006-10-26 11:52:07’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '(null)'
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '2006-10-26 11:52:07’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '0’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is 'NO ANSWER’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is 'DOCUMENTATION’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '(null)'
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '1161856327.1’
Oct 26 11:52:07 DEBUG[5900] pbx.c: Function result is '(null)'
Oct 26 11:52:07 DEBUG[5900] chan_sip.c: update_call_counter(490) - decrement call limit counter
Oct 26 11:52:07 DEBUG[5807] chan_sip.c: Stopping retransmission on ‘[email protected]’ of Response 215: Match Not Found