16:09:07.378|.\Call.cpp(48)|Log5||??:Currently active calls [none]
16:09:07.943|.\RegistrarDB.cpp(305)|Trace5||RegistrarDB::getAllContactIds:There's 27 contact(s) registered
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=d0ea400c6faef20a; expires in 279
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=1e5c7674e310f02b; expires in 279
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=bcb2c750b435d835; expires in 279
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=7b7e1471a7d36d56; expires in 280
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:*[email protected]:40000;rinstance=10d60c21a58c1d02; expires in 279
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=783887833ab6ed92; expires in 280
16:09:07.943|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=a896d0031e0794c4; expires in 279
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=32f582c9dc914162; expires in 289
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=5e2ae4b27d522892; expires in 280
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:5488; expires in 96
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:5100;user=phone; expires in 333
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=27bfa90cc80741d9; expires in 289
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=9548e2fe83b17d3c; expires in 289
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=1d2da71bf43c0737; expires in 289
16:09:07.944|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=c9b8c5d0e57ceb2c; expires in 279
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=69a7c3604675f8a9; expires in 279
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=71bed7fd37f5c94c; expires in 279
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=4de93dc5aa505c66; expires in 279
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=0347b5ffa113ba9f; expires in 279
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=4cdd34279a0678ed; expires in 280
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:*[email protected]:40000;rinstance=69e971c725bc31c2; expires in 279
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=cc31634186d93af5; expires in 280
16:09:07.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=a859b927a8376531; expires in 289
16:09:07.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:52113;rinstance=b8949f572af0e859; expires in 29
16:09:07.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=72ace2a26aa89512; expires in 279
16:09:07.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:*[email protected]:40000;rinstance=73caef594d481bf8; expires in 279
16:09:07.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=6bd1becbde949030; expires in 289
16:09:15.485|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.148|.\ClientRegistration.cxx(279)|Trace5|Resip|::ResipLogger:requesting refresh of ClientRegistration sip:[email protected]:5060
16:09:18.148|.\ClientAuthManager.cxx(319)|Debug8|Resip|::ResipLogger: Add auth, 03B4D708 in response to: Digest realm="sip.skype.com",nonce="4f95c4f300003faddd5ba871de09a589c6618cdca29fe028",stale=true,algorithm=MD5
16:09:18.148|.\ClientAuthManager.cxx(344)|Debug8|Resip|::ResipLogger:ClientAuthManager::RealmState::addAuthentication, proxy: 0 Digest username="6551000115069",realm="sip.skype.com",nonce="4f95c4f300003faddd5ba871de09a589c6618cdca29fe028",uri="sip:sip.skype.com:5060",response="cf0e01425c70d9b00ca6989286bd2d9b",algorithm=MD5
16:09:18.148|.\DialogUsageManager.cxx(866)|Debug8|Resip|::ResipLogger:SEND:
REGISTER sip:sip.skype.com:5060 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-f671d558417fdb5c-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:[email protected]:5060;rinstance=6a250f847867869e>
To: <sip:[email protected]:5060>
From: <sip:[email protected]:5060>;tag=0d33323e
Call-ID: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.
CSeq: 29 REGISTER
Expires: 60
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: 3CXPhoneSystem 10.0.22539.0
Authorization: Digest username="6551000115069",realm="sip.skype.com",nonce="4f95c4f300003faddd5ba871de09a589c6618cdca29fe028",uri="sip:sip.skype.com:5060",response="cf0e01425c70d9b00ca6989286bd2d9b",algorithm=MD5
Content-Length: 0
16:09:18.148|.\DialogId.cxx(50)|Debug8|Resip|::ResipLogger:DialogId::DialogId: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.-0d33323e-
16:09:18.148|.\DialogUsageManager.cxx(999)|Debug8|Resip|::ResipLogger:Send: SipReq: REGISTER sip.skype.com:5060 tid=f671d558417fdb5c cseq=REGISTER [email protected]:5060 / 29 from(tu)
16:09:18.149|.\SipStack.cxx(314)|Debug8|Resip|::ResipLogger:SEND: SipReq: REGISTER sip.skype.com:5060 tid=f671d558417fdb5c cseq=REGISTER [email protected]:5060 / 29 from(tu)
16:09:18.248|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer F tid=f671d558417fdb5c ms=32000
16:09:18.248|.\DnsResult.cxx(214)|Debug8|Resip|::ResipLogger:DnsResult::lookup sip:[email protected];transport=UDP
16:09:18.248|.\dns\DnsStub.cxx(65)|Debug8|Resip|::ResipLogger:_sip._udp.sip.skype.com (SRV) --> p=0 w=0 1.sip.skype.com:5060_sip._udp.sip.skype.com (SRV) --> p=1 w=0 2.sip.skype.com:5060
16:09:18.248|.\dns\DnsStub.cxx(47)|Debug8|Resip|::ResipLogger:1.sip.skype.com(A)--> 63.209.144.201
16:09:18.248|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer E1 tid=f671d558417fdb5c ms=500
16:09:18.252|.\TransportSelector.cxx(562)|Debug8|Resip|::ResipLogger:Looked up source for destination: [ V4 63.209.144.201:5060 UDP target domain=sip.skype.com mFlowKey=0 ] -> [ V4 192.168.15.25:0 UDP target domain=sip.skype.com mFlowKey=0 ] sent-by= sent-port=0
16:09:18.252|.\TransportSelector.cxx(1107)|Debug8|Resip|::ResipLogger:findTransportBySource([ V4 192.168.15.25:0 UDP target domain=sip.skype.com mFlowKey=0 ])
16:09:18.252|.\TransportSelector.cxx(1208)|Debug8|Resip|::ResipLogger:findTransport (any port, specific interface) => Transport: [ V4 192.168.15.25:5060 UDP target domain=unspecified mFlowKey=852 ] on 192.168.15.25
16:09:18.253|.\TransportSelector.cxx(940)|Debug8|Resip|::ResipLogger:Transmitting to [ V4 63.209.144.201:5060 UDP target domain=sip.skype.com mFlowKey=0 ] tlsDomain= via [ V4 192.168.15.25:5060 UDP target domain=sip.skype.com mFlowKey=0 ]
REGISTER sip:sip.skype.com:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.25:5060;branch=z9hG4bK-d8754z-f671d558417fdb5c-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:[email protected]:5060;rinstance=6a250f847867869e>
To: <sip:[email protected]:5060>
From: <sip:[email protected]:5060>;tag=0d33323e
Call-ID: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.
CSeq: 29 REGISTER
Expires: 60
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: 3CXPhoneSystem 10.0.22539.0
Authorization: Digest username="6551000115069",realm="sip.skype.com",nonce="4f95c4f300003faddd5ba871de09a589c6618cdca29fe028",uri="sip:sip.skype.com:5060",response="cf0e01425c70d9b00ca6989286bd2d9b",algorithm=MD5
Content-Length: 0
16:09:18.253|.\Transport.cxx(213)|Debug8|Resip|::ResipLogger:Adding message to tx buffer to: [ V4 63.209.144.201:5060 UDP target domain=sip.skype.com mFlowKey=0 ]
16:09:18.484|.\Transport.cxx(287)|Debug8|Resip|::ResipLogger:incoming from: [ V4 63.209.144.201:5060 UDP target domain=unspecified mFlowKey=852 ]
16:09:18.484|.\DnsResult.cxx(206)|Debug8|Resip|::ResipLogger:Whitelisting _sip._udp.sip.skype.com(33): 1.sip.skype.com:5060
16:09:18.484|.\dns\RRVip.cxx(129)|Debug8|Resip|::ResipLogger:updating an existing vip: 1.sip.skype.com:5060 with 1.sip.skype.com:5060
16:09:18.485|.\DnsResult.cxx(206)|Debug8|Resip|::ResipLogger:Whitelisting sip.skype.com(1): 63.209.144.201
16:09:18.485|.\dns\RRVip.cxx(129)|Debug8|Resip|::ResipLogger:updating an existing vip: 63.209.144.201 with 63.209.144.201
16:09:18.485|.\TransactionState.cxx(2112)|Debug8|Resip|::ResipLogger:Send to TU: TU: DialogUsageManager size=0
[b]
SIP/2.0 401 Unauthorized[/b]
Via: SIP/2.0/UDP 192.168.15.25:5060;branch=z9hG4bK-d8754z-f671d558417fdb5c-1---d8754z-;rport=5060;received=200.33.148.100
To: <sip:[email protected]:5060>;tag=c97b4d1cb1f3d0da549e06a8d482ef63.1950
From: <sip:[email protected]:5060>;tag=0d33323e
Call-ID: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.
CSeq: 29 REGISTER
Server: OpenSIPS
WWW-Authenticate: Digest realm="sip.skype.com", nonce="4f95c51c0000438e6765c17158c855ea74a29fc356711c90", stale=true, algorithm=MD5
Content-Length: 0
16:09:18.485|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer K tid=f671d558417fdb5c ms=5000
16:09:18.485|.\DialogUsageManager.cxx(1333)|Trace5|Resip|::ResipLogger:Got: SipResp: 401 tid=f671d558417fdb5c cseq=REGISTER / 29 from(wire)
16:09:18.485|.\DialogUsageManager.cxx(1841)|Debug8|Resip|::ResipLogger:DialogUsageManager::processResponse:
SipResp: 401 tid=f671d558417fdb5c cseq=REGISTER / 29 from(wire)
16:09:18.485|.\UserProfile.cxx(158)|Debug8|Resip|::ResipLogger:Found credential for realm: realm=3CXPhoneSystem user=65510001150693CXPhoneSystem
16:09:18.486|.\UserProfile.cxx(135)|Debug8|Resip|::ResipLogger:Adding credential: realm=sip.skype.com user=6551000115069
16:09:18.486|.\ClientAuthManager.cxx(224)|Debug8|Resip|::ResipLogger:ClientAuthManager::RealmState::handleAuth: 03B4D708 Digest realm="sip.skype.com",nonce="4f95c51c0000438e6765c17158c855ea74a29fc356711c90",stale=true,algorithm=MD5 is proxy: 0
16:09:18.486|.\ClientAuthManager.cxx(198)|Debug8|Resip|::ResipLogger:ClientAuthManager::RealmState::transition from cached to current
16:09:18.486|.\UserProfile.cxx(158)|Debug8|Resip|::ResipLogger:Found credential for realm: realm=sip.skype.com user=6551000115069sip.skype.com
16:09:18.486|.\ClientAuthManager.cxx(63)|Debug8|Resip|::ResipLogger:Produced response to digest challenge for UserProfile: <sip:[email protected]:5060>[realm=3CXPhoneSystem user=6551000115069, realm=sip.skype.com user=6551000115069]
16:09:18.486|.\DialogSet.cxx(253)|Debug8|Resip|::ResipLogger:about to re-send request with digest credentials
16:09:18.486|.\ClientAuthManager.cxx(319)|Debug8|Resip|::ResipLogger: Add auth, 03B4D708 in response to: Digest realm="sip.skype.com",nonce="4f95c51c0000438e6765c17158c855ea74a29fc356711c90",stale=true,algorithm=MD5
16:09:18.487|.\ClientAuthManager.cxx(344)|Debug8|Resip|::ResipLogger:ClientAuthManager::RealmState::addAuthentication, proxy: 0 Digest username="6551000115069",realm="sip.skype.com",nonce="4f95c51c0000438e6765c17158c855ea74a29fc356711c90",uri="sip:sip.skype.com:5060",response="49cae829315887ff021627c90085b8cc",algorithm=MD5
16:09:18.487|.\DialogUsageManager.cxx(866)|Debug8|Resip|::ResipLogger:SEND:
REGISTER sip:sip.skype.com:5060 SIP/2.0
Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-6b6afe1c1641e82d-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:[email protected]:5060;rinstance=6a250f847867869e>
To: <sip:[email protected]:5060>
From: <sip:[email protected]:5060>;tag=0d33323e
Call-ID: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.
CSeq: 30 REGISTER
Expires: 60
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: 3CXPhoneSystem 10.0.22539.0
Authorization: Digest username="6551000115069",realm="sip.skype.com",nonce="4f95c51c0000438e6765c17158c855ea74a29fc356711c90",uri="sip:sip.skype.com:5060",response="49cae829315887ff021627c90085b8cc",algorithm=MD5
Content-Length: 0
16:09:18.487|.\DialogId.cxx(50)|Debug8|Resip|::ResipLogger:DialogId::DialogId: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.-0d33323e-
16:09:18.487|.\DialogUsageManager.cxx(999)|Debug8|Resip|::ResipLogger:Send: SipReq: REGISTER sip.skype.com:5060 tid=6b6afe1c1641e82d cseq=REGISTER [email protected]:5060 / 30 from(tu)
16:09:18.488|.\SipStack.cxx(314)|Debug8|Resip|::ResipLogger:SEND: SipReq: REGISTER sip.skype.com:5060 tid=6b6afe1c1641e82d cseq=REGISTER [email protected]:5060 / 30 from(tu)
16:09:18.585|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer F tid=6b6afe1c1641e82d ms=32000
16:09:18.585|.\DnsResult.cxx(214)|Debug8|Resip|::ResipLogger:DnsResult::lookup sip:[email protected];transport=UDP
16:09:18.585|.\dns\DnsStub.cxx(65)|Debug8|Resip|::ResipLogger:_sip._udp.sip.skype.com (SRV) --> p=0 w=0 1.sip.skype.com:5060_sip._udp.sip.skype.com (SRV) --> p=1 w=0 2.sip.skype.com:5060
16:09:18.585|.\dns\DnsStub.cxx(47)|Debug8|Resip|::ResipLogger:1.sip.skype.com(A)--> 63.209.144.201
16:09:18.585|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer E1 tid=6b6afe1c1641e82d ms=500
16:09:18.591|.\TransportSelector.cxx(562)|Debug8|Resip|::ResipLogger:Looked up source for destination: [ V4 63.209.144.201:5060 UDP target domain=sip.skype.com mFlowKey=0 ] -> [ V4 192.168.15.25:0 UDP target domain=sip.skype.com mFlowKey=0 ] sent-by= sent-port=0
16:09:18.591|.\TransportSelector.cxx(1107)|Debug8|Resip|::ResipLogger:findTransportBySource([ V4 192.168.15.25:0 UDP target domain=sip.skype.com mFlowKey=0 ])
16:09:18.591|.\TransportSelector.cxx(1208)|Debug8|Resip|::ResipLogger:findTransport (any port, specific interface) => Transport: [ V4 192.168.15.25:5060 UDP target domain=unspecified mFlowKey=852 ] on 192.168.15.25
16:09:18.591|.\TransportSelector.cxx(940)|Debug8|Resip|::ResipLogger:Transmitting to [ V4 63.209.144.201:5060 UDP target domain=sip.skype.com mFlowKey=0 ] tlsDomain= via [ V4 192.168.15.25:5060 UDP target domain=sip.skype.com mFlowKey=0 ]
REGISTER sip:sip.skype.com:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.25:5060;branch=z9hG4bK-d8754z-6b6afe1c1641e82d-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:[email protected]:5060;rinstance=6a250f847867869e>
To: <sip:[email protected]:5060>
From: <sip:[email protected]:5060>;tag=0d33323e
Call-ID: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.
CSeq: 30 REGISTER
Expires: 60
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Supported: replaces
User-Agent: 3CXPhoneSystem 10.0.22539.0
Authorization: Digest username="6551000115069",realm="sip.skype.com",nonce="4f95c51c0000438e6765c17158c855ea74a29fc356711c90",uri="sip:sip.skype.com:5060",response="49cae829315887ff021627c90085b8cc",algorithm=MD5
Content-Length: 0
16:09:18.591|.\Transport.cxx(213)|Debug8|Resip|::ResipLogger:Adding message to tx buffer to: [ V4 63.209.144.201:5060 UDP target domain=sip.skype.com mFlowKey=0 ]
16:09:18.817|.\Transport.cxx(287)|Debug8|Resip|::ResipLogger:incoming from: [ V4 63.209.144.201:5060 UDP target domain=unspecified mFlowKey=852 ]
16:09:18.817|.\DnsResult.cxx(206)|Debug8|Resip|::ResipLogger:Whitelisting _sip._udp.sip.skype.com(33): 1.sip.skype.com:5060
16:09:18.817|.\dns\RRVip.cxx(129)|Debug8|Resip|::ResipLogger:updating an existing vip: 1.sip.skype.com:5060 with 1.sip.skype.com:5060
16:09:18.817|.\DnsResult.cxx(206)|Debug8|Resip|::ResipLogger:Whitelisting sip.skype.com(1): 63.209.144.201
16:09:18.817|.\dns\RRVip.cxx(129)|Debug8|Resip|::ResipLogger:updating an existing vip: 63.209.144.201 with 63.209.144.201
16:09:18.817|.\TransactionState.cxx(2112)|Debug8|Resip|::ResipLogger:Send to TU: TU: DialogUsageManager size=4
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.15.25:5060;branch=z9hG4bK-d8754z-6b6afe1c1641e82d-1---d8754z-;rport=5060;received=200.33.148.100
Contact: <sip:[email protected]:5060;rinstance=6a250f847867869e;transport=udp>;expires=45
To: <sip:[email protected]:5060>;tag=c97b4d1cb1f3d0da549e06a8d482ef63.ade7
From: <sip:[email protected]:5060>;tag=0d33323e
Call-ID: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.
CSeq: 30 REGISTER
Expires: 45
Server: OpenSIPS
Content-Length: 0
16:09:18.817|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer K tid=6b6afe1c1641e82d ms=5000
16:09:18.818|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.818|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.818|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.818|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.818|.\DialogUsageManager.cxx(1333)|Trace5|Resip|::ResipLogger:Got: SipResp: 200 tid=6b6afe1c1641e82d cseq=REGISTER [email protected]:5060 / 30 from(wire)
16:09:18.818|.\DialogUsageManager.cxx(1841)|Debug8|Resip|::ResipLogger:DialogUsageManager::processResponse:
SipResp: 200 tid=6b6afe1c1641e82d cseq=REGISTER [email protected]:5060 / 30 from(wire)
16:09:18.818|.\UserProfile.cxx(158)|Debug8|Resip|::ResipLogger:Found credential for realm: realm=3CXPhoneSystem user=65510001150693CXPhoneSystem
16:09:18.818|.\ClientAuthManager.cxx(41)|Debug8|Resip|::ResipLogger:ClientAuthManager::handle: transitioning Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.-0d33323eto cached
16:09:18.818|.\ClientAuthManager.cxx(198)|Debug8|Resip|::ResipLogger:ClientAuthManager::RealmState::transition from current to cached
16:09:18.819|.\DialogId.cxx(50)|Debug8|Resip|::ResipLogger:DialogId::DialogId: Nzk1NWU2MDEzMTgyODVlMmM3YmRhMDcwODUxOWUwMGE.-0d33323e-c97b4d1cb1f3d0da549e06a8d482ef63.ade7
16:09:18.819|.\ClientRegistration.cxx(402)|Debug8|Resip|::ResipLogger:Clearing service route ([])
16:09:18.819|.\TimerQueue.cxx(105)|Debug8|Resip|::ResipLogger:Adding application timer: DumTimeout::Registration ClientRegistration sip:[email protected]:5060: duration=40 seq=15
16:09:18.919|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.919|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.919|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.919|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.919|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:18.919|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.019|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.019|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.019|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.419|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.419|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.419|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.419|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:19.419|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:24.497|.\Transport.cxx(287)|Debug8|Resip|::ResipLogger:incoming from: [ V4 192.168.15.3:52113 UDP target domain=unspecified mFlowKey=852 ]
16:09:24.497|.\TransactionUser.cxx(66)|Debug8|Resip|::ResipLogger:Checking if SipReq: REGISTER 192.168.15.25:5060 tid=6f2acd0b045da973 cseq=REGISTER [email protected]:52113 / 25 from(wire) is for me
16:09:24.498|.\TransactionUser.cxx(71)|Debug8|Resip|::ResipLogger:Checking rule...
16:09:24.498|.\MessageFilterRule.cxx(42)|Debug8|Resip|::ResipLogger:Matching rule for:
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-6f2acd0b045da973-1---d8754z-;rport=52113
Max-Forwards: 70
Contact: <sip:[email protected]:52113;rinstance=b8949f572af0e859>
To: "Hector Fdz"<sip:[email protected]:5060>
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 25 REGISTER
Expires: 120
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Proxy-Authorization: Digest username="Ext.1000",realm="3CXPhoneSystem",nonce="414d535c05a6559858:64764571f8f24b25fb8811f93a769545",uri="sip:192.168.15.25:5060",response="7c0e4e0a0636b9cd5c8f1d5597ddc45d",algorithm=MD5
Supported: replaces
User-Agent: 3CXPhone 6.0.18815.0
Content-Length: 0
16:09:24.498|.\TransactionUser.cxx(74)|Debug8|Resip|::ResipLogger:Match!
16:09:24.498|.\Helper.cxx(375)|Debug8|Resip|::ResipLogger:Helper::makeResponse(SipReq: REGISTER 192.168.15.25:5060 tid=6f2acd0b045da973 cseq=REGISTER [email protected]:52113 / 25 from(wire) code=100 reason=
16:09:24.498|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer Trying tid=6f2acd0b045da973 ms=3500
16:09:24.498|.\TransactionState.cxx(2112)|Debug8|Resip|::ResipLogger:Send to TU: TU: DialogUsageManager size=0
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-6f2acd0b045da973-1---d8754z-;rport=52113
Max-Forwards: 70
Contact: <sip:[email protected]:52113;rinstance=b8949f572af0e859>
To: "Hector Fdz"<sip:[email protected]:5060>
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 25 REGISTER
Expires: 120
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Proxy-Authorization: Digest username="Ext.1000",realm="3CXPhoneSystem",nonce="414d535c05a6559858:64764571f8f24b25fb8811f93a769545",uri="sip:192.168.15.25:5060",response="7c0e4e0a0636b9cd5c8f1d5597ddc45d",algorithm=MD5
Supported: replaces
User-Agent: 3CXPhone 6.0.18815.0
Content-Length: 0
16:09:24.499|.\Authorization.cpp(874)|Debug2||FindBlacklistEntry:EBL: IPBL found ip = 192.168.15.3; result = not found
16:09:24.499|.\ServerAuthManager.cxx(337)|Trace5|Resip|::ResipLogger:Requesting credential for Ext.1000 @ 3CXPhoneSystem
16:09:24.499|.\DialogSetId.cxx(34)|Debug8|Resip|::ResipLogger:********** Generated Local Tag ***********
16:09:24.499|.\DialogId.cxx(50)|Debug8|Resip|::ResipLogger:DialogId::DialogId: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.-5d07cb0b-3268b15c
16:09:24.499|.\ServerAuthManager.cxx(51)|Trace5|Resip|::ResipLogger:ServerAuth requested credentials SipReq: REGISTER 192.168.15.25:5060 tid=6f2acd0b045da973 cseq=REGISTER [email protected]:52113 / 25 from(wire)
16:09:24.500|.\Helpers.cpp(32)|Debug2||Helpers::Authenticate:[Auth] Expired nonce: (414d535c05a6559858:64764571f8f24b25fb8811f93a769545) made 108 sec. ago
16:09:24.500|.\ServerAuthManager.cxx(129)|Trace5|Resip|::ResipLogger:Checking for auth result in realm=3CXPhoneSystem A1=
16:09:24.500|.\ServerAuthManager.cxx(202)|Trace5|Resip|::ResipLogger:Nonce expired for Ext.1000
16:09:24.500|.\Helper.cxx(375)|Debug8|Resip|::ResipLogger:Helper::makeResponse(SipReq: REGISTER 192.168.15.25:5060 tid=6f2acd0b045da973 cseq=REGISTER [email protected]:52113 / 25 from(wire) code=407 reason=
16:09:24.500|.\ServerAuthManager.cxx(394)|Trace5|Resip|::ResipLogger:Sending challenge to SipReq: REGISTER 192.168.15.25:5060 tid=6f2acd0b045da973 cseq=REGISTER [email protected]:52113 / 25 from(wire)
16:09:24.500|.\DialogUsageManager.cxx(866)|Debug8|Resip|::ResipLogger:SEND:
[b]
SIP/2.0 407 Proxy Authentication Required[/b]
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-6f2acd0b045da973-1---d8754z-;rport=52113
Proxy-Authenticate: Digest nonce="414d535c05a6560415:511be7e24f45a0a9ed3a726d1dc58965",algorithm=MD5,realm="3CXPhoneSystem"
To: "Hector Fdz"<sip:[email protected]:5060>;tag=3334b156
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 25 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:24.501|.\SipStack.cxx(296)|Debug8|Resip|::ResipLogger:SEND: SipResp: 407 tid=6f2acd0b045da973 cseq=REGISTER / 25 from(tu)
16:09:24.501|.\ServerAuthManager.cxx(110)|Trace5|Resip|::ResipLogger:ServerAuth rejected request UserAuthInfo Ext.1000 @ 3CXPhoneSystem A1=
16:09:24.598|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer J tid=6f2acd0b045da973 ms=32000
16:09:24.598|.\TransportSelector.cxx(940)|Debug8|Resip|::ResipLogger:Transmitting to [ V4 192.168.15.3:52113 UDP target domain=unspecified mFlowKey=852 ] tlsDomain= via [ V4 192.168.15.25:5060 UDP target domain=unspecified mFlowKey=852 ]
[b]SIP/2.0 407 Proxy Authentication Required[/b]
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-6f2acd0b045da973-1---d8754z-;rport=52113
Proxy-Authenticate: Digest nonce="414d535c05a6560415:511be7e24f45a0a9ed3a726d1dc58965",algorithm=MD5,realm="3CXPhoneSystem"
To: "Hector Fdz"<sip:[email protected]:5060>;tag=3334b156
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 25 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:24.598|.\Transport.cxx(213)|Debug8|Resip|::ResipLogger:Adding message to tx buffer to: [ V4 192.168.15.3:52113 UDP target domain=unspecified mFlowKey=852 ]
16:09:24.718|.\Transport.cxx(287)|Debug8|Resip|::ResipLogger:incoming from: [ V4 192.168.15.3:52113 UDP target domain=unspecified mFlowKey=852 ]
16:09:24.718|.\TransactionUser.cxx(66)|Debug8|Resip|::ResipLogger:Checking if SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire) is for me
16:09:24.718|.\TransactionUser.cxx(71)|Debug8|Resip|::ResipLogger:Checking rule...
16:09:24.718|.\MessageFilterRule.cxx(42)|Debug8|Resip|::ResipLogger:Matching rule for:
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-2d0b89745907e067-1---d8754z-;rport=52113
Max-Forwards: 70
Contact: <sip:[email protected]:52113;rinstance=b8949f572af0e859>
To: "Hector Fdz"<sip:[email protected]:5060>
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 26 REGISTER
Expires: 120
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Proxy-Authorization: Digest username="Ext.1000",realm="3CXPhoneSystem",nonce="414d535c05a6560415:511be7e24f45a0a9ed3a726d1dc58965",uri="sip:192.168.15.25:5060",response="5afb6107d30f3fffddc42b6639844cdc",algorithm=MD5
Supported: replaces
User-Agent: 3CXPhone 6.0.18815.0
Content-Length: 0
16:09:24.718|.\TransactionUser.cxx(74)|Debug8|Resip|::ResipLogger:Match!
16:09:24.719|.\Helper.cxx(375)|Debug8|Resip|::ResipLogger:Helper::makeResponse(SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire) code=100 reason=
16:09:24.719|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer Trying tid=2d0b89745907e067 ms=3500
16:09:24.719|.\TransactionState.cxx(2112)|Debug8|Resip|::ResipLogger:Send to TU: TU: DialogUsageManager size=0
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-2d0b89745907e067-1---d8754z-;rport=52113
Max-Forwards: 70
Contact: <sip:[email protected]:52113;rinstance=b8949f572af0e859>
To: "Hector Fdz"<sip:[email protected]:5060>
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 26 REGISTER
Expires: 120
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REGISTER, SUBSCRIBE, NOTIFY, REFER, INFO, MESSAGE
Proxy-Authorization: Digest username="Ext.1000",realm="3CXPhoneSystem",nonce="414d535c05a6560415:511be7e24f45a0a9ed3a726d1dc58965",uri="sip:192.168.15.25:5060",response="5afb6107d30f3fffddc42b6639844cdc",algorithm=MD5
Supported: replaces
User-Agent: 3CXPhone 6.0.18815.0
Content-Length: 0
16:09:24.719|.\Authorization.cpp(874)|Debug2||FindBlacklistEntry:EBL: IPBL found ip = 192.168.15.3; result = not found
16:09:24.719|.\ServerAuthManager.cxx(337)|Trace5|Resip|::ResipLogger:Requesting credential for Ext.1000 @ 3CXPhoneSystem
16:09:24.719|.\DialogSetId.cxx(34)|Debug8|Resip|::ResipLogger:********** Generated Local Tag ***********
16:09:24.719|.\DialogId.cxx(50)|Debug8|Resip|::ResipLogger:DialogId::DialogId: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.-b20dba4c-3268b15c
16:09:24.720|.\ServerAuthManager.cxx(51)|Trace5|Resip|::ResipLogger:ServerAuth requested credentials SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire)
16:09:24.720|.\Helpers.cpp(71)|Debug2||Helpers::Authenticate:[Auth] Saving nonce (414d535c05a6560415:511be7e24f45a0a9ed3a726d1dc58965) for user [Ext.1000] at pos=1
16:09:24.720|.\ServerAuthManager.cxx(129)|Trace5|Resip|::ResipLogger:Checking for auth result in realm=3CXPhoneSystem A1=
16:09:24.720|.\ServerAuthManager.cxx(214)|Trace5|Resip|::ResipLogger:Authorized request for 3CXPhoneSystem
16:09:24.721|.\Authorization.cpp(151)|Trace5|Authorization|AuthMgr::onAuthSuccess:Caller "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c has been authenticated successfully
16:09:24.721|.\Authorization.cpp(161)|Trace5|Authorization|AuthMgr::onAuthSuccess:Successful authentication from IP: 192.168.15.3
16:09:24.721|.\DialogUsageManager.cxx(1333)|Trace5|Resip|::ResipLogger:Got: SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire)
16:09:24.721|.\DialogUsageManager.cxx(1651)|Debug8|Resip|::ResipLogger:DialogUsageManager::processRequest: SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire)
16:09:24.721|.\DialogSetId.cxx(34)|Debug8|Resip|::ResipLogger:********** Generated Local Tag ***********
16:09:24.721|.\DialogSetId.cxx(34)|Debug8|Resip|::ResipLogger:********** Generated Local Tag ***********
16:09:24.722|.\DialogSetId.cxx(34)|Debug8|Resip|::ResipLogger:********** Generated Local Tag ***********
16:09:24.722|.\DialogSet.cxx(85)|Debug8|Resip|::ResipLogger: ************* Created DialogSet(UAS) -- NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.-09043d66*************
16:09:24.722|.\DialogSetId.cxx(34)|Debug8|Resip|::ResipLogger:********** Generated Local Tag ***********
16:09:24.722|.\DialogId.cxx(50)|Debug8|Resip|::ResipLogger:DialogId::DialogId: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.-4d6c4a32-3268b15c
16:09:24.722|.\ServerRegistration.cxx(110)|Debug8|Resip|::ResipLogger:got a registration
16:09:24.722|.\RegistrarDB.cpp(285)|Trace5||RegistrarDB::getContacts:Found 1 contact(s) for AOR sip:[email protected]:5060
16:09:24.722|.\ServerRegistration.cxx(248)|Debug8|Resip|::ResipLogger:instance or reg-id missing
16:09:24.723|.\ServerRegistration.cxx(328)|Trace5|Resip|::ResipLogger:Adding sip:[email protected]:5060 -> <sip:[email protected]:52113;rinstance=b8949f572af0e859>
16:09:24.723|.\ServerRegistration.cxx(329)|Debug8|Resip|::ResipLogger:Contact has tuple [ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]
16:09:24.723|.\RegistrarDB.cpp(163)|Trace5||RegistrarDB::updateContact:Update AOR sip:[email protected]:5060 with contact [<sip:[email protected]:52113;rinstance=b8949f572af0e859>]
16:09:24.723|.\RegistrarDB.cpp(181)|Debug2||RegistrarDB::updateContact:Updated; cid = 3151313435
16:09:24.723|.\RegistrarDB.cpp(319)|Trace5||RegistrarDB::getDNsContactIds:There's 1 contact record(s) found for DN 1000
16:09:24.724|.\Helper.cxx(375)|Debug8|Resip|::ResipLogger:Helper::makeResponse(SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire) code=200 reason=
16:09:24.724|.\ServerRegistration.cxx(45)|Trace5|Resip|::ResipLogger:accepted a registration sip:[email protected]:5060
16:09:24.724|.\RegistrarDB.cpp(285)|Trace5||RegistrarDB::getContacts:Found 1 contact(s) for AOR sip:[email protected]:5060
16:09:24.724|.\DialogUsageManager.cxx(866)|Debug8|Resip|::ResipLogger:SEND:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-2d0b89745907e067-1---d8754z-;rport=52113
Contact: <sip:[email protected]:52113;rinstance=b8949f572af0e859>;expires=120
To: "Hector Fdz"<sip:[email protected]:5060>;tag=8028e01c
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 26 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:24.724|.\SipStack.cxx(296)|Debug8|Resip|::ResipLogger:SEND: SipResp: 200 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(tu)
16:09:24.725|.\RegistrarDB.cpp(351)|Debug2||RegistrarDB::findContId:Look for contact: sip:[email protected]:52113;rinstance=b8949f572af0e859
16:09:24.725|.\DevsMgr.cpp(260)|Trace5||Device::updateTransport:Updating device by message: SipReq: REGISTER 192.168.15.25:5060 tid=2d0b89745907e067 cseq=REGISTER [email protected]:52113 / 26 from(wire)
16:09:24.729|.\CallMgr.cpp(1066)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:Check locality of IP 192.168.15.3
16:09:24.729|.\CallMgr.cpp(1072)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:IPADDR(0): addr = 127.0.0.1, mask 255.0.0.0
16:09:24.729|.\CallMgr.cpp(1072)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:IPADDR(1): addr = 192.168.15.25, mask 255.255.255.0
16:09:24.729|.\CallMgr.cpp(1075)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:IP 192.168.15.3 is local
16:09:24.732|.\DevsMgr.cpp(208)|Trace5||Device::update:PBX contact is local IP: sip:[email protected]:5060
16:09:24.738|.\DBAccessor.cpp(1633)|Trace5|DataBase|DBConfigAccessor::addRegistrarContact:Update registration: key=1000;contact=sip:[email protected]:52113;rinstance=b8949f572af0e859; id=28
16:09:24.738|.\DialogUsageManager.cxx(2143)|Debug8|Resip|::ResipLogger:Got merged request removal request
16:09:24.738|.\TimerQueue.cxx(105)|Debug8|Resip|::ResipLogger:Adding application timer:
16:09:24.738|.\DialogSet.cxx(123)|Debug8|Resip|::ResipLogger: ********** DialogSet::~DialogSet: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.-09043d66*************
16:09:24.738|.\RegistrarDB.cpp(351)|Debug2||RegistrarDB::findContId:Look for contact: sip:[email protected]:52113;rinstance=b8949f572af0e859
16:09:24.738|.\ExtnMgr.cpp(758)|Debug2||ExtnMgr::onRegUpdContact:Issue: [pres:1000;2;reg;107]
16:09:24.819|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer J tid=2d0b89745907e067 ms=32000
16:09:24.819|.\TransportSelector.cxx(940)|Debug8|Resip|::ResipLogger:Transmitting to [ V4 192.168.15.3:52113 UDP target domain=unspecified mFlowKey=852 ] tlsDomain= via [ V4 192.168.15.25:5060 UDP target domain=unspecified mFlowKey=852 ]
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.15.3:52113;branch=z9hG4bK-d8754z-2d0b89745907e067-1---d8754z-;rport=52113
Contact: <sip:[email protected]:52113;rinstance=b8949f572af0e859>;expires=120
To: "Hector Fdz"<sip:[email protected]:5060>;tag=8028e01c
From: "Hector Fdz"<sip:[email protected]:5060>;tag=3268b15c
Call-ID: NDA3N2MwZGQzOGM5YTEzNjlhN2ZiZTQyYmFlZGIyZDQ.
CSeq: 26 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:24.819|.\Transport.cxx(213)|Debug8|Resip|::ResipLogger:Adding message to tx buffer to: [ V4 192.168.15.3:52113 UDP target domain=unspecified mFlowKey=852 ]
16:09:28.769|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:28.869|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:28.869|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:29.019|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:29.019|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:29.019|.\DialogUsageManager.cxx(2151)|Debug8|Resip|::ResipLogger:Merged request removed
16:09:37.423|.\TuSelector.cxx(70)|Trace5|Resip|::ResipLogger:Stats message
16:09:37.423|.\StatisticsMessage.cxx(152)|Trace5|Resip|::ResipLogger:RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 2 TIMERS 4
Transaction summary: reqi 174 reqo 60 rspi 60 rspo 173
Details: INVi 0/S0/F0 INVo 0/S0/F0 ACKi 0 ACKo 0 BYEi 0/S0/F0 BYEo 0/S0/F0 CANi 0/S0/F0 CANo 0/S0/F0 MSGi 0/S0/F0 MSGo 0/S0/F0 OPTi 0/S0/F0 OPTo 0/S0/F0 REGi 173/S86/F86 REGo 34/S17/F17 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 1/S0/F1 SUBo 0/S0/F0 NOTi 0/S0/F0 NOTo 26/S0/F26
Retransmissions: INVx 0 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 0 finx 0 nonx 0 PUBx 0 SUBx 0 NOTx 0
16:09:37.945|.\RegistrarDB.cpp(305)|Trace5||RegistrarDB::getAllContactIds:There's 27 contact(s) registered
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=d0ea400c6faef20a; expires in 249
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=1e5c7674e310f02b; expires in 249
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=bcb2c750b435d835; expires in 249
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=7b7e1471a7d36d56; expires in 250
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:*[email protected]:40000;rinstance=10d60c21a58c1d02; expires in 249
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=783887833ab6ed92; expires in 250
16:09:37.945|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=a896d0031e0794c4; expires in 249
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=32f582c9dc914162; expires in 259
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=5e2ae4b27d522892; expires in 250
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:5488; expires in 66
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:5100;user=phone; expires in 303
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=27bfa90cc80741d9; expires in 259
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=9548e2fe83b17d3c; expires in 259
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=1d2da71bf43c0737; expires in 259
16:09:37.946|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=c9b8c5d0e57ceb2c; expires in 249
16:09:37.947|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=69a7c3604675f8a9; expires in 249
16:09:37.947|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=71bed7fd37f5c94c; expires in 249
16:09:37.947|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=4de93dc5aa505c66; expires in 249
16:09:37.947|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=0347b5ffa113ba9f; expires in 249
16:09:37.947|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=4cdd34279a0678ed; expires in 250
16:09:37.947|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:*[email protected]:40000;rinstance=69e971c725bc31c2; expires in 249
16:09:37.948|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40300;rinstance=cc31634186d93af5; expires in 250
16:09:37.948|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=a859b927a8376531; expires in 259
16:09:37.948|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:52113;rinstance=b8949f572af0e859; expires in 107
16:09:37.948|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40000;rinstance=72ace2a26aa89512; expires in 249
16:09:37.948|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:*[email protected]:40000;rinstance=73caef594d481bf8; expires in 249
16:09:37.949|.\Registrar.cpp(97)|Debug2|Registrar|ServRegs::checkExpiration:Checking sip:[email protected]:40600;rinstance=6bd1becbde949030; expires in 259
16:09:39.380|.\Call.cpp(48)|Log5||??:Currently active calls [none]
16:09:40.166|.\Transport.cxx(287)|Debug8|Resip|::ResipLogger:incoming from: [ V4 192.168.15.25:5100 UDP target domain=unspecified mFlowKey=852 ]
16:09:40.166|.\TransactionUser.cxx(66)|Debug8|Resip|::ResipLogger:Checking if SipReq: REGISTER 192.168.15.25:5060 tid=4944F7C7 cseq=REGISTER [email protected]:5100 / 5 from(wire) is for me
16:09:40.166|.\TransactionUser.cxx(71)|Debug8|Resip|::ResipLogger:Checking rule...
16:09:40.167|.\MessageFilterRule.cxx(42)|Debug8|Resip|::ResipLogger:Matching rule for:
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bK4944F7C7
Max-Forwards: 70
Route: <sip:192.168.15.25:5060;lr>
Contact: <sip:[email protected]:5100;user=phone>
To: <sip:[email protected]:5060;user=phone>
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 5 REGISTER
Expires: 600
Allow: INVITE, BYE, ACK, OPTIONS, CANCEL
Proxy-Authorization: Digest username="8888",realm="3CXPhoneSystem",nonce="414d535c05a654e767:00462cc21e3e920d6ad98012a3ac991c",uri="sip:192.168.15.25",response="ba6f84c985b615c5cddc2b5809e5dbbf",algorithm=MD5,cnonce="7012",opaque="",nc=00000002
User-Agent: Netbricks-Sip-T.38IAF/2.01 (PRODUCT ID:5, 05 Jul 2007)
Content-Length: 0
16:09:40.167|.\TransactionUser.cxx(74)|Debug8|Resip|::ResipLogger:Match!
16:09:40.167|.\Helper.cxx(375)|Debug8|Resip|::ResipLogger:Helper::makeResponse(SipReq: REGISTER 192.168.15.25:5060 tid=4944F7C7 cseq=REGISTER [email protected]:5100 / 5 from(wire) code=100 reason=
16:09:40.167|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer Trying tid=4944F7C7 ms=3500
16:09:40.167|.\TransactionState.cxx(2112)|Debug8|Resip|::ResipLogger:Send to TU: TU: DialogUsageManager size=0
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bK4944F7C7
Max-Forwards: 70
Route: <sip:192.168.15.25:5060;lr>
Contact: <sip:[email protected]:5100;user=phone>
To: <sip:[email protected]:5060;user=phone>
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 5 REGISTER
Expires: 600
Allow: INVITE, BYE, ACK, OPTIONS, CANCEL
Proxy-Authorization: Digest username="8888",realm="3CXPhoneSystem",nonce="414d535c05a654e767:00462cc21e3e920d6ad98012a3ac991c",uri="sip:192.168.15.25",response="ba6f84c985b615c5cddc2b5809e5dbbf",algorithm=MD5,cnonce="7012",opaque="",nc=00000002
User-Agent: Netbricks-Sip-T.38IAF/2.01 (PRODUCT ID:5, 05 Jul 2007)
Content-Length: 0
16:09:40.167|.\Authorization.cpp(874)|Debug2||FindBlacklistEntry:EBL: IPBL found ip = 192.168.15.25; result = not found
16:09:40.167|.\ServerAuthManager.cxx(337)|Trace5|Resip|::ResipLogger:Requesting credential for 8888 @ 3CXPhoneSystem
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bK4944F7C7
Proxy-Authenticate: Digest nonce="414d535c05a6561494:97da083cfd60b317c8bc440c2718135e",algorithm=MD5,realm="3CXPhoneSystem"
To: <sip:[email protected]:5060;user=phone>;tag=f57b0c55
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 5 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:40.169|.\SipStack.cxx(296)|Debug8|Resip|::ResipLogger:SEND: SipResp: 407 tid=4944F7C7 cseq=REGISTER / 5 from(tu)
16:09:40.169|.\ServerAuthManager.cxx(110)|Trace5|Resip|::ResipLogger:ServerAuth rejected request UserAuthInfo 8888 @ 3CXPhoneSystem A1=
16:09:40.267|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer J tid=4944F7C7 ms=32000
16:09:40.267|.\TransportSelector.cxx(940)|Debug8|Resip|::ResipLogger:Transmitting to [ V4 192.168.15.25:5100 UDP target domain=unspecified mFlowKey=852 ] tlsDomain= via [ V4 192.168.15.25:5060 UDP target domain=unspecified mFlowKey=852 ]
[b]SIP/2.0 407 Proxy Authentication Required[/b]
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bK4944F7C7
Proxy-Authenticate: Digest nonce="414d535c05a6561494:97da083cfd60b317c8bc440c2718135e",algorithm=MD5,realm="3CXPhoneSystem"
To: <sip:[email protected]:5060;user=phone>;tag=f57b0c55
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 5 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:40.267|.\Transport.cxx(213)|Debug8|Resip|::ResipLogger:Adding message to tx buffer to: [ V4 192.168.15.25:5100 UDP target domain=unspecified mFlowKey=852 ]
16:09:40.268|.\Transport.cxx(287)|Debug8|Resip|::ResipLogger:incoming from: [ V4 192.168.15.25:5100 UDP target domain=unspecified mFlowKey=852 ]
16:09:40.268|.\TransactionUser.cxx(66)|Debug8|Resip|::ResipLogger:Checking if SipReq: REGISTER 192.168.15.25:5060 tid=F0472E44 cseq=REGISTER [email protected]:5100 / 6 from(wire) is for me
16:09:40.268|.\TransactionUser.cxx(71)|Debug8|Resip|::ResipLogger:Checking rule...
16:09:40.268|.\MessageFilterRule.cxx(42)|Debug8|Resip|::ResipLogger:Matching rule for:
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bKF0472E44
Max-Forwards: 70
Route: <sip:192.168.15.25:5060;lr>
Contact: <sip:[email protected]:5100;user=phone>
To: <sip:[email protected]:5060;user=phone>
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 6 REGISTER
Expires: 600
Allow: INVITE, BYE, ACK, OPTIONS, CANCEL
Proxy-Authorization: Digest username="8888",realm="3CXPhoneSystem",nonce="414d535c05a6561494:97da083cfd60b317c8bc440c2718135e",uri="sip:192.168.15.25",response="23c0fa2c635b8c13989414f041ee1300",algorithm=MD5,cnonce="7012",opaque="",nc=00000001
User-Agent: Netbricks-Sip-T.38IAF/2.01 (PRODUCT ID:5, 05 Jul 2007)
Content-Length: 0
16:09:40.268|.\TransactionUser.cxx(74)|Debug8|Resip|::ResipLogger:Match!
16:09:40.268|.\Helper.cxx(375)|Debug8|Resip|::ResipLogger:Helper::makeResponse(SipReq: REGISTER 192.168.15.25:5060 tid=F0472E44 cseq=REGISTER [email protected]:5100 / 6 from(wire) code=100 reason=
16:09:40.268|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer Trying tid=F0472E44 ms=3500
16:09:40.269|.\TransactionState.cxx(2112)|Debug8|Resip|::ResipLogger:Send to TU: TU: DialogUsageManager size=0
REGISTER sip:192.168.15.25:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bKF0472E44
Max-Forwards: 70
Route: <sip:192.168.15.25:5060;lr>
Contact: <sip:[email protected]:5100;user=phone>
To: <sip:[email protected]:5060;user=phone>
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 6 REGISTER
Expires: 600
Allow: INVITE, BYE, ACK, OPTIONS, CANCEL
Proxy-Authorization: Digest username="8888",realm="3CXPhoneSystem",nonce="414d535c05a6561494:97da083cfd60b317c8bc440c2718135e",uri="sip:192.168.15.25",response="23c0fa2c635b8c13989414f041ee1300",algorithm=MD5,cnonce="7012",opaque="",nc=00000001
User-Agent: Netbricks-Sip-T.38IAF/2.01 (PRODUCT ID:5, 05 Jul 2007)
Content-Length: 0
16:09:40.269|.\Authorization.cpp(874)|Debug2||FindBlacklistEntry:EBL: IPBL found ip = 192.168.15.25; result = not found
16:09:40.269|.\ServerAuthManager.cxx(337)|Trace5|Resip|::ResipLogger:Requesting credential for 8888 @ 3CXPhoneSystem
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bKF0472E44
Contact: <sip:[email protected]:5100;user=phone>;expires=600
To: <sip:[email protected]:5060;user=phone>;tag=093bef6e
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 6 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:40.281|.\SipStack.cxx(296)|Debug8|Resip|::ResipLogger:SEND: SipResp: 200 tid=F0472E44 cseq=REGISTER [email protected]:5100 / 6 from(tu)
16:09:40.281|.\RegistrarDB.cpp(351)|Debug2||RegistrarDB::findContId:Look for contact: sip:[email protected]:5100;user=phone
16:09:40.281|.\DevsMgr.cpp(260)|Trace5||Device::updateTransport:Updating device by message: SipReq: REGISTER 192.168.15.25:5060 tid=F0472E44 cseq=REGISTER [email protected]:5100 / 6 from(wire)
16:09:40.284|.\CallMgr.cpp(1066)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:Check locality of IP 192.168.15.25
16:09:40.284|.\CallMgr.cpp(1072)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:IPADDR(0): addr = 127.0.0.1, mask 255.0.0.0
16:09:40.284|.\CallMgr.cpp(1072)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:IPADDR(1): addr = 192.168.15.25, mask 255.255.255.0
16:09:40.284|.\CallMgr.cpp(1075)|Debug2|CallManager|CallMgr::isIpInLocalNetwork:IP 192.168.15.25 is local
16:09:40.287|.\DevsMgr.cpp(208)|Trace5||Device::update:PBX contact is local IP: sip:[email protected]:5060
16:09:40.292|.\DBAccessor.cpp(1633)|Trace5|DataBase|DBConfigAccessor::addRegistrarContact:Update registration: key=8888;contact=sip:[email protected]:5100;user=phone; id=1
16:09:40.292|.\DialogUsageManager.cxx(2143)|Debug8|Resip|::ResipLogger:Got merged request removal request
16:09:40.292|.\TimerQueue.cxx(105)|Debug8|Resip|::ResipLogger:Adding application timer:
16:09:40.292|.\DialogSet.cxx(123)|Debug8|Resip|::ResipLogger: ********** DialogSet::~DialogSet: [email protected]*************
16:09:40.369|.\TimerQueue.cxx(85)|Debug8|Resip|::ResipLogger:Adding timer: Timer J tid=F0472E44 ms=32000
16:09:40.369|.\TransportSelector.cxx(940)|Debug8|Resip|::ResipLogger:Transmitting to [ V4 192.168.15.25:5100 UDP target domain=unspecified mFlowKey=852 ] tlsDomain= via [ V4 192.168.15.25:5060 UDP target domain=unspecified mFlowKey=852 ]
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.15.25:5100;branch=z9hG4bKF0472E44
Contact: <sip:[email protected]:5100;user=phone>;expires=600
To: <sip:[email protected]:5060;user=phone>;tag=093bef6e
From: <sip:[email protected]:5060>;tag=0-6175
Call-ID: [email protected]
CSeq: 6 REGISTER
User-Agent: 3CXPhoneSystem 10.0.22539.0
Content-Length: 0
16:09:40.369|.\Transport.cxx(213)|Debug8|Resip|::ResipLogger:Adding message to tx buffer to: [ V4 192.168.15.25:5100 UDP target domain=unspecified mFlowKey=852 ]