[reSIProcate] 407 Proxy Authorization Required not handled forNOTIFY
Knut Farner
knut.farner at paradial.com
Thu Sep 1 09:35:30 CDT 2005
Thanks for your quick reply. Your fix works great.
Knut
-----Original Message-----
From: Scott Godin [mailto:slgodin at icescape.com]
Sent: 1. september 2005 15:01
To: Knut Farner; resiprocate-devel at list.sipfoundry.org
Subject: RE: [reSIProcate] 407 Proxy Authorization Required not handled
forNOTIFY
Good find!
I think I know what the problem is. I've committed a fix to SVN main.
Essentially I've replaced all instances of mDum.send() with mDialog.send()
in both ClientSubscription.cxx and ServerSubscription.cxx. Please let me
know if this addresses your issue.
For reference here is the SVN change log description:
- changed ClientSubscription.cxx and ServerSubscription.cxx to send all
messages via the Dialog::send interface, instead of the
DialogUsageManager::send interface. This allows requests to be tracked by
the Dialog - so that it can correctly respond to Digest challenges.
Scott
----------------------------------------------------------------------------
--
From: resiprocate-devel-bounces at list.sipfoundry.org
[mailto:resiprocate-devel-bounces at list.sipfoundry.org] On Behalf Of Knut
Farner
Sent: Thursday, September 01, 2005 3:51 AM
To: resiprocate-devel at list.sipfoundry.org
Subject: [reSIProcate] 407 Proxy Authorization Required not handled
forNOTIFY
Hello all,
I'm using DUM (resiprocate-0-9-0 build 5263) on Windows XP and have a
problem with authorization of a NOTIFY message. When 407 is received DUM
calls
onError in my ServerSubscriptionHandler.
Authorization works correctly for other messages (REGISTER, INVITE,
SUBSCRIBE).
I've attached the resip log below.
Regards,
Knut Farner
DEBUG | 20050831-165301.250 | realsip | RESIP:TRANSPORT | 176 |
Transport.cxx:209 | incoming from: [ V4 192.168.0.17:5060 UDP received on:
Transport: [ V4 0.0.0.0:44100 UDP connect
ionId=0 ] connectionId=0 ]
DEBUG | 20050831-165301.265 | realsip | RESIP:TRANSACTION | 176 |
TransactionUser.cxx:56 | Checking if SipReq: SUBSCRIBE
user_b at 192.168.0.220:44100 tid=837e6613xc0a800114eb23a05 cse
q=SUBSCRIBE contact=user_a at 192.168.0.70:44100 / 2 from(wire) is for me
DEBUG | 20050831-165301.265 | realsip | RESIP:TRANSACTION | 176 |
TransactionUser.cxx:61 | Checking rule...
DEBUG | 20050831-165301.265 | realsip | RESIP:TRANSACTION | 176 |
MessageFilterRule.cxx:42 | Matching rule for SUBSCRIBE
sip:user_b at 192.168.0.220:44100 SIP/2.0
To: <sip:user_b at realsip.com>
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_a at 192.168.0.70:44100>
Expires: 300
Max-Forwards: 69
Accept: application/pidf+xml
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, SUBSCRIBE, NOTIFY, MESSAGE
User-Agent: realsip/0.7
Event: presence
Content-Length: 0
DEBUG | 20050831-165301.312 | realsip | RESIP:TRANSACTION | 176 |
TransactionUser.cxx:64 | Match!
DEBUG | 20050831-165301.312 | realsip | RESIP:TRANSACTION | 176 |
TransactionState.cxx:1535 | Send to TU: TU: DialogUsageManager size=0
SUBSCRIBE sip:user_b at 192.168.0.220:44100 SIP/2
.0
To: <sip:user_b at realsip.com>
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_a at 192.168.0.70:44100>
Expires: 300
Max-Forwards: 69
Accept: application/pidf+xml
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, SUBSCRIBE, NOTIFY, MESSAGE
User-Agent: realsip/0.7
Event: presence
Content-Length: 0
INFO | 20050831-165301.453 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:830 | Got: SipReq: SUBSCRIBE
user_b at 192.168.0.220:44100 tid=837e6613xc0a800114eb23a05 cseq=SUBSCRIBE
contact=user_a at 192.168.0.70:44100 / 2 from(wire)
DEBUG | 20050831-165301.468 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1212 | DialogUsageManager::processRequest: SipReq:
SUBSCRIBE user_b at 192.168.0.220:44100 tid=837e661
3xc0a800114eb23a05 cseq=SUBSCRIBE contact=user_a at 192.168.0.70:44100 / 2
from(wire)
DEBUG | 20050831-165301.484 | realsip | RESIP:DUM | 1716 |
DialogSetId.cxx:31 | ********** Generated Local Tag ***********
DEBUG | 20050831-165301.484 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1493 | Looking for dialogSet:
43014058fb3ed577 at S251dHM1MTUw-6f49642a in map:
DEBUG | 20050831-165301.484 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1494 | [5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
DEBUG | 20050831-165301.500 | realsip | RESIP:DUM | 1716 |
DialogSetId.cxx:31 | ********** Generated Local Tag ***********
DEBUG | 20050831-165301.500 | realsip | RESIP:DUM | 1716 |
DialogSetId.cxx:31 | ********** Generated Local Tag ***********
DEBUG | 20050831-165301.500 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:81 | ************* Created DialogSet(UAS) --
43014058fb3ed577 at S251dHM1MTUw-2f289974*************
DEBUG | 20050831-165301.500 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1342 | *********** Calling AppDialogSetFactory
*************
DEBUG | 20050831-165301.515 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1348 | ************* Adding DialogSet ***************
DEBUG | 20050831-165301.515 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1349 | Before: [5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
DEBUG | 20050831-165301.515 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1351 | After:
Req[43014058fb3ed577 at S251dHM1MTUw-2f289974 -> 00F19B38,
5e1ecb4d8a277d02 at V2lubnk.-56
0fa814 -> 00F73728]
DEBUG | 20050831-165301.531 | realsip | RESIP:DUM | 1716 |
DialogSetId.cxx:31 | ********** Generated Local Tag ***********
DEBUG | 20050831-165301.531 | realsip | RESIP:DUM | 1716 | DialogId.cxx:50
| DialogId::DialogId: 43014058fb3ed577 at S251dHM1MTUw-5f1f5e48-7f45fb54
DEBUG | 20050831-165301.531 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:665 | findDialog:
43014058fb3ed577 at S251dHM1MTUw-5f1f5e48-7f45fb54 in []
DEBUG | 20050831-165301.531 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:600 | Creating a new Dialog from msg: SUBSCRIBE
sip:user_b at 192.168.0.220:44100 SIP/2.0
To: <sip:user_b at realsip.com>
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_a at 192.168.0.70:44100>
Expires: 300
Max-Forwards: 69
Accept: application/pidf+xml
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, SUBSCRIBE, NOTIFY, MESSAGE
User-Agent: realsip/0.7
Event: presence
Content-Length: 0
DEBUG | 20050831-165301.578 | realsip | RESIP:DUM | 1716 | Dialog.cxx:86 |
UAS dialog ID creation, DS: 43014058fb3ed577 at S251dHM1MTUw-2f289974
DEBUG | 20050831-165301.578 | realsip | RESIP:DUM | 1716 | DialogId.cxx:63
| DialogId::DialogId: 43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54
DEBUG | 20050831-165301.593 | realsip | RESIP:DUM | 1716 | Dialog.cxx:121
| ************** Created Dialog as UAS **************
DEBUG | 20050831-165301.593 | realsip | RESIP:DUM | 1716 | Dialog.cxx:122
| mRemoteNameAddr: <sip:user_a at realsip.com>;tag=7f45fb54
DEBUG | 20050831-165301.593 | realsip | RESIP:DUM | 1716 | Dialog.cxx:123
| mLocalNameAddr: <sip:user_b at realsip.com>;tag=2f289974
DEBUG | 20050831-165301.593 | realsip | RESIP:DUM | 1716 | Dialog.cxx:124
| mLocalContact: <sip:user_b at 192.168.0.220:44100>
DEBUG | 20050831-165301.609 | realsip | RESIP:DUM | 1716 | Dialog.cxx:125
| mRemoteTarget: <sip:user_a at 192.168.0.70:44100>
DEBUG | 20050831-165301.609 | realsip | RESIP:DUM | 1716 | Dialog.cxx:206
| Dialog::Dialog 43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54
DEBUG | 20050831-165301.609 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:635 | ### Calling CreateAppDialog ### SUBSCRIBE
sip:user_b at 192.168.0.220:44100 SIP/2.0
To: <sip:user_b at realsip.com>
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_a at 192.168.0.70:44100>
Expires: 300
Max-Forwards: 69
Accept: application/pidf+xml
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, SUBSCRIBE, NOTIFY, MESSAGE
User-Agent: realsip/0.7
Event: presence
Content-Length: 0
DEBUG | 20050831-165301.656 | realsip | RESIP:DUM | 1716 | Dialog.cxx:289
| Dialog::dispatch: SipReq: SUBSCRIBE user_b at 192.168.0.220:44100
tid=837e6613xc0a800114eb23a05 cseq=SUBSCRI
BE contact=user_a at 192.168.0.70:44100 / 2 from(wire)
DEBUG | 20050831-165301.671 | realsip | RESIP:DUM | 1716 |
ServerSubscription.cxx:195 | ServerSubscriptionHandler::dispatch: SipReq:
SUBSCRIBE user_b at 192.168.0.220:44100 tid=837e661
3xc0a800114eb23a05 cseq=SUBSCRIBE contact=user_a at 192.168.0.70:44100 / 2
from(wire)
DEBUG | 20050831-165301.671 | realsip | RESIP | 1716 | Helper.cxx:296 |
Helper::makeResponse(SipReq: SUBSCRIBE user_b at 192.168.0.220:44100
tid=837e6613xc0a800114eb23a05 cseq=SUBSCRIB
E contact=user_a at 192.168.0.70:44100 / 2 from(wire) code=200 reason=
DEBUG | 20050831-165301.687 | realsip | RESIP:DUM | 1716 | Dialog.cxx:918
| Dialog::makeResponse: SIP/2.0 200 OK
To: <sip:user_b at realsip.com>;tag=2f289974
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_b at 192.168.0.220:44100>
Content-Length: 0
DEBUG | 20050831-165301.718 | realsip | RESIP:TRANSACTION | 1716 |
TimerQueue.cxx:105 | Adding application timer: DumTimeout::Subscription
BaseUsage: 5: duration=300 seq=1
DEBUG | 20050831-165301.718 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1493 | Looking for dialogSet:
43014058fb3ed577 at S251dHM1MTUw-2f289974 in map:
DEBUG | 20050831-165301.718 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1494 | [43014058fb3ed577 at S251dHM1MTUw-2f289974 ->
00F19B38, 5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
DEBUG | 20050831-165301.734 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:607 | SEND: SIP/2.0 200 OK
To: <sip:user_b at realsip.com>;tag=2f289974
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_b at 192.168.0.220:44100>
Expires: 300
User-Agent: realsip/0.7
Content-Length: 0
DEBUG | 20050831-165301.750 | realsip | RESIP:TRANSPORT | 176 |
Transport.cxx:209 | incoming from: [ V4 192.168.0.17:5060 UDP received on:
Transport: [ V4 0.0.0.0:44100 UDP connect
ionId=0 ] connectionId=0 ]
DEBUG | 20050831-165301.765 | realsip | RESIP | 1716 | SipStack.cxx:269 |
SEND: SipResp: 200 tid=837e6613xc0a800114eb23a05 cseq=SUBSCRIBE
contact=user_b at 192.168.0.220:44100 / 2 from(
tu)
DEBUG | 20050831-165301.781 | realsip | RESIP:DUM | 1716 | Dialog.cxx:850
| Dialog::makeRequest: NOTIFY sip:user_a at 192.168.0.70:44100 SIP/2.0
To: <sip:user_a at realsip.com>;tag=7f45fb54
From: <sip:user_b at realsip.com>;tag=2f289974
Via: SIP/2.0/ ;branch=z9hG4bK-d87543-df56655dba3c614b-1--d87543-;rport
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 NOTIFY
Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_b at 192.168.0.220:44100>
Max-Forwards: 70
Content-Length: 0
DEBUG | 20050831-165301.812 | realsip | RESIP:TRANSACTION | 176 |
TimerQueue.cxx:85 | Adding timer: Timer J tid=837e6613xc0a800114eb23a05
ms=32000
DEBUG | 20050831-165301.828 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1493 | Looking for dialogSet:
43014058fb3ed577 at S251dHM1MTUw-2f289974 in map:
DEBUG | 20050831-165301.828 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:514 | Looked up source for destination: [ V4
192.168.0.17:5060 UDP received on: Transport: [ V
4 0.0.0.0:44100 UDP connectionId=0 ] connectionId=0 ] -> [ V4
192.168.0.220:5060 UDP connectionId=0 ] sent-by=192.168.0.17 sent-port=5060
DEBUG | 20050831-165301.828 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1494 | [43014058fb3ed577 at S251dHM1MTUw-2f289974 ->
00F19B38, 5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
DEBUG | 20050831-165301.843 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:658 | Transmitting to [ V4 192.168.0.17:5060 UDP
received on: Transport: [ V4 0.0.0.0:44100 UD
P connectionId=0 ] connectionId=0 ] via [ V4 192.168.0.220:5060 UDP
connectionId=0 ]SIP/2.0 200 OK
To: <sip:user_b at realsip.com>;tag=2f289974
From: <sip:user_a at realsip.com>;tag=7f45fb54
Via: SIP/2.0/UDP 192.168.0.17:5060;branch=z9hG4bK837e6613xc0a800114eb23a05
Via: SIP/2.0/UDP
192.168.0.70:44100;branch=z9hG4bK-d87543-85370944920ff916-1--d87543-;rport=4
4100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 SUBSCRIBE
Record-Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_b at 192.168.0.220:44100>
Expires: 300
User-Agent: realsip/0.7
Content-Length: 0
DEBUG | 20050831-165301.843 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:607 | SEND: NOTIFY sip:user_a at 192.168.0.70:44100
SIP/2.0
To: <sip:user_a at realsip.com>;tag=7f45fb54
From: <sip:user_b at realsip.com>;tag=2f289974
Via: SIP/2.0/ ;branch=z9hG4bK-d87543-df56655dba3c614b-1--d87543-;rport
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 NOTIFY
Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_b at 192.168.0.220:44100>
Max-Forwards: 70
Content-Type: application/pidf+xml
User-Agent: realsip/0.7
Subscription-State: active;expires=300
Event: presence
Content-Length: 288
<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf"
entity="sip:user_b at realsip.com:44100">
<tuple id="f9464d57" >
<status><basic>open</basic></status>
<contact priority="1">sip:user_b at realsip.com</contact>
</tuple>
</presence>
DEBUG | 20050831-165301.890 | realsip | RESIP:TRANSPORT | 176 |
Transport.cxx:160 | Adding message to tx buffer to: [ V4 192.168.0.17:5060
UDP received on: Transport: [ V4 0.0.0.0:
44100 UDP connectionId=0 ] connectionId=0 ]
DEBUG | 20050831-165301.953 | realsip | RESIP:DUM | 1716 | DialogId.cxx:50
| DialogId::DialogId: 43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54
DEBUG | 20050831-165301.968 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1493 | Looking for dialogSet:
43014058fb3ed577 at S251dHM1MTUw-2f289974 in map:
DEBUG | 20050831-165301.968 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1494 | [43014058fb3ed577 at S251dHM1MTUw-2f289974 ->
00F19B38, 5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
DEBUG | 20050831-165301.968 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:665 | findDialog:
43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54 in
[43014058fb3ed577 at S251dHM1MTUw-2f28997
4-7f45fb54 -> 00F1A250]
DEBUG | 20050831-165301.984 | realsip | RESIP | 1716 | SipStack.cxx:269 |
SEND: SipReq: NOTIFY user_a at 192.168.0.70:44100 tid=4f6c066738775912
cseq=NOTIFY contact=user_b at 192.168
.0.220:44100 / 2 from(tu)
DEBUG | 20050831-165302.015 | realsip | RESIP:TRANSACTION | 176 |
TimerQueue.cxx:85 | Adding timer: Timer F tid=4f6c066738775912 ms=32000
DEBUG | 20050831-165302.015 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:238 | Looking up dns entries (from route) for
sip:192.168.0.17:5060;lr
DEBUG | 20050831-165302.015 | realsip | RESIP:DNS | 176 |
DnsResult.cxx:136 | DnsResult::lookup sip:192.168.0.17:5060;lr
DEBUG | 20050831-165302.031 | realsip | RESIP:DNS | 176 |
DnsResult.cxx:255 | Numeric result so return immediately: [ V4
192.168.0.17:5060 UDP connectionId=0 ]
DEBUG | 20050831-165302.031 | realsip | RESIP:TRANSACTION | 176 |
TimerQueue.cxx:85 | Adding timer: Timer E1 tid=4f6c066738775912 ms=500
DEBUG | 20050831-165302.031 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:514 | Looked up source for destination: [ V4
192.168.0.17:5060 UDP connectionId=0 ] -> [ V4 19
2.168.0.220:0 UDP connectionId=0 ] sent-by= sent-port=0
DEBUG | 20050831-165302.046 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:740 | findTransport([ V4 192.168.0.220:0 UDP
connectionId=0 ])
DEBUG | 20050831-165302.046 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:782 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:44100 UDP connectionI
d=0 ]
DEBUG | 20050831-165302.046 | realsip | RESIP:TRANSPORT | 176 |
TransportSelector.cxx:658 | Transmitting to [ V4 192.168.0.17:5060 UDP
received on: Transport: [ V4 0.0.0.0:44100 UD
P connectionId=0 ] connectionId=0 ] via [ V4 192.168.0.220:0 UDP
connectionId=0 ]NOTIFY sip:user_a at 192.168.0.70:44100 SIP/2.0
To: <sip:user_a at realsip.com>;tag=7f45fb54
From: <sip:user_b at realsip.com>;tag=2f289974
Via: SIP/2.0/UDP
192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 NOTIFY
Route: <sip:192.168.0.17:5060;lr>
Contact: <sip:user_b at 192.168.0.220:44100>
Max-Forwards: 70
Content-Type: application/pidf+xml
User-Agent: realsip/0.7
Subscription-State: active;expires=300
Event: presence
Content-Length: 288
<?xml version="1.0" encoding="UTF-8"?>
<presence xmlns="urn:ietf:params:xml:ns:pidf"
entity="sip:user_b at realsip.com:44100">
<tuple id="f9464d57" >
<status><basic>open</basic></status>
<contact priority="1">sip:user_b at realsip.com</contact>
</tuple>
</presence>
DEBUG | 20050831-165302.109 | realsip | RESIP:TRANSPORT | 176 |
Transport.cxx:160 | Adding message to tx buffer to: [ V4 192.168.0.17:5060
UDP received on: Transport: [ V4 0.0.0.0:
44100 UDP connectionId=0 ] connectionId=0 ]
DEBUG | 20050831-165302.125 | realsip | RESIP:TRANSPORT | 176 |
Transport.cxx:209 | incoming from: [ V4 192.168.0.17:5060 UDP received on:
Transport: [ V4 0.0.0.0:44100 UDP connect
ionId=0 ] connectionId=0 ]
DEBUG | 20050831-165302.125 | realsip | RESIP:TRANSACTION | 176 |
TransactionState.cxx:1535 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 407 Proxy Authentication required
To: <sip:user_a at realsip.com>;tag=7f45fb54
From: <sip:user_b at realsip.com>;tag=2f289974
Via: SIP/2.0/UDP
192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport=
44100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 NOTIFY
Max-Forwards: 70
Proxy-Authenticate: Digest
algorithm=MD5,realm="realsip.com",qop="auth",nonce="2d313536323837323839323a
31313235343935373932323233"
Server: RealTunnel/1.0.1-0119
Content-Length: 0
DEBUG | 20050831-165302.156 | realsip | RESIP:TRANSACTION | 176 |
TimerQueue.cxx:85 | Adding timer: Timer K tid=4f6c066738775912 ms=5000
INFO | 20050831-165302.218 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:830 | Got: SipResp: 407 tid=4f6c066738775912
cseq=NOTIFY / 2 from(wire)
DEBUG | 20050831-165302.218 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1380 | DialogUsageManager::processResponse: SIP/2.0
407 Proxy Authentication required
To: <sip:user_a at realsip.com>;tag=7f45fb54
From: <sip:user_b at realsip.com>;tag=2f289974
Via: SIP/2.0/UDP
192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport=
44100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 NOTIFY
Max-Forwards: 70
Proxy-Authenticate: Digest
algorithm=MD5,realm="realsip.com",qop="auth",nonce="2d313536323837323839323a
31313235343935373932323233"
Server: RealTunnel/1.0.1-0119
Content-Length: 0
DEBUG | 20050831-165302.234 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1493 | Looking for dialogSet:
43014058fb3ed577 at S251dHM1MTUw-2f289974 in map:
DEBUG | 20050831-165302.250 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1494 | [43014058fb3ed577 at S251dHM1MTUw-2f289974 ->
00F19B38, 5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
DEBUG | 20050831-165302.250 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1395 | DialogUsageManager::processResponse: SipResp:
407 tid=4f6c066738775912 cseq=NOTIFY / 2 from
(wire)
DEBUG | 20050831-165302.250 | realsip | RESIP:DUM | 1716 | DialogId.cxx:50
| DialogId::DialogId: 43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54
DEBUG | 20050831-165302.265 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:665 | findDialog:
43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54 in
[43014058fb3ed577 at S251dHM1MTUw-2f28997
4-7f45fb54 -> 00F1A250]
DEBUG | 20050831-165302.265 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:361 | Found matching dialog mClientSubscriptions(0),
mServerSubscriptions(1) for
SIP/2.0 407 Proxy Authentication required
To: <sip:user_a at realsip.com>;tag=7f45fb54
From: <sip:user_b at realsip.com>;tag=2f289974
Via: SIP/2.0/UDP
192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport=
44100
Call-ID: 43014058fb3ed577 at S251dHM1MTUw
CSeq: 2 NOTIFY
Max-Forwards: 70
Proxy-Authenticate: Digest
algorithm=MD5,realm="realsip.com",qop="auth",nonce="2d313536323837323839323a
31313235343935373932323233"
Server: RealTunnel/1.0.1-0119
Content-Length: 0
DEBUG | 20050831-165302.296 | realsip | RESIP:DUM | 1716 | Dialog.cxx:289
| Dialog::dispatch: SipResp: 407 tid=4f6c066738775912 cseq=NOTIFY / 2
from(wire)
DEBUG | 20050831-165302.296 | realsip | RESIP:DUM | 1716 |
ServerSubscription.cxx:195 | ServerSubscriptionHandler::dispatch: SipResp:
407 tid=4f6c066738775912 cseq=NOTIFY / 2 from(
wire)
DEBUG | 20050831-165302.312 | realsip | RESIP:DUM | 1716 |
ServerSubscription.cxx:274 | ServerSubscriptionHandler::UsageTermination:
SipResp: 407 tid=4f6c066738775912 cseq=NOTIFY /
2 from(wire)
DEBUG | 20050831-165302.312 | realsip | RESIP:DUM | 1716 |
ServerSubscription.cxx:35 | ServerSubscription::~ServerSubscription
INFO | 20050831-165302.312 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:830 | Got: DestroyDialog
43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54
DEBUG | 20050831-165302.328 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:934 | Destroying usageDestroyDialog
43014058fb3ed577 at S251dHM1MTUw-2f289974-7f45fb54
DEBUG | 20050831-165302.328 | realsip | RESIP:DUM | 1716 | Dialog.cxx:211
| Dialog::~Dialog()
INFO | 20050831-165302.328 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:830 | Got: DestroyDialogSet
43014058fb3ed577 at S251dHM1MTUw-2f289974
DEBUG | 20050831-165302.328 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:934 | Destroying usageDestroyDialogSet
43014058fb3ed577 at S251dHM1MTUw-2f289974
DEBUG | 20050831-165302.343 | realsip | RESIP:DUM | 1716 |
DialogSet.cxx:119 | ********** DialogSet::~DialogSet:
43014058fb3ed577 at S251dHM1MTUw-2f289974*************
DEBUG | 20050831-165302.343 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1524 | ************* Removing DialogSet
***************
DEBUG | 20050831-165302.343 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1525 | Before:
[43014058fb3ed577 at S251dHM1MTUw-2f289974 -> 00F19B38,
5e1ecb4d8a277d02 at V2lubnk.-560f
a814 -> 00F73728]
DEBUG | 20050831-165302.359 | realsip | RESIP:DUM | 1716 |
DialogUsageManager.cxx:1527 | After: [5e1ecb4d8a277d02 at V2lubnk.-560fa814 ->
00F73728]
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://list.resiprocate.org/pipermail/resiprocate-devel/attachments/20050901/d03c3862/attachment.htm>
More information about the resiprocate-devel
mailing list