[root@asterisk1 asterisk]# tail -f /var/log/asterisk/full
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1103' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1109' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1112' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1102' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1108' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1107' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1110' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1104' to 60 seconds (requested 300)
Dec 12 13:15:17 NOTICE[5475] chan_iax2.c: Restricting registration for peer '1100' to 60 seconds (requested 300)
Dec 12 13:15:49 DEBUG[5484] chan_sip.c: Stopping retransmission on '0fdf3dc83422e14c2c96687162c08f0e@192.168.1.250' of Request 102: Match Found
Dec 12 13:15:58 DEBUG[5481] dsp.c: dsp busy pattern set to 2500,500
Dec 12 13:15:58 VERBOSE[5481] logger.c: -- Accepting overlap call from '3147910062' to '6643' on channel 0/8, span 2
Dec 12 13:15:58 VERBOSE[22249] logger.c: -- Starting simple switch on 'Zap/32-1'
Dec 12 13:16:01 DEBUG[5484] chan_sip.c: Auto destroying call '5a2cb396e953418601e9919413d2dcfb@192.168.1.106'
Dec 12 13:16:01 DEBUG[22249] chan_zap.c: Enabled echo cancellation on channel 32
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Macro("Zap/32-1", "exten-vm|6643|6643") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Macro("Zap/32-1", "user-callerid") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '0'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "0?report") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Not taking any branch
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '0'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "0?start") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Not taking any branch
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is '3147910062'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "REALCALLERIDNUM=3147910062") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing NoOp("Zap/32-1", "REALCALLERIDNUM is 3147910062") in new stack
Dec 12 13:16:01 DEBUG[22249] db.c: Unable to find key '3147910062/user' in family 'DEVICE'
Dec 12 13:16:01 DEBUG[22249] func_db.c: DB: DEVICE/3147910062/user not found in database.
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is ''
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "AMPUSER=") in new stack
Dec 12 13:16:01 DEBUG[22249] db.c: Unable to find key '/cidname' in family 'AMPUSER'
Dec 12 13:16:01 DEBUG[22249] func_db.c: DB: AMPUSER//cidname not found in database.
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is ''
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "AMPUSERCIDNAME=") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '1'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "1?report") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Goto (macro-user-callerid,s,10)
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing NoOp("Zap/32-1", "TTL: ARG1: 6643") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '0'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "0?continue") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Not taking any branch
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '1'
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '-1'
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is '64'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "_TTL=64") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '1'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "1?continue") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Goto (macro-user-callerid,s,20)
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is '"LADUE, MO" <3147910062>'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing NoOp("Zap/32-1", "Using CallerID "LADUE, MO" <3147910062>") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing NoOp("Zap/32-1", "CAME FROM: ") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "RRNODEST=") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "_NODEST=") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "FROMCONTEXT=exten-vm") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "VMBOX=6643") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "EXTTOCALL=6643") in new stack
Dec 12 13:16:01 DEBUG[22249] db.c: Unable to find key '6643' in family 'CFU'
Dec 12 13:16:01 DEBUG[22249] func_db.c: DB: CFU/6643 not found in database.
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is ''
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "CFUEXT=") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '1'
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '0'
Dec 12 13:16:01 DEBUG[22249] pbx.c: Expression result is '1'
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is '15'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Set("Zap/32-1", "RT=15") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing Macro("Zap/32-1", "record-enable|6643|IN") in new stack
Dec 12 13:16:01 DEBUG[22249] pbx.c: Function result is '0'
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "0 > 0?2:4") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Goto (macro-record-enable,s,4)
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Executing DeadAGI("Zap/32-1", "recordingcheck|20061212-131601|1165950958.7647") in new stack
Dec 12 13:16:01 VERBOSE[22249] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Dec 12 13:16:04 DEBUG[5484] chan_sip.c: Stopping retransmission on '13a2744859ebeef87cf9408772cc40c0@192.168.1.250' of Request 102: Match Found
Dec 12 13:16:05 VERBOSE[22249] logger.c: recordingcheck|20061212-131601|1165950958.7647: Inbound recording not enabled
Dec 12 13:16:05 VERBOSE[22249] logger.c: -- AGI Script recordingcheck completed, returning 0
Dec 12 13:16:05 VERBOSE[22249] logger.c: -- Executing NoOp("Zap/32-1", "No recording needed") in new stack
Dec 12 13:16:05 DEBUG[22249] pbx.c: Expression result is '0'
Dec 12 13:16:05 VERBOSE[22249] logger.c: -- Executing GotoIf("Zap/32-1", "0?dolocaldial|1") in new stack
Dec 12 13:16:05 DEBUG[22249] pbx.c: Not taking any branch
Dec 12 13:16:05 VERBOSE[22249] logger.c: -- Executing Macro("Zap/32-1", "dial|15|tr|6643") in new stack
Dec 12 13:16:05 VERBOSE[22249] logger.c: -- Executing DeadAGI("Zap/32-1", "dialparties.agi") in new stack
Dec 12 13:16:05 VERBOSE[22249] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
Dec 12 13:16:06 VERBOSE[5481] logger.c: -- Channel 0/8, span 2 got hangup request
Dec 12 13:16:07 VERBOSE[22249] logger.c: dialparties.agi: Starting New Dialparties.agi
Dec 12 13:16:07 VERBOSE[22249] logger.c: dialparties.agi: priority is 1
Dec 12 13:16:07 VERBOSE[22249] logger.c: dialparties.agi: Caller ID name is 'LADUE, MO' number is '3147910062'
Dec 12 13:16:07 VERBOSE[22249] logger.c: dialparties.agi: Methodology of ring is 'none'
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: USE_CONFIRMATION: 'FALSE'
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: RINGGROUP_INDEX: ''
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- dialparties.agi: Added extension 6643 to extension map
Dec 12 13:16:07 DEBUG[22249] db.c: Unable to find key '6643' in family 'CF'
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- dialparties.agi: Extension 6643 cf is disabled
Dec 12 13:16:07 DEBUG[22249] db.c: Unable to find key '6643' in family 'DND'
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- dialparties.agi: Extension 6643 do not disturb is disabled
Dec 12 13:16:07 DEBUG[22249] db.c: Unable to find key '6643' in family 'CW'
Dec 12 13:16:07 DEBUG[22249] db.c: Unable to find key '6643' in family 'CFB'
Dec 12 13:16:07 DEBUG[22249] db.c: Unable to find key '6643' in family 'CFU'
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: extnum: 6643
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: exthascw: 0
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: exthascfb: 0
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: extcfb:
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: exthascfu: 0
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: extcfu:
Dec 12 13:16:07 DEBUG[22255] manager.c: Manager received command 'login'
Dec 12 13:16:07 VERBOSE[22255] logger.c: == Parsing '/etc/asterisk/manager.conf': Dec 12 13:16:07 VERBOSE[22255] logger.c: == Parsing '/etc/asterisk/manager.conf': Found
Dec 12 13:16:07 VERBOSE[22255] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Dec 12 13:16:07 VERBOSE[22255] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': Found
Dec 12 13:16:07 DEBUG[22255] acl.c: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for peer
Dec 12 13:16:07 DEBUG[22255] acl.c: 127.0.0.1/255.255.255.0/255.255.255.0 appended to acl for peer
Dec 12 13:16:07 DEBUG[22255] acl.c: ##### Testing 127.0.0.1 with 0.0.0.0
Dec 12 13:16:07 DEBUG[22255] acl.c: ##### Testing 127.0.0.1 with 127.0.0.0
Dec 12 13:16:07 VERBOSE[22255] logger.c: == Manager 'admin' logged on from 127.0.0.1
Dec 12 13:16:07 DEBUG[22255] manager.c: Manager received command 'ExtensionState'
Dec 12 13:16:07 DEBUG[22255] manager.c: Manager received command 'Logoff'
Dec 12 13:16:07 VERBOSE[22255] logger.c: == Manager 'admin' logged off from 127.0.0.1
Dec 12 13:16:07 VERBOSE[22249] logger.c: > dialparties.agi: ExtensionState: 0
Dec 12 13:16:07 VERBOSE[22249] logger.c: dialparties.agi: Extension 6643 has ExtensionState: 0
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- dialparties.agi: Checking CW and CFB status for extension 6643
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- dialparties.agi: dbset CALLTRACE/6643 to 3147910062
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- AGI Script dialparties.agi completed, returning 0
Dec 12 13:16:07 DEBUG[22249] app_macro.c: Extension s, macroexten 6643, priority 9 returned normally even though call was hung up
Dec 12 13:16:07 DEBUG[22249] app_macro.c: Extension s, macroexten 6643, priority 12 returned normally even though call was hung up
Dec 12 13:16:07 DEBUG[22249] pbx.c: Extension 6643, priority 1 returned normally even though call was hung up
Dec 12 13:16:07 DEBUG[22249] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Dec 12 13:16:07 DEBUG[22249] 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-12-12 13:16:01','\"LADUE, MO\" <3147910062>','3147910062','6643','from-pstn', 'Zap/32-1','','DeadAGI','dialparties.agi',6,0,'NO ANSWER',2,'','1165950958.7647')
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/32-1
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: Hangup: channel: 32 index = 0, normal = 20, callwait = -1, thirdcall = -1
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: disabled echo cancellation on channel 32
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/32-1
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: Updated conferencing on 32, with 0 conference users
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/32-1
Dec 12 13:16:07 DEBUG[22249] chan_zap.c: disabled echo cancellation on channel 32
Dec 12 13:16:07 VERBOSE[22249] logger.c: -- Hungup 'Zap/32-1'