May 21 13:16:35 DEBUG[2887] chan_sip.c: Auto destroying call '5a3c321241d29e682158942547ccec83@10.212.1.110' May 21 13:16:36 DEBUG[2887] chan_sip.c: Setting NAT on RTP to 524288 May 21 13:16:36 DEBUG[2887] chan_sip.c: Stopping retransmission on 'Njk0Mzk2ZjA4NjA1MWE5YWZkZGNkYTFiOWUwNTc5MGE.' of Response 1: Match Found May 21 13:16:36 DEBUG[2887] chan_sip.c: Setting NAT on RTP to 524288 May 21 13:16:36 DEBUG[2887] chan_sip.c: Checking SIP call limits for device 5001 May 21 13:16:36 DEBUG[2887] chan_sip.c: build_route: Contact hop: May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Function result is 'device' May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '5001' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Noop May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Not taking any branch May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Not taking any branch May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '5001' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: NoOp May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '5001' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Function result is 'Greg Ketchum' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Not taking any branch May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '5001' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Noop May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '"Greg Ketchum" <5001>' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: NoOp May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Macro May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '5001' May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 VERBOSE[30951] logger.c: recordingcheck|20070521-131636|1179767796.12: Outbound recording not enabled May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: DeadAGI May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Noop May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Macro May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Not taking any branch May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: NoOp May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] db.c: Unable to find key '5001/emergency_cid' in family 'DEVICE' May 21 13:16:36 DEBUG[30951] func_db.c: DB: DEVICE/5001/emergency_cid not found in database. May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Not taking any branch May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] pbx.c: Function result is '"" <9189253265>' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: NoOp May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Macro May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: DeadAGI May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Function result is 'SIP/CCM' May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: Set May 21 13:16:36 DEBUG[30951] pbx.c: Expression result is '0' May 21 13:16:36 DEBUG[30951] pbx.c: Not taking any branch May 21 13:16:36 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:36 DEBUG[30951] chan_sip.c: Setting NAT on RTP to 0 May 21 13:16:36 DEBUG[30951] chan_sip.c: Outgoing Call for 3210 May 21 13:16:58 DEBUG[30951] chan_sip.c: update_call_counter(3210) - decrement call limit counter May 21 13:16:58 DEBUG[30951] chan_sip.c: Acked pending invite 102 May 21 13:16:58 DEBUG[30951] chan_sip.c: Stopping retransmission on '26de345670e82d8d4409a800404eb81f@10.212.1.110' of Request 102: Match Found May 21 13:16:58 DEBUG[30951] app_dial.c: Exiting with DIALSTATUS=CANCEL. May 21 13:16:58 DEBUG[2887] chan_sip.c: Stopping retransmission on 'Njk0Mzk2ZjA4NjA1MWE5YWZkZGNkYTFiOWUwNTc5MGE.' of Response 2: Match Found May 21 13:16:58 DEBUG[30951] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. May 21 13:16:58 DEBUG[30951] 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 ('2007-05-21 13:16:36','9189253265','9189253265','73210','from-internal', 'SIP/5001-08588198','SIP/CCM-0857cb40','ResetCDR','w',22,0,'NO ANSWER',3,'','1179767796.12') May 21 13:16:58 DEBUG[30951] app_macro.c: Executed application: ResetCDR May 21 13:16:58 NOTICE[30951] cdr.c: CDR on channel 'SIP/5001-08588198' not posted May 21 13:16:58 NOTICE[30951] cdr.c: CDR on channel 'SIP/5001-08588198' lacks end May 21 13:16:58 DEBUG[30951] app_macro.c: Executed application: NoCDR May 21 13:16:58 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:58 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:58 DEBUG[30951] pbx.c: Expression result is '1' May 21 13:16:58 DEBUG[30951] app_macro.c: Executed application: GotoIf May 21 13:16:58 DEBUG[30951] chan_sip.c: update_call_counter(5001) - decrement call limit counter May 21 13:17:14 DEBUG[2887] chan_sip.c: Stopping retransmission on '0d61ab482defcacc42a2e88f4099b9d1@10.212.1.110' of Request 102: Match Found May 21 13:17:14 DEBUG[2887] chan_sip.c: Stopping retransmission on '28527b727e5880e50af799e902343340@10.212.1.110' of Request 102: Match Found