[asterisk-users] Re: DUNDi with SIP
Watkins, Bradley
Bradley.Watkins at compuware.com
Thu Aug 3 11:28:52 MST 2006
I'm basically trying to figure out why you aren't authenticating properly.
When you posted the [peer] sections of your sip.conf, were the secret= lines literal, or did you replace the actual secret with "password"?
- Brad
-----Original Message-----
From: asterisk-users-bounces at lists.digium.com [mailto:asterisk-users-bounces at lists.digium.com] On Behalf Of Douglas Garstang
Sent: Thursday, August 03, 2006 11:43 AM
To: Asterisk Users Mailing List - Non-Commercial Discussion
Subject: RE: [asterisk-users] Re: DUNDi with SIP
Thanks Bradley.
Here's a full sip console trace on the first pbx box.
xxx.yyy.128.18(phone 3254101): Originating phone, registered on pbx1.
xxx.yyy.142.162: pbx1
xxx.yyy.142.163: pbx2
Do you know what you are looking for?
Doug.
[Aug 3 09:40:28]
<-- SIP read from xxx.yyy.128.18:5060:
INVITE sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bKeac2a6619BA84D58
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>
CSeq: 1 INVITE
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
Contact: <sip:3254101 at xxx.yyy.128.18>
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER
User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.6.3.0067
Supported: 100rel,replace
Allow-Events: talk,hold,conference
Max-Forwards: 70
Content-Type: application/sdp
Content-Length: 229
v=0
o=- 1154619309 1154619309 IN IP4 xxx.yyy.128.18 s=Polycom IP Phone c=IN IP4 xxx.yyy.128.18 t=0 0 a=sendrecv m=audio 2260 RTP/AVP 0 18 101 a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
[Aug 3 09:40:28] --- (14 headers 10 lines)[Aug 3 09:40:28] --- [Aug 3 09:40:28] Using INVITE request as basis request - 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
[Aug 3 09:40:28] Sending to xxx.yyy.128.18 : 5060 (non-NAT) [Aug 3 09:40:28] Reliably Transmitting (no NAT) to xxx.yyy.128.18:5060:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bKeac2a6619BA84D58;received=xxx.yyy.128.18
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>;tag=as7757655f
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
CSeq: 1 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.162>
Proxy-Authenticate: Digest realm="ipt.twoeighty.com", nonce="673c57e6"
Content-Length: 0
---
[Aug 3 09:40:28] Scheduling destruction of call '86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18' in 15000 ms [Aug 3 09:40:28] Found user '3254101'
[Aug 3 09:40:28]
<-- SIP read from xxx.yyy.128.18:5060:
ACK sip:9220370 at labpbx1.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bKeac2a6619BA84D58
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>;tag=as7757655f
CSeq: 1 ACK
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
Contact: <sip:3254101 at xxx.yyy.128.18>
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER
User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.6.3.0067
Max-Forwards: 70
Content-Length: 0
[Aug 3 09:40:28] --- (11 headers 0 lines)[Aug 3 09:40:28] ---
[Aug 3 09:40:28]
<-- SIP read from xxx.yyy.128.18:5060:
INVITE sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bK23dd36ae56C5E669
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>
CSeq: 2 INVITE
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
Contact: <sip:3254101 at xxx.yyy.128.18>
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER
User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.6.3.0067
Supported: 100rel,replace
Allow-Events: talk,hold,conference
Proxy-Authorization: Digest username="3254101", realm="ipt.twoeighty.com", nonce="673c57e6", uri="sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone", response="9d5875c8a16dfdf29ac5a43a02e44eec", algorithm=MD5
Max-Forwards: 70
Content-Type: application/sdp
Content-Length: 229
v=0
o=- 1154619309 1154619309 IN IP4 xxx.yyy.128.18
s=Polycom IP Phone
c=IN IP4 xxx.yyy.128.18
t=0 0
a=sendrecv
m=audio 2260 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
[Aug 3 09:40:28] --- (15 headers 10 lines)[Aug 3 09:40:28] ---
[Aug 3 09:40:28] Using INVITE request as basis request - 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
[Aug 3 09:40:28] Sending to xxx.yyy.128.18 : 5060 (non-NAT)
[Aug 3 09:40:28] Found user '3254101'
[Aug 3 09:40:28] Found RTP audio format 0
[Aug 3 09:40:28] Found RTP audio format 18
[Aug 3 09:40:28] Found RTP audio format 101
[Aug 3 09:40:28] Peer audio RTP is at port xxx.yyy.128.18:2260
[Aug 3 09:40:28] Found description format PCMU
[Aug 3 09:40:28] Found description format G729
[Aug 3 09:40:28] Found description format telephone-event
[Aug 3 09:40:28] Capabilities: us - 0x104 (ulaw|g729), peer - audio=0x104 (ulaw|g729)/video=0x0 (nothing), combined - 0x104 (ulaw|g729)
[Aug 3 09:40:28] Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event)
[Aug 3 09:40:28] Looking for 9220370 in pbx_betty_start (domain labpbx1.ipt.twoeighty.com)
[Aug 3 09:40:28] list_route: hop: <sip:3254101 at xxx.yyy.128.18>
[Aug 3 09:40:28] Transmitting (no NAT) to xxx.yyy.128.18:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bK23dd36ae56C5E669;received=xxx.yyy.128.18
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
CSeq: 2 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.162>
Content-Length: 0
---
[Aug 3 09:40:28] -- Executing NoOp("SIP/3254101-3ebc", "*** OnNet originated call "Chocolate Chip" <3254101> -> 9220370") in new stack
[Aug 3 09:40:28] -- Executing AGI("SIP/3254101-3ebc", "ipt/originator.py") in new stack
[Aug 3 09:40:28] -- Launched AGI Script /var/lib/asterisk/agi-bin/ipt/originator.py
[Aug 3 09:40:28] -- AGI Script Executing Application: (SetAccount) Options: (9220370)
[Aug 3 09:40:28] -- AGI Script Executing Application: (ChanIsAvail) Options: (SIP/9220370)
[Aug 3 09:40:28] Destroying call '46b578613a629ebb69171e8b7f9b8458 at xxx.yyy.142.162'
[Aug 3 09:40:28] -- AGI Script Executing Application: (Dial) Options: (SIP/dundisip2/9220370)
[Aug 3 09:40:28] We're at xxx.yyy.142.162 port 27164
[Aug 3 09:40:28] Adding codec 0x4 (ulaw) to SDP
[Aug 3 09:40:28] Adding codec 0x100 (g729) to SDP
[Aug 3 09:40:28] Adding non-codec 0x1 (telephone-event) to SDP
[Aug 3 09:40:28] 14 headers, 12 lines
[Aug 3 09:40:28] Reliably Transmitting (no NAT) to xxx.yyy.142.163:5060:
INVITE sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK23000840;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Date: Thu, 03 Aug 2006 15:40:28 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 269
v=0
o=root 13082 13082 IN IP4 xxx.yyy.142.162
s=session
c=IN IP4 xxx.yyy.142.162
t=0 0
m=audio 27164 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
---
[Aug 3 09:40:28] -- Called dundisip2/9220370
[Aug 3 09:40:28]
<-- SIP read from xxx.yyy.142.163:5060:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK23000840;rport;received=xxx.yyy.142.162
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.163>
Proxy-Authenticate: Digest realm="ipt.twoeighty.com", nonce="122095ae"
Content-Length: 0
[Aug 3 09:40:28] --- (11 headers 0 lines)[Aug 3 09:40:28] ---
[Aug 3 09:40:28] Transmitting (no NAT) to xxx.yyy.142.163:5060:
ACK sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK23000840;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 102 ACK
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Content-Length: 0
---
[Aug 3 09:40:28] We're at xxx.yyy.142.162 port 27164
[Aug 3 09:40:28] Adding codec 0x4 (ulaw) to SDP
[Aug 3 09:40:28] Adding codec 0x100 (g729) to SDP
[Aug 3 09:40:28] Adding non-codec 0x1 (telephone-event) to SDP
[Aug 3 09:40:28] Reliably Transmitting (no NAT) to xxx.yyy.142.163:5060:
INVITE sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK188cc77a;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 103 INVITE
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Proxy-Authorization: Digest username="dundisip2", realm="ipt.twoeighty.com", algorithm=MD5, uri="sip:9220370 at labpbx2.ipt.twoeighty.com", nonce="122095ae", response="c3812ae6a639df3827b26ff969acad23", opaque=""
Date: Thu, 03 Aug 2006 15:40:28 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 269
v=0
o=root 13082 13083 IN IP4 xxx.yyy.142.162
s=session
c=IN IP4 xxx.yyy.142.162
t=0 0
m=audio 27164 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
---
[Aug 3 09:40:28]
<-- SIP read from xxx.yyy.142.163:5060:
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK188cc77a;rport;received=xxx.yyy.142.162
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 103 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.163>
Content-Length: 0
[Aug 3 09:40:28] --- (10 headers 0 lines)[Aug 3 09:40:28] ---
[Aug 3 09:40:28] Transmitting (no NAT) to xxx.yyy.142.163:5060:
ACK sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK188cc77a;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 103 ACK
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Content-Length: 0
---
[Aug 3 09:40:28] WARNING[13063]: chan_sip.c:9696 handle_response_invite: Forbidden - wrong password on authentication for INVITE to '"Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86'
[Aug 3 09:40:28] -- SIP/dundisip2-936f is circuit-busy
[Aug 3 09:40:28] == Everyone is busy/congested at this time (1:0/1/0)
[Aug 3 09:40:28] -- AGI Script Executing Application: (Dial) Options: (Local/u9220370 at global_vmdeposit)
[Aug 3 09:40:28] -- Called u9220370 at global_vmdeposit
[Aug 3 09:40:28] -- Executing Answer("Local/u9220370 at global_vmdeposit-3666,2", "") in new stack
[Aug 3 09:40:28] -- Local/u9220370 at global_vmdeposit-3666,1 answered SIP/3254101-3ebc
[Aug 3 09:40:28] -- Executing Wait("Local/u9220370 at global_vmdeposit-3666,2", "1") in new stack
[Aug 3 09:40:28] We're at xxx.yyy.142.162 port 28718
[Aug 3 09:40:28] Adding codec 0x4 (ulaw) to SDP
[Aug 3 09:40:28] Adding codec 0x100 (g729) to SDP
[Aug 3 09:40:28] Adding non-codec 0x1 (telephone-event) to SDP
[Aug 3 09:40:28] Reliably Transmitting (no NAT) to xxx.yyy.128.18:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bK23dd36ae56C5E669;received=xxx.yyy.128.18
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>;tag=as4889fec6
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
CSeq: 2 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.162>
Content-Type: application/sdp
Content-Length: 269
v=0
o=root 13082 13082 IN IP4 xxx.yyy.142.162
s=session
c=IN IP4 xxx.yyy.142.162
t=0 0
m=audio 28718 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
---
[Aug 3 09:40:28]
<-- SIP read from xxx.yyy.128.18:5060:
ACK sip:9220370 at xxx.yyy.142.162 SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bKfc84778d745812F4
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>;tag=as4889fec6
CSeq: 2 ACK
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
Contact: <sip:3254101 at xxx.yyy.128.18>
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, INFO, MESSAGE, SUBSCRIBE, NOTIFY, PRACK, UPDATE, REFER
User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.6.3.0067
Max-Forwards: 70
Content-Length: 0
[Aug 3 09:40:28] --- (11 headers 0 lines)[Aug 3 09:40:28] ---
[Aug 3 09:40:28] Destroying call '7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162'
[Aug 3 09:40:29] == Spawn extension (pbx_betty_start, 9220370, 2) exited non-zero on 'Local/u9220370 at global_vmdeposit-3666,2<ZOMBIE>'
[Aug 3 09:40:29] -- Executing VoiceMail("SIP/3254101-3ebc", "u9220370 at voicemail") in new stack
uniqueid => 58
customer_id => 0
context => voicemail
mailbox => 9220370
password => 1234
operator => No
attach => Yes
delete => No
stamp => 0000-00-00 00:00:00
envelope => Yes
saycid => Yes
[Aug 3 09:40:29] -- Playing 'vm-theperson' (language 'en')
[Aug 3 09:40:30]
<-- SIP read from xxx.yyy.128.18:5060:
BYE sip:9220370 at xxx.yyy.142.162 SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bKcaab7aa7CAA53996
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>;tag=as4889fec6
CSeq: 3 BYE
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
Contact: <sip:3254101 at xxx.yyy.128.18>
User-Agent: PolycomSoundPointIP-SPIP_600-UA/1.6.3.0067
Proxy-Authorization: Digest username="3254101", realm="ipt.twoeighty.com", nonce="673c57e6", uri="sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone", response="9d5875c8a16dfdf29ac5a43a02e44eec", algorithm=MD5
Max-Forwards: 70
Content-Length: 0
[Aug 3 09:40:30] --- (11 headers 0 lines)[Aug 3 09:40:30] ---
[Aug 3 09:40:30] Sending to xxx.yyy.128.18 : 5060 (non-NAT)
[Aug 3 09:40:30] Transmitting (no NAT) to xxx.yyy.128.18:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP xxx.yyy.128.18;branch=z9hG4bKcaab7aa7CAA53996;received=xxx.yyy.128.18
From: "Chocolate Chip" <sip:3254101 at labpbx1.ipt.twoeighty.com>;tag=6140575F-F74900CC
To: <sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone>;tag=as4889fec6
Call-ID: 86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18
CSeq: 3 BYE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.162>
Content-Length: 0
---
[Aug 3 09:40:30] == Spawn extension (global_vmdeposit, u9220370, 3) exited non-zero on 'SIP/3254101-3ebc'
[Aug 3 09:40:31] Destroying call '86e7a3db-bc712205-5e89a5da at xxx.yyy.128.18'
and here's a full sip console trace on the second pbx box.
<-- SIP read from xxx.yyy.142.162:5060:
INVITE sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK23000840;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Date: Thu, 03 Aug 2006 15:40:28 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 269
v=0
o=root 13082 13082 IN IP4 xxx.yyy.142.162
s=session
c=IN IP4 xxx.yyy.142.162
t=0 0
m=audio 27164 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
--- (14 headers 12 lines)---
Using INVITE request as basis request - 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
Sending to xxx.yyy.142.162 : 5060 (NAT)
Reliably Transmitting (no NAT) to xxx.yyy.142.162:5060:
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK23000840;rport;received=xxx.yyy.142.162
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.163>
Proxy-Authenticate: Digest realm="ipt.twoeighty.com", nonce="122095ae"
Content-Length: 0
---
Scheduling destruction of call '7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162' in 15000 ms
Found user '3254101'
<-- SIP read from xxx.yyy.142.162:5060:
ACK sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK23000840;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 102 ACK
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Content-Length: 0
--- (11 headers 0 lines)---
<-- SIP read from xxx.yyy.142.162:5060:
INVITE sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK188cc77a;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 103 INVITE
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Proxy-Authorization: Digest username="dundisip2", realm="ipt.twoeighty.com", algorithm=MD5, uri="sip:9220370 at labpbx2.ipt.twoeighty.com", nonce="122095ae", response="c3812ae6a639df3827b26ff969acad23", opaque=""
Date: Thu, 03 Aug 2006 15:40:28 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 269
v=0
o=root 13082 13083 IN IP4 xxx.yyy.142.162
s=session
c=IN IP4 xxx.yyy.142.162
t=0 0
m=audio 27164 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
--- (15 headers 12 lines)---
Using INVITE request as basis request - 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
Sending to xxx.yyy.142.162 : 5060 (NAT)
Found user '3254101'
Aug 3 09:40:25 NOTICE[10884]: chan_sip.c:10469 handle_request_invite: Failed to authenticate user "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
Reliably Transmitting (no NAT) to xxx.yyy.142.162:5060:
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK188cc77a;rport;received=xxx.yyy.142.162
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 103 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:9220370 at xxx.yyy.142.163>
Content-Length: 0
---
<-- SIP read from xxx.yyy.142.162:5060:
ACK sip:9220370 at labpbx2.ipt.twoeighty.com SIP/2.0
Via: SIP/2.0/UDP xxx.yyy.142.162:5060;branch=z9hG4bK188cc77a;rport
From: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as097cbc86
To: <sip:9220370 at labpbx2.ipt.twoeighty.com>;tag=as004358bd
Contact: <sip:3254101 at xxx.yyy.142.162>
Call-ID: 7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162
CSeq: 103 ACK
User-Agent: Asterisk PBX
Max-Forwards: 70
Remote-Party-ID: "Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;privacy=off;screen=no
Content-Length: 0
--- (11 headers 0 lines)---
Destroying call '7cd3cdfc64631a6f243aed9968503ae2 at xxx.yyy.142.162'
> -----Original Message-----
> From: Watkins, Bradley
> [mailto:asterisk-users-bounces at lists.digium.com]On Behalf Of Watkins,
> Bradley
> Sent: Wednesday, August 02, 2006 6:31 PM
> To: Asterisk Users Mailing List - Non-Commercial Discussion
> Subject: RE: [asterisk-users] Re: DUNDi with SIP
>
>
> Could you perhaps post a sip debug from both of the Asterisk
> consoles for the respective peers?
>
> I think we're very close, and I definitely want to get this
> working for you.
>
> Regards,
> - Brad
>
> _____
>
> From: asterisk-users-bounces at lists.digium.com on behalf of
> Douglas Garstang
> Sent: Wed 8/2/2006 7:16 PM
> To: Asterisk Users Mailing List - Non-Commercial Discussion
> Subject: RE: [asterisk-users] Re: DUNDi with SIP
>
>
>
> Bradley,
>
> I changed the type from friend to peer in sip.conf...
>
> [dundisip1]
> type=peer
> secret=password
> insecure=very
> context=global_dundi_local
> host=labpbx1.ipt.twoeighty.com
> qualify=yes
>
> [dundisip2]
> type=peer
> secret=password
> insecure=very
> context=global_dundi_local
> host=labpbx2.ipt.twoeighty.com
> qualify=yes
>
> but that just yielded the same error...
>
> [Aug 2 17:07:51] NOTICE[10971]: chan_sip.c:9685
> handle_response_invite: Failed to authenticate on INVITE to
> '"Chocolate Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as5e6e3efe'
>
> Btw, here's a sip trace between the asterisk boxes...
>
> Capturing on eth0
> 1 0.000000 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP/SDP
> Request: INVITE
> sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone, with
> session description
> 2 0.000311 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP Status:
> 407 Proxy Authentication Required
> 3 0.177497 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP Request:
> ACK sip:9220370 at labpbx1.ipt.oneeighty.com
> 4 0.329036 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP/SDP
> Request: INVITE
> sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone, with
> session description
> 5 0.329492 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP Status: 100 Trying
> 6 0.643513 xxx.yyy.142.162 -> xxx.yyy.142.163 SIP/SDP
> Request: INVITE sip:9220370 at labpbx2.ipt.twoeighty.com, with
> session description
> 7 0.644104 xxx.yyy.142.163 -> xxx.yyy.142.162 SIP Status:
> 407 Proxy Authentication Required
> 8 0.644356 xxx.yyy.142.162 -> xxx.yyy.142.163 SIP Request:
> ACK sip:9220370 at labpbx2.ipt.oneeighty.com
> 9 0.647990 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP/SDP
> Status: 200 OK, with session description
> 10 0.806136 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP Request:
> ACK sip:9220370 at xxx.yyy.142.162
> 11 2.280664 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP Request:
> BYE sip:9220370 at xxx.yyy.142.162
> 12 2.280780 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP Status: 200 OK
>
> You can see that the first system doesn't resend the INVITE
> with the auth credentials as requested.
>
> So, then I also put the username field, and sip.conf now
> looks like this:
>
> [dundisip1]
> type=peer
> username=dundisip1
> secret=password
> insecure=very
> context=global_dundi_local
> host=labpbx1.ipt.twoeighty.com
> qualify=yes
>
> [dundisip2]
> type=peer
> username=dundisip2
> secret=password
> insecure=very
> context=global_dundi_local
> host=labpbx2.ipt.twoeeighty.com
> qualify=yes
>
> and with dundi.conf as:
>
> 180netsip => global_dundi_local,0,SIP,dundisip1/${NUMBER}
> 180netsip => global_dundi_local,0,SIP,dundisip2/${NUMBER}
>
> A CLI lookup still yields:
>
> *CLI> dundi lookup 9220370 at 180netsip
> 1. 0 SIP/dundisip2/9220370 (EXISTS|CANMATCH)
> from 00:14:22:1e:2a:d0, expires in 0 s
> DUNDi lookup completed in 130 ms
>
> HOWEVER, at attempt to dial results in this now:
>
> [Aug 2 17:14:00] WARNING[11178]: chan_sip.c:9696
> handle_response_invite: Forbidden - wrong password on
> authentication for INVITE to '"Chocolate Chip"
> <sip:3254101 at xxx.yyy.142.162>;tag=as6090e60f'
>
> And here's the SIP trace for THAT!
>
> 1 0.000000 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP/SDP
> Request: INVITE
> sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone, with
> session description
> 2 0.000311 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP Status:
> 407 Proxy Authentication Required
> 3 0.158008 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP Request:
> ACK sip:9220370 at labpbx1.ipt.twoeighty.com
> 4 0.295054 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP/SDP
> Request: INVITE
> sip:9220370 at labpbx1.ipt.twoeighty.com;user=phone, with
> session description
> 5 0.300557 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP Status: 100 Trying
> 6 0.602324 xxx.yyy.142.162 -> xxx.yyy.142.163 SIP/SDP
> Request: INVITE sip:9220370 at labpbx2.ipt.twoeighty.com, with
> session description
> 7 0.603002 xxx.yyy.142.163 -> xxx.yyy.142.162 SIP Status:
> 407 Proxy Authentication Required
> 8 0.603303 xxx.yyy.142.162 -> xxx.yyy.142.163 SIP Request:
> ACK sip:9220370 at labpbx2.ipt.twoeighty.com
> 9 0.603485 xxx.yyy.142.162 -> xxx.yyy.142.163 SIP/SDP
> Request: INVITE sip:9220370 at labpbx2.ipt.twoeighty.com, with
> session description
> 10 0.604251 xxx.yyy.142.163 -> xxx.yyy.142.162 SIP Status:
> 403 Forbidden
> 11 0.604553 xxx.yyy.142.162 -> xxx.yyy.142.163 SIP Request:
> ACK sip:9220370 at labpbx2.ipt.twoeighty.com
> 12 0.608324 xxx.yyy.142.162 -> xxx.yyy.128.18 SIP/SDP
> Status: 200 OK, with session description
> 13 0.749668 xxx.yyy.128.18 -> xxx.yyy.142.162 SIP Request:
> ACK sip:9220370 at xxx.yyy.142.162
>
> And on the second Asterisk console we have logged:
>
> Aug 2 17:13:57 NOTICE[29764]: chan_sip.c:10469
> handle_request_invite: Failed to authenticate user "Chocolate
> Chip" <sip:3254101 at xxx.yyy.142.162>;tag=as6090e60f
>
> Ugh... not having much luck with this...
>
>
>
>
>
>
>
>
>
>
>
> > -----Original Message-----
> > From: Watkins, Bradley [mailto:Bradley.Watkins at compuware.com]
> > Sent: Wednesday, August 02, 2006 5:01 PM
> > To: Asterisk Users Mailing List - Non-Commercial Discussion
> > Subject: RE: [asterisk-users] Re: DUNDi with SIP
> >
> >
> > Try putting a username= in the peer (BTW, use peer not friend)
> > definitions. You appear to be attempting to authenticate as the
> > originating callerid (3254101).
> >
> > - Brad
> >
> > -----Original Message-----
> > From: asterisk-users-bounces at lists.digium.com
> > [mailto:asterisk-users-bounces at lists.digium.com] On Behalf
> Of Douglas
> > Garstang
> > Sent: Wednesday, August 02, 2006 6:45 PM
> > To: Asterisk Users Mailing List - Non-Commercial Discussion
> > Subject: RE: [asterisk-users] Re: DUNDi with SIP
> >
> > > -----Original Message-----
> > > From: Aaron Daniel [mailto:amdtech at shsu.edu]
> > > Sent: Wednesday, August 02, 2006 4:02 PM
> > > To: Asterisk Users Mailing List - Non-Commercial Discussion
> > > Subject: RE: [asterisk-users] Re: DUNDi with SIP
> > >
> > >
> > > On Wed, 2006-08-02 at 15:52 -0600, Douglas Garstang wrote:
> > > > Well yes, it looked dubious to me too, although I can't
> > > find the syntaxt documented anywhere.
> > > > However, that's what DUNDis giving me as a path to the phone!
> > > >
> > > > Something is screwed with DUNDi and SIP. Has ANYONE
> > > actually implemnted it?
> > > > I can't find it documented anywhere
> > > >
> > > > Doug.
> > >
> > > DUNDi gives you only what you give it to give you. You're the one
> > > that needs to set the dial string correctly in DUNDi to get
> > one back
> > > that works. DUNDi is only as automatic as you let it be.
> > >
> > > This is what ours looks like. We don't use the iax
> > versions (mainly
> > > cause I want a homogenous SIP system), but we have entries
> > in sip.conf
> >
> > > include files for each of the servers so we just dial
> > > ${server}/${number}. This has been working for us for
> > about 2 months
> > > now, pretty much flawlessly as long as the phone's registered.
> > >
> > > e164 => dundi-extens,0,SIP,scm1/${NUMBER} e164-iax =>
> > > dundi-extens,0,IAX2,dundi:${SECRET}@scm1/${NUMBER}
> > > internal => dundi-extens,0,SIP,scm1/${NUMBER} internal-iax =>
> > > dundi-extens,0,IAX2,dundi:${SECRET}@scm1/${NUMBER}
> > >
> > > [scm1]
> > > type=friend
> > > secret=p4ssw0rd
> > > insecure=very
> > > context=incoming
> > > host=scm1.shsu.edu
> > > qualify=yes
> > > nat=no
> >
> > Aaron, while not really sure what I was doing, but extending
> > beyond your
> > example, I gave this a shot:
> >
> > dundi.conf:
> > 180netsip => global_dundi_local,0,SIP,dundisip1/${NUMBER}
> > 180netsip => global_dundi_local,0,SIP,dundisip2/${NUMBER}
> >
> > sip.conf:
> > [dundisip1]
> > type=friend
> > secret=password
> > insecure=very
> > context=global_dundi_local
> > host=labpbx1.ipt.twoeighty.com
> > qualify=yes
> >
> > [dundisip2]
> > type=friend
> > secret=password
> > insecure=very
> > context=global_dundi_local
> > host=labpbx2.ipt.twoeighty.com
> > qualify=yes
> >
> > A CLI lookup looks better...
> >
> > *CLI> dundi lookup 9220370 at 180netsip
> > 1. 0 SIP/dundisip2/9220370 (EXISTS|CANMATCH)
> > from 00:14:22:1e:2a:d0, expires in 0 s DUNDi lookup
> completed in
> > 107 ms
> >
> > However, my dial still fails...
> >
> > [Aug 2 16:42:44] -- AGI Script Executing Application: (Dial)
> > Options: (SIP/dundisip2/9220370)
> > [Aug 2 16:42:44] -- Called dundisip2/9220370
> > [Aug 2 16:42:44] NOTICE[10474]: chan_sip.c:9685
> > handle_response_invite:
> > Failed to authenticate on INVITE to '"Chocolate Chip"
> > <sip:3254101 at xxx.yyy.142.162>;tag=as4f13a2f1'
> > [Aug 2 16:42:44] -- SIP/dundisip2-7b30 is circuit-busy
> >
> >
> > _______________________________________________
> > --Bandwidth and Colocation provided by Easynews.com --
> >
> > asterisk-users mailing list
> > To UNSUBSCRIBE or update options visit:
> > http://lists.digium.com/mailman/listinfo/asterisk-users
> >
> > The contents of this e-mail are intended for the named
> > addressee only. It contains information that may be
> > confidential. Unless you are the named addressee or an
> > authorized designee, you may not copy or use it, or disclose
> > it to anyone else. If you received it in error please notify
> > us immediately and then destroy it.
> > _______________________________________________
> > --Bandwidth and Colocation provided by Easynews.com --
> >
> > asterisk-users mailing list
> > To UNSUBSCRIBE or update options visit:
> > http://lists.digium.com/mailman/listinfo/asterisk-users
> >
> _______________________________________________
> --Bandwidth and Colocation provided by Easynews.com --
>
> asterisk-users mailing list
> To UNSUBSCRIBE or update options visit:
> http://lists.digium.com/mailman/listinfo/asterisk-users
>
>
>
> The contents of this e-mail are intended for the named
> addressee only. It contains information that may be
> confidential. Unless you are the named addressee or an
> authorized designee, you may not copy or use it, or disclose
> it to anyone else. If you received it in error please notify
> us immediately and then destroy it.
>
_______________________________________________
--Bandwidth and Colocation provided by Easynews.com --
asterisk-users mailing list
To UNSUBSCRIBE or update options visit:
http://lists.digium.com/mailman/listinfo/asterisk-users
The contents of this e-mail are intended for the named addressee only. It contains information that may be confidential. Unless you are the named addressee or an authorized designee, you may not copy or use it, or disclose it to anyone else. If you received it in error please notify us immediately and then destroy it.
More information about the asterisk-users
mailing list