testdb*CLI> Sip read: INVITE sip:12128121207@pbxtest.acecape.com SIP/2.0 Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK032bad94 From: "2128121201" ;tag=as6c4b03ec To: Contact: Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 INVITE User-Agent: AcePBX Date: Mon, 15 Nov 2004 17:40:31 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Content-Type: application/sdp Content-Length: 216 v=0 testdb*CLI> o=root 23089 23089 IN IP4 66.114.83.12 s=session c=IN IP4 66.114.83.12 t=0 0 m=audio 46508 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 12 headers, 10 lines Using latest request as basis request Sending to 66.114.83.12 : 5060 (non-NAT) Found RTP audio format 0 Found RTP audio format 101 Peer audio RTP is at port 66.114.83.12:46508 Found description format PCMU Found description format telephone-event Capabilities: us - 0x4(ULAW), peer - audio=0x4(ULAW)/video=0x0(EMPTY), combined - 0x4(ULAW) Non-codec capabilities: us - 0x1(G723), peer - 0x1(G723), combined - 0x1(G723) Found no matching peer or user for '66.114.83.12:5060' testdb*CLI> Looking for 12128121207 in sip testdb*CLI> list_route: hop: testdb*CLI> Transmitting (no NAT): SIP/2.0 100 Trying Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK032bad94 From: "2128121201" ;tag=as6c4b03ec To: ;tag=as40db7c72 Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 INVITE User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 to 66.114.83.12:5060 testdb*CLI> -- Executing Wait("SIP/66.114.83.12-4170e310", "1") in new stack testdb*CLI> -- Executing AbsoluteTimeout("SIP/66.114.83.12-4170e310", "900") in new stack testdb*CLI> -- Set Absolute Timeout to 900 testdb*CLI> -- Executing Dial("SIP/66.114.83.12-4170e310", "SIP/121281212070000|10|") in new stack testdb*CLI> We're at 66.114.83.67 port 49406 testdb*CLI> Answering/Requesting with root capability 4 testdb*CLI> 12 headers, 8 lines testdb*CLI> Reliably Transmitting: INVITE sip:121281212070000@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK5e349b23;rport From: "2128121201" ;tag=as29b2ecf3 To: Contact: Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 CSeq: 102 INVITE User-Agent: AcePBX Date: Mon, 15 Nov 2004 17:30:09 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Content-Type: application/sdp Content-Length: 160 v=0 o=root 28539 28539 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 49406 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=silenceSupp:off - - - - (NAT) to 66.114.76.250:1290 testdb*CLI> -- Called 121281212070000 testdb*CLI> Sip read: SIP/2.0 100 Trying Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK5e349b23;rport From: "2128121201" ;tag=as29b2ecf3 To: Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:10 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Length: 0 10 headers, 0 lines testdb*CLI> Sip read: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK5e349b23;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:11 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Length: 0 10 headers, 0 lines testdb*CLI> -- SIP/121281212070000-3a8d is ringing testdb*CLI> Transmitting (no NAT): SIP/2.0 180 Ringing Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK032bad94 From: "2128121201" ;tag=as6c4b03ec To: ;tag=as40db7c72 Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 INVITE User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 to 66.114.83.12:5060 testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK5e349b23;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:12 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Type: application/sdp Content-Length: 141 v=0 o=Cisco-SIPUA 6321 9288 IN IP4 66.114.76.250 s=SIP Call c=IN IP4 66.114.76.250 t=0 0 m=audio 20942 RTP/AVP 0 a=rtpmap:0 PCMU/8000 11 headers, 7 lines Found RTP audio format 0 Peer audio RTP is at port 66.114.76.250:20942 Found description format PCMU Capabilities: us - 0x4(ULAW), peer - audio=0x4(ULAW)/video=0x0(EMPTY), combined - 0x4(ULAW) Non-codec capabilities: us - 0x1(G723), peer - 0x0(EMPTY), combined - 0x0(EMPTY) list_route: hop: set_destination: Parsing for address/port to send to set_destination: set destination to 66.114.76.250, port 5060 Transmitting: ACK sip:121281212070000@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK76d80c6d;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Contact: Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 CSeq: 102 ACK User-Agent: AcePBX Content-Length: 0 (NAT) to 66.114.76.250:1290 testdb*CLI> -- SIP/121281212070000-3a8d answered SIP/66.114.83.12-4170e310 testdb*CLI> We're at 66.114.83.67 port 41032 testdb*CLI> Answering with preferred capability 0x4(ULAW) testdb*CLI> Answering with non-codec capability 0x1(G723) testdb*CLI> Reliably Transmitting (no NAT): SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK032bad94 From: "2128121201" ;tag=as6c4b03ec To: ;tag=as40db7c72 Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 INVITE User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Type: application/sdp Content-Length: 216 v=0 o=root 28539 28539 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 41032 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - to 66.114.83.12:5060 testdb*CLI> -- Attempting native bridge of SIP/66.114.83.12-4170e310 and SIP/121281212070000-3a8d testdb*CLI> Sip read: ACK sip:12128121207@pbxtest.acecape.com SIP/2.0 Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK27445f2a From: "2128121201" ;tag=as6c4b03ec To: ;tag=as40db7c72 Contact: Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 ACK User-Agent: AcePBX Content-Length: 0 testdb*CLI> 9 headers, 0 lines testdb*CLI> Sip read: INVITE sip:2128121201@66.114.83.67:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.76.250:5060 From: ;tag=0009e88122b8003b4b8ebc84-7318cb6c To: "2128121201" ;tag=as29b2ecf3 Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:14 GMT CSeq: 101 INVITE User-Agent: CSCO/5 Contact: Content-Type: application/sdp Content-Length: 136 v=0 o=Cisco-SIPUA 25838 9248 IN IP4 66.114.76.250 s=SIP Call c=IN IP4 0.0.0.0 t=0 0 m=audio 20942 RTP/AVP 0 a=rtpmap:0 PCMU/8000 11 headers, 7 lines Using latest request as basis request Sending to 66.114.76.250 : 5060 (NAT) Found RTP audio format 0 Peer audio RTP is at port 0.0.0.0:20942 Found description format PCMU Capabilities: us - 0x4(ULAW), peer - audio=0x4(ULAW)/video=0x0(EMPTY), combined - 0x4(ULAW) Non-codec capabilities: us - 0x1(G723), peer - 0x0(EMPTY), combined - 0x0(EMPTY) -- Started music on hold, class 'default', on SIP/66.114.83.12-4170e310 We're at 66.114.83.67 port 49406 Answering/Requesting with root capability 4 testdb*CLI> Reliably Transmitting (NAT): SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.76.250:5060;received=66.114.76.250;rport=1290 From: ;tag=0009e88122b8003b4b8ebc84-7318cb6c To: "2128121201" ;tag=as29b2ecf3 Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 CSeq: 101 INVITE User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Type: application/sdp Content-Length: 160 v=0 o=root 28539 28540 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 49406 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=silenceSupp:off - - - - to 66.114.76.250:1290 testdb*CLI> Sip read: ACK sip:2128121201@66.114.83.67:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.76.250:5060 From: ;tag=0009e88122b8003b4b8ebc84-7318cb6c To: "2128121201" ;tag=as29b2ecf3 Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:14 GMT CSeq: 101 ACK User-Agent: CSCO/5 Content-Length: 0 9 headers, 0 lines testdb*CLI> Sip read: REFER sip:2128121201@66.114.83.67:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.76.250:5060 From: ;tag=0009e88122b8003b4b8ebc84-7318cb6c To: "2128121201" ;tag=as29b2ecf3 Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:18 GMT CSeq: 102 REFER User-Agent: CSCO/5 Contact: Content-Length: 0 Refer-To: sip:1100@66.114.83.67 Referred-By: 12 headers, 0 lines Looking for 1100 in xyz Looking for 121281212070000 in xyz -- Stopped music on hold on SIP/66.114.83.12-4170e310 Transmitting (NAT): SIP/2.0 202 Accepted Via: SIP/2.0/UDP 66.114.76.250:5060;received=66.114.76.250;rport=1290 From: ;tag=0009e88122b8003b4b8ebc84-7318cb6c To: "2128121201" ;tag=as29b2ecf3 Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 CSeq: 102 REFER User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 to 66.114.76.250:1290 set_destination: Parsing for address/port to send to set_destination: set destination to 66.114.76.250, port 5060 Reliably Transmitting: NOTIFY sip:121281212070000@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK6b5b26b4;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Contact: Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 CSeq: 103 NOTIFY User-Agent: AcePBX Event: refer;id=102 Subscription-state: terminated;reason=noresource Content-Type: message/sipfrag;version=2.0 Content-Length: 14 SIP/2.0 200 OK (NAT) to 66.114.76.250:1290 set_destination: Parsing for address/port to send to set_destination: set destination to 66.114.76.250, port 5060 Reliably Transmitting: BYE sip:121281212070000@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK7305b467;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Contact: Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 CSeq: 104 BYE User-Agent: AcePBX Content-Length: 0 (NAT) to 66.114.76.250:1290 testdb*CLI> -- Executing Wait("SIP/66.114.83.12-4170e310", "1") in new stack testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK6b5b26b4;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:18 GMT CSeq: 103 NOTIFY Content-Length: 0 8 headers, 0 lines Message is NOTIFY testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK7305b467;rport From: "2128121201" ;tag=as29b2ecf3 To: ;tag=0009e88122b8003b4b8ebc84-7318cb6c Call-ID: 00d4444b055d9f71095aed086f9456ab@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:18 GMT CSeq: 104 BYE Server: CSCO/5 Content-Length: 0 9 headers, 0 lines testdb*CLI> Message is BYE testdb*CLI> Destroying call '00d4444b055d9f71095aed086f9456ab@66.114.83.67' testdb*CLI> -- Executing AbsoluteTimeout("SIP/66.114.83.12-4170e310", "0") in new stack testdb*CLI> -- Set Absolute Timeout to 0 testdb*CLI> -- Executing Ringing("SIP/66.114.83.12-4170e310", "") in new stack testdb*CLI> -- Executing DeadAGI("SIP/66.114.83.12-4170e310", "callprocessing.agi") in new stack testdb*CLI> -- Launched AGI Script /usr/local/asterisk/var/lib/asterisk/agi-bin/callprocessing.agi testdb*CLI> -- AGI Script Executing Application: (NoCDR) Options: ((null)) testdb*CLI> Nov 15 12:30:21 WARNING[720919]: cdr.c:114 ast_cdr_free: CDR on channel 'SIP/66.114.83.12-4170e310' not posted testdb*CLI> Nov 15 12:30:21 WARNING[720919]: cdr.c:116 ast_cdr_free: CDR on channel 'SIP/66.114.83.12-4170e310' lacks end testdb*CLI> -- AGI Script Executing Application: (SetCDRUserField) Options: (2:2128121201>1100) testdb*CLI> -- AGI Script Executing Application: (SetMusicOnHold) Options: (xyz) testdb*CLI> -- AGI Script Executing Application: (SetCIDName) Options: (2128121201|a) testdb*CLI> -- AGI Script Executing Application: (SetCIDNum) Options: (2128121201|a) testdb*CLI> -- AGI Script Executing Application: (Dial) Options: (SIP/1212812120701100|20|tT) testdb*CLI> We're at 66.114.83.67 port 47076 testdb*CLI> Answering/Requesting with root capability 4 testdb*CLI> 12 headers, 8 lines testdb*CLI> Reliably Transmitting: INVITE sip:1212812120701100@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK7f9ce202;rport From: "2128121201" ;tag=as5b0b0d00 To: Contact: Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 CSeq: 102 INVITE User-Agent: AcePBX Date: Mon, 15 Nov 2004 17:30:25 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Content-Type: application/sdp Content-Length: 160 v=0 o=root 28539 28539 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 47076 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=silenceSupp:off - - - - (NAT) to 66.114.76.250:1290 testdb*CLI> -- Called 1212812120701100 testdb*CLI> Sip read: SIP/2.0 100 Trying Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK7f9ce202;rport From: "2128121201" ;tag=as5b0b0d00 To: Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:27 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Length: 0 10 headers, 0 lines testdb*CLI> Sip read: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK7f9ce202;rport From: "2128121201" ;tag=as5b0b0d00 To: ;tag=0009e88122b8003c23b95446-189c1fa1 Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:27 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Length: 0 10 headers, 0 lines -- SIP/1212812120701100-1cd1 is ringing testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK7f9ce202;rport From: "2128121201" ;tag=as5b0b0d00 To: ;tag=0009e88122b8003c23b95446-189c1fa1 Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:32 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Type: application/sdp Content-Length: 143 v=0 o=Cisco-SIPUA 28305 15969 IN IP4 66.114.76.250 s=SIP Call c=IN IP4 66.114.76.250 t=0 0 m=audio 20944 RTP/AVP 0 a=rtpmap:0 PCMU/8000 11 headers, 7 lines Found RTP audio format 0 Peer audio RTP is at port 66.114.76.250:20944 Found description format PCMU Capabilities: us - 0x4(ULAW), peer - audio=0x4(ULAW)/video=0x0(EMPTY), combined - 0x4(ULAW) Non-codec capabilities: us - 0x1(G723), peer - 0x0(EMPTY), combined - 0x0(EMPTY) list_route: hop: set_destination: Parsing for address/port to send to set_destination: set destination to 66.114.76.250, port 5060 Transmitting: ACK sip:1212812120701100@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK0dd8952c;rport From: "2128121201" ;tag=as5b0b0d00 To: ;tag=0009e88122b8003c23b95446-189c1fa1 Contact: Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 CSeq: 102 ACK testdb*CLI> User-Agent: AcePBX Content-Length: 0 (NAT) to 66.114.76.250:1290 testdb*CLI> -- SIP/1212812120701100-1cd1 answered SIP/66.114.83.12-4170e310 testdb*CLI> -- Attempting native bridge of SIP/66.114.83.12-4170e310 and SIP/1212812120701100-1cd1 testdb*CLI> Sip read: BYE sip:2128121201@66.114.83.67:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.76.250:5060 From: ;tag=0009e88122b8003c23b95446-189c1fa1 To: "2128121201" ;tag=as5b0b0d00 Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 Date: Mon, 15 Nov 2004 17:33:33 GMT CSeq: 101 BYE User-Agent: CSCO/5 Content-Length: 0 9 headers, 0 lines Sending to 66.114.76.250 : 5060 (NAT) Transmitting (NAT): SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.76.250:5060;received=66.114.76.250;rport=1290 From: ;tag=0009e88122b8003c23b95446-189c1fa1 To: "2128121201" ;tag=as5b0b0d00 Call-ID: 2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67 CSeq: 101 BYE User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 to 66.114.76.250:1290 testdb*CLI> -- AGI Script callprocessing.agi completed, returning 0 -- Executing Hangup("SIP/66.114.83.12-4170e310", "") in new stack set_destination: Parsing for address/port to send to testdb*CLI> set_destination: set destination to 66.114.83.12, port 5060 testdb*CLI> Reliably Transmitting: BYE sip:2128121201@66.114.83.12 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK66f2b87b;rport From: ;tag=as40db7c72 To: "2128121201" ;tag=as6c4b03ec Contact: Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 BYE User-Agent: AcePBX Content-Length: 0 (no NAT) to 66.114.83.12:5060 testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK66f2b87b From: ;tag=as40db7c72 To: "2128121201" ;tag=as6c4b03ec Call-ID: 314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12 CSeq: 102 BYE User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 testdb*CLI> 10 headers, 0 lines testdb*CLI> Message is BYE testdb*CLI> Destroying call '2bb7ed3d7fd5a463798ba0c66c9369af@66.114.83.67' testdb*CLI> Destroying call '314b97e65fa6b8aa467eb1e2032bc8df@66.114.83.12'