< Previous by Date	Date Index	Next by Date >
	Thread Index	Next in Thread >
[reSIProcate] Strange issue: can't received the re-INVITE message

From: Karlsson <boost.regex@xxxxxxxxx>
Date: Mon, 20 Jul 2009 18:55:36 +0800
Hi all, I got a very strange issue with 1.5, after the call is established, when the caller(UAC) use re-INVITE to HOLD the call,
the callee can't received the re-INVITE message - but the re-INVITE message is appears in the wireshark log.

I have attached the log files in mail, log1.pcap of the callee, we can saw the re-INVITE message is arrived, but in the stack log - debug-log.txt,
we can't saw this INVITE.

I have tested with eyeBeam, got the same result.

Thanks
INFO | 20090720-184357.007 | MY TEL | RESIP:DNS | 324 | dnsutil.cxx:145 | local 
hostname does not contain a domain part chuxue-PC
DEBUG | 20090720-184357.008 | MY TEL | RESIP:DUM | 324 | BaseCreator.cxx:155 | 
BaseCreator::makeInitialRequest: 

1
DEBUG | 20090720-184357.008 | MY TEL | RESIP:DUM | 324 | 
RegistrationCreator.cxx:36 | RegistrationCreator::RegistrationCreator: 1
DEBUG | 20090720-184357.008 | MY TEL | RESIP:DUM | 324 | DialogSet.cxx:53 |  
************* Created DialogSet(UAC)  -- 
MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256*************
DEBUG | 20090720-184357.008 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:867 | SEND: 

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-e6738a181f097e41-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012;rinstance=860b72dd40013114>

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 1 REGISTER

Expires: 90

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Content-Length: 0




DEBUG | 20090720-184357.009 | MY TEL | RESIP:DUM | 324 | DialogId.cxx:50 | 
DialogId::DialogId: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256-
DEBUG | 20090720-184357.009 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:1001 | Send: SipReq:  REGISTER 125.22.86.19 
tid=e6738a181f097e41 cseq=REGISTER contact=9199025012 / 1 from(tu)
DEBUG | 20090720-184357.009 | MY TEL | RESIP | 324 | sipstack.cxx:316 | SEND: 
SipReq:  REGISTER 125.22.86.19 tid=e6738a181f097e41 cseq=REGISTER 
contact=9199025012 / 1 from(tu)
DEBUG | 20090720-184357.034 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer F tid=e6738a181f097e41 ms=32000
DEBUG | 20090720-184357.034 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:316 | Looking up dns entries for sip:125.22.86.19
DEBUG | 20090720-184357.034 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:207 | 
DnsResult::lookup sip:125.22.86.19
DEBUG | 20090720-184357.034 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:391 | 
Numeric result so return immediately: [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184357.034 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=e6738a181f097e41 ms=500
DEBUG | 20090720-184357.038 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=125.22.86.19 mFlowKey=0 ] -> [ V4 
192.168.1.188:0 UDP target domain=125.22.86.19 mFlowKey=0 ] sent-by= sent-port=0
DEBUG | 20090720-184357.038 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP 
target domain=125.22.86.19 mFlowKey=0 ])
DEBUG | 20090720-184357.038 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1219 | findTransport (any port, any interface) => 
Transport: [ V4 0.0.0.0:6211 UDP target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184357.039 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=125.22.86.19 mFlowKey=0 ]

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-e6738a181f097e41-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012@xxxxxxxxxxxxx:6211;rinstance=860b72dd40013114>

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 1 REGISTER

Expires: 90

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Content-Length: 0




DEBUG | 20090720-184357.039 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184357.534 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=e6738a181f097e41 ms=1000
DEBUG | 20090720-184357.534 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184357.610 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184357.610 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:199 | 
Whitelisting 125.22.86.19(1): 125.22.86.19
DEBUG | 20090720-184357.610 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

SIP/2.0 401 Unauthorized

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-e6738a181f097e41-1---d8754z-;rport

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 1 REGISTER

WWW-Authenticate: Digest 
realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",opaque="",stale=FALSE,algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184357.610 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer K tid=e6738a181f097e41 ms=5000
INFO | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipResp: 401 tid=e6738a181f097e41 
cseq=REGISTER / 1 from(wire)
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse: 

SipResp: 401 tid=e6738a181f097e41 cseq=REGISTER / 1 from(wire)
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:229 | ClientAuthManager::RealmState::handleAuth: 0605AE38 
Digest 
realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",opaque="",stale=FALSE,algorithm=MD5
 is proxy: 0
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from 
invalid to current
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | UserProfile.cxx:158 | 
Found credential for realm: realm=125.22.86.19 user=9199025012125.22.86.19
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:63 | Produced response to digest challenge for 
UserProfile: "9199025012"<sip:9199025012@xxxxxxxxxxxx>[realm=125.22.86.19 
user=9199025012]
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:253 | 
about to re-send request with digest credentials
DEBUG | 20090720-184357.634 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:324 |  Add auth, 0605AE38 in response to: Digest 
realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",opaque="",stale=FALSE,algorithm=MD5
DEBUG | 20090720-184357.635 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication, 
proxy: 0 Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5
DEBUG | 20090720-184357.635 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:867 | SEND: 

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-be138f019d491335-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012;rinstance=860b72dd40013114>

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 2 REGISTER

Expires: 90

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Authorization: Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184357.636 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256-
DEBUG | 20090720-184357.636 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1001 | Send: SipReq:  REGISTER 125.22.86.19 
tid=be138f019d491335 cseq=REGISTER contact=9199025012 / 2 from(tu)
DEBUG | 20090720-184357.636 | MY TEL | RESIP | 3672 | sipstack.cxx:316 | SEND: 
SipReq:  REGISTER 125.22.86.19 tid=be138f019d491335 cseq=REGISTER 
contact=9199025012 / 2 from(tu)
DEBUG | 20090720-184357.660 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer F tid=be138f019d491335 ms=32000
DEBUG | 20090720-184357.660 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:316 | Looking up dns entries for sip:125.22.86.19
DEBUG | 20090720-184357.660 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:207 | 
DnsResult::lookup sip:125.22.86.19
DEBUG | 20090720-184357.660 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:391 | 
Numeric result so return immediately: [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184357.660 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=be138f019d491335 ms=500
DEBUG | 20090720-184357.664 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=125.22.86.19 mFlowKey=0 ] -> [ V4 
192.168.1.188:0 UDP target domain=125.22.86.19 mFlowKey=0 ] sent-by= sent-port=0
DEBUG | 20090720-184357.664 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP 
target domain=125.22.86.19 mFlowKey=0 ])
DEBUG | 20090720-184357.664 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1219 | findTransport (any port, any interface) => 
Transport: [ V4 0.0.0.0:6211 UDP target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184357.664 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=125.22.86.19 mFlowKey=0 ]

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-be138f019d491335-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012@xxxxxxxxxxxxx:6211;rinstance=860b72dd40013114>

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 2 REGISTER

Expires: 90

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Authorization: Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184357.665 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184358.104 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.160 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=be138f019d491335 ms=1000
DEBUG | 20090720-184358.160 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184358.255 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.255 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E2 tid=be138f019d491335 ms=4000
DEBUG | 20090720-184358.255 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:199 | 
Whitelisting 125.22.86.19(1): 125.22.86.19
DEBUG | 20090720-184358.255 | MY TEL | RESIP:DNS | 1692 | rrvip.cxx:128 | 
updating an existing vip: 125.22.86.19 with 125.22.86.19
DEBUG | 20090720-184358.255 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-be138f019d491335-1---d8754z-;rport

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 2 REGISTER

Content-Length: 0




INFO | 20090720-184358.266 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=be138f019d491335 
cseq=REGISTER / 2 from(wire)
DEBUG | 20090720-184358.266 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse: 

SipResp: 100 tid=be138f019d491335 cseq=REGISTER / 2 from(wire)
DEBUG | 20090720-184358.281 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.281 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:199 | 
Whitelisting 125.22.86.19(1): 125.22.86.19
DEBUG | 20090720-184358.281 | MY TEL | RESIP:DNS | 1692 | rrvip.cxx:128 | 
updating an existing vip: 125.22.86.19 with 125.22.86.19
DEBUG | 20090720-184358.281 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-be138f019d491335-1---d8754z-;rport

Contact: 
<sip:9199025012@xxxxxxxxxxxxx:6211;rinstance=860b72dd40013114>;expires=50

To: <sip:9199025012@xxxxxxxxxxxx>;tag=1248086639414

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 2 REGISTER

Expires: 50

Content-Length: 0




DEBUG | 20090720-184358.281 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer K tid=be138f019d491335 ms=5000
INFO | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=be138f019d491335 
cseq=REGISTER contact=9199025012@xxxxxxxxxxxxx:6211 / 2 from(wire)
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse: 

SipResp: 200 tid=be138f019d491335 cseq=REGISTER 
contact=9199025012@xxxxxxxxxxxxx:6211 / 2 from(wire)
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:41 | ClientAuthManager::handle: transitioning 
MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256to cached
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from 
current to cached
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: 
MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256-1248086639414
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:19 | First keep alive for: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:20 | Keepalive interval 30 seconds
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:21 | Keepalive id 0
DEBUG | 20090720-184358.296 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ](0)
DEBUG | 20090720-184358.296 | MY TEL | RESIP:DUM | 3672 | 
ClientRegistration.cxx:403 | Clearing service route ([])
DEBUG | 20090720-184358.296 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: DumTimeout::Registration 
ClientRegistration sip:9199025012@xxxxxxxxxxxx: duration=45 seq=1
DEBUG | 20090720-184358.297 | MY TEL | RESIP:DUM | 3672 | BaseCreator.cxx:155 | 
BaseCreator::makeInitialRequest: 

1
DEBUG | 20090720-184358.298 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:53 |  
************* Created DialogSet(UAC)  -- 
MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.-6319d361*************
DEBUG | 20090720-184358.298 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:867 | SEND: 

SUBSCRIBE sip:9199025012@xxxxxxxxxxxx SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-8a74cc346a58c413-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012>

To: <sip:9199025012@xxxxxxxxxxxx>

From: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361

Call-ID: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.

CSeq: 1 SUBSCRIBE

Expires: 3600

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Event: message-summary

Content-Length: 0




DEBUG | 20090720-184358.299 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.-6319d361-
DEBUG | 20090720-184358.299 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1001 | Send: SipReq:  SUBSCRIBE 9199025012@xxxxxxxxxxxx 
tid=8a74cc346a58c413 cseq=SUBSCRIBE contact=9199025012 / 1 from(tu)
DEBUG | 20090720-184358.299 | MY TEL | RESIP | 3672 | sipstack.cxx:316 | SEND: 
SipReq:  SUBSCRIBE 9199025012@xxxxxxxxxxxx tid=8a74cc346a58c413 cseq=SUBSCRIBE 
contact=9199025012 / 1 from(tu)
DEBUG | 20090720-184358.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer F tid=8a74cc346a58c413 ms=32000
DEBUG | 20090720-184358.306 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:316 | Looking up dns entries for 
sip:9199025012@xxxxxxxxxxxx
DEBUG | 20090720-184358.306 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:207 | 
DnsResult::lookup sip:9199025012@xxxxxxxxxxxx
DEBUG | 20090720-184358.306 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:391 | 
Numeric result so return immediately: [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184358.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=8a74cc346a58c413 ms=500
DEBUG | 20090720-184358.310 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=125.22.86.19 mFlowKey=0 ] -> [ V4 
192.168.1.188:0 UDP target domain=125.22.86.19 mFlowKey=0 ] sent-by= sent-port=0
DEBUG | 20090720-184358.310 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP 
target domain=125.22.86.19 mFlowKey=0 ])
DEBUG | 20090720-184358.310 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1219 | findTransport (any port, any interface) => 
Transport: [ V4 0.0.0.0:6211 UDP target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.310 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=125.22.86.19 mFlowKey=0 ]

SUBSCRIBE sip:9199025012@xxxxxxxxxxxx SIP/2.0

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-8a74cc346a58c413-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012@xxxxxxxxxxxxx:6211>

To: <sip:9199025012@xxxxxxxxxxxx>

From: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361

Call-ID: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.

CSeq: 1 SUBSCRIBE

Expires: 3600

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Event: message-summary

Content-Length: 0




DEBUG | 20090720-184358.311 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184358.732 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.753 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.806 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=8a74cc346a58c413 ms=1000
DEBUG | 20090720-184358.806 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184358.880 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.881 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:199 | 
Whitelisting 125.22.86.19(1): 125.22.86.19
DEBUG | 20090720-184358.881 | MY TEL | RESIP:DNS | 1692 | rrvip.cxx:128 | 
updating an existing vip: 125.22.86.19 with 125.22.86.19
DEBUG | 20090720-184358.881 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

SIP/2.0 501 Not implemented

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-8a74cc346a58c413-1---d8754z-;rport

To: <sip:9199025012@xxxxxxxxxxxx>

From: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361

Call-ID: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.

CSeq: 1 SUBSCRIBE

Content-Length: 0




DEBUG | 20090720-184358.881 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer K tid=8a74cc346a58c413 ms=5000
INFO | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipResp: 501 tid=8a74cc346a58c413 
cseq=SUBSCRIBE / 1 from(wire)
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse: 

SipResp: 501 tid=8a74cc346a58c413 cseq=SUBSCRIBE / 1 from(wire)
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.-6319d361-
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:791 | 
mState == 3 Creating a new Dialog from msg: 

SIP/2.0 501 Not implemented

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-8a74cc346a58c413-1---d8754z-;rport

To: <sip:9199025012@xxxxxxxxxxxx>

From: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361

Call-ID: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.

CSeq: 1 SUBSCRIBE

Content-Length: 0




DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.-6319d361-
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:232 | 
************** Created Dialog as UAC **************
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:233 | 
mRemoteNameAddr: <sip:9199025012@xxxxxxxxxxxx>
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:234 | 
mLocalNameAddr: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:235 | 
mLocalContact: <sip:>
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:236 | 
mRemoteTarget: <sip:>
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:239 | 
Dialog::Dialog MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.-6319d361-
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:838 | 
### Calling CreateAppDialog ###: 

SIP/2.0 501 Not implemented

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-8a74cc346a58c413-1---d8754z-;rport

To: <sip:9199025012@xxxxxxxxxxxx>

From: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361

Call-ID: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.

CSeq: 1 SUBSCRIBE

Content-Length: 0




DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:370 | 
Dialog::dispatch: SipResp: 501 tid=8a74cc346a58c413 cseq=SUBSCRIBE / 1 
from(wire)
DEBUG | 20090720-184358.899 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:40 | Association added for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.900 | MY TEL | RESIP:DUM | 3672 | 
ClientSubscription.cxx:33 | ClientSubscription::ClientSubscription from SipReq: 
 SUBSCRIBE 9199025012@xxxxxxxxxxxx tid=8a74cc346a58c413 cseq=SUBSCRIBE 
contact=9199025012 / 1 from(tu)
DEBUG | 20090720-184358.900 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:1013 | 
Dialog::makeRequest: 

SUBSCRIBE sip: SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-cb7f682a0b37fd5b-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:>

To: <sip:9199025012@xxxxxxxxxxxx>

From: "9199025012"<sip:9199025012@xxxxxxxxxxxx>;tag=6319d361

Call-ID: MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.

CSeq: 2 SUBSCRIBE

Event: message-summary

Content-Length: 0




DEBUG | 20090720-184358.900 | MY TEL | RESIP:DUM | 3672 | 
ClientSubscription.cxx:59 | ClientSubscription::dispatch SipResp: 501 
tid=8a74cc346a58c413 cseq=SUBSCRIBE / 1 from(wire)
DEBUG | 20090720-184358.900 | MY TEL | RESIP:DUM | 3672 | 
ClientSubscription.cxx:114 | processing client subscription response
INFO | 20090720-184358.900 | MY TEL | RESIP:DUM | 3672 | 
ClientSubscription.cxx:505 | End subscription: sip:
DEBUG | 20090720-184358.901 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:244 | 
Dialog::~Dialog() 
DEBUG | 20090720-184358.901 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:49 | Association removed for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184358.902 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:123 |  
********** DialogSet::~DialogSet: 
MDI3Y2QxZTljOTdiMjdlNjk2MjIyZjk5OWY2ZWEyYzg.-6319d361*************
DEBUG | 20090720-184359.378 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
INFO | 20090720-184410.178 | MY TEL | RESIP | 1692 | sipmessage.cxx:897 | 2 
extra bytes after body. Ignoring these bytes.
DEBUG | 20090720-184410.178 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184410.178 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:66 | Checking if SipReq:  INVITE 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=INVITE 
contact=125.22.86.19:5060 / 2 from(wire) is for me
DEBUG | 20090720-184410.178 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:71 | Checking rule...
DEBUG | 20090720-184410.178 | MY TEL | RESIP:TRANSACTION | 1692 | 
messagefilterrule.cxx:42 | Matching rule for: 

INVITE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>

From: "9199025015" <sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Expires: 300

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, 
INFO

Content-Type: application/sdp

Content-Length: 469



v=0

o=- 3 2 IN IP4 125.22.86.19

s=CounterPath eyeBeam 1.5

c=IN IP4 125.22.86.19

t=0 0

m=audio 20376 RTP/AVP 107 100 106 6 0 105 8 18 3 5 101

a=alt:1 1 : RATSpnUb 4d/5zS8T 192.168.1.198 5674

a=fmtp:18 annexb=yes

a=fmtp:101 0-15

a=rtpmap:107 BV32/16000

a=rtpmap:100 SPEEX/16000

a=rtpmap:106 SPEEX-FEC/16000

a=rtpmap:105 SPEEX-FEC/8000

a=rtpmap:18 G729/8000

a=rtpmap:101 telephone-event/8000

a=sendrecv

a=x-rtp-session-id:9B66355A56BB48DE8BC1CFB616D794FC


DEBUG | 20090720-184410.178 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:74 | Match!
DEBUG | 20090720-184410.178 | MY TEL | RESIP | 1692 | helper.cxx:375 | 
Helper::makeResponse(SipReq:  INVITE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=INVITE contact=125.22.86.19:5060 / 2 from(wire) code=100 
reason=
DEBUG | 20090720-184410.179 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer Trying tid=1248086651227 ms=80
DEBUG | 20090720-184410.179 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

INVITE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>

From: "9199025015" <sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Expires: 300

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, 
INFO

Content-Type: application/sdp

Content-Length: 469



v=0

o=- 3 2 IN IP4 125.22.86.19

s=CounterPath eyeBeam 1.5

c=IN IP4 125.22.86.19

t=0 0

m=audio 20376 RTP/AVP 107 100 106 6 0 105 8 18 3 5 101

a=alt:1 1 : RATSpnUb 4d/5zS8T 192.168.1.198 5674

a=fmtp:18 annexb=yes

a=fmtp:101 0-15

a=rtpmap:107 BV32/16000

a=rtpmap:100 SPEEX/16000

a=rtpmap:106 SPEEX-FEC/16000

a=rtpmap:105 SPEEX-FEC/8000

a=rtpmap:18 G729/8000

a=rtpmap:101 telephone-event/8000

a=sendrecv

a=x-rtp-session-id:9B66355A56BB48DE8BC1CFB616D794FC


INFO | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipReq:  INVITE 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=INVITE 
contact=125.22.86.19:5060 / 2 from(wire)
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1653 | DialogUsageManager::processRequest: SipReq:  
INVITE 9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=INVITE 
contact=125.22.86.19:5060 / 2 from(wire)
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogSetId.cxx:34 | 
********** Generated Local Tag *********** 
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogSetId.cxx:34 | 
********** Generated Local Tag *********** 
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogSetId.cxx:34 | 
********** Generated Local Tag *********** 
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:85 |  
************* Created DialogSet(UAS)  -- 
NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658*************
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogSetId.cxx:34 | 
********** Generated Local Tag *********** 
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: 
NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-9d4c4e22-180bff76
DEBUG | 20090720-184410.182 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:791 | 
mState == 3 Creating a new Dialog from msg: 

INVITE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Expires: 300

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, 
INFO

Content-Type: application/sdp

Content-Length: 469



v=0

o=- 3 2 IN IP4 125.22.86.19

s=CounterPath eyeBeam 1.5

c=IN IP4 125.22.86.19

t=0 0

m=audio 20376 RTP/AVP 107 100 106 6 0 105 8 18 3 5 101

a=alt:1 1 : RATSpnUb 4d/5zS8T 192.168.1.198 5674

a=fmtp:18 annexb=yes

a=fmtp:101 0-15

a=rtpmap:107 BV32/16000

a=rtpmap:100 SPEEX/16000

a=rtpmap:106 SPEEX-FEC/16000

a=rtpmap:105 SPEEX-FEC/8000

a=rtpmap:18 G729/8000

a=rtpmap:101 telephone-event/8000

a=sendrecv

a=x-rtp-session-id:9B66355A56BB48DE8BC1CFB616D794FC


DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:87 | UAS 
dialog ID creation, DS: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:63 | 
DialogId::DialogId: 
NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658-180bff76
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:141 | 
************** Created Dialog as UAS **************
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:142 | 
mRemoteNameAddr: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:143 | 
mLocalNameAddr: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:144 | 
mLocalContact: <sip:9199025012@xxxxxxxxxxxxx:45151>
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:145 | 
mRemoteTarget: <sip:125.22.86.19:5060>
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:239 | 
Dialog::Dialog NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658-180bff76
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:838 | 
### Calling CreateAppDialog ###: 

INVITE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Expires: 300

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, 
INFO

Content-Type: application/sdp

Content-Length: 469



v=0

o=- 3 2 IN IP4 125.22.86.19

s=CounterPath eyeBeam 1.5

c=IN IP4 125.22.86.19

t=0 0

m=audio 20376 RTP/AVP 107 100 106 6 0 105 8 18 3 5 101

a=alt:1 1 : RATSpnUb 4d/5zS8T 192.168.1.198 5674

a=fmtp:18 annexb=yes

a=fmtp:101 0-15

a=rtpmap:107 BV32/16000

a=rtpmap:100 SPEEX/16000

a=rtpmap:106 SPEEX-FEC/16000

a=rtpmap:105 SPEEX-FEC/8000

a=rtpmap:18 G729/8000

a=rtpmap:101 telephone-event/8000

a=sendrecv

a=x-rtp-session-id:9B66355A56BB48DE8BC1CFB616D794FC


DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:370 | 
Dialog::dispatch: SipReq:  INVITE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=INVITE contact=125.22.86.19:5060 / 2 from(wire)
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:40 | Association added for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184410.183 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:402 | 
Dialog::dispatch  --  Created new server invite sessionSipReq:  INVITE 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=INVITE 
contact=125.22.86.19:5060 / 2 from(wire)
DEBUG | 20090720-184410.184 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:77 
| ^^^ InviteSession::InviteSession 0606B110
DEBUG | 20090720-184410.184 | MY TEL | RESIP | 3672 | sipmessage.cxx:1004 | 
SipMessage::getContents: application/sdp
DEBUG | 20090720-184410.184 | MY TEL | RESIP | 3672 | helper.cxx:2115 | Got sdp

INFO | 20090720-184410.186 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:2606 
| Transition UAS_Start -> UAS_Offer
DEBUG | 20090720-184410.186 | MY TEL | RESIP:DUM | 3672 | DialogSetId.cxx:34 | 
********** Generated Local Tag *********** 
INFO | 20090720-184410.189 | MY TEL | RESIP:DUM | 3672 | 
ServerInviteSession.cxx:131 | UAS_Offer: provisional(180)
INFO | 20090720-184410.189 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:2606 
| Transition UAS_Offer -> UAS_EarlyOffer
DEBUG | 20090720-184410.189 | MY TEL | RESIP | 3672 | helper.cxx:375 | 
Helper::makeResponse(SipReq:  INVITE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=INVITE contact=125.22.86.19:5060 / 2 from(wire) code=180 
reason=
DEBUG | 20090720-184410.189 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:1076 | 
Dialog::makeResponse: 

SIP/2.0 180 Ringing

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Content-Length: 0




DEBUG | 20090720-184410.189 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: DumTimeout::Retransmit1xx 
INVITE: 8 UAS_EarlyOffer ADDR=<sip:9199025012@xxxxxxxxxxxxx>;tag=766da658 
PEER="9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76: duration=60 seq=2
DEBUG | 20090720-184410.189 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:867 | SEND: 

SIP/2.0 180 Ringing

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

User-Agent: MyTel

Content-Length: 0




DEBUG | 20090720-184410.190 | MY TEL | RESIP | 3672 | sipstack.cxx:298 | SEND: 
SipResp: 180 tid=1248086651227 cseq=INVITE 
contact=9199025012@xxxxxxxxxxxxx:45151 / 2 from(tu)
DEBUG | 20090720-184410.210 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=unspecified mFlowKey=868 ] -> [ V4 
192.168.1.188:0 UDP target domain=unspecified mFlowKey=868 ] 
sent-by=125.22.86.19 sent-port=5060
DEBUG | 20090720-184410.210 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=unspecified mFlowKey=868 ]

SIP/2.0 180 Ringing

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

User-Agent: MyTel

Content-Length: 0




DEBUG | 20090720-184410.210 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
INFO | 20090720-184412.442 | MY TEL | RESIP:DUM | 324 | 
ServerInviteSession.cxx:321 | UAS_EarlyOffer: provideAnswer
INFO | 20090720-184412.442 | MY TEL | RESIP:DUM | 324 | InviteSession.cxx:2606 
| Transition UAS_EarlyOffer -> UAS_EarlyProvidedAnswer
INFO | 20090720-184412.442 | MY TEL | RESIP:DUM | 324 | 
ServerInviteSession.cxx:513 | UAS_EarlyProvidedAnswer: accept(200)
INFO | 20090720-184412.442 | MY TEL | RESIP:DUM | 324 | InviteSession.cxx:2606 
| Transition UAS_EarlyProvidedAnswer -> UAS_Accepted
DEBUG | 20090720-184412.442 | MY TEL | RESIP | 324 | helper.cxx:375 | 
Helper::makeResponse(SipReq:  INVITE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=INVITE contact=125.22.86.19:5060 / 2 from(wire) code=200 
reason=
DEBUG | 20090720-184412.443 | MY TEL | RESIP:DUM | 324 | Dialog.cxx:1076 | 
Dialog::makeResponse: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

Content-Length: 0




DEBUG | 20090720-184412.444 | MY TEL | RESIP:TRANSACTION | 324 | 
timerqueue.cxx:105 | Adding application timer: DumTimeout::Retransmit200 
INVITE: 8 UAS_Accepted ADDR=<sip:9199025012@xxxxxxxxxxxxx>;tag=766da658 
PEER="9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76: duration=500 seq=2
DEBUG | 20090720-184412.444 | MY TEL | RESIP:TRANSACTION | 324 | 
timerqueue.cxx:105 | Adding application timer: DumTimeout::WaitForAck INVITE: 8 
UAS_Accepted ADDR=<sip:9199025012@xxxxxxxxxxxxx>;tag=766da658 
PEER="9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76: duration=32000 
seq=2
DEBUG | 20090720-184412.444 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:867 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Content-Type: application/sdp

Supported: replaces

User-Agent: MyTel

Content-Length: 147



v=0

o=- 18513323 18513323 IN IP4 192.168.1.188

s=Call

c=IN IP4 192.168.1.188

t=0 0

m=audio 20470 RTP/AVP 0

a=rtpmap:0 PCMU/8000

a=ptime:20


DEBUG | 20090720-184412.444 | MY TEL | RESIP | 324 | sipstack.cxx:298 | SEND: 
SipResp: 200 tid=1248086651227 cseq=INVITE 
contact=9199025012@xxxxxxxxxxxxx:45151 / 2 from(tu)
DEBUG | 20090720-184412.464 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=unspecified mFlowKey=868 ] -> [ V4 
192.168.1.188:0 UDP target domain=unspecified mFlowKey=868 ] 
sent-by=125.22.86.19 sent-port=5060
DEBUG | 20090720-184412.464 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=unspecified mFlowKey=868 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Content-Type: application/sdp

Supported: replaces

User-Agent: MyTel

Content-Length: 147



v=0

o=- 18513323 18513323 IN IP4 192.168.1.188

s=Call

c=IN IP4 192.168.1.188

t=0 0

m=audio 20470 RTP/AVP 0

a=rtpmap:0 PCMU/8000

a=ptime:20


DEBUG | 20090720-184412.464 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184412.465 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer StaleServer tid=1248086651227 ms=32000
INFO | 20090720-184412.954 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:1104 
| Retransmitting: 
SipResp: 200 tid=1248086651227 cseq=INVITE 
contact=9199025012@xxxxxxxxxxxxx:45151 / 2 from(tu)
DEBUG | 20090720-184412.954 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:867 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Content-Type: application/sdp

Supported: replaces

User-Agent: MyTel

Content-Length: 147



v=0

o=- 18513323 18513323 IN IP4 192.168.1.188

s=Call

c=IN IP4 192.168.1.188

t=0 0

m=audio 20470 RTP/AVP 0

a=rtpmap:0 PCMU/8000

a=ptime:20


DEBUG | 20090720-184412.954 | MY TEL | RESIP | 3672 | sipstack.cxx:298 | SEND: 
SipResp: 200 tid=1248086651227 cseq=INVITE 
contact=9199025012@xxxxxxxxxxxxx:45151 / 2 from(tu)
DEBUG | 20090720-184412.955 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: DumTimeout::Retransmit200 
INVITE: 8 UAS_Accepted ADDR=<sip:9199025012@xxxxxxxxxxxxx>;tag=766da658 
PEER="9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76: duration=1000 seq=2
DEBUG | 20090720-184412.979 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=unspecified mFlowKey=868 ] -> [ V4 
192.168.1.188:0 UDP target domain=unspecified mFlowKey=868 ] 
sent-by=125.22.86.19 sent-port=5060
DEBUG | 20090720-184412.980 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=unspecified mFlowKey=868 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-f16a6e5dbd506570-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 INVITE

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Content-Type: application/sdp

Supported: replaces

User-Agent: MyTel

Content-Length: 147



v=0

o=- 18513323 18513323 IN IP4 192.168.1.188

s=Call

c=IN IP4 192.168.1.188

t=0 0

m=audio 20470 RTP/AVP 0

a=rtpmap:0 PCMU/8000

a=ptime:20


DEBUG | 20090720-184412.980 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184413.728 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
INFO | 20090720-184413.728 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:345 | Someone sent us an ACK/200 with the same tid as the 
original INVITE. This is bad behavior, and should be corrected in the client.
DEBUG | 20090720-184413.728 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:66 | Checking if SipReq:  ACK 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=ACK 
contact=125.22.86.19:5060 / 2 from(wire) is for me
DEBUG | 20090720-184413.728 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:71 | Checking rule...
DEBUG | 20090720-184413.728 | MY TEL | RESIP:TRANSACTION | 1692 | 
messagefilterrule.cxx:42 | Matching rule for: 

ACK sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-9811d949e521d458-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015" <sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 ACK

Content-Length: 0




DEBUG | 20090720-184413.729 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:74 | Match!
DEBUG | 20090720-184413.729 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

ACK sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-9811d949e521d458-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015" <sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 ACK

Content-Length: 0




INFO | 20090720-184413.735 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipReq:  ACK 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=ACK contact=125.22.86.19:5060 / 2 from(wire)
DEBUG | 20090720-184413.735 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1653 | DialogUsageManager::processRequest: SipReq:  ACK 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=ACK 
contact=125.22.86.19:5060 / 2 from(wire)
INFO | 20090720-184413.735 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1713 | Handling in-dialog request: SipReq:  ACK 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=ACK 
contact=125.22.86.19:5060 / 2 from(wire)
DEBUG | 20090720-184413.735 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: 
NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658-180bff76
DEBUG | 20090720-184413.735 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:484 | 
Found matching dialog mClientSubscriptions(0), mServerSubscriptions(0) for 

ACK sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-9811d949e521d458-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:125.22.86.19:5060>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 2 ACK

Content-Length: 0




DEBUG | 20090720-184413.736 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:370 | 
Dialog::dispatch: SipReq:  ACK 9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 
cseq=ACK contact=125.22.86.19:5060 / 2 from(wire)
INFO | 20090720-184413.736 | MY TEL | RESIP:DUM | 3672 | 
ServerInviteSession.cxx:802 | dispatchAccepted: SipReq:  ACK 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=ACK 
contact=125.22.86.19:5060 / 2 from(wire)
INFO | 20090720-184413.736 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:2606 
| Transition UAS_Accepted -> InviteSession::Connected
INFO | 20090720-184421.371 | MY TEL | RESIP | 1692 | sipmessage.cxx:897 | 2 
extra bytes after body. Ignoring these bytes.
DEBUG | 20090720-184421.371 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184428.319 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184428.319 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090720-184428.319 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090720-184428.319 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ](0)
DEBUG | 20090720-184428.324 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=unspecified mFlowKey=868 ] -> [ V4 
192.168.1.188:0 UDP target domain=unspecified mFlowKey=868 ] sent-by= 
sent-port=0
DEBUG | 20090720-184428.324 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=unspecified mFlowKey=868 ]






DEBUG | 20090720-184428.324 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
INFO | 20090720-184443.320 | MY TEL | RESIP:DUM | 3672 | 
ClientRegistration.cxx:280 | requesting refresh of ClientRegistration 
sip:9199025012@xxxxxxxxxxxx
DEBUG | 20090720-184443.320 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:324 |  Add auth, 0605AE38 in response to: Digest 
realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",opaque="",stale=FALSE,algorithm=MD5
DEBUG | 20090720-184443.320 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication, 
proxy: 0 Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5
DEBUG | 20090720-184443.320 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:867 | SEND: 

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-4f3e6347921e5613-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012;rinstance=860b72dd40013114>

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 3 REGISTER

Expires: 90

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Authorization: Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184443.321 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256-
DEBUG | 20090720-184443.321 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1001 | Send: SipReq:  REGISTER 125.22.86.19 
tid=4f3e6347921e5613 cseq=REGISTER contact=9199025012 / 3 from(tu)
DEBUG | 20090720-184443.321 | MY TEL | RESIP | 3672 | sipstack.cxx:316 | SEND: 
SipReq:  REGISTER 125.22.86.19 tid=4f3e6347921e5613 cseq=REGISTER 
contact=9199025012 / 3 from(tu)
DEBUG | 20090720-184443.346 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer F tid=4f3e6347921e5613 ms=32000
DEBUG | 20090720-184443.346 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:316 | Looking up dns entries for sip:125.22.86.19
DEBUG | 20090720-184443.346 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:207 | 
DnsResult::lookup sip:125.22.86.19
DEBUG | 20090720-184443.346 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:391 | 
Numeric result so return immediately: [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184443.346 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=4f3e6347921e5613 ms=500
DEBUG | 20090720-184443.349 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=125.22.86.19 mFlowKey=0 ] -> [ V4 
192.168.1.188:0 UDP target domain=125.22.86.19 mFlowKey=0 ] sent-by= sent-port=0
DEBUG | 20090720-184443.349 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP 
target domain=125.22.86.19 mFlowKey=0 ])
DEBUG | 20090720-184443.350 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1219 | findTransport (any port, any interface) => 
Transport: [ V4 0.0.0.0:6211 UDP target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184443.350 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=125.22.86.19 mFlowKey=0 ]

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-4f3e6347921e5613-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012@xxxxxxxxxxxxx:6211;rinstance=860b72dd40013114>

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 3 REGISTER

Expires: 90

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Authorization: Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184443.350 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184443.846 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=4f3e6347921e5613 ms=1000
DEBUG | 20090720-184443.846 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184443.922 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184443.923 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E2 tid=4f3e6347921e5613 ms=4000
DEBUG | 20090720-184443.923 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:199 | 
Whitelisting 125.22.86.19(1): 125.22.86.19
DEBUG | 20090720-184443.923 | MY TEL | RESIP:DNS | 1692 | rrvip.cxx:128 | 
updating an existing vip: 125.22.86.19 with 125.22.86.19
DEBUG | 20090720-184443.923 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-4f3e6347921e5613-1---d8754z-;rport

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 3 REGISTER

Content-Length: 0




DEBUG | 20090720-184443.949 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184443.949 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:199 | 
Whitelisting 125.22.86.19(1): 125.22.86.19
DEBUG | 20090720-184443.949 | MY TEL | RESIP:DNS | 1692 | rrvip.cxx:128 | 
updating an existing vip: 125.22.86.19 with 125.22.86.19
DEBUG | 20090720-184443.949 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=1 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-4f3e6347921e5613-1---d8754z-;rport

Contact: 
<sip:9199025012@xxxxxxxxxxxxx:6211;rinstance=860b72dd40013114>;expires=50

To: <sip:9199025012@xxxxxxxxxxxx>;tag=1248086685083

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 3 REGISTER

Expires: 50

Content-Length: 0




DEBUG | 20090720-184443.949 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer K tid=4f3e6347921e5613 ms=5000
INFO | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=4f3e6347921e5613 
cseq=REGISTER / 3 from(wire)
DEBUG | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse: 

SipResp: 100 tid=4f3e6347921e5613 cseq=REGISTER / 3 from(wire)
INFO | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=4f3e6347921e5613 
cseq=REGISTER contact=9199025012@xxxxxxxxxxxxx:6211 / 3 from(wire)
DEBUG | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse: 

SipResp: 200 tid=4f3e6347921e5613 cseq=REGISTER 
contact=9199025012@xxxxxxxxxxxxx:6211 / 3 from(wire)
DEBUG | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:41 | ClientAuthManager::handle: transitioning 
MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256to cached
DEBUG | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from 
cached to cached
DEBUG | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: 
MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256-1248086685083
DEBUG | 20090720-184443.952 | MY TEL | RESIP:DUM | 3672 | 
ClientRegistration.cxx:403 | Clearing service route ([])
DEBUG | 20090720-184443.952 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: DumTimeout::Registration 
ClientRegistration sip:9199025012@xxxxxxxxxxxx: duration=45 seq=2
DEBUG | 20090720-184444.418 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184444.441 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
INFO | 20090720-184456.999 | MY TEL | RESIP:TRANSACTION | 1692 | 
tuselector.cxx:70 | Stats message 
WARNING | 20090720-184456.999 | MY TEL | RESIP:STATS | 1692 | 
statisticsmessage.cxx:152 | RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 0 TIMERS 1
Transaction summary: reqi 3 reqo 8 rspi 12 rspo 3
Details: INVi 2/S2/F0 INVo 0/S0/F0 ACKi 1 ACKo 0 BYEi 0/S0/F0 BYEo 0/S0/F0 CANi 
0/S0/F0 CANo 0/S0/F0 MSGi 0/S0/F0 MSGo 0/S0/F0 OPTi 0/S0/F0 OPTo 0/S0/F0 REGi 
0/S0/F0 REGo 3/S4/F2 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 0/S0/F0 SUBo 2/S0/F2 NOTi 
0/S0/F0 NOTo 0/S0/F0
Retransmissions: INVx 0 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 3 finx 0 nonx 0 PUBx 0 
SUBx 1 NOTx 0
DEBUG | 20090720-184458.330 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184458.330 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090720-184458.330 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090720-184458.330 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ](0)
DEBUG | 20090720-184458.347 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=unspecified mFlowKey=868 ] -> [ V4 
192.168.1.188:0 UDP target domain=unspecified mFlowKey=868 ] sent-by= 
sent-port=0
DEBUG | 20090720-184458.348 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=unspecified mFlowKey=868 ]






DEBUG | 20090720-184458.348 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:287 | incoming from: [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:66 | Checking if SipReq:  BYE 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=BYE / 4 from(wire) is for 
me
DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:71 | Checking rule...
DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
messagefilterrule.cxx:42 | Matching rule for: 

BYE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-a42a26343318fa16-1---d8754z-;rport

Max-Forwards: 70

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015" <sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 4 BYE

Reason: SIP;description="User Hung Up"

Content-Length: 0




DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionuser.cxx:74 | Match!
DEBUG | 20090720-184501.306 | MY TEL | RESIP | 1692 | helper.cxx:375 | 
Helper::makeResponse(SipReq:  BYE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=BYE / 4 from(wire) code=100 reason=
DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer Trying tid=1248086651227 ms=3500
DEBUG | 20090720-184501.306 | MY TEL | RESIP:TRANSACTION | 1692 | 
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0 

BYE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-a42a26343318fa16-1---d8754z-;rport

Max-Forwards: 70

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015" <sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 4 BYE

Reason: SIP;description="User Hung Up"

Content-Length: 0




INFO | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1335 | Got: SipReq:  BYE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=BYE / 4 from(wire)
DEBUG | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1653 | DialogUsageManager::processRequest: SipReq:  BYE 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=BYE / 4 from(wire)
INFO | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:1713 | Handling in-dialog request: SipReq:  BYE 
9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 cseq=BYE / 4 from(wire)
DEBUG | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | DialogId.cxx:50 | 
DialogId::DialogId: 
NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658-180bff76
DEBUG | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:484 | 
Found matching dialog mClientSubscriptions(0), mServerSubscriptions(0) for 

BYE sip:9199025012@xxxxxxxxxxxxx:45151 SIP/2.0

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-a42a26343318fa16-1---d8754z-;rport

Max-Forwards: 70

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 4 BYE

Reason: SIP;description="User Hung Up"

Content-Length: 0




DEBUG | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:370 | 
Dialog::dispatch: SipReq:  BYE 9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 
cseq=BYE / 4 from(wire)
INFO | 20090720-184501.310 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:2020 
| Received SipReq:  BYE 9199025012@xxxxxxxxxxxxx:45151 tid=1248086651227 
cseq=BYE / 4 from(wire)
DEBUG | 20090720-184501.310 | MY TEL | RESIP | 3672 | helper.cxx:375 | 
Helper::makeResponse(SipReq:  BYE 9199025012@xxxxxxxxxxxxx:45151 
tid=1248086651227 cseq=BYE / 4 from(wire) code=200 reason=
DEBUG | 20090720-184501.311 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:1076 | 
Dialog::makeResponse: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-a42a26343318fa16-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 4 BYE

Content-Length: 0




DEBUG | 20090720-184501.311 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:867 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-a42a26343318fa16-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 4 BYE

User-Agent: MyTel

Content-Length: 0




DEBUG | 20090720-184501.312 | MY TEL | RESIP | 3672 | sipstack.cxx:298 | SEND: 
SipResp: 200 tid=1248086651227 cseq=BYE contact=9199025012@xxxxxxxxxxxxx:45151 
/ 4 from(tu)
INFO | 20090720-184501.312 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:2606 
| Transition InviteSession::Connected -> InviteSession::Terminated
DEBUG | 20090720-184501.332 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer J tid=1248086651227 ms=32000
DEBUG | 20090720-184501.336 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=unspecified mFlowKey=868 ] -> [ V4 
192.168.1.188:0 UDP target domain=unspecified mFlowKey=868 ] 
sent-by=125.22.86.19 sent-port=5060
DEBUG | 20090720-184501.336 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=unspecified mFlowKey=868 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 125.22.86.19:5060;branch=z9hG4bK1248086651227

Via: SIP/2.0/UDP 
192.168.1.198:24590;branch=z9hG4bK-d8754z-a42a26343318fa16-1---d8754z-;rport

Contact: <sip:9199025012@xxxxxxxxxxxxx:45151>

To: <sip:9199025012@xxxxxxxxxxxxx>;tag=766da658

From: "9199025015"<sip:9199025015@xxxxxxxxxxxx>;tag=180bff76

Call-ID: NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.

CSeq: 4 BYE

User-Agent: MyTel

Content-Length: 0




DEBUG | 20090720-184501.336 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184501.392 | MY TEL | RESIP:DUM | 3672 | InviteSession.cxx:83 
| ^^^ InviteSession::~InviteSession 0606B110
DEBUG | 20090720-184501.394 | MY TEL | RESIP:DUM | 3672 | Dialog.cxx:244 | 
Dialog::~Dialog() 
DEBUG | 20090720-184501.394 | MY TEL | RESIP:DUM | 3672 | 
KeepAliveManager.cxx:49 | Association removed for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184501.395 | MY TEL | RESIP:DUM | 3672 | 
DialogUsageManager.cxx:2145 | Got merged request removal request
DEBUG | 20090720-184501.395 | MY TEL | RESIP:TRANSACTION | 3672 | 
timerqueue.cxx:105 | Adding application timer: 
DEBUG | 20090720-184501.395 | MY TEL | RESIP:DUM | 3672 | DialogSet.cxx:123 |  
********** DialogSet::~DialogSet: 
NWJkYTRjNGMxMGEwM2QzNzJhYzk3ODRjODU2MzUzYjY.-766da658*************
INFO | 20090720-184514.981 | MY TEL | RESIP:DUM | 324 | 
ClientRegistration.cxx:190 | Removing binding
DEBUG | 20090720-184514.981 | MY TEL | RESIP:DUM | 324 | 
ClientAuthManager.cxx:324 |  Add auth, 0605AE38 in response to: Digest 
realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",opaque="",stale=FALSE,algorithm=MD5
DEBUG | 20090720-184514.982 | MY TEL | RESIP:DUM | 324 | 
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication, 
proxy: 0 Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5
DEBUG | 20090720-184514.982 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:867 | SEND: 

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-1979b51a01186654-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:9199025012;rinstance=860b72dd40013114>;expires=0

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 4 REGISTER

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Authorization: Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184514.982 | MY TEL | RESIP:DUM | 324 | DialogId.cxx:50 | 
DialogId::DialogId: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256-
DEBUG | 20090720-184514.982 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:1001 | Send: SipReq:  REGISTER 125.22.86.19 
tid=1979b51a01186654 cseq=REGISTER contact=9199025012 / 4 from(tu)
DEBUG | 20090720-184514.982 | MY TEL | RESIP | 324 | sipstack.cxx:316 | SEND: 
SipReq:  REGISTER 125.22.86.19 tid=1979b51a01186654 cseq=REGISTER 
contact=9199025012 / 4 from(tu)
DEBUG | 20090720-184514.989 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer F tid=1979b51a01186654 ms=32000
DEBUG | 20090720-184514.989 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:316 | Looking up dns entries for sip:125.22.86.19
DEBUG | 20090720-184514.989 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:207 | 
DnsResult::lookup sip:125.22.86.19
DEBUG | 20090720-184514.989 | MY TEL | RESIP:DNS | 1692 | dnsresult.cxx:391 | 
Numeric result so return immediately: [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ]
DEBUG | 20090720-184514.989 | MY TEL | RESIP:TRANSACTION | 1692 | 
timerqueue.cxx:85 | Adding timer: Timer E1 tid=1979b51a01186654 ms=500
DEBUG | 20090720-184514.992 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:562 | Looked up source for destination: [ V4 
125.22.86.19:5060 UDP target domain=125.22.86.19 mFlowKey=0 ] -> [ V4 
192.168.1.188:0 UDP target domain=125.22.86.19 mFlowKey=0 ] sent-by= sent-port=0
DEBUG | 20090720-184514.992 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP 
target domain=125.22.86.19 mFlowKey=0 ])
DEBUG | 20090720-184514.992 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:1219 | findTransport (any port, any interface) => 
Transport: [ V4 0.0.0.0:6211 UDP target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184514.993 | MY TEL | RESIP:TRANSPORT | 1692 | 
transportselector.cxx:940 | Transmitting to [ V4 125.22.86.19:5060 UDP target 
domain=125.22.86.19 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:6211 UDP 
target domain=125.22.86.19 mFlowKey=0 ]

REGISTER sip:125.22.86.19 SIP/2.0

Via: SIP/2.0/UDP 
192.168.1.188:6211;branch=z9hG4bK-d8754z-1979b51a01186654-1---d8754z-;rport

Max-Forwards: 70

Contact: 
<sip:9199025012@xxxxxxxxxxxxx:6211;rinstance=860b72dd40013114>;expires=0

To: <sip:9199025012@xxxxxxxxxxxx>

From: <sip:9199025012@xxxxxxxxxxxx>;tag=dc61f256

Call-ID: MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.

CSeq: 4 REGISTER

Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER, 
SUBSCRIBE, INFO

Supported: replaces

User-Agent: MyTel

Authorization: Digest 
username="9199025012",realm="125.22.86.19",nonce="e052038a6e1c0e45872f9066a12584e2",uri="sip:125.22.86.19",response="824b8717f037d43ec52f2602f931b3ec",algorithm=MD5

Content-Length: 0




DEBUG | 20090720-184514.993 | MY TEL | RESIP:TRANSPORT | 1692 | 
transport.cxx:213 | Adding message to tx buffer to: [ V4 125.22.86.19:5060 UDP 
target domain=125.22.86.19 mFlowKey=0 ]
WARNING | 20090720-184515.080 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:250 | force shutdown 
DEBUG | 20090720-184515.080 | MY TEL | RESIP:DUM | 324 | HandleManager.cxx:93 | 
Waiting for usages to be deleted (2)
DEBUG | 20090720-184515.080 | MY TEL | RESIP:DUM | 324 | HandleManager.cxx:96 | 
1 -> AppDialogSet 1
DEBUG | 20090720-184515.080 | MY TEL | RESIP:DUM | 324 | HandleManager.cxx:96 | 
2 -> ClientRegistration sip:9199025012@xxxxxxxxxxxx
INFO | 20090720-184515.080 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:214 | DialogUsageManager::onAllHandlesDestroyed: 
removing TU
INFO | 20090720-184515.093 | MY TEL | RESIP:TRANSACTION | 1692 | 
tuselector.cxx:40 | TransactionUserMessage::RemoveTransactionUser TU: 
DialogUsageManager size=0
INFO | 20090720-184515.100 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:1143 | TU unregistered 
WARNING | 20090720-184515.118 | MY TEL | RESIP | 1692 | stackthread.cxx:45 | 
Shutting down stack thread
DEBUG | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:137 | DialogUsageManager::mDialogSetMap has 1 DialogSets
DEBUG | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:141 | 
DialgSetId:MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256
DEBUG | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
ClientRegistration.cxx:60 | ClientRegistration::~ClientRegistration
DEBUG | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
KeepAliveManager.cxx:49 | Association removed for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
DEBUG | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
KeepAliveManager.cxx:53 | Keepalive 0 removed
DEBUG | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
KeepAliveManager.cxx:54 | No more association for [ V4 125.22.86.19:5060 UDP 
target domain=unspecified mFlowKey=868 ]
INFO | 20090720-184515.710 | MY TEL | RESIP:DUM | 324 | 
DialogUsageManager.cxx:1043 | DialogUsageManager::destroy() not posting to stack
DEBUG | 20090720-184515.711 | MY TEL | RESIP:DUM | 324 | DialogSet.cxx:123 |  
********** DialogSet::~DialogSet: 
MjBmOGYyMTNjODFhNTcwN2RjMjRlYjkzZTIwZGZmOWE.-dc61f256*************
DEBUG | 20090720-184515.711 | MY TEL | RESIP | 324 | sipstack.cxx:90 | 
SipStack::~SipStack()
DEBUG | 20090720-184515.711 | MY TEL | RESIP | 324 | security.cxx:915 | 
BaseSecurity::~BaseSecurity
DEBUG | 20090720-184515.711 | MY TEL | RESIP:TRANSACTION | 324 | 
transactionmap.cxx:18 | 1248086651227 -> 060FF3F8: tid=1248086651227 [ 
ServerNonInvite/Completed unreliable target=[ V4 125.22.86.19:5060 UDP target 
domain=unspecified mFlowKey=868 ]]
DEBUG | 20090720-184515.712 | MY TEL | RESIP:TRANSACTION | 324 | 
transactionmap.cxx:18 | 1979b51a01186654 -> 06059D68: tid=1979b51a01186654 [ 
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT 
target domain=unspecified mFlowKey=0 ]]
INFO | 20090720-184515.712 | MY TEL | RESIP:TRANSPORT | 324 | 
udptransport.cxx:67 | Shutting down [ V4 0.0.0.0:6211 UDP target 
domain=unspecified mFlowKey=868 ]
Attachment: log1.pcap
Description: Binary data
Follow-Ups:
- Re: [reSIProcate] Strange issue: can't received the re-INVITE message
  - From: Scott Godin
Prev by Date: [reSIProcate] Fwd: contact header port problem
Next by Date: Re: [reSIProcate] Strange issue: can't received the re-INVITE message
Previous by thread: [reSIProcate] Fwd: contact header port problem
Next by thread: Re: [reSIProcate] Strange issue: can't received the re-INVITE message
Index(es):
- Date
- Thread