< Previous by Date Date Index Next by Date >
  Thread Index  

[reSIProcate] 407 Proxy Authorization Required not handled for NOTIFY


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@xxxxxxxxxxxxx:44100 tid=837e6613xc0a800114eb23a05 cse

q=SUBSCRIBE contact=user_a@xxxxxxxxxxxx: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@xxxxxxxxxxxxx:44100 SIP/2.0

To: <sip:user_b@xxxxxxxxxxx>

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_a@xxxxxxxxxxxx: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@xxxxxxxxxxxxx:44100 SIP/2

.0

To: <sip:user_b@xxxxxxxxxxx>

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_a@xxxxxxxxxxxx: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@xxxxxxxxxxxxx:44100 tid=837e6613xc0a800114eb23a05 cseq=SUBSCRIBE

contact=user_a@xxxxxxxxxxxx:44100 / 2 from(wire)

DEBUG | 20050831-165301.468 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1212 | DialogUsageManager::processRequest: SipReq: SUBSCRIBE user_b@xxxxxxxxxxxxx:44100 tid=837e661

3xc0a800114eb23a05 cseq=SUBSCRIBE contact=user_a@xxxxxxxxxxxx: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@S251dHM1MTUw-6f49642a in map:

DEBUG | 20050831-165301.484 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1494 | [5e1ecb4d8a277d02@xxxxxxxxxxxxxxxxx -> 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@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@xxxxxxxxxxxxxxxxx -> 00F73728]

DEBUG | 20050831-165301.515 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1351 | After: Req[43014058fb3ed577@S251dHM1MTUw-2f289974 -> 00F19B38, 5e1ecb4d8a277d02@xxxxxxxxxxx

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@S251dHM1MTUw-5f1f5e48-7f45fb54

DEBUG | 20050831-165301.531 | realsip | RESIP:DUM | 1716 | DialogSet.cxx:665 | findDialog: 43014058fb3ed577@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@xxxxxxxxxxxxx:44100 SIP/2.0

To: <sip:user_b@xxxxxxxxxxx>

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_a@xxxxxxxxxxxx: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@S251dHM1MTUw-2f289974

DEBUG | 20050831-165301.578 | realsip | RESIP:DUM | 1716 | DialogId.cxx:63 | DialogId::DialogId: 43014058fb3ed577@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@xxxxxxxxxxx>;tag=7f45fb54

DEBUG | 20050831-165301.593 | realsip | RESIP:DUM | 1716 | Dialog.cxx:123 | mLocalNameAddr: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

DEBUG | 20050831-165301.593 | realsip | RESIP:DUM | 1716 | Dialog.cxx:124 | mLocalContact: <sip:user_b@xxxxxxxxxxxxx:44100>

DEBUG | 20050831-165301.609 | realsip | RESIP:DUM | 1716 | Dialog.cxx:125 | mRemoteTarget: <sip:user_a@xxxxxxxxxxxx:44100>

DEBUG | 20050831-165301.609 | realsip | RESIP:DUM | 1716 | Dialog.cxx:206 | Dialog::Dialog 43014058fb3ed577@S251dHM1MTUw-2f289974-7f45fb54

DEBUG | 20050831-165301.609 | realsip | RESIP:DUM | 1716 | DialogSet.cxx:635 | ### Calling CreateAppDialog ### SUBSCRIBE sip:user_b@xxxxxxxxxxxxx:44100 SIP/2.0

To: <sip:user_b@xxxxxxxxxxx>

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_a@xxxxxxxxxxxx: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@xxxxxxxxxxxxx:44100 tid=837e6613xc0a800114eb23a05 cseq=SUBSCRI

BE contact=user_a@xxxxxxxxxxxx:44100 / 2 from(wire)

DEBUG | 20050831-165301.671 | realsip | RESIP:DUM | 1716 | ServerSubscription.cxx:195 | ServerSubscriptionHandler::dispatch: SipReq: SUBSCRIBE user_b@xxxxxxxxxxxxx:44100 tid=837e661

3xc0a800114eb23a05 cseq=SUBSCRIBE contact=user_a@xxxxxxxxxxxx:44100 / 2 from(wire)

DEBUG | 20050831-165301.671 | realsip | RESIP | 1716 | Helper.cxx:296 | Helper::makeResponse(SipReq: SUBSCRIBE user_b@xxxxxxxxxxxxx:44100 tid=837e6613xc0a800114eb23a05 cseq=SUBSCRIB

E contact=user_a@xxxxxxxxxxxx: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@xxxxxxxxxxx>;tag=2f289974

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_b@xxxxxxxxxxxxx: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@S251dHM1MTUw-2f289974 in map:

DEBUG | 20050831-165301.718 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1494 | [43014058fb3ed577@S251dHM1MTUw-2f289974 -> 00F19B38, 5e1ecb4d8a277d02@xxxxxxxxxxxxxxxxx ->

00F73728]

DEBUG | 20050831-165301.734 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:607 | SEND: SIP/2.0 200 OK

To: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_b@xxxxxxxxxxxxx: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@xxxxxxxxxxxxx:44100 / 2 from(

tu)

DEBUG | 20050831-165301.781 | realsip | RESIP:DUM | 1716 | Dialog.cxx:850 | Dialog::makeRequest: NOTIFY sip:user_a@xxxxxxxxxxxx:44100 SIP/2.0

To: <sip:user_a@xxxxxxxxxxx>;tag=7f45fb54

From: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

Via: SIP/2.0/ ;branch=z9hG4bK-d87543-df56655dba3c614b-1--d87543-;rport

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 NOTIFY

Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_b@xxxxxxxxxxxxx: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@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@S251dHM1MTUw-2f289974 -> 00F19B38, 5e1ecb4d8a277d02@xxxxxxxxxxxxxxxxx ->

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@xxxxxxxxxxx>;tag=2f289974

From: <sip:user_a@xxxxxxxxxxx>;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=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 SUBSCRIBE

Record-Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_b@xxxxxxxxxxxxx: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@xxxxxxxxxxxx:44100 SIP/2.0

To: <sip:user_a@xxxxxxxxxxx>;tag=7f45fb54

From: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

Via: SIP/2.0/ ;branch=z9hG4bK-d87543-df56655dba3c614b-1--d87543-;rport

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 NOTIFY

Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_b@xxxxxxxxxxxxx: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@xxxxxxxxxxx:44100">

<tuple id="f9464d57" >

<status><basic>open</basic></status>

<contact priority="1">sip:user_b@xxxxxxxxxxx</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@S251dHM1MTUw-2f289974-7f45fb54

DEBUG | 20050831-165301.968 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1493 | Looking for dialogSet: 43014058fb3ed577@S251dHM1MTUw-2f289974 in map:

DEBUG | 20050831-165301.968 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1494 | [43014058fb3ed577@S251dHM1MTUw-2f289974 -> 00F19B38, 5e1ecb4d8a277d02@xxxxxxxxxxxxxxxxx ->

00F73728]

DEBUG | 20050831-165301.968 | realsip | RESIP:DUM | 1716 | DialogSet.cxx:665 | findDialog: 43014058fb3ed577@S251dHM1MTUw-2f289974-7f45fb54 in [43014058fb3ed577@S251dHM1MTUw-2f28997

4-7f45fb54 -> 00F1A250]

DEBUG | 20050831-165301.984 | realsip | RESIP | 1716 | SipStack.cxx:269 | SEND: SipReq: NOTIFY user_a@xxxxxxxxxxxx:44100 tid=4f6c066738775912 cseq=NOTIFY contact=user_b@xxxxxxx

.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@xxxxxxxxxxxx:44100 SIP/2.0

To: <sip:user_a@xxxxxxxxxxx>;tag=7f45fb54

From: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

Via: SIP/2.0/UDP 192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 NOTIFY

Route: <sip:192.168.0.17:5060;lr>

Contact: <sip:user_b@xxxxxxxxxxxxx: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@xxxxxxxxxxx:44100">

<tuple id="f9464d57" >

<status><basic>open</basic></status>

<contact priority="1">sip:user_b@xxxxxxxxxxx</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@xxxxxxxxxxx>;tag=7f45fb54

From: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

Via: SIP/2.0/UDP 192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 NOTIFY

Max-Forwards: 70

Proxy-Authenticate: Digest algorithm=MD5,realm="realsip.com",qop="auth",nonce="2d313536323837323839323a31313235343935373932323233"

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@xxxxxxxxxxx>;tag=7f45fb54

From: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

Via: SIP/2.0/UDP 192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 NOTIFY

Max-Forwards: 70

Proxy-Authenticate: Digest algorithm=MD5,realm="realsip.com",qop="auth",nonce="2d313536323837323839323a31313235343935373932323233"

Server: RealTunnel/1.0.1-0119

Content-Length: 0

 

DEBUG | 20050831-165302.234 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1493 | Looking for dialogSet: 43014058fb3ed577@S251dHM1MTUw-2f289974 in map:

DEBUG | 20050831-165302.250 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1494 | [43014058fb3ed577@S251dHM1MTUw-2f289974 -> 00F19B38, 5e1ecb4d8a277d02@xxxxxxxxxxxxxxxxx ->

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@S251dHM1MTUw-2f289974-7f45fb54

DEBUG | 20050831-165302.265 | realsip | RESIP:DUM | 1716 | DialogSet.cxx:665 | findDialog: 43014058fb3ed577@S251dHM1MTUw-2f289974-7f45fb54 in [43014058fb3ed577@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@xxxxxxxxxxx>;tag=7f45fb54

From: <sip:user_b@xxxxxxxxxxx>;tag=2f289974

Via: SIP/2.0/UDP 192.168.0.220:44100;branch=z9hG4bK-d87543-4f6c066738775912-1--d87543-;rport=44100

Call-ID: 43014058fb3ed577@S251dHM1MTUw

CSeq: 2 NOTIFY

Max-Forwards: 70

Proxy-Authenticate: Digest algorithm=MD5,realm="realsip.com",qop="auth",nonce="2d313536323837323839323a31313235343935373932323233"

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@S251dHM1MTUw-2f289974-7f45fb54

DEBUG | 20050831-165302.328 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:934 | Destroying usageDestroyDialog 43014058fb3ed577@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@S251dHM1MTUw-2f289974

DEBUG | 20050831-165302.328 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:934 | Destroying usageDestroyDialogSet 43014058fb3ed577@S251dHM1MTUw-2f289974

DEBUG | 20050831-165302.343 | realsip | RESIP:DUM | 1716 | DialogSet.cxx:119 | ********** DialogSet::~DialogSet: 43014058fb3ed577@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@S251dHM1MTUw-2f289974 -> 00F19B38, 5e1ecb4d8a277d02@xxxxxxxxxxxxx

a814 -> 00F73728]

DEBUG | 20050831-165302.359 | realsip | RESIP:DUM | 1716 | DialogUsageManager.cxx:1527 | After: [5e1ecb4d8a277d02@xxxxxxxxxxxxxxxxx -> 00F73728]