---
Dec 1 17:09:53 DEBUG[8664] chan_sip.c: Stopping retransmission on '4535c94c2290ea197d1633ca194065fc@192.168.2.12' of Request 102: Match Found
Dec 1 17:09:54 VERBOSE[19760] logger.c: -- Zap/2-1 is ringing
Dec 1 17:09:58 DEBUG[8664] chan_sip.c: Auto destroying call 'adbb5e45-ffafa44f-688a31ae@192.168.2.94'
Dec 1 17:10:00 VERBOSE[8664] logger.c:
<-- SIP read from 192.168.2.92:5060:
CANCEL sip:5038510262@192.168.2.12 SIP/2.0
Via: SIP/2.0/UDP 192.168.2.92:5060;branch=z9hG4bK-80600ad9
From: "202" ;tag=8058321111268b71o0
To: "William"
Call-ID: 111ae91-532738f1@192.168.2.92
CSeq: 102 CANCEL
Max-Forwards: 70
Proxy-Authorization: Digest username="202",realm="asterisk",nonce="2caec3fb",uri="sip:5038510262@192.168.2.12",algorithm=MD5,response="9b68b12cb5f8abb458e98747b4c5953c"
User-Agent: Linksys/SPA942-4.1.18
Content-Length: 0


Dec 1 17:10:00 VERBOSE[8664] logger.c: --- (10 headers 0 lines)Dec 1 17:10:00 VERBOSE[8664] logger.c: --- (10 headers 0 lines)---
Dec 1 17:10:00 VERBOSE[8664] logger.c: Sending to 192.168.2.92 : 5060 (non-NAT)
Dec 1 17:10:00 VERBOSE[8664] logger.c: Reliably Transmitting (no NAT) to 192.168.2.92:5060:
SIP/2.0 487 Request Terminated
Via: SIP/2.0/UDP 192.168.2.92:5060;branch=z9hG4bK-80600ad9;received=192.168.2.92
From: "202" ;tag=8058321111268b71o0
To: "William" ;tag=as23ab564d
Call-ID: 111ae91-532738f1@192.168.2.92
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact:
Content-Length: 0


---
Dec 1 17:10:00 VERBOSE[8664] logger.c: Transmitting (no NAT) to 192.168.2.92:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.2.92:5060;branch=z9hG4bK-80600ad9;received=192.168.2.92
From: "202" ;tag=8058321111268b71o0
To: "William" ;tag=as23ab564d
Call-ID: 111ae91-532738f1@192.168.2.92
CSeq: 102 CANCEL
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact:
Content-Length: 0


---
Dec 1 17:10:00 DEBUG[19760] chan_zap.c: Hangup: channel: 2 index = 0, normal = 21, callwait = -1, thirdcall = -1
Dec 1 17:10:00 DEBUG[19760] chan_zap.c: disabled echo cancellation on channel 2
Dec 1 17:10:00 DEBUG[19760] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/2-1
Dec 1 17:10:00 DEBUG[19760] chan_zap.c: Updated conferencing on 2, with 0 conference users
Dec 1 17:10:00 VERBOSE[19760] logger.c: -- Hungup 'Zap/2-1'
Dec 1 17:10:00 DEBUG[19760] app_dial.c: Exiting with DIALSTATUS=CANCEL.
Dec 1 17:10:00 VERBOSE[19760] logger.c: == Spawn extension (macro-dialout-trunk, s, 14) exited non-zero on 'SIP/202-3bba' in macro 'dialout-trunk'
Dec 1 17:10:00 VERBOSE[19760] logger.c: == Spawn extension (from-internal, 5038510262, 1) exited non-zero on 'SIP/202-3bba'
Dec 1 17:10:00 VERBOSE[19760] logger.c: -- Executing Macro("SIP/202-3bba", "hangupcall") in new stack
Dec 1 17:10:00 VERBOSE[19760] logger.c: -- Executing ResetCDR("SIP/202-3bba", "w") in new stack
Dec 1 17:10:00 DEBUG[19760] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Dec 1 17:10:00 DEBUG[19760] 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-01 17:09:38','ANSI','','5038510262','from-internal', 'SIP/202-3bba','Zap/2-1','ResetCDR','w',22,0,'NO ANSWER',3,'','1165021778.100')
Dec 1 17:10:00 VERBOSE[19760] logger.c: -- Executing NoCDR("SIP/202-3bba", "") in new stack
Dec 1 17:10:00 WARNING[19760] cdr.c: CDR on channel 'SIP/202-3bba' not posted
Dec 1 17:10:00 WARNING[19760] cdr.c: CDR on channel 'SIP/202-3bba' lacks end
Dec 1 17:10:00 VERBOSE[19760] logger.c: -- Executing Wait("SIP/202-3bba", "5") in new stack
Dec 1 17:10:00 VERBOSE[19760] logger.c: == Spawn extension (macro-hangupcall, s, 3) exited non-zero on 'SIP/202-3bba' in macro 'hangupcall'
Dec 1 17:10:00 VERBOSE[19760] logger.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/202-3bba'
Dec 1 17:10:00 DEBUG[19760] chan_sip.c: update_call_counter(202) - decrement call limit counter
Dec 1 17:10:00 VERBOSE[8664] logger.c:
<-- SIP read from 192.168.2.92:5060:
ACK sip:5038510262@192.168.2.12 SIP/2.0
Via: SIP/2.0/UDP 192.168.2.92:5060;branch=z9hG4bK-80600ad9
From: "202" ;tag=8058321111268b71o0
To: "William" ;tag=as23ab564d
Call-ID: 111ae91-532738f1@192.168.2.92
CSeq: 102 ACK
Max-Forwards: 70
Proxy-Authorization: Digest username="202",realm="asterisk",nonce="2caec3fb",uri="sip:5038510262@192.168.2.12",algorithm=MD5,response="0548bb7296865bb3892e98cdea1aabbc"
Contact: "202"
User-Agent: Linksys/SPA942-4.1.18
Content-Length: 0


Dec 1 17:10:00 VERBOSE[8664] logger.c: --- (11 headers 0 lines)Dec 1 17:10:00 VERBOSE[8664] logger.c: --- (11 headers 0 lines)---
Dec 1 17:10:00 DEBUG[8664] chan_sip.c: Stopping retransmission on '111ae91-532738f1@192.168.2.92' of Response 102: Match Found
Dec 1 17:10:00 VERBOSE[8664] logger.c: Destroying call '111ae91-532738f1@192.168.2.92'
Dec 1 17:10:00 VERBOSE[8664] logger.c: Destroying call '111ae91-532738f1@192.168.2.92'