[reSIProcate] 407 Proxy Authorization Required not handled for NOTIFY

Knut Farner knut.farner at paradial.com
Thu Sep 1 02:50:38 CDT 2005


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/5e50e2a5/attachment.htm>


More information about the resiprocate-devel mailing list