[reSIProcate-users] The reSIProcate does not send ACK once it received the 200 OK of INVITE
Dear all, I'm write a phone base on resip 1.5, I have used it to do the load test call this week, the test steps are: make the call and hang up the call once the call is established.
About 5-10 minutes later, I got a strange issue: the caller does not send ACK once it received the 200 OK from callee.
I have attached the log in attachment, please help me, thanks in advance.
INVITE sip:101@xxxxxxxxxxxxx SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059>
To: <sip:101@xxxxxxxxxxxxx>
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: LOAD TEST PHONE
Content-Length: 290
v=0
o=- 4107081 4107081 IN IP4 192.168.1.188
s=call
c=IN IP4 192.168.1.188
t=0 0
m=audio 20712 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=ptime:20
a=fmtp:101 0-15
DEBUG | 20090930-150916.215 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150916.526 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer Trying
3500 -> tid=090ddb53 [ ServerNonInvite/Completed unreliable target=[ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150916.526 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1044 | TransactionState::processServerNonInvite: Timer:
Timer Trying 3500
STACK | 20090930-150916.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer A 500 ->
tid=cb7b3734c1179931 [ ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0
UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150916.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
A 500 tid=cb7b3734c1179931 [ ClientInvite/Calling unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150916.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[cb7b3734c1179931] Type[Timer A] duration[500]
DEBUG | 20090930-150916.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer A tid=cb7b3734c1179931 ms=1000
INFO | 20090930-150916.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:971 | Retransmitting INVITE: SipReq: INVITE
101@xxxxxxxxxxxxx tid=cb7b3734c1179931 cseq=INVITE
contact=108@xxxxxxxxxxxxx:5059 / 1 from(tu)
DEBUG | 20090930-150916.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150917.393 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=47729f6f457b893b [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150917.393 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
B 32000 tid=47729f6f457b893b [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150917.393 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[47729f6f457b893b] Type[Timer B] duration[32000]
STACK | 20090930-150917.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer A 1000
-> tid=cb7b3734c1179931 [ ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0
UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150917.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
A 1000 tid=cb7b3734c1179931 [ ClientInvite/Calling unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150917.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[cb7b3734c1179931] Type[Timer A] duration[1000]
DEBUG | 20090930-150917.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer A tid=cb7b3734c1179931 ms=2000
INFO | 20090930-150917.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:971 | Retransmitting INVITE: SipReq: INVITE
101@xxxxxxxxxxxxx tid=cb7b3734c1179931 cseq=INVITE
contact=108@xxxxxxxxxxxxx:5059 / 1 from(tu)
DEBUG | 20090930-150917.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150918.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150918.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;received=192.168.1.188;rport=5059
Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="18b3037c"
To: <sip:101@xxxxxxxxxxxxx>;tag=as26303834
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150918.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 407
tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire) -> tid=cb7b3734c1179931 [
ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipResp: 407
tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire) tid=cb7b3734c1179931 [
ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer D tid=cb7b3734c1179931 ms=32000
DEBUG | 20090930-150918.317 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:423 | hint provided by app: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;rport
DEBUG | 20090930-150918.317 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=unspecified mFlowKey=0 ]
ACK sip:101@xxxxxxxxxxxxx SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;rport
Max-Forwards: 70
To: <sip:101@xxxxxxxxxxxxx>;tag=as26303834
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 1 ACK
Content-Length: 0
DEBUG | 20090930-150918.317 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150918.318 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150918.318 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150918.318 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;received=192.168.1.188;rport=5059
Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="18b3037c"
To: <sip:101@xxxxxxxxxxxxx>;tag=as26303834
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 407 tid=cb7b3734c1179931
cseq=INVITE / 1 from(wire)
STACK | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 407 tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire)
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:229 | ClientAuthManager::RealmState::handleAuth: 03EA7C40
Digest algorithm=MD5,realm="asterisk",nonce="18b3037c" is proxy: 1
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
invalid to current
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
UserProfile.cxx:153 | Didn't find credential for realm: asterisk
realm=192.168.1.100 user=108
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:63 | Produced response to digest challenge for
UserProfile: "108"<sip:108@xxxxxxxxxxxxx>[realm=192.168.1.100 user=108]
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:253 | about to re-send request with digest credentials
STACK | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:254 | 1
STACK | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150918.331 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:324 | Add auth, 03EA7C40 in response to: Digest
algorithm=MD5,realm="asterisk",nonce="18b3037c"
DEBUG | 20090930-150918.332 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication,
proxy: 1 Digest
username="108",realm="asterisk",nonce="18b3037c",uri="sip:101@xxxxxxxxxxxxx",response="bdca3e616eca4f51d6841f53782bb3c6",algorithm=MD5
DEBUG | 20090930-150918.332 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:867 | SEND:
INVITE sip:101@xxxxxxxxxxxxx SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108>
To: <sip:101@xxxxxxxxxxxxx>
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Content-Type: application/sdp
Proxy-Authorization: Digest
username="108",realm="asterisk",nonce="18b3037c",uri="sip:101@xxxxxxxxxxxxx",response="bdca3e616eca4f51d6841f53782bb3c6",algorithm=MD5
Supported: replaces
User-Agent: LOAD TEST PHONE
Content-Length: 290
v=0
o=- 4107081 4107081 IN IP4 192.168.1.188
s=call
c=IN IP4 192.168.1.188
t=0 0
m=audio 20712 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=ptime:20
a=fmtp:101 0-15
STACK | 20090930-150918.332 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150918.332 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150918.333 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77-
DEBUG | 20090930-150918.333 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1001 | Send: SipReq: INVITE 101@xxxxxxxxxxxxx
tid=91766a30660e9d46 cseq=INVITE contact=108 / 2 from(tu)
DEBUG | 20090930-150918.333 | LOAD TEST PHONE 1.0 | RESIP | 3684 |
sipstack.cxx:316 | SEND: SipReq: INVITE 101@xxxxxxxxxxxxx tid=91766a30660e9d46
cseq=INVITE contact=108 / 2 from(tu)
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:389 | No matching transaction for SipReq: INVITE
101@xxxxxxxxxxxxx tid=91766a30660e9d46 cseq=INVITE contact=108 / 2 from(tu)
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:56 | Creating new TransactionState: tid=91766a30660e9d46 [
ClientInvite/Calling reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipReq:
INVITE 101@xxxxxxxxxxxxx tid=91766a30660e9d46 cseq=INVITE contact=108 / 2
from(tu) tid=91766a30660e9d46 [ ClientInvite/Calling reliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer B tid=91766a30660e9d46 ms=32000
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2005 | sendToWire with no dns result: tid=91766a30660e9d46
[ ClientInvite/Calling reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:316 | Looking up dns entries for sip:101@xxxxxxxxxxxxx
DEBUG | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:207 | DnsResult::lookup sip:101@xxxxxxxxxxxxx
DEBUG | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:391 | Numeric result so return immediately: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1832 | tid=91766a30660e9d46 [ ClientInvite/Calling
reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]] got DNS result: 192.168.1.100 --> [[ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]]
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:187 | Returning next dns entry: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1873 | Unreliable transport: tid=91766a30660e9d46 [
ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer A tid=91766a30660e9d46 ms=500
DEBUG | 20090930-150918.347 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-150918.347 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-150918.348 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-150918.348 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ] -> [ V4
192.168.1.188:0 UDP target domain=192.168.1.100 mFlowKey=0 ] sent-by=
sent-port=0
DEBUG | 20090930-150918.348 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP
target domain=192.168.1.100 mFlowKey=0 ])
DEBUG | 20090930-150918.348 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1219 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:5059 UDP target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150918.348 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=192.168.1.100 mFlowKey=0 ]
INVITE sip:101@xxxxxxxxxxxxx SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059>
To: <sip:101@xxxxxxxxxxxxx>
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Content-Type: application/sdp
Proxy-Authorization: Digest
username="108",realm="asterisk",nonce="18b3037c",uri="sip:101@xxxxxxxxxxxxx",response="bdca3e616eca4f51d6841f53782bb3c6",algorithm=MD5
Supported: replaces
User-Agent: LOAD TEST PHONE
Content-Length: 290
v=0
o=- 4107081 4107081 IN IP4 192.168.1.188
s=call
c=IN IP4 192.168.1.188
t=0 0
m=audio 20712 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=ptime:20
a=fmtp:101 0-15
DEBUG | 20090930-150918.348 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150918.394 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150918.394 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;received=192.168.1.188;rport=5059
Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="18b3037c"
To: <sip:101@xxxxxxxxxxxxx>;tag=as26303834
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150918.394 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 407
tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire) -> tid=cb7b3734c1179931 [
ClientInvite/Completed unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.395 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipResp: 407
tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire) tid=cb7b3734c1179931 [
ClientInvite/Completed unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.395 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150918.437 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150918.437 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-cb7b3734c1179931-1---d8754z-;received=192.168.1.188;rport=5059
Proxy-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="18b3037c"
To: <sip:101@xxxxxxxxxxxxx>;tag=as26303834
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 1 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150918.437 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 407
tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire) -> tid=cb7b3734c1179931 [
ClientInvite/Completed unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.437 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipResp: 407
tid=cb7b3734c1179931 cseq=INVITE / 1 from(wire) tid=cb7b3734c1179931 [
ClientInvite/Completed unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.437 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:101@xxxxxxxxxxxxx>
To: <sip:101@xxxxxxxxxxxxx>
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 100
tid=91766a30660e9d46 cseq=INVITE contact=101@xxxxxxxxxxxxx / 2 from(wire) ->
tid=91766a30660e9d46 [ ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0
UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipResp: 100
tid=91766a30660e9d46 cseq=INVITE contact=101@xxxxxxxxxxxxx / 2 from(wire)
tid=91766a30660e9d46 [ ClientInvite/Calling unreliable target=[ V4 0.0.0.0:0
UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150918.461 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:101@xxxxxxxxxxxxx>
To: <sip:101@xxxxxxxxxxxxx>
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-150918.483 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=91766a30660e9d46
cseq=INVITE contact=101@xxxxxxxxxxxxx / 2 from(wire)
STACK | 20090930-150918.483 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150918.483 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150918.483 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 100 tid=91766a30660e9d46 cseq=INVITE contact=101@xxxxxxxxxxxxx / 2
from(wire)
STACK | 20090930-150918.483 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:101@xxxxxxxxxxxxx>
To: <sip:101@xxxxxxxxxxxxx>
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-150918.566 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150918.566 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150918.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 180
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientInvite/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipResp: 180
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) tid=91766a30660e9d46 [
ClientInvite/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.567 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150918.567 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150918.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientInvite/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) tid=91766a30660e9d46 [
ClientInvite/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150918.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=1
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150918.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:878 | Received 2xx on client invite transaction
STACK | 20090930-150918.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:879 | tid=91766a30660e9d46 [ ClientStale/Proceeding
unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]]
DEBUG | 20090930-150918.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer StaleClient tid=91766a30660e9d46
ms=32000
INFO | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 180 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 180 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:41 | ClientAuthManager::handle: transitioning
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77to cached
DEBUG | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
current to cached
DEBUG | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77-as21ffae66
STACK | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:772 | Cannot create a dialog, no Contact or To tag in 1xx.
INFO | 20090930-150918.573 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 200 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:41 | ClientAuthManager::handle: transitioning
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77to cached
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
cached to cached
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77-as21ffae66
STACK | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:791 | mState == 3 Creating a new Dialog from msg:
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77-as21ffae66
INFO | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
Dialog.cxx:220 | Got an INVITE or SUBSCRIBE that doesn't have exactly one
contact
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
Dialog.cxx:221 | SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
DEBUG | 20090930-150918.574 | LOAD TEST PHONE 1.0 | RESIP | 3684 |
baseexception.cxx:17 | BaseException at .\Dialog.cxx:222 Too many contacts (or
no contact) in response
INFO | 20090930-150918.576 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:799 | Unable to create dialog: Too many contacts (or no contact)
in response
DEBUG | 20090930-150918.577 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:123 | ********** DialogSet::~DialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77*************
STACK | 20090930-150918.577 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1997 | ************* Removing DialogSet ***************
STACK | 20090930-150918.577 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1998 | Before:
[Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 -> 03EE47B8,
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
STACK | 20090930-150918.577 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:2000 | After:
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
STACK | 20090930-150918.577 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
Handled.cxx:23 | &&&&&& ~Handled 108 this(03F72B80) 03889B30
STACK | 20090930-150918.844 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer A 500 ->
tid=91766a30660e9d46 [ ClientStale/Proceeding unreliable target=[ V4 0.0.0.0:0
UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150918.844 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
A 500
STACK | 20090930-150919.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer D 32000
-> tid=47729f6f457b893b [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150919.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
D 32000 tid=47729f6f457b893b [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150919.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[47729f6f457b893b] Type[Timer D] duration[32000]
STACK | 20090930-150919.260 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=45154c6b894d9b64 [ ClientStale/Proceeding unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150919.261 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
B 32000
DEBUG | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientStale/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150919.570 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
INFO | 20090930-150919.571 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150919.571 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150919.571 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
INFO | 20090930-150919.571 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1848 | Throwing away stray response:
SipResp: 200 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
STACK | 20090930-150919.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer A 2000
-> tid=cb7b3734c1179931 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150919.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
A 2000 tid=cb7b3734c1179931 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150919.711 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[cb7b3734c1179931] Type[Timer A] duration[2000]
DEBUG | 20090930-150920.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150920.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150920.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientStale/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150920.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150920.567 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150920.568 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150920.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
INFO | 20090930-150920.568 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150920.568 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150920.568 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
INFO | 20090930-150920.568 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1848 | Throwing away stray response:
SipResp: 200 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
STACK | 20090930-150921.241 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleClient 32000 -> tid=45154c6b894d9b64 [ ClientStale/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150921.241 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
StaleClient 32000
STACK | 20090930-150921.266 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
Stateless 32000 -> tid=af7bdf116051383d [ Stateless/Calling unreliable target=[
V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150921.266 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:597 | TransactionState::processStateless: Timer: Timer
Stateless 32000
STACK | 20090930-150921.638 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=738b9d27 [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150921.638 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
DEBUG | 20090930-150922.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150922.567 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150922.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientStale/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150922.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150922.568 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150922.568 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150922.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
INFO | 20090930-150922.587 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150922.587 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150922.587 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
INFO | 20090930-150922.587 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1848 | Throwing away stray response:
SipResp: 200 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
STACK | 20090930-150922.878 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=7dd87c9e [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150922.878 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
STACK | 20090930-150922.936 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer J 32000
-> tid=19b44899 [ ServerNonInvite/Completed unreliable target=[ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150922.936 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1044 | TransactionState::processServerNonInvite: Timer:
Timer J 32000
INFO | 20090930-150924.540 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
tuselector.cxx:70 | Stats message
WARNING | 20090930-150924.540 | LOAD TEST PHONE 1.0 | RESIP:STATS | 2780 |
statisticsmessage.cxx:152 | RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 11 SERVERTX 8 TIMERS 27
Transaction summary: reqi 170 reqo 200 rspi 180 rspo 171
Details: INVi 67/S71/F0 INVo 72/S48/F40 ACKi 66 ACKo 80 BYEi 37/S37/F0 BYEo
0/S0/F0 CANi 0/S37/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 9/S4/F5 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 0/S0/F0 SUBo
0/S0/F0 NOTi 0/S0/F0 NOTo 0/S0/F0
Retransmissions: INVx 31 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 4 finx 0 nonx 0 PUBx
0 SUBx 0 NOTx 0
DEBUG | 20090930-150925.018 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150925.018 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090930-150925.018 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090930-150925.018 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ](0)
STACK | 20090930-150925.023 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:151 | Sending keep alive to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150925.027 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-150925.027 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-150925.027 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-150925.028 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ] -> [ V4
192.168.1.188:0 UDP target domain=unspecified mFlowKey=840 ] sent-by=
sent-port=0
DEBUG | 20090930-150925.028 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150925.028 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
STACK | 20090930-150926.079 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=350072645560276f [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.079 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
B 32000 tid=350072645560276f [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.079 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[350072645560276f] Type[Timer B] duration[32000]
STACK | 20090930-150926.090 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer D 32000
-> tid=350072645560276f [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.090 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
D 32000 tid=350072645560276f [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.090 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[350072645560276f] Type[Timer D] duration[32000]
STACK | 20090930-150926.142 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=f374c3740e5ac767 [ ClientStale/Proceeding unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.142 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
B 32000
STACK | 20090930-150926.197 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleClient 32000 -> tid=f374c3740e5ac767 [ ClientStale/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.197 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
StaleClient 32000
STACK | 20090930-150926.224 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
Stateless 32000 -> tid=c530b30a4961d338 [ Stateless/Calling unreliable target=[
V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.224 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:597 | TransactionState::processStateless: Timer: Timer
Stateless 32000
STACK | 20090930-150926.377 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=6ccc2027 [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150926.377 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
DEBUG | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientStale/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150926.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
INFO | 20090930-150926.579 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150926.579 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150926.579 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
INFO | 20090930-150926.579 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1848 | Throwing away stray response:
SipResp: 200 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
STACK | 20090930-150929.620 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=2b2d5d78 [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150929.620 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
STACK | 20090930-150929.653 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer J 32000
-> tid=5227927e [ ServerNonInvite/Completed unreliable target=[ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150929.653 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1044 | TransactionState::processServerNonInvite: Timer:
Timer J 32000
DEBUG | 20090930-150930.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150930.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
STACK | 20090930-150930.568 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire) -> tid=91766a30660e9d46 [
ClientStale/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150930.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: SipResp: 200
tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
DEBUG | 20090930-150930.569 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150930.569 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150930.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-91766a30660e9d46-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:101@xxxxxxxxxxxxx>;tag=as21ffae66
From: "108"<sip:108@xxxxxxxxxxxxx>;tag=5e310e77
Call-ID: Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.
CSeq: 2 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Content-Type: application/sdp
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 311
v=0
o=root 5404 5404 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 19852 RTP/AVP 0 8 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv
INFO | 20090930-150930.581 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=91766a30660e9d46
cseq=INVITE / 2 from(wire)
STACK | 20090930-150930.581 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-150930.581 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
INFO | 20090930-150930.581 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1848 | Throwing away stray response:
SipResp: 200 tid=91766a30660e9d46 cseq=INVITE / 2 from(wire)
STACK | 20090930-150932.726 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=10435d24536c641e [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.726 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
B 32000 tid=10435d24536c641e [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.726 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[10435d24536c641e] Type[Timer B] duration[32000]
STACK | 20090930-150932.733 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer D 32000
-> tid=10435d24536c641e [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.733 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
D 32000 tid=10435d24536c641e [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.733 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[10435d24536c641e] Type[Timer D] duration[32000]
STACK | 20090930-150932.759 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=02523608d51cd84e [ ClientStale/Proceeding unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.759 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
B 32000
STACK | 20090930-150932.858 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleClient 32000 -> tid=02523608d51cd84e [ ClientStale/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.858 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
StaleClient 32000
STACK | 20090930-150932.886 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
Stateless 32000 -> tid=f60981768f4c5a3a [ Stateless/Calling unreliable target=[
V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150932.887 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:597 | TransactionState::processStateless: Timer: Timer
Stateless 32000
STACK | 20090930-150933.036 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=4ad1ae35 [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150933.037 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
STACK | 20090930-150936.281 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=793fdc2c [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150936.281 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
STACK | 20090930-150936.469 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer J 32000
-> tid=31da8bfa [ ServerNonInvite/Completed unreliable target=[ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150936.469 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1044 | TransactionState::processServerNonInvite: Timer:
Timer J 32000
STACK | 20090930-150939.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=6c1c115c6b6f8615 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
B 32000 tid=6c1c115c6b6f8615 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[6c1c115c6b6f8615] Type[Timer B] duration[32000]
STACK | 20090930-150939.597 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer D 32000
-> tid=6c1c115c6b6f8615 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.597 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
D 32000 tid=6c1c115c6b6f8615 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.597 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[6c1c115c6b6f8615] Type[Timer D] duration[32000]
STACK | 20090930-150939.627 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=c67839771b632722 [ ClientStale/Proceeding unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.627 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
B 32000
STACK | 20090930-150939.737 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleClient 32000 -> tid=c67839771b632722 [ ClientStale/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.737 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
StaleClient 32000
STACK | 20090930-150939.772 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
Stateless 32000 -> tid=554c112fe837145a [ Stateless/Calling unreliable target=[
V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150939.772 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:597 | TransactionState::processStateless: Timer: Timer
Stateless 32000
STACK | 20090930-150944.999 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleServer 32000 -> tid=57eae257 [ ServerStale/Proceeding unreliable target=[
V4 192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150944.999 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1569 | TransactionState::processServerStale: Timer: Timer
StaleServer 32000
STACK | 20090930-150945.052 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer J 32000
-> tid=090ddb53 [ ServerNonInvite/Completed unreliable target=[ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ]]
STACK | 20090930-150945.052 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1044 | TransactionState::processServerNonInvite: Timer:
Timer J 32000
STACK | 20090930-150948.211 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=cb7b3734c1179931 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150948.211 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
B 32000 tid=cb7b3734c1179931 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150948.211 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[cb7b3734c1179931] Type[Timer B] duration[32000]
STACK | 20090930-150950.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer D 32000
-> tid=cb7b3734c1179931 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150950.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:808 | TransactionState::processClientInvite: Timer: Timer
D 32000 tid=cb7b3734c1179931 [ ClientInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150950.316 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:960 | timer fired: TimerMessage
TransactionId[cb7b3734c1179931] Type[Timer D] duration[32000]
STACK | 20090930-150950.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer B 32000
-> tid=91766a30660e9d46 [ ClientStale/Proceeding unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150950.343 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
B 32000
STACK | 20090930-150950.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer
StaleClient 32000 -> tid=91766a30660e9d46 [ ClientStale/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150950.569 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1525 | TransactionState::processClientStale: Timer: Timer
StaleClient 32000
DEBUG | 20090930-150955.040 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150955.040 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090930-150955.040 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090930-150955.040 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ](0)
STACK | 20090930-150955.043 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:151 | Sending keep alive to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150955.046 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-150955.046 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-150955.046 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-150955.046 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ] -> [ V4
192.168.1.188:0 UDP target domain=unspecified mFlowKey=840 ] sent-by=
sent-port=0
DEBUG | 20090930-150955.046 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150955.046 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
INFO | 20090930-150957.170 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientRegistration.cxx:280 | requesting refresh of ClientRegistration
sip:108@xxxxxxxxxxxxx
STACK | 20090930-150957.170 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.170 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.170 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:324 | Add auth, 03A1ED68 in response to: Digest
algorithm=MD5,realm="asterisk",nonce="5a422126"
DEBUG | 20090930-150957.170 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication,
proxy: 0 Digest
username="108",realm="asterisk",nonce="5a422126",uri="sip:192.168.1.100",response="18989f02028c4ca61624bcf35ae3c96a",algorithm=MD5
DEBUG | 20090930-150957.170 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:867 | SEND:
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="5a422126",uri="sip:192.168.1.100",response="18989f02028c4ca61624bcf35ae3c96a",algorithm=MD5
Content-Length: 0
STACK | 20090930-150957.171 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.171 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.171 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-
DEBUG | 20090930-150957.171 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1001 | Send: SipReq: REGISTER 192.168.1.100
tid=7d08d0193d523614 cseq=REGISTER contact=108 / 10 from(tu)
DEBUG | 20090930-150957.171 | LOAD TEST PHONE 1.0 | RESIP | 3684 |
sipstack.cxx:316 | SEND: SipReq: REGISTER 192.168.1.100 tid=7d08d0193d523614
cseq=REGISTER contact=108 / 10 from(tu)
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:389 | No matching transaction for SipReq: REGISTER
192.168.1.100 tid=7d08d0193d523614 cseq=REGISTER contact=108 / 10 from(tu)
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:56 | Creating new TransactionState: tid=7d08d0193d523614 [
ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipReq:
REGISTER 192.168.1.100 tid=7d08d0193d523614 cseq=REGISTER contact=108 / 10
from(tu)
DEBUG | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer F tid=7d08d0193d523614 ms=32000
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2005 | sendToWire with no dns result: tid=7d08d0193d523614
[ ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:316 | Looking up dns entries for sip:192.168.1.100
DEBUG | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:207 | DnsResult::lookup sip:192.168.1.100
DEBUG | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:391 | Numeric result so return immediately: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1832 | tid=7d08d0193d523614 [ ClientNonInvite/Trying
reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]] got DNS result: 192.168.1.100 --> [[ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]]
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:187 | Returning next dns entry: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1873 | Unreliable transport: tid=7d08d0193d523614 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150957.176 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=7d08d0193d523614 ms=500
DEBUG | 20090930-150957.179 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-150957.179 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-150957.179 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-150957.180 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ] -> [ V4
192.168.1.188:0 UDP target domain=192.168.1.100 mFlowKey=0 ] sent-by=
sent-port=0
DEBUG | 20090930-150957.180 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP
target domain=192.168.1.100 mFlowKey=0 ])
DEBUG | 20090930-150957.180 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1219 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:5059 UDP target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150957.180 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=192.168.1.100 mFlowKey=0 ]
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="5a422126",uri="sip:192.168.1.100",response="18989f02028c4ca61624bcf35ae3c96a",algorithm=MD5
Content-Length: 0
DEBUG | 20090930-150957.180 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150957.182 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150957.182 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150957.183 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 100
tid=7d08d0193d523614 cseq=REGISTER / 10 from(wire) -> tid=7d08d0193d523614 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.183 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
100 tid=7d08d0193d523614 cseq=REGISTER / 10 from(wire)
DEBUG | 20090930-150957.183 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E2 tid=7d08d0193d523614 ms=4000
DEBUG | 20090930-150957.183 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150957.183 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150957.183 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>;tag=as56e0581e
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="6a1f7198"
Content-Length: 0
STACK | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 401
tid=7d08d0193d523614 cseq=REGISTER / 10 from(wire) -> tid=7d08d0193d523614 [
ClientNonInvite/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
401 tid=7d08d0193d523614 cseq=REGISTER / 10 from(wire)
DEBUG | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150957.186 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=1
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>;tag=as56e0581e
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="6a1f7198"
Content-Length: 0
DEBUG | 20090930-150957.187 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer K tid=7d08d0193d523614 ms=5000
INFO | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=7d08d0193d523614
cseq=REGISTER / 10 from(wire)
STACK | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 100 tid=7d08d0193d523614 cseq=REGISTER / 10 from(wire)
STACK | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-7d08d0193d523614-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 10 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 401 tid=7d08d0193d523614
cseq=REGISTER / 10 from(wire)
STACK | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 401 tid=7d08d0193d523614 cseq=REGISTER / 10 from(wire)
DEBUG | 20090930-150957.201 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:229 | ClientAuthManager::RealmState::handleAuth: 03A1ED68
Digest algorithm=MD5,realm="asterisk",nonce="6a1f7198" is proxy: 0
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
cached to current
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
UserProfile.cxx:153 | Didn't find credential for realm: asterisk
realm=192.168.1.100 user=108
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:63 | Produced response to digest challenge for
UserProfile: "108"<sip:108@xxxxxxxxxxxxx>[realm=192.168.1.100 user=108]
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:253 | about to re-send request with digest credentials
STACK | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:254 | 1
STACK | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:324 | Add auth, 03A1ED68 in response to: Digest
algorithm=MD5,realm="asterisk",nonce="6a1f7198"
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication,
proxy: 0 Digest
username="108",realm="asterisk",nonce="6a1f7198",uri="sip:192.168.1.100",response="260bdfeb60954788a3cc17f2bf2b2cfe",algorithm=MD5
DEBUG | 20090930-150957.202 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:867 | SEND:
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="6a1f7198",uri="sip:192.168.1.100",response="260bdfeb60954788a3cc17f2bf2b2cfe",algorithm=MD5
Content-Length: 0
STACK | 20090930-150957.203 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.203 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.203 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-
DEBUG | 20090930-150957.203 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1001 | Send: SipReq: REGISTER 192.168.1.100
tid=d502427b3b366820 cseq=REGISTER contact=108 / 11 from(tu)
DEBUG | 20090930-150957.203 | LOAD TEST PHONE 1.0 | RESIP | 3684 |
sipstack.cxx:316 | SEND: SipReq: REGISTER 192.168.1.100 tid=d502427b3b366820
cseq=REGISTER contact=108 / 11 from(tu)
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:389 | No matching transaction for SipReq: REGISTER
192.168.1.100 tid=d502427b3b366820 cseq=REGISTER contact=108 / 11 from(tu)
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:56 | Creating new TransactionState: tid=d502427b3b366820 [
ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipReq:
REGISTER 192.168.1.100 tid=d502427b3b366820 cseq=REGISTER contact=108 / 11
from(tu)
DEBUG | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer F tid=d502427b3b366820 ms=32000
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2005 | sendToWire with no dns result: tid=d502427b3b366820
[ ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:316 | Looking up dns entries for sip:192.168.1.100
DEBUG | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:207 | DnsResult::lookup sip:192.168.1.100
DEBUG | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:391 | Numeric result so return immediately: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1832 | tid=d502427b3b366820 [ ClientNonInvite/Trying
reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]] got DNS result: 192.168.1.100 --> [[ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]]
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:187 | Returning next dns entry: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1873 | Unreliable transport: tid=d502427b3b366820 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-150957.212 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=d502427b3b366820 ms=500
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ] -> [ V4
192.168.1.188:0 UDP target domain=192.168.1.100 mFlowKey=0 ] sent-by=
sent-port=0
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP
target domain=192.168.1.100 mFlowKey=0 ])
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1219 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:5059 UDP target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=192.168.1.100 mFlowKey=0 ]
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="6a1f7198",uri="sip:192.168.1.100",response="260bdfeb60954788a3cc17f2bf2b2cfe",algorithm=MD5
Content-Length: 0
DEBUG | 20090930-150957.217 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-150957.219 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150957.219 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150957.220 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 100
tid=d502427b3b366820 cseq=REGISTER / 11 from(wire) -> tid=d502427b3b366820 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.220 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
100 tid=d502427b3b366820 cseq=REGISTER / 11 from(wire)
DEBUG | 20090930-150957.220 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E2 tid=d502427b3b366820 ms=4000
DEBUG | 20090930-150957.220 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150957.220 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150957.220 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-150957.226 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-150957.226 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=90
To: <sip:108@xxxxxxxxxxxxx>;tag=as56e0581e
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Date: Wed, 30 Sep 2009 07:09:26 GMT
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-150957.226 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=d502427b3b366820 cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 11
from(wire) -> tid=d502427b3b366820 [ ClientNonInvite/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.226 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
200 tid=d502427b3b366820 cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 11
from(wire)
DEBUG | 20090930-150957.226 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-150957.227 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-150957.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=1
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=90
To: <sip:108@xxxxxxxxxxxxx>;tag=as56e0581e
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Date: Wed, 30 Sep 2009 07:09:26 GMT
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-150957.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer K tid=d502427b3b366820 ms=5000
INFO | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=d502427b3b366820
cseq=REGISTER / 11 from(wire)
STACK | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 100 tid=d502427b3b366820 cseq=REGISTER / 11 from(wire)
STACK | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=d502427b3b366820
cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 11 from(wire)
STACK | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 200 tid=d502427b3b366820 cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059
/ 11 from(wire)
DEBUG | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:41 | ClientAuthManager::handle: transitioning
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65to cached
DEBUG | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
current to cached
DEBUG | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-as56e0581e
STACK | 20090930-150957.234 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-d502427b3b366820-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=90
To: <sip:108@xxxxxxxxxxxxx>;tag=as56e0581e
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 11 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Date: Wed, 30 Sep 2009 07:09:26 GMT
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-150957.235 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientRegistration.cxx:403 | Clearing service route ([])
DEBUG | 20090930-150957.235 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: DumTimeout::Registration
ClientRegistration sip:108@xxxxxxxxxxxxx: duration=81 seq=5
STACK | 20090930-150957.676 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E1 500
-> tid=7d08d0193d523614 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.676 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E1 500
STACK | 20090930-150957.712 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E1 500
-> tid=d502427b3b366820 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-150957.712 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E1 500
STACK | 20090930-151001.183 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E2 4000
-> tid=7d08d0193d523614 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151001.183 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E2 4000
STACK | 20090930-151001.220 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E2 4000
-> tid=d502427b3b366820 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151001.220 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E2 4000
STACK | 20090930-151002.187 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer K 5000
-> tid=7d08d0193d523614 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151002.187 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer K 5000
STACK | 20090930-151002.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer K 5000
-> tid=d502427b3b366820 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151002.227 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer K 5000
INFO | 20090930-151024.546 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
tuselector.cxx:70 | Stats message
WARNING | 20090930-151024.546 | LOAD TEST PHONE 1.0 | RESIP:STATS | 2780 |
statisticsmessage.cxx:152 | RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 0 TIMERS 2
Transaction summary: reqi 170 reqo 202 rspi 186 rspo 171
Details: INVi 67/S71/F0 INVo 72/S50/F40 ACKi 66 ACKo 80 BYEi 37/S37/F0 BYEo
0/S0/F0 CANi 0/S37/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 11/S5/F6 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 0/S0/F0 SUBo
0/S0/F0 NOTi 0/S0/F0 NOTo 0/S0/F0
Retransmissions: INVx 31 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 4 finx 0 nonx 0 PUBx
0 SUBx 0 NOTx 0
DEBUG | 20090930-151025.057 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151025.057 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090930-151025.057 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090930-151025.057 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ](0)
STACK | 20090930-151025.065 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:151 | Sending keep alive to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151025.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-151025.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-151025.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-151025.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ] -> [ V4
192.168.1.188:0 UDP target domain=unspecified mFlowKey=840 ] sent-by=
sent-port=0
DEBUG | 20090930-151025.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151025.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151055.060 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151055.060 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090930-151055.060 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090930-151055.060 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ](0)
STACK | 20090930-151055.082 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:151 | Sending keep alive to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151055.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-151055.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-151055.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-151055.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ] -> [ V4
192.168.1.188:0 UDP target domain=unspecified mFlowKey=840 ] sent-by=
sent-port=0
DEBUG | 20090930-151055.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151055.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
INFO | 20090930-151118.261 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientRegistration.cxx:280 | requesting refresh of ClientRegistration
sip:108@xxxxxxxxxxxxx
STACK | 20090930-151118.261 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151118.261 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151118.261 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:324 | Add auth, 03A1ED68 in response to: Digest
algorithm=MD5,realm="asterisk",nonce="6a1f7198"
DEBUG | 20090930-151118.261 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication,
proxy: 0 Digest
username="108",realm="asterisk",nonce="6a1f7198",uri="sip:192.168.1.100",response="260bdfeb60954788a3cc17f2bf2b2cfe",algorithm=MD5
DEBUG | 20090930-151118.261 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:867 | SEND:
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="6a1f7198",uri="sip:192.168.1.100",response="260bdfeb60954788a3cc17f2bf2b2cfe",algorithm=MD5
Content-Length: 0
STACK | 20090930-151118.262 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151118.262 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151118.262 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-
DEBUG | 20090930-151118.262 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1001 | Send: SipReq: REGISTER 192.168.1.100
tid=aa12bf00547ec52d cseq=REGISTER contact=108 / 12 from(tu)
DEBUG | 20090930-151118.262 | LOAD TEST PHONE 1.0 | RESIP | 3684 |
sipstack.cxx:316 | SEND: SipReq: REGISTER 192.168.1.100 tid=aa12bf00547ec52d
cseq=REGISTER contact=108 / 12 from(tu)
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:389 | No matching transaction for SipReq: REGISTER
192.168.1.100 tid=aa12bf00547ec52d cseq=REGISTER contact=108 / 12 from(tu)
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:56 | Creating new TransactionState: tid=aa12bf00547ec52d [
ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipReq:
REGISTER 192.168.1.100 tid=aa12bf00547ec52d cseq=REGISTER contact=108 / 12
from(tu)
DEBUG | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer F tid=aa12bf00547ec52d ms=32000
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2005 | sendToWire with no dns result: tid=aa12bf00547ec52d
[ ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:316 | Looking up dns entries for sip:192.168.1.100
DEBUG | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:207 | DnsResult::lookup sip:192.168.1.100
DEBUG | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:391 | Numeric result so return immediately: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1832 | tid=aa12bf00547ec52d [ ClientNonInvite/Trying
reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]] got DNS result: 192.168.1.100 --> [[ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]]
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:187 | Returning next dns entry: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1873 | Unreliable transport: tid=aa12bf00547ec52d [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-151118.285 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=aa12bf00547ec52d ms=500
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ] -> [ V4
192.168.1.188:0 UDP target domain=192.168.1.100 mFlowKey=0 ] sent-by=
sent-port=0
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP
target domain=192.168.1.100 mFlowKey=0 ])
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1219 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:5059 UDP target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=192.168.1.100 mFlowKey=0 ]
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="6a1f7198",uri="sip:192.168.1.100",response="260bdfeb60954788a3cc17f2bf2b2cfe",algorithm=MD5
Content-Length: 0
DEBUG | 20090930-151118.289 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151118.786 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E1 500
-> tid=aa12bf00547ec52d [ ClientNonInvite/Trying unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151118.786 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E1 500
DEBUG | 20090930-151118.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=aa12bf00547ec52d ms=1000
STACK | 20090930-151118.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:744 | Retransmitting: SipReq: REGISTER 192.168.1.100
tid=aa12bf00547ec52d cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 12 from(tu)
DEBUG | 20090930-151118.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151119.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E1 1000
-> tid=aa12bf00547ec52d [ ClientNonInvite/Trying unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151119.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E1 1000
DEBUG | 20090930-151119.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=aa12bf00547ec52d ms=2000
STACK | 20090930-151119.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:744 | Retransmitting: SipReq: REGISTER 192.168.1.100
tid=aa12bf00547ec52d cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 12 from(tu)
DEBUG | 20090930-151119.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-151119.880 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 100
tid=aa12bf00547ec52d cseq=REGISTER / 12 from(wire) -> tid=aa12bf00547ec52d [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
100 tid=aa12bf00547ec52d cseq=REGISTER / 12 from(wire)
DEBUG | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E2 tid=aa12bf00547ec52d ms=4000
DEBUG | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-151119.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>;tag=as08a352e6
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="5efbfd89",
stale=true
Content-Length: 0
STACK | 20090930-151119.882 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 401
tid=aa12bf00547ec52d cseq=REGISTER / 12 from(wire) -> tid=aa12bf00547ec52d [
ClientNonInvite/Proceeding unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151119.882 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
401 tid=aa12bf00547ec52d cseq=REGISTER / 12 from(wire)
DEBUG | 20090930-151119.882 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-151119.882 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-151119.882 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=1
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>;tag=as08a352e6
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="5efbfd89",
stale=true
Content-Length: 0
DEBUG | 20090930-151119.882 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer K tid=aa12bf00547ec52d ms=5000
INFO | 20090930-151119.896 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=aa12bf00547ec52d
cseq=REGISTER / 12 from(wire)
STACK | 20090930-151119.896 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151119.896 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151119.896 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 100 tid=aa12bf00547ec52d cseq=REGISTER / 12 from(wire)
STACK | 20090930-151119.896 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-aa12bf00547ec52d-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 12 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-151119.896 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 401 tid=aa12bf00547ec52d
cseq=REGISTER / 12 from(wire)
STACK | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 401 tid=aa12bf00547ec52d cseq=REGISTER / 12 from(wire)
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:229 | ClientAuthManager::RealmState::handleAuth: 03A1ED68
Digest algorithm=MD5,realm="asterisk",nonce="5efbfd89",stale=true is proxy: 0
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
cached to current
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
UserProfile.cxx:153 | Didn't find credential for realm: asterisk
realm=192.168.1.100 user=108
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:63 | Produced response to digest challenge for
UserProfile: "108"<sip:108@xxxxxxxxxxxxx>[realm=192.168.1.100 user=108]
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:253 | about to re-send request with digest credentials
STACK | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:254 | 1
STACK | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151119.897 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:324 | Add auth, 03A1ED68 in response to: Digest
algorithm=MD5,realm="asterisk",nonce="5efbfd89",stale=true
DEBUG | 20090930-151119.898 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication,
proxy: 0 Digest
username="108",realm="asterisk",nonce="5efbfd89",uri="sip:192.168.1.100",response="588bf0049d4b9306bed4bfe0d357a18b",algorithm=MD5
DEBUG | 20090930-151119.898 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:867 | SEND:
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="5efbfd89",uri="sip:192.168.1.100",response="588bf0049d4b9306bed4bfe0d357a18b",algorithm=MD5
Content-Length: 0
STACK | 20090930-151119.898 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151119.898 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151119.898 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-
DEBUG | 20090930-151119.898 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1001 | Send: SipReq: REGISTER 192.168.1.100
tid=5c08b429886a3b62 cseq=REGISTER contact=108 / 13 from(tu)
DEBUG | 20090930-151119.899 | LOAD TEST PHONE 1.0 | RESIP | 3684 |
sipstack.cxx:316 | SEND: SipReq: REGISTER 192.168.1.100 tid=5c08b429886a3b62
cseq=REGISTER contact=108 / 13 from(tu)
STACK | 20090930-151119.907 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:389 | No matching transaction for SipReq: REGISTER
192.168.1.100 tid=5c08b429886a3b62 cseq=REGISTER contact=108 / 13 from(tu)
STACK | 20090930-151119.907 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:56 | Creating new TransactionState: tid=5c08b429886a3b62 [
ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151119.907 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipReq:
REGISTER 192.168.1.100 tid=5c08b429886a3b62 cseq=REGISTER contact=108 / 13
from(tu)
DEBUG | 20090930-151119.907 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer F tid=5c08b429886a3b62 ms=32000
STACK | 20090930-151119.907 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2005 | sendToWire with no dns result: tid=5c08b429886a3b62
[ ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:316 | Looking up dns entries for sip:192.168.1.100
DEBUG | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:207 | DnsResult::lookup sip:192.168.1.100
DEBUG | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:391 | Numeric result so return immediately: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1832 | tid=5c08b429886a3b62 [ ClientNonInvite/Trying
reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]] got DNS result: 192.168.1.100 --> [[ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]]
STACK | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:187 | Returning next dns entry: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1873 | Unreliable transport: tid=5c08b429886a3b62 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-151119.908 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=5c08b429886a3b62 ms=500
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ] -> [ V4
192.168.1.188:0 UDP target domain=192.168.1.100 mFlowKey=0 ] sent-by=
sent-port=0
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP
target domain=192.168.1.100 mFlowKey=0 ])
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1219 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:5059 UDP target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151119.911 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=192.168.1.100 mFlowKey=0 ]
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="5efbfd89",uri="sip:192.168.1.100",response="588bf0049d4b9306bed4bfe0d357a18b",algorithm=MD5
Content-Length: 0
DEBUG | 20090930-151119.912 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
DEBUG | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 100
tid=5c08b429886a3b62 cseq=REGISTER / 13 from(wire) -> tid=5c08b429886a3b62 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
100 tid=5c08b429886a3b62 cseq=REGISTER / 13 from(wire)
DEBUG | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E2 tid=5c08b429886a3b62 ms=4000
DEBUG | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-151119.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=0
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:287 | incoming from: [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ]
STACK | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:288 |
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=90
To: <sip:108@xxxxxxxxxxxxx>;tag=as08a352e6
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Date: Wed, 30 Sep 2009 07:10:49 GMT
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
STACK | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for SipResp: 200
tid=5c08b429886a3b62 cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 13
from(wire) -> tid=5c08b429886a3b62 [ ClientNonInvite/Proceeding unreliable
target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipResp:
200 tid=5c08b429886a3b62 cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 13
from(wire)
DEBUG | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:199 | Whitelisting 192.168.1.100(1): 192.168.1.100
DEBUG | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
rrvip.cxx:128 | updating an existing vip: 192.168.1.100 with 192.168.1.100
DEBUG | 20090930-151119.919 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2116 | Send to TU: TU: DialogUsageManager size=1
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=90
To: <sip:108@xxxxxxxxxxxxx>;tag=as08a352e6
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Date: Wed, 30 Sep 2009 07:10:49 GMT
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-151119.920 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer K tid=5c08b429886a3b62 ms=5000
INFO | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 100 tid=5c08b429886a3b62
cseq=REGISTER / 13 from(wire)
STACK | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 100 tid=5c08b429886a3b62 cseq=REGISTER / 13 from(wire)
STACK | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 100 Trying
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;received=192.168.1.188;rport=5059
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
INFO | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1335 | Got: SipResp: 200 tid=5c08b429886a3b62
cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059 / 13 from(wire)
STACK | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogUsageManager.cxx:1843 | DialogUsageManager::processResponse:
SipResp: 200 tid=5c08b429886a3b62 cseq=REGISTER contact=108@xxxxxxxxxxxxx:5059
/ 13 from(wire)
DEBUG | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:41 | ClientAuthManager::handle: transitioning
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65to cached
DEBUG | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientAuthManager.cxx:203 | ClientAuthManager::RealmState::transition from
current to cached
DEBUG | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-as08a352e6
STACK | 20090930-151119.929 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
DialogSet.cxx:489 | No matching dialog for
SIP/2.0 200 OK
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-5c08b429886a3b62-1---d8754z-;received=192.168.1.188;rport=5059
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=90
To: <sip:108@xxxxxxxxxxxxx>;tag=as08a352e6
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 13 REGISTER
Expires: 90
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO
Date: Wed, 30 Sep 2009 07:10:49 GMT
Supported: replaces
User-Agent: Asterisk PBX
Content-Length: 0
DEBUG | 20090930-151119.930 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
ClientRegistration.cxx:403 | Clearing service route ([])
DEBUG | 20090930-151119.930 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: DumTimeout::Registration
ClientRegistration sip:108@xxxxxxxxxxxxx: duration=81 seq=6
STACK | 20090930-151120.408 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E1 500
-> tid=5c08b429886a3b62 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151120.408 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E1 500
STACK | 20090930-151121.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E1 2000
-> tid=aa12bf00547ec52d [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151121.787 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E1 2000
STACK | 20090930-151123.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E2 4000
-> tid=aa12bf00547ec52d [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151123.881 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E2 4000
STACK | 20090930-151123.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer E2 4000
-> tid=5c08b429886a3b62 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151123.914 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer E2 4000
INFO | 20090930-151124.542 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
tuselector.cxx:70 | Stats message
WARNING | 20090930-151124.542 | LOAD TEST PHONE 1.0 | RESIP:STATS | 2780 |
statisticsmessage.cxx:152 | RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 2 SERVERTX 0 TIMERS 4
Transaction summary: reqi 170 reqo 206 rspi 190 rspo 171
Details: INVi 67/S71/F0 INVo 72/S50/F40 ACKi 66 ACKo 80 BYEi 37/S37/F0 BYEo
0/S0/F0 CANi 0/S37/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 13/S6/F7 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 0/S0/F0 SUBo
0/S0/F0 NOTi 0/S0/F0 NOTo 0/S0/F0
Retransmissions: INVx 31 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 6 finx 0 nonx 0 PUBx
0 SUBx 0 NOTx 0
STACK | 20090930-151124.882 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer K 5000
-> tid=aa12bf00547ec52d [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151124.882 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer K 5000
STACK | 20090930-151124.920 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:354 | Found matching transaction for Timer: Timer K 5000
-> tid=5c08b429886a3b62 [ ClientNonInvite/Completed unreliable target=[ V4
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151124.920 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: Timer:
Timer K 5000
DEBUG | 20090930-151125.068 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:67 | Refreshing keepalive for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151125.068 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:68 | Keepalive interval 30 seconds
DEBUG | 20090930-151125.068 | LOAD TEST PHONE 1.0 | RESIP:DUM | 3684 |
KeepAliveManager.cxx:69 | Keepalive id 0)
DEBUG | 20090930-151125.068 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 3684 |
timerqueue.cxx:105 | Adding application timer: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ](0)
STACK | 20090930-151125.086 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:151 | Sending keep alive to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151125.099 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-151125.099 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-151125.099 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-151125.099 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=unspecified mFlowKey=840 ] -> [ V4
192.168.1.188:0 UDP target domain=unspecified mFlowKey=840 ] sent-by=
sent-port=0
DEBUG | 20090930-151125.099 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=unspecified mFlowKey=840 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151125.099 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
STACK | 20090930-151135.933 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
Y2E0MWZkYjQ1Y2MwMjU4YzliMGU4NTI4NTdiOTlmYTM.-5e310e77 in map:
STACK | 20090930-151135.933 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151135.933 | LOAD TEST PHONE 1.0 | RESIP | 4696 |
baseexception.cxx:17 | BaseException at .\DialogUsageManager.cxx:1013 Request
no longer exists
INFO | 20090930-151142.421 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
ClientRegistration.cxx:190 | Removing binding
STACK | 20090930-151142.421 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151142.421 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151142.421 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
ClientAuthManager.cxx:324 | Add auth, 03A1ED68 in response to: Digest
algorithm=MD5,realm="asterisk",nonce="5efbfd89",stale=true
DEBUG | 20090930-151142.421 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
ClientAuthManager.cxx:349 | ClientAuthManager::RealmState::addAuthentication,
proxy: 0 Digest
username="108",realm="asterisk",nonce="5efbfd89",uri="sip:192.168.1.100",response="588bf0049d4b9306bed4bfe0d357a18b",algorithm=MD5
DEBUG | 20090930-151142.421 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:867 | SEND:
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-ce6a01077509ab26-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108;rinstance=4a5e5f26184763f1>;expires=0
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 14 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="5efbfd89",uri="sip:192.168.1.100",response="588bf0049d4b9306bed4bfe0d357a18b",algorithm=MD5
Content-Length: 0
STACK | 20090930-151142.422 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1959 | Looking for dialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 in map:
STACK | 20090930-151142.422 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1960 |
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
DEBUG | 20090930-151142.422 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogId.cxx:50 | DialogId::DialogId:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65-
DEBUG | 20090930-151142.422 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1001 | Send: SipReq: REGISTER 192.168.1.100
tid=ce6a01077509ab26 cseq=REGISTER contact=108 / 14 from(tu)
DEBUG | 20090930-151142.422 | LOAD TEST PHONE 1.0 | RESIP | 4696 |
sipstack.cxx:316 | SEND: SipReq: REGISTER 192.168.1.100 tid=ce6a01077509ab26
cseq=REGISTER contact=108 / 14 from(tu)
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:389 | No matching transaction for SipReq: REGISTER
192.168.1.100 tid=ce6a01077509ab26 cseq=REGISTER contact=108 / 14 from(tu)
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:56 | Creating new TransactionState: tid=ce6a01077509ab26 [
ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target
domain=unspecified mFlowKey=0 ]]
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:661 | TransactionState::processClientNonInvite: SipReq:
REGISTER 192.168.1.100 tid=ce6a01077509ab26 cseq=REGISTER contact=108 / 14
from(tu)
DEBUG | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer F tid=ce6a01077509ab26 ms=32000
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:2005 | sendToWire with no dns result: tid=ce6a01077509ab26
[ ClientNonInvite/Trying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:316 | Looking up dns entries for sip:192.168.1.100
DEBUG | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:207 | DnsResult::lookup sip:192.168.1.100
DEBUG | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:391 | Numeric result so return immediately: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1832 | tid=ce6a01077509ab26 [ ClientNonInvite/Trying
reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified
mFlowKey=0 ]] got DNS result: 192.168.1.100 --> [[ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]]
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:DNS | 2780 |
dnsresult.cxx:187 | Returning next dns entry: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
STACK | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
transactionstate.cxx:1873 | Unreliable transport: tid=ce6a01077509ab26 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
DEBUG | 20090930-151142.425 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
timerqueue.cxx:85 | Adding timer: Timer E1 tid=ce6a01077509ab26 ms=500
DEBUG | 20090930-151142.428 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:361 | Best Route - subnet=192.168.1.0 net-mask=255.255.255.0
next-hop=0.0.0.0 if-index=12
DEBUG | 20090930-151142.428 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 1/2 if-index=1 NIC IP=127.0.0.1 NIC
Mask=255.0.0.0
DEBUG | 20090930-151142.428 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
wincompat.cxx:371 | IP Table entry 2/2 if-index=12 NIC IP=192.168.1.188 NIC
Mask=255.255.255.0
DEBUG | 20090930-151142.428 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:562 | Looked up source for destination: [ V4
192.168.1.100:5060 UDP target domain=192.168.1.100 mFlowKey=0 ] -> [ V4
192.168.1.188:0 UDP target domain=192.168.1.100 mFlowKey=0 ] sent-by=
sent-port=0
DEBUG | 20090930-151142.428 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1107 | findTransportBySource([ V4 192.168.1.188:0 UDP
target domain=192.168.1.100 mFlowKey=0 ])
DEBUG | 20090930-151142.428 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:1219 | findTransport (any port, any interface) =>
Transport: [ V4 0.0.0.0:5059 UDP target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151142.429 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transportselector.cxx:940 | Transmitting to [ V4 192.168.1.100:5060 UDP target
domain=192.168.1.100 mFlowKey=0 ] tlsDomain= via [ V4 192.168.1.188:5059 UDP
target domain=192.168.1.100 mFlowKey=0 ]
REGISTER sip:192.168.1.100 SIP/2.0
Via: SIP/2.0/UDP
192.168.1.188:5059;branch=z9hG4bK-d8754z-ce6a01077509ab26-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:108@xxxxxxxxxxxxx:5059;rinstance=4a5e5f26184763f1>;expires=0
To: <sip:108@xxxxxxxxxxxxx>
From: <sip:108@xxxxxxxxxxxxx>;tag=6a73eb65
Call-ID: YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.
CSeq: 14 REGISTER
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, REGISTER,
SUBSCRIBE, INFO
Supported: replaces
User-Agent: LOAD TEST PHONE
Authorization: Digest
username="108",realm="asterisk",nonce="5efbfd89",uri="sip:192.168.1.100",response="588bf0049d4b9306bed4bfe0d357a18b",algorithm=MD5
Content-Length: 0
DEBUG | 20090930-151142.429 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 2780 |
transport.cxx:213 | Adding message to tx buffer to: [ V4 192.168.1.100:5060 UDP
target domain=192.168.1.100 mFlowKey=0 ]
WARNING | 20090930-151142.499 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:250 | force shutdown
DEBUG | 20090930-151142.499 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
HandleManager.cxx:93 | Waiting for usages to be deleted (2)
DEBUG | 20090930-151142.499 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
HandleManager.cxx:96 | 1 -> AppDialogSet 1
DEBUG | 20090930-151142.499 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
HandleManager.cxx:96 | 2 -> ClientRegistration sip:108@xxxxxxxxxxxxx
INFO | 20090930-151142.499 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:214 | DialogUsageManager::onAllHandlesDestroyed:
removing TU
INFO | 20090930-151142.504 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 2780 |
tuselector.cxx:40 | TransactionUserMessage::RemoveTransactionUser TU:
DialogUsageManager size=0
INFO | 20090930-151142.509 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1143 | TU unregistered
WARNING | 20090930-151142.529 | LOAD TEST PHONE 1.0 | RESIP | 2780 |
stackthread.cxx:45 | Shutting down stack thread
DEBUG | 20090930-151143.119 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:137 | DialogUsageManager::mDialogSetMap has 1 DialogSets
DEBUG | 20090930-151143.119 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:141 |
DialgSetId:YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65
DEBUG | 20090930-151143.119 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
ClientRegistration.cxx:60 | ClientRegistration::~ClientRegistration
DEBUG | 20090930-151143.119 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
KeepAliveManager.cxx:49 | Association removed for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
DEBUG | 20090930-151143.119 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
KeepAliveManager.cxx:53 | Keepalive 0 removed
DEBUG | 20090930-151143.119 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
KeepAliveManager.cxx:54 | No more association for [ V4 192.168.1.100:5060 UDP
target domain=unspecified mFlowKey=840 ]
INFO | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1043 | DialogUsageManager::destroy() not posting to stack
STACK | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
Handled.cxx:23 | &&&&&& ~Handled 2 this(03A1FD78) 03889B30
DEBUG | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogSet.cxx:123 | ********** DialogSet::~DialogSet:
YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65*************
STACK | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1997 | ************* Removing DialogSet ***************
STACK | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:1998 | Before:
[YTAwZGJiYTJiNmQ5MTVmMjFjZjFlOWVjZWUwMWNkMDU.-6a73eb65 -> 03E58910]
STACK | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
DialogUsageManager.cxx:2000 | After: []
STACK | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:DUM | 4696 |
Handled.cxx:23 | &&&&&& ~Handled 1 this(03E561F8) 03889B30
DEBUG | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP | 4696 |
sipstack.cxx:90 | SipStack::~SipStack()
DEBUG | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP | 4696 |
security.cxx:915 | BaseSecurity::~BaseSecurity
DEBUG | 20090930-151143.120 | LOAD TEST PHONE 1.0 | RESIP:TRANSACTION | 4696 |
transactionmap.cxx:18 | ce6a01077509ab26 -> 03F3DF78: tid=ce6a01077509ab26 [
ClientNonInvite/Trying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
target domain=unspecified mFlowKey=0 ]]
INFO | 20090930-151143.121 | LOAD TEST PHONE 1.0 | RESIP:TRANSPORT | 4696 |
udptransport.cxx:67 | Shutting down [ V4 0.0.0.0:5059 UDP target
domain=unspecified mFlowKey=840 ]