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

Re: [reSIProcate] Performance of a P2P-over-SIP program using resiprocate


So here it is...

I did not have logs for that trace so I made a new one.

Here is the sequence of packets:
(The INVITEs 542 and 545 are only for reference for the DEBUG logs)


======
No.     Time        Source                Destination           Protocol Info
429 213.330240 192.168.61.132 192.168.61.130 SIP/XML Request: INVITE
sip:spzero@xxxxxxxxxxxxxx:12005

Frame 429 (623 bytes on wire, 623 bytes captured)
Ethernet II, Src: Vmware_5f:e3:82 (00:0c:29:5f:e3:82), Dst: Vmware_f2:ad:ed
(00:0c:29:f2:ad:ed)
Internet Protocol, Src: 192.168.61.132 (192.168.61.132), Dst: 192.168.61.130
(192.168.61.130)
User Datagram Protocol, Src Port: 5060 (5060), Dst Port: 12005 (12005)
Session Initiation Protocol
    Request-Line: INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
        Method: INVITE
        [Resent Packet: False]
    Message Header
        Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
        Max-Forwards: 70
        Contact: <sip:olathe@xxxxxxxxxxxxxx:5060>
        To: spzero <sip:spzero@xxxxxxxxxxxxxx:12005>
        From: olathe <sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
        Call-ID: 107-3006@xxxxxxxxxxxxxx
        CSeq: 1 INVITE
        Allow: INVITE, ACK, MESSAGE
        Content-Type: text/xml
        Content-Length: 180
    Message body

No.     Time        Source                Destination           Protocol Info
542 216.556699 192.168.61.132 192.168.61.130 SIP/XML Request: INVITE
sip:spzero@xxxxxxxxxxxxxx:12005

No.     Time        Source                Destination           Protocol Info
543 216.600727 192.168.61.130 192.168.61.132 SIP/XML Status: 606 Not
Acceptable

Frame 543 (396 bytes on wire, 396 bytes captured)
Ethernet II, Src: Vmware_f2:ad:ed (00:0c:29:f2:ad:ed), Dst: Vmware_5f:e3:82
(00:0c:29:5f:e3:82)
Internet Protocol, Src: 192.168.61.130 (192.168.61.130), Dst: 192.168.61.132
(192.168.61.132)
User Datagram Protocol, Src Port: 12005 (12005), Dst Port: 5060 (5060)
Session Initiation Protocol
    Status-Line: SIP/2.0 606 Not Acceptable
        Status-Code: 606
        [Resent Packet: False]
    Message Header
        Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
        To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
        From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
        Call-ID: 107-3006@xxxxxxxxxxxxxx
        CSeq: 1 INVITE
        Content-Type: text/xml
        Content-Length: 50
    Message body

No.     Time        Source                Destination           Protocol Info
544 216.600936 192.168.61.132 192.168.61.130 SIP Request: ACK
sip:spzero@xxxxxxxxxxxxxx:12005

Frame 544 (333 bytes on wire, 333 bytes captured)
Ethernet II, Src: Vmware_5f:e3:82 (00:0c:29:5f:e3:82), Dst: Vmware_f2:ad:ed
(00:0c:29:f2:ad:ed)
Internet Protocol, Src: 192.168.61.132 (192.168.61.132), Dst: 192.168.61.130
(192.168.61.130)
User Datagram Protocol, Src Port: 5060 (5060), Dst Port: 12005 (12005)
Session Initiation Protocol
    Request-Line: ACK sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
        Method: ACK
        [Resent Packet: False]
    Message Header
        Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
        To: spzero <sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
        From: olathe <sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
        Call-ID: 107-3006@xxxxxxxxxxxxxx
        CSeq: 1 ACK
        Content-Length: 0

No.     Time        Source                Destination           Protocol Info
545 216.640772 192.168.61.132 192.168.61.130 SIP/XML Request: INVITE
sip:spzero@xxxxxxxxxxxxxx:12005

No.     Time        Source                Destination           Protocol Info
578 217.680430 192.168.61.130 192.168.61.132 SIP/XML Status: 606 Not
Acceptable

Frame 578 (396 bytes on wire, 396 bytes captured)
Ethernet II, Src: Vmware_f2:ad:ed (00:0c:29:f2:ad:ed), Dst: Vmware_5f:e3:82
(00:0c:29:5f:e3:82)
Internet Protocol, Src: 192.168.61.130 (192.168.61.130), Dst: 192.168.61.132
(192.168.61.132)
User Datagram Protocol, Src Port: 12005 (12005), Dst Port: 5060 (5060)
Session Initiation Protocol
    Status-Line: SIP/2.0 606 Not Acceptable
        Status-Code: 606
        [Resent Packet: True]
        [Suspected resend of frame: 543]
    Message Header
        Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
        To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
        From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
        Call-ID: 107-3006@xxxxxxxxxxxxxx
        CSeq: 1 INVITE
        Content-Type: text/xml
        Content-Length: 50
    Message body

======


And here are the DEBUG logs:
(This is the best I could manage to filter)
First the INVITE and 606 to the tx queue.
Then what I found to be between the two "reference" INVITE's.
(So that the 606 and the ACK should be there)
Last is a list of what should be many 606, one of them is the retransmission but I cannot
tell which.


=========
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:287 | incoming from:
[ V4 192.168.61.132:5060 UDP target domain=unspecified received on: Transport: [ V4
0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionUser.cxx:66 | Checking
if SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1
from(wire) is for me
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionUser.cxx:71 | Checking
rule...DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320
| MessageFilterRule.cxx:42 |
Matching rule for:

INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
Max-Forwards: 70
Contact: <sip:olathe@xxxxxxxxxxxxxx:5060>
To: spzero <sip:spzero@xxxxxxxxxxxxxx:12005>
From: olathe <sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Allow: INVITE, ACK, MESSAGE
Content-Type: text/xml
Content-Length: 180

<?xml version="1.0" encoding="ISO-8859-1" ?>
<request>
<name>Meno</name>
<extended type="size">0</extended>
<extended type="date">01.01.1900-01.01.2100</extended>
</request>

DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionUser.cxx:74 | Match!
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP | 3071 | 3080104320 | Helper.cxx:372 |
Helper::makeResponse(SipReq:
INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1 from(wire)
code=100 reason=
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer Trying tid=-3006-107-0 ms=80
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionState.cxx:1852 | Send
to TU: TU: DialogUsageManager size=0

INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
Max-Forwards: 70
Contact: <sip:olathe@xxxxxxxxxxxxxx:5060>
To: spzero <sip:spzero@xxxxxxxxxxxxxx:12005>
From: olathe <sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Allow: INVITE, ACK, MESSAGE
Content-Type: text/xml
Content-Length: 180

<?xml version="1.0" encoding="ISO-8859-1" ?>
<request>
<name>Meno</name>
<extended type="size">0</extended>
<extended type="date">01.01.1900-01.01.2100</extended>
</request>

DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-96-0 ms=2000
INFO | 20070505-000009.006 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogUsageManager.cxx:1227 | Got: SipReq:
INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1 from(wire)
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogUsageManager.cxx:1494 |
DialogUsageManager::processRequest: SipReq: INVITE spzero@xxxxxxxxxxxxxx:12005
tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1 from(wire)
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSetId.cxx:31 | ********** Generated
Local Tag ***********
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSetId.cxx:31 | ********** Generated
Local Tag ***********
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSetId.cxx:31 | ********** Generated
Local Tag ***********
DEBUG | 20070505-000009.006 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSet.cxx:84 |  ************* Created
DialogSet(UAS)  -- 107-3006@xxxxxxxxxxxxxxxxxxxxxxx*************
UAS(INVITE): testAppDialogSet: created.
UAS(INVITE): testAppDialogSet: UAS UserProfile requested for msg:
SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1
from(wire)
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSetId.cxx:31 | ********** Generated
Local Tag ***********
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogId.cxx:50 | DialogId::DialogId:
107-3006@xxxxxxxxxxxxxxxxxxxxxxxxxxx
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSet.cxx:736 | mState == 3 Creating
a new Dialog from msg:

INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
Max-Forwards: 70
Contact: <sip:olathe@xxxxxxxxxxxxxx:5060>
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>
From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Allow: INVITE, ACK, MESSAGE
Content-Type: text/xml
Content-Length: 180

<?xml version="1.0" encoding="ISO-8859-1" ?>
<request>
<name>Meno</name>
<extended type="size">0</extended>
<extended type="date">01.01.1900-01.01.2100</extended>
</request>

DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:87 | UAS dialog ID creation,
DS: 107-3006@xxxxxxxxxxxxxxxxxxxxxxx
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogId.cxx:63 | DialogId::DialogId:
107-3006@xxxxxxxxxxxxxxxxxxxxxxxxxxx
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:129 | ************** Created
Dialog as UAS **************
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:130 | mRemoteNameAddr:
"olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
DEBUG | 20070505-000009.009 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:131 | mLocalNameAddr:
"spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:132 | mLocalContact:
<sip:spzero@xxxxxxxxxxxxxx:12005>
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:133 | mRemoteTarget:
<sip:olathe@xxxxxxxxxxxxxx:5060>
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:227 | Dialog::Dialog
107-3006@xxxxxxxxxxxxxxxxxxxxxxxxxxx
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSet.cxx:774 | ### Calling
CreateAppDialog ###:

INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
Max-Forwards: 70
Contact: <sip:olathe@xxxxxxxxxxxxxx:5060>
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>
From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Allow: INVITE, ACK, MESSAGE
Content-Type: text/xml
Content-Length: 180

<?xml version="1.0" encoding="ISO-8859-1" ?>
<request>
<name>Meno</name>
<extended type="size">0</extended>
<extended type="date">01.01.1900-01.01.2100</extended>
</request>

UAS(INVITE): testAppDialog: created.
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:313 | Dialog::dispatch:
SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1
from(wire)
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:345 | Dialog::dispatch  --
Created new server invite sessionSipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005
tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1 from(wire)
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:73 | ^^^
InviteSession::InviteSession 0x83f9be8
DEBUG | 20070505-000009.010 | kenobi | nsp | RESIP | 3071 | 3080104320 |
SipMessage.cxx:963 | SipMessage::getContents:
text/xml
INFO | 20070505-000009.013 | kenobi | nsp | RESIP | 3071 | 3080104320 |
SipMessage.cxx:972 | SipMessage::getContents:
got content type (text/xml) that is not known, returning as opaque
application/octet-stream
INFO | 20070505-000009.015 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:2067 | Transition
UAS_Start -> UAS_NoOffer
UAS: ServerInviteSession-onNewSession -
SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1
from(wire)
searching for files containing: Meno
INFO | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
ServerInviteSession.cxx:384 | UAS_NoOffer:
reject(606)
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP | 3071 | 3080104320 | Helper.cxx:372 |
Helper::makeResponse(SipReq:
INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-107-0 cseq=INVITE
contact=olathe@xxxxxxxxxxxxxx:5060 / 1 from(wire)
code=606 reason=
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:982 | Dialog::makeResponse:

SIP/2.0 606 Not Acceptable
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Content-Length: 0


UAS: InviteSession-onReadyToSend -
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogUsageManager.cxx:800 | SEND:

SIP/2.0 606 Not Acceptable
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Content-Type: text/xml
Content-Length: 50

<?xml version="1.0" ?><reply status="Not found" />
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP | 3071 | 3080104320 | SipStack.cxx:290
| SEND: SipResp: 606
tid=-3006-107-0 cseq=INVITE / 1 from(tu)
INFO | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:2067 | Transition
UAS_NoOffer -> InviteSession::Terminated
UAS: InviteSession-onTerminated -
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:79 | ^^^
InviteSession::~InviteSession 0x83f9be8
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:232 | Dialog::~Dialog()
UAS(INVITE): testAppDialog: destroyed.
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogUsageManager.cxx:1986 | Got merged
request removal request
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:105 | Adding
application timer:
DEBUG | 20070505-000009.025 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSet.cxx:122 |  **********
DialogSet::~DialogSet: 107-3006@xxxxxxxxxxxxxxxxxxxxxxx*************
UAS(INVITE): testAppDialogSet: destroyed.
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:287 | incoming from:
[ V4 192.168.61.132:5060 UDP target domain=unspecified received on: Transport: [ V4
0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer H tid=-3006-107-0 ms=64000
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-107-0 ms=1000
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
TransportSelector.cxx:521 | Looked
up source for destination: [ V4 192.168.61.132:5060 UDP target domain=unspecified
received on: Transport: [ V4
0.0.0.0:12005 UDP target domain=unspecified connectionId=0 ] connectionId=0 ] -> [ V4
192.168.61.130:0 UDP target
domain=unspecified received on: Transport: [ V4 0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ]
connectionId=0 ] sent-by=192.168.61.132 sent-port=5060
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
TransportSelector.cxx:879 |
Transmitting to [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ] tlsDomain= via [ V4
192.168.61.130:12005 UDP target
domain=unspecified received on: Transport: [ V4 0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ]
connectionId=0 ]

SIP/2.0 606 Not Acceptable
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-107-0
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=f3c2db46
From: "olathe"<sip:olathe@xxxxxxxxxxxxxx:5060>;tag=107
Call-ID: 107-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Content-Type: text/xml
Content-Length: 50

<?xml version="1.0" ?><reply status="Not found" />
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000009.078 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer I tid=-3006-80-0 ms=10000
DEBUG | 20070505-000009.129 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:287 | incoming from:
[ V4 192.168.61.132:5060 UDP target domain=unspecified received on: Transport: [ V4
0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000009.129 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionUser.cxx:66 | Checking
if SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-108-0 cseq=INVITE
contact=malise@xxxxxxxxxxxxxx:5060 / 1
from(wire) is for me
DEBUG | 20070505-000009.129 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionUser.cxx:71 | Checking
rule...DEBUG | 20070505-000009.129 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320
| MessageFilterRule.cxx:42 |
Matching rule for:

INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0

=====

20070505-000012.574 | kenobi | nsp | RESIP | 3071 | 3080104320 | SipMessage.cxx:972 |
SipMessage::getContents: got
content type (text/xml) that is not known, returning as opaque application/octet-stream
INFO | 20070505-000012.574 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:2067 | Transition
UAS_Start -> UAS_NoOffer
UAS: ServerInviteSession-onNewSession -
SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-138-0 cseq=INVITE
contact=yorick@xxxxxxxxxxxxxx:5060 / 1
from(wire)
searching for files containing: Behin
INFO | 20070505-000012.587 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
ServerInviteSession.cxx:384 | UAS_NoOffer:
reject(606)
DEBUG | 20070505-000012.587 | kenobi | nsp | RESIP | 3071 | 3080104320 | Helper.cxx:372 |
Helper::makeResponse(SipReq:
INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-138-0 cseq=INVITE
contact=yorick@xxxxxxxxxxxxxx:5060 / 1 from(wire)
code=606 reason=
DEBUG | 20070505-000012.587 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:982 | Dialog::makeResponse:

SIP/2.0 606 Not Acceptable
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-138-0
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=16547413
From: "yorick"<sip:yorick@xxxxxxxxxxxxxx:5060>;tag=138
Call-ID: 138-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Content-Length: 0


UAS: InviteSession-onReadyToSend -
DEBUG | 20070505-000012.587 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogUsageManager.cxx:800 | SEND:

SIP/2.0 606 Not Acceptable
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-138-0
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=16547413
From: "yorick"<sip:yorick@xxxxxxxxxxxxxx:5060>;tag=138
Call-ID: 138-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Content-Type: text/xml
Content-Length: 50

<?xml version="1.0" ?><reply status="Not found" />
DEBUG | 20070505-000012.604 | kenobi | nsp | RESIP | 3071 | 3080104320 | SipStack.cxx:290
| SEND: SipResp: 606
tid=-3006-138-0 cseq=INVITE / 1 from(tu)
INFO | 20070505-000012.604 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:2067 | Transition
UAS_NoOffer -> InviteSession::Terminated
UAS: InviteSession-onTerminated -
DEBUG | 20070505-000012.605 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
InviteSession.cxx:79 | ^^^
InviteSession::~InviteSession 0x83f9be8
DEBUG | 20070505-000012.605 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
Dialog.cxx:232 | Dialog::~Dialog()
UAS(INVITE): testAppDialog: destroyed.
DEBUG | 20070505-000012.605 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogUsageManager.cxx:1986 | Got merged
request removal request
DEBUG | 20070505-000012.605 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:105 | Adding
application timer:
DEBUG | 20070505-000012.605 | kenobi | nsp | RESIP:DUM | 3071 | 3080104320 |
DialogSet.cxx:122 |  **********
DialogSet::~DialogSet: 138-3006@xxxxxxxxxxxxxxxxxxxxxxx*************
UAS(INVITE): testAppDialogSet: destroyed.
DEBUG | 20070505-000012.656 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:287 | incoming from:
[ V4 192.168.61.132:5060 UDP target domain=unspecified received on: Transport: [ V4
0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000012.657 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer H tid=-3006-138-0 ms=64000
DEBUG | 20070505-000012.658 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-138-0 ms=1000
DEBUG | 20070505-000012.658 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
TransportSelector.cxx:521 | Looked
up source for destination: [ V4 192.168.61.132:5060 UDP target domain=unspecified
received on: Transport: [ V4
0.0.0.0:12005 UDP target domain=unspecified connectionId=0 ] connectionId=0 ] -> [ V4
192.168.61.130:0 UDP target
domain=unspecified received on: Transport: [ V4 0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ]
connectionId=0 ] sent-by=192.168.61.132 sent-port=5060
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
TransportSelector.cxx:879 |
Transmitting to [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ] tlsDomain= via [ V4
192.168.61.130:12005 UDP target
domain=unspecified received on: Transport: [ V4 0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ]
connectionId=0 ]

SIP/2.0 606 Not Acceptable
Via: SIP/2.0/UDP 192.168.61.132:5060;branch=z9hG4bK-3006-138-0
To: "spzero"<sip:spzero@xxxxxxxxxxxxxx:12005>;tag=16547413
From: "yorick"<sip:yorick@xxxxxxxxxxxxxx:5060>;tag=138
Call-ID: 138-3006@xxxxxxxxxxxxxx
CSeq: 1 INVITE
Content-Type: text/xml
Content-Length: 50

<?xml version="1.0" ?><reply status="Not found" />
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer I tid=-3006-107-0 ms=10000
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-111-0 ms=4000
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000012.659 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-129-0 ms=2000

DEBUG | 20070505-000012.713 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:287 | incoming from:
[ V4 192.168.61.132:5060 UDP target domain=unspecified received on: Transport: [ V4
0.0.0.0:12005 UDP target
domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000012.713 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TransactionUser.cxx:66 | Checking
if SipReq:  INVITE spzero@xxxxxxxxxxxxxx:12005 tid=-3006-139-0 cseq=INVITE
contact=huyen@xxxxxxxxxxxxxx:5060 / 1
from(wire) is for meDEBUG | 20070505-000012.713 | kenobi | nsp | RESIP:TRANSACTION | 3071
| 3080104320 |
TransactionUser.cxx:71 | Checking rule...DEBUG | 20070505-000012.713 | kenobi | nsp |
RESIP:TRANSACTION | 3071 |
3080104320 | MessageFilterRule.cxx:42 | Matching rule for:

INVITE sip:spzero@xxxxxxxxxxxxxx:12005 SIP/2.0
=======

DEBUG | 20070505-000013.268 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer I tid=-3006-111-0 ms=10000
DEBUG | 20070505-000013.268 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.268 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-116-0 ms=4000
DEBUG | 20070505-000013.268 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.268 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-135-0 ms=2000
DEBUG | 20070505-000013.373 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.373 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-117-0 ms=4000
DEBUG | 20070505-000013.423 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.423 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-136-0 ms=2000
DEBUG | 20070505-000013.476 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.476 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-118-0 ms=4000
DEBUG | 20070505-000013.581 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.581 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-137-0 ms=2000
DEBUG | 20070505-000013.581 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.581 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-119-0 ms=4000
DEBUG | 20070505-000013.631 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.631 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-120-0 ms=4000
DEBUG | 20070505-000013.683 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.683 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-138-0 ms=2000
DEBUG | 20070505-000013.789 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.789 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-121-0 ms=4000
DEBUG | 20070505-000013.839 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.839 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-122-0 ms=4000
DEBUG | 20070505-000013.839 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.839 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-139-0 ms=2000
DEBUG | 20070505-000013.948 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.948 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-123-0 ms=4000
DEBUG | 20070505-000013.948 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000013.948 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-140-0 ms=2000
DEBUG | 20070505-000014.056 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.056 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-141-0 ms=2000
DEBUG | 20070505-000014.107 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.108 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-124-0 ms=4000
DEBUG | 20070505-000014.160 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.160 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-142-0 ms=2000
DEBUG | 20070505-000014.212 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.212 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-125-0 ms=4000
DEBUG | 20070505-000014.317 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.317 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-143-0 ms=2000
DEBUG | 20070505-000014.421 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.421 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-126-0 ms=4000
DEBUG | 20070505-000014.421 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.421 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-127-0 ms=4000
DEBUG | 20070505-000014.577 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.577 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-128-0 ms=4000
DEBUG | 20070505-000014.681 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.681 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-129-0 ms=4000
DEBUG | 20070505-000014.837 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.837 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-130-0 ms=4000
DEBUG | 20070505-000014.941 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000014.941 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-131-0 ms=4000
DEBUG | 20070505-000015.045 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.045 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-132-0 ms=4000
DEBUG | 20070505-000015.046 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.046 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-133-0 ms=4000
DEBUG | 20070505-000015.201 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.202 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-134-0 ms=4000
DEBUG | 20070505-000015.306 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.306 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-135-0 ms=4000
DEBUG | 20070505-000015.469 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.469 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-136-0 ms=4000
DEBUG | 20070505-000015.626 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.626 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-137-0 ms=4000
DEBUG | 20070505-000015.729 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.730 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-138-0 ms=4000
DEBUG | 20070505-000015.886 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.886 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-139-0 ms=4000
DEBUG | 20070505-000015.990 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000015.990 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-140-0 ms=4000
DEBUG | 20070505-000016.094 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000016.094 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-141-0 ms=4000
DEBUG | 20070505-000016.198 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000016.198 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-142-0 ms=4000
DEBUG | 20070505-000016.354 | kenobi | nsp | RESIP:TRANSPORT | 3071 | 3080104320 |
Transport.cxx:213 | Adding message
to tx buffer to: [ V4 192.168.61.132:5060 UDP target domain=unspecified received on:
Transport: [ V4 0.0.0.0:12005 UDP
target domain=unspecified connectionId=0 ] connectionId=0 ]
DEBUG | 20070505-000016.354 | kenobi | nsp | RESIP:TRANSACTION | 3071 | 3080104320 |
TimerQueue.cxx:85 | Adding timer:
Timer G tid=-3006-143-0 ms=4000
==========

And just to not leave anything out here is the raw ACK.

==========

0000  00 0c 29 f2 ad ed 00 0c 29 5f e3 82 08 00 45 00   ..).....)_....E.
0010  01 3f 00 00 40 00 40 11 3d 57 c0 a8 3d 84 c0 a8   .?..@.@.=W..=...
0020  3d 82 13 c4 2e e5 01 2b 04 b8 41 43 4b 20 73 69   =......+..ACK si
0030  70 3a 73 70 7a 65 72 6f 40 31 39 32 2e 31 36 38   p:spzero@xxxxxxx
0040  2e 36 31 2e 31 33 30 3a 31 32 30 30 35 20 53 49   .61.130:12005 SI
0050  50 2f 32 2e 30 0d 0a 56 69 61 3a 20 53 49 50 2f   P/2.0..Via: SIP/
0060  32 2e 30 2f 55 44 50 20 31 39 32 2e 31 36 38 2e   2.0/UDP 192.168.
0070  36 31 2e 31 33 32 3a 35 30 36 30 3b 62 72 61 6e   61.132:5060;bran
0080  63 68 3d 7a 39 68 47 34 62 4b 2d 33 30 30 36 2d   ch=z9hG4bK-3006-
0090  31 30 37 2d 30 0d 0a 54 6f 3a 20 73 70 7a 65 72   107-0..To: spzer
00a0  6f 20 3c 73 69 70 3a 73 70 7a 65 72 6f 40 31 39   o <sip:spzero@19
00b0  32 2e 31 36 38 2e 36 31 2e 31 33 30 3a 31 32 30   2.168.61.130:120
00c0  30 35 3e 3b 74 61 67 3d 66 33 63 32 64 62 34 36   05>;tag=f3c2db46
00d0  0d 0a 46 72 6f 6d 3a 20 6f 6c 61 74 68 65 20 3c   ..From: olathe <
00e0  73 69 70 3a 6f 6c 61 74 68 65 40 31 39 32 2e 31   sip:olathe@xxxxx
00f0  36 38 2e 36 31 2e 31 33 32 3a 35 30 36 30 3e 3b   68.61.132:5060>;
0100  74 61 67 3d 31 30 37 0d 0a 43 61 6c 6c 2d 49 44   tag=107..Call-ID
0110  3a 20 31 30 37 2d 33 30 30 36 40 31 39 32 2e 31   : 107-3006@xxxxx
0120  36 38 2e 36 31 2e 31 33 32 0d 0a 43 53 65 71 3a   68.61.132..CSeq:
0130  20 31 20 41 43 4b 0d 0a 43 6f 6e 74 65 6e 74 2d    1 ACK..Content-
0140  4c 65 6e 67 74 68 3a 20 30 0d 0a 0d 0a            Length: 0....
=================