testdb*CLI> sip debug testdb*CLI> SIP Debugging Enabled testdb*CLI> testdb*CLI> testdb*CLI> testdb*CLI> Destroying call '0009e881-22b853b0-10cf0a95-6b4e517d@66.114.76.250' testdb*CLI> Sip read: INVITE sip:12128121207@pbxtest.acecape.com SIP/2.0 Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK08350ba2 From: "2128121201" ;tag=as17ffed2f To: Contact: Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@66.114.83.12 CSeq: 102 INVITE User-Agent: AcePBX Date: Mon, 15 Nov 2004 17:29:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Content-Type: application/sdp Content-Length: 216 v=0 testdb*CLI> o=root 22058 22058 IN IP4 66.114.83.12 s=session c=IN IP4 66.114.83.12 t=0 0 m=audio 48160 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:48160 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' 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=z9hG4bK08350ba2 From: "2128121201" ;tag=as17ffed2f To: ;tag=as0b66a5da Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@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-41707c30", "1") in new stack testdb*CLI> -- Executing AbsoluteTimeout("SIP/66.114.83.12-41707c30", "900") in new stack testdb*CLI> -- Set Absolute Timeout to 900 testdb*CLI> -- Executing AGI("SIP/66.114.83.12-41707c30", "test.agi") in new stack testdb*CLI> -- Launched AGI Script /usr/local/asterisk/var/lib/asterisk/agi-bin/test.agi testdb*CLI> -- AGI Script Executing Application: (Dial) Options: (SIP/121281212070000|10|tT) We're at 66.114.83.67 port 45490 Answering/Requesting with root capability 4 12 headers, 8 lines Reliably Transmitting: INVITE sip:121281212070000@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK6df273ad;rport From: "2128121201" ;tag=as33be486f To: Contact: Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 CSeq: 102 INVITE User-Agent: AcePBX Date: Mon, 15 Nov 2004 17:19:28 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Content-Type: application/sdp Content-Length: 160 v=0 o=root 28174 28174 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 45490 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=z9hG4bK6df273ad;rport From: "2128121201" ;tag=as33be486f To: Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:31 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=z9hG4bK6df273ad;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:31 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Length: 0 10 headers, 0 lines -- SIP/121281212070000-348c is ringing Transmitting (no NAT): SIP/2.0 180 Ringing Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK08350ba2 From: "2128121201" ;tag=as17ffed2f To: ;tag=as0b66a5da Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@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: REGISTER sip:66.114.83.67 SIP/2.0 Via: SIP/2.0/UDP 66.114.76.250:5060 From: sip:12128121207010001@66.114.83.67 To: sip:12128121207010001@66.114.83.67 Call-ID: 0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250 Date: Mon, 15 Nov 2004 17:22:33 GMT CSeq: 101 REGISTER User-Agent: CSCO/5 Contact: Content-Length: 0 Expires: 120 11 headers, 0 lines Using latest request as basis request Sending to 66.114.76.250 : 5060 (non-NAT) Transmitting (NAT): SIP/2.0 100 Trying Via: SIP/2.0/UDP 66.114.76.250:5060;received=66.114.76.250;rport=1290 From: sip:12128121207010001@66.114.83.67 To: sip:12128121207010001@66.114.83.67;tag=as0271c1d1 Call-ID: 0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250 CSeq: 101 REGISTER User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 to 66.114.76.250:1290 Transmitting (NAT): SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 66.114.76.250:5060;received=66.114.76.250;rport=1290 From: sip:12128121207010001@66.114.83.67 To: sip:12128121207010001@66.114.83.67;tag=as0271c1d1 Call-ID: 0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250 CSeq: 101 REGISTER User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: WWW-Authenticate: Digest realm="asterisk", nonce="145904da" Content-Length: 0 to 66.114.76.250:1290 Scheduling destruction of call '0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250' in 15000 ms testdb*CLI> Sip read: REGISTER sip:66.114.83.67 SIP/2.0 Via: SIP/2.0/UDP 66.114.76.250:5060 From: sip:12128121207010001@66.114.83.67 To: sip:12128121207010001@66.114.83.67 Call-ID: 0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250 Date: Mon, 15 Nov 2004 17:22:34 GMT CSeq: 102 REGISTER User-Agent: CSCO/5 Contact: Authorization: Digest username="12128121207010001",realm="asterisk",uri="sip:66.114.83.67",response="5ddedbeaab005d86a8dcf3e260e7acf2",nonce="145904da",algorithm=md5 Content-Length: 0 Expires: 120 12 headers, 0 lines Using latest request as basis request Sending to 66.114.76.250 : 5060 (NAT) Transmitting (NAT): SIP/2.0 100 Trying Via: SIP/2.0/UDP 66.114.76.250:5060;received=66.114.76.250;rport=1290 From: sip:12128121207010001@66.114.83.67 To: sip:12128121207010001@66.114.83.67;tag=as0271c1d1 Call-ID: 0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250 CSeq: 102 REGISTER User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Contact: Content-Length: 0 to 66.114.76.250:1290 testdb*CLI> 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: sip:12128121207010001@66.114.83.67 To: sip:12128121207010001@66.114.83.67;tag=as0271c1d1 Call-ID: 0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250 CSeq: 102 REGISTER User-Agent: AcePBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER Expires: 120 Contact: ;expires=120 Date: Mon, 15 Nov 2004 17:19:32 GMT Content-Length: 0 to 66.114.76.250:1290 Scheduling destruction of call '0009e881-22b853b2-77710aea-7a98fe3e@66.114.76.250' in 15000 ms testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK6df273ad;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:36 GMT CSeq: 102 INVITE Server: CSCO/5 Contact: Content-Type: application/sdp Content-Length: 143 v=0 o=Cisco-SIPUA 27711 17552 IN IP4 66.114.76.250 s=SIP Call c=IN IP4 66.114.76.250 t=0 0 m=audio 20934 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:20934 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=z9hG4bK74d9b70f;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Contact: Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 CSeq: 102 ACK User-Agent: AcePBX Content-Length: 0 (NAT) to 66.114.76.250:1290 -- SIP/121281212070000-348c answered SIP/66.114.83.12-41707c30 We're at 66.114.83.67 port 42522 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=z9hG4bK08350ba2 From: "2128121201" ;tag=as17ffed2f To: ;tag=as0b66a5da Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@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 28174 28174 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 42522 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-41707c30 and SIP/121281212070000-348c testdb*CLI> Sip read: ACK sip:12128121207@pbxtest.acecape.com SIP/2.0 Via: SIP/2.0/UDP 66.114.83.12:5060;branch=z9hG4bK415d802c From: "2128121201" ;tag=as17ffed2f To: ;tag=as0b66a5da Contact: Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@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=0009e88122b8003616bb494b-30df037d To: "2128121201" ;tag=as33be486f Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:38 GMT CSeq: 101 INVITE User-Agent: CSCO/5 Contact: Content-Type: application/sdp Content-Length: 136 v=0 o=Cisco-SIPUA 26424 5685 IN IP4 66.114.76.250 s=SIP Call c=IN IP4 0.0.0.0 t=0 0 m=audio 20934 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:20934 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-41707c30 We're at 66.114.83.67 port 45490 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=0009e88122b8003616bb494b-30df037d To: "2128121201" ;tag=as33be486f Call-ID: 559e56f729c9330257961e8975394b8a@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 28174 28175 IN IP4 66.114.83.67 s=session c=IN IP4 66.114.83.67 t=0 0 m=audio 45490 RTP/AVP 0 a=rtpmap:0 PCMU/8000 a=silenceSupp:off - - - - to 66.114.76.250:1290 testdb*CLI> 11 headers, 2 lines testdb*CLI> Reliably Transmitting: NOTIFY sip:12128121207010001@66.114.76.250:5060 SIP/2.0 Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK0be575ba;rport From: "Unknown" ;tag=as6bd3f084 To: Contact: Call-ID: 1aca599f092ade665ce2bded6688915a@66.114.83.67 CSeq: 102 NOTIFY User-Agent: AcePBX Event: message-summary Content-Type: application/simple-message-summary Content-Length: 38 Messages-Waiting: no Voicemail: 0/1 (NAT) to 66.114.76.250:1290 testdb*CLI> Scheduling destruction of call '1aca599f092ade665ce2bded6688915a@66.114.83.67' in 15000 ms 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=0009e88122b8003616bb494b-30df037d To: "2128121201" ;tag=as33be486f Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:38 GMT CSeq: 101 ACK User-Agent: CSCO/5 Content-Length: 0 testdb*CLI> 9 headers, 0 lines testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK0be575ba;rport From: "Unknown" ;tag=as6bd3f084 To: Call-ID: 1aca599f092ade665ce2bded6688915a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:39 GMT CSeq: 102 NOTIFY Content-Length: 0 testdb*CLI> 8 headers, 0 lines testdb*CLI> Destroying call '1aca599f092ade665ce2bded6688915a@66.114.83.67' 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=0009e88122b8003616bb494b-30df037d To: "2128121201" ;tag=as33be486f Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:41 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-41707c30 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=0009e88122b8003616bb494b-30df037d To: "2128121201" ;tag=as33be486f Call-ID: 559e56f729c9330257961e8975394b8a@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=z9hG4bK483091d9;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Contact: Call-ID: 559e56f729c9330257961e8975394b8a@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=z9hG4bK78179d8f;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Contact: Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 CSeq: 104 BYE User-Agent: AcePBX Content-Length: 0 (NAT) to 66.114.76.250:1290 testdb*CLI> -- AGI Script test.agi completed, returning 0 testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK483091d9;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:41 GMT CSeq: 103 NOTIFY Content-Length: 0 testdb*CLI> 8 headers, 0 lines testdb*CLI> Message is NOTIFY testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK78179d8f;rport From: "2128121201" ;tag=as33be486f To: ;tag=0009e88122b8003616bb494b-30df037d Call-ID: 559e56f729c9330257961e8975394b8a@66.114.83.67 Date: Mon, 15 Nov 2004 17:22:41 GMT CSeq: 104 BYE Server: CSCO/5 Content-Length: 0 testdb*CLI> 9 headers, 0 lines testdb*CLI> Message is BYE testdb*CLI> 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=z9hG4bK3dad957a;rport From: ;tag=as0b66a5da To: "2128121201" ;tag=as17ffed2f Contact: Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@66.114.83.12 CSeq: 102 BYE User-Agent: AcePBX Content-Length: 0 (no NAT) to 66.114.83.12:5060 testdb*CLI> Destroying call '559e56f729c9330257961e8975394b8a@66.114.83.67' testdb*CLI> Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 66.114.83.67:5060;branch=z9hG4bK3dad957a From: ;tag=as0b66a5da To: "2128121201" ;tag=as17ffed2f Call-ID: 339780c0081c0e317ecc0d1c4d3e41e5@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 '339780c0081c0e317ecc0d1c4d3e41e5@66.114.83.12' testdb*CLI>