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

Re: [reSIProcate] Register Synchronization

From: 许 <xubonts@xxxxxxx>
Date: Thu, 8 Jan 2015 09:04:46 +0800 (CST)

Thanks,

I check the things you said, but still can't synchronize.

Here are the logs.

At 2015-01-08 01:21:35, "Scott Godin" <sgodin@xxxxxxxxxxxxxxx> wrote:

Hi,

You have only shown the configuration and logs from one of the 2 boxes. Do you have RegSyncPort and RegSyncPeer set on the other box as well? The RegSyncPort needs to match on both boxes.

The only other reason for a lack of synchronization is if the registration is using an outbound/RFC5626 registration. These registrations cannot be sync'd - since outbound registrations are locked to the actual TCP connection.

Regards,
Scott

On Wed, Jan 7, 2015 at 1:40 AM, 许 <xubonts@xxxxxxx> wrote:
Hi, everyone.
I try to use two repros to realize the Registration Synchronization. But I can't do that now.
The two repros have connected through the "RegSyncPort" and "RegSyncPeer".
I can see that on its Web When I register success to the repro1.
But I can't see that registration on the repro2's Web. Does it normal?
I read the introduction http://www.resiprocate.org/Using_Repro#Active_Registration_Replication . And I think all of the repro's Web should appear the same Registrations.

repro.config and repro.log attached.

Please help me analyze, thanks.

Attachment: repro1.config
Description: Binary data

INFO | 20150108-085713.268 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:190 
| Starting repro version 0.9...
INFO | 20150108-085713.270 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:452 
| V4 enabled
INFO | 20150108-085713.270 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:453 
| V6 enabled
INFO | 20150108-085713.286 | repro.exe | RESIP:DNS | 7068 | AresDns.cxx:350 | 
DNS initialization: found  1 name servers
INFO | 20150108-085713.286 | repro.exe | RESIP:DNS | 7068 | AresDns.cxx:361 |  
name server: 172.20.51.149
DEBUG | 20150108-085713.286 | repro.exe | RESIP | 7068 | Compression.cxx:44 | 
COMPRESSION SUPPORT NOT COMPILED IN
DEBUG | 20150108-085713.286 | repro.exe | RESIP | 7068 | Compression.cxx:47 | 
Compression configuration object created; algorithm = 0
DEBUG | 20150108-085713.286 | repro.exe | RESIP:TRANSPORT | 7068 | 
TransportSelector.cxx:97 | No compression library available
INFO | 20150108-085713.287 | repro.exe | RESIP:DNS | 7068 | DnsUtil.cxx:156 | 
local hostname does not contain a domain part DF-XUBO-PC
DEBUG | 20150108-085713.287 | repro.exe | RESIP:TRANSPORT | 7068 | 
InternalTransport.cxx:99 | Creating fd=560 V4/UDP
DEBUG | 20150108-085713.287 | repro.exe | RESIP:TRANSPORT | 7068 | 
InternalTransport.cxx:107 | Binding to 0.0.0.0
INFO | 20150108-085713.287 | repro.exe | RESIP:TRANSPORT | 7068 | 
UdpTransport.cxx:54 | Creating UDP transport host= port=5060 ipv4=1
DEBUG | 20150108-085713.287 | repro.exe | RESIP:TRANSPORT | 7068 | 
UdpTransport.cxx:68 | No compression library available: Transport: [ V4 
0.0.0.0:5060 UDP target domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085713.291 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: 127.0.0.1:5060
DEBUG | 20150108-085713.291 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: 127.0.0.1:5060
DEBUG | 20150108-085713.291 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: 192.168.56.1:5060
DEBUG | 20150108-085713.291 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: 172.20.40.30:5060
DEBUG | 20150108-085713.291 | repro.exe | RESIP:TRANSPORT | 7068 | 
TransportSelector.cxx:225 | Adding transport: [ V4 0.0.0.0:5060 UDP target 
domain=unspecified mFlowKey=0 ]
DEBUG | 20150108-085713.292 | repro.exe | RESIP:TRANSPORT | 7068 | 
InternalTransport.cxx:99 | Creating fd=580 V6/UDP
DEBUG | 20150108-085713.292 | repro.exe | RESIP:TRANSPORT | 7068 | 
InternalTransport.cxx:107 | Binding to ::
INFO | 20150108-085713.292 | repro.exe | RESIP:TRANSPORT | 7068 | 
UdpTransport.cxx:54 | Creating UDP transport host= port=5060 ipv4=0
DEBUG | 20150108-085713.292 | repro.exe | RESIP:TRANSPORT | 7068 | 
UdpTransport.cxx:68 | No compression library available: Transport: [ V6 :: 
port=5060 UDP target domain=unspecified mFlowKey=580 ]
DEBUG | 20150108-085713.300 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: fe80::5efe:c0a8:3801:5060
DEBUG | 20150108-085713.300 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: fe80::5efe:ac14:281e:5060
DEBUG | 20150108-085713.300 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: fe80::100:7f:fffe:5060
DEBUG | 20150108-085713.300 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: ::1:5060
DEBUG | 20150108-085713.300 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: fe80::4c5b:188a:4d63:5154:5060
DEBUG | 20150108-085713.300 | repro.exe | RESIP | 7068 | SipStack.cxx:437 | 
Adding domain alias: fe80::88e1:e06e:3583:b499:5060
DEBUG | 20150108-085713.300 | repro.exe | RESIP:TRANSPORT | 7068 | 
TransportSelector.cxx:225 | Adding transport: [ V6 :: port=5060 UDP target 
domain=unspecified mFlowKey=0 ]
DEBUG | 20150108-085713.300 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:53 
| No BerkeleyDb prefix specified - using default
INFO | 20150108-085713.300 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:61 | 
Using BerkeleyDb prefixed with ./\repro
DEBUG | 20150108-085713.301 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_user.db
DEBUG | 20150108-085713.304 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_user.db
DEBUG | 20150108-085713.304 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_route.db
DEBUG | 20150108-085713.306 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_route.db
DEBUG | 20150108-085713.306 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_acl.db
DEBUG | 20150108-085713.309 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_acl.db
DEBUG | 20150108-085713.309 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_config.db
DEBUG | 20150108-085713.312 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_config.db
DEBUG | 20150108-085713.312 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_staticreg.db
DEBUG | 20150108-085713.314 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_staticreg.db
DEBUG | 20150108-085713.314 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_filter.db
DEBUG | 20150108-085713.316 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_filter.db
DEBUG | 20150108-085713.316 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_silo.db
DEBUG | 20150108-085713.319 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_silo.db
DEBUG | 20150108-085713.319 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:182 
| About to open secondary Berkeley DB: ./\repro_silo_idx1.db
DEBUG | 20150108-085713.321 | repro.exe | REPRO:APP | 7068 | BerkeleyDb.cxx:209 
| Opened secondary Berkeley DB: ./\repro_silo_idx1.db
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:41 | Instantiating new RequestProcessor chain
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: StrictRouteFixup
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: IsTrustedNode
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: 
DigestAuthenticator
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: AmIResponsible
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: RequestFilter
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: StaticRoute
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: LocationServer
INFO | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:806 
| RequestProcessor chain: [StrictRouteFixup, IsTrustedNode, 
DigestAuthenticator, AmIResponsible, RequestFilter, StaticRoute, LocationServer]
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:41 | Instantiating new ResponseProcessor chain
DEBUG | 20150108-085713.322 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new ResponseProcessor to chain: 
OutboundTargetHandler
INFO | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:812 
| ResponseProcessor chain: [OutboundTargetHandler]
DEBUG | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:41 | Instantiating new TargetProcessor chain
DEBUG | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new TargetProcessor to chain: QValueTargetHandler
DEBUG | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | 
ProcessorChain.cxx:58 | Adding new TargetProcessor to chain: SimpleTargetHandler
INFO | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:818 
| TargetProcessor chain: [QValueTargetHandler, SimpleTargetHandler]
INFO | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:976 
| Adding domain 172.20.40.30 from config
INFO | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | ReproRunner.cxx:976 
| Adding domain 172.20.51.140 from config
DEBUG | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | HttpBase.cxx:78 | 
Creating fd=976 V4/
DEBUG | 20150108-085713.323 | repro.exe | REPRO:APP | 7068 | HttpBase.cxx:93 | 
Binding to 0.0.0.0
DEBUG | 20150108-085713.324 | repro.exe | REPRO:APP | 7068 | WebAdmin.cxx:90 |  
Looking to see if admin user exists (creating WebAdmin)
DEBUG | 20150108-085713.324 | repro.exe | REPRO:APP | 7068 | WebAdmin.cxx:111 | 
Changing the web admin password
DEBUG | 20150108-085713.342 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=1020 
V4/
DEBUG | 20150108-085713.342 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to 0.0.0.0
DEBUG | 20150108-085713.342 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=1040 
V6/
DEBUG | 20150108-085713.342 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to ::
DEBUG | 20150108-085713.343 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=1084 
V4/
DEBUG | 20150108-085713.343 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to 0.0.0.0
DEBUG | 20150108-085713.343 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=1104 
V6/
DEBUG | 20150108-085713.343 | repro.exe | REPRO:APP | 7068 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to ::
INFO | 20150108-085713.344 | repro.exe | REPRO:APP | 8436 | Proxy.cxx:143 | 
Proxy::thread start
INFO | 20150108-085713.348 | repro.exe | REPRO:APP | 9500 | 
RegSyncClient.cxx:214 | RegSyncClient::handleXml: InitialSync complete.
DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.146:5060 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 
20000000011180100600@172.20.40.30:5060 tid=1208430356 cseq=3 REGISTER 
contact=20000000011180100600@172.20.51.146:5060 / 3 from(wire) is for me
DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:20000000011180100600@172.20.40.30:5060 SIP/2.0

Via: SIP/2.0/UDP 172.20.51.146:5060;rport=5060;branch=z9hG4bK1208430356

Max-Forwards: 70

Contact: <sip:20000000011180100600@172.20.51.146:5060>

To: <sip:20000000011180100600@2000000001>

From: <sip:20000000011180100600@2000000001>;tag=535622003

Call-ID: 541394626

CSeq: 3 REGISTER

Expires: 300

User-Agent: IP DOME

Content-Length: 0




DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085734.592 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 20000000011180100600@172.20.40.30:5060 
tid=1208430356 cseq=3 REGISTER contact=20000000011180100600@172.20.51.146:5060 
/ 3 from(wire) code=100 reason=
DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=1208430356 ms=3500
DEBUG | 20150108-085734.592 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:20000000011180100600@172.20.40.30:5060 SIP/2.0

Via: SIP/2.0/UDP 172.20.51.146:5060;rport=5060;branch=z9hG4bK1208430356

Max-Forwards: 70

Contact: <sip:20000000011180100600@172.20.51.146:5060>

To: <sip:20000000011180100600@2000000001>

From: <sip:20000000011180100600@2000000001>;tag=535622003

Call-ID: 541394626

CSeq: 3 REGISTER

Expires: 300

User-Agent: IP DOME

Content-Length: 0




INFO | 20150108-085734.593 | repro.exe | REPRO:APP | 9912 | AclStore.cxx:532 | 
AclStore - source address NOT trusted: 172.20.51.146:5060 UDP
DEBUG | 20150108-085734.593 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 20000000011180100600@172.20.40.30:5060 
tid=1208430356 cseq=3 REGISTER contact=20000000011180100600@172.20.51.146:5060 
/ 3 from(wire) code=407 reason=
INFO | 20150108-085734.593 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:416 | Sending challenge to SipReq:  REGISTER 
20000000011180100600@172.20.40.30:5060 tid=1208430356 cseq=3 REGISTER 
contact=20000000011180100600@172.20.51.146:5060 / 3 from(wire)
DEBUG | 20150108-085734.593 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/UDP 172.20.51.146:5060;rport=5060;branch=z9hG4bK1208430356

Proxy-Authenticate: Digest 
nonce="13065152254:345422d2623d547e94d382a738a04927",algorithm=MD5,realm="172.20.40.30",qop="auth,auth-int"

To: <sip:20000000011180100600@2000000001>;tag=b53d0b41

From: <sip:20000000011180100600@2000000001>;tag=535622003

Call-ID: 541394626

CSeq: 3 REGISTER

Content-Length: 0




DEBUG | 20150108-085734.593 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 407 tid=1208430356 cseq=3 REGISTER / 3 from(tu)
INFO | 20150108-085734.593 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:46 | ServerAuth challenged request SipReq:  REGISTER 
20000000011180100600@172.20.40.30:5060 tid=1208430356 cseq=3 REGISTER 
contact=20000000011180100600@172.20.51.146:5060 / 3 from(wire)
DEBUG | 20150108-085734.593 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=1208430356 ms=32000
DEBUG | 20150108-085734.598 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.146:5060 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.146 sent-port=5060
DEBUG | 20150108-085734.598 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.146:5060 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/UDP 172.20.51.146:5060;rport=5060;branch=z9hG4bK1208430356

Proxy-Authenticate: Digest 
nonce="13065152254:345422d2623d547e94d382a738a04927",algorithm=MD5,realm="172.20.40.30",qop="auth,auth-int"

To: <sip:20000000011180100600@2000000001>;tag=b53d0b41

From: <sip:20000000011180100600@2000000001>;tag=535622003

Call-ID: 541394626

CSeq: 3 REGISTER

Content-Length: 0



sigcomp id=
DEBUG | 20150108-085742.974 | repro.exe | REPRO:APP | 3128 | 
XmlRpcServerBase.cxx:208 | XmlRpcServerBase::process: Received TCP connection 
as connection=1 fd=1276
DEBUG | 20150108-085742.975 | repro.exe | REPRO:APP | 3128 | 
RegSyncServer.cxx:91 | RegSyncServer::handleRequest:  connectionId=1, 
requestId=1, request=<InitialSync>

  <Request>

     <Version>3</Version>

  </Request>

</InitialSync>
INFO | 20150108-085742.975 | repro.exe | REPRO:APP | 3128 | 
RegSyncServer.cxx:118 | RegSyncServer::handleInitialSyncRequest
DEBUG | 20150108-085742.975 | repro.exe | REPRO:APP | 3128 | 
XmlRpcConnection.cxx:197 | XmlRpcConnection::processSomeWrites - Wrote it all
DEBUG | 20150108-085751.372 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085751.372 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f746e-236f5643 cseq=1 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 1 from(wire) is for me
DEBUG | 20150108-085751.372 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085751.372 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f746e-236f5643

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 1 REGISTER

Expires: 3600

Content-Length: 0




DEBUG | 20150108-085751.372 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085751.372 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f746e-236f5643 cseq=1 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 1 from(wire) code=100 reason=
DEBUG | 20150108-085751.373 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=-1fa5bf-7b9f746e-236f5643 
ms=3500
DEBUG | 20150108-085751.373 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f746e-236f5643

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 1 REGISTER

Expires: 3600

Content-Length: 0




INFO | 20150108-085751.373 | repro.exe | REPRO:APP | 9912 | AclStore.cxx:532 | 
AclStore - source address NOT trusted: 172.20.51.140:6062 UDP
DEBUG | 20150108-085751.373 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f746e-236f5643 cseq=1 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 1 from(wire) code=407 reason=
INFO | 20150108-085751.373 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:416 | Sending challenge to SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f746e-236f5643 cseq=1 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 1 from(wire)
DEBUG | 20150108-085751.373 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f746e-236f5643

Proxy-Authenticate: Digest 
nonce="13065152271:ca1622a8cb0a5faaf8892e890407149d",algorithm=MD5,realm="172.20.40.30",qop="auth,auth-int"

To: <sip:010010000503010000@172.20.40.30>;tag=5647a023

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 1 REGISTER

Content-Length: 0




DEBUG | 20150108-085751.373 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 407 tid=-1fa5bf-7b9f746e-236f5643 cseq=1 REGISTER / 1 from(tu)
INFO | 20150108-085751.373 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:46 | ServerAuth challenged request SipReq:  REGISTER 
172.20.40.30 tid=-1fa5bf-7b9f746e-236f5643 cseq=1 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 1 from(wire)
DEBUG | 20150108-085751.373 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=-1fa5bf-7b9f746e-236f5643 ms=32000
DEBUG | 20150108-085751.378 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.140:6062 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.140 sent-port=6062
DEBUG | 20150108-085751.378 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f746e-236f5643

Proxy-Authenticate: Digest 
nonce="13065152271:ca1622a8cb0a5faaf8892e890407149d",algorithm=MD5,realm="172.20.40.30",qop="auth,auth-int"

To: <sip:010010000503010000@172.20.40.30>;tag=5647a023

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 1 REGISTER

Content-Length: 0



sigcomp id=
DEBUG | 20150108-085751.400 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085751.400 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(wire) is for me
DEBUG | 20150108-085751.400 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085751.400 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f748a-43c80203

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 2 REGISTER

Expires: 3600

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152271:ca1622a8cb0a5faaf8892e890407149d",uri="sip:172.20.40.30",response="dd8e1f0eb25444160c5b4c20530eb46a",algorithm=MD5,cnonce="7b9f748a",qop=auth,nc=00000001

Content-Length: 0




DEBUG | 20150108-085751.401 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085751.401 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(wire) code=100 reason=
DEBUG | 20150108-085751.401 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=-1fa5bf-7b9f748a-43c80203 
ms=3500
DEBUG | 20150108-085751.401 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f748a-43c80203

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 2 REGISTER

Expires: 3600

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152271:ca1622a8cb0a5faaf8892e890407149d",uri="sip:172.20.40.30",response="dd8e1f0eb25444160c5b4c20530eb46a",algorithm=MD5,cnonce="7b9f748a",qop=auth,nc=00000001

Content-Length: 0




INFO | 20150108-085751.401 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:359 | Requesting credential for 010010000503010000 @ 
172.20.40.30
INFO | 20150108-085751.401 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:52 | ServerAuth requested credentials SipReq:  REGISTER 
172.20.40.30 tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(wire)
DEBUG | 20150108-085751.401 | repro.exe | REPRO:APP | 8652 | 
repro/UserAuthGrabber.hxx:47 | Grabbed user info for 
010010000503010000@172.20.40.30 : 48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085751.401 | repro.exe | RESIP:TRANSACTION | 8652 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

UserAuthInfo 010010000503010000 @ 172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
INFO | 20150108-085751.401 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:130 | Checking for auth result in realm=172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085751.401 | repro.exe | RESIP | 9912 | Helper.cxx:774 | 
Authenticating: realm=172.20.40.30 expires=3000
INFO | 20150108-085751.401 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:215 | Authorized request for 172.20.40.30
INFO | 20150108-085751.401 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1591 | Got: SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(wire)
DEBUG | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1947 | DialogUsageManager::processRequest: SipReq:  
REGISTER 172.20.40.30 tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(wire)
DEBUG | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:84 | 
 ************* Created DialogSet(UAS) *************: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-1d636932
DEBUG | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | DialogId.cxx:50 | 
DialogId::DialogId: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-6d5a6b6b-1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf
DEBUG | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:176 | got a registration
DEBUG | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:195 | InMemorySyncRegDb::lockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
INFO | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:379 | Adding sip:010010000503010000@172.20.40.30 -> 
<sip:010010000503010000@172.20.51.140:6062>
DEBUG | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:380 | Contact has tuple [ V4 172.20.51.140:6062 UDP 
target domain=unspecified mFlowKey=560 ] and detected public address [ V4 
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]
DEBUG | 20150108-085751.402 | repro.exe | REPRO:APP | 9912 | Registrar.cxx:84 | 
Registrar::onAdd SipReq:  REGISTER 172.20.40.30 tid=-1fa5bf-7b9f748a-43c80203 
cseq=2 REGISTER contact=010010000503010000@172.20.51.140:6062 / 2 from(wire)
DEBUG | 20150108-085751.402 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(wire) code=200 reason=
INFO | 20150108-085751.402 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:49 | accepted a registration 
sip:010010000503010000@172.20.40.30
DEBUG | 20150108-085751.403 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:216 | InMemorySyncRegDb::unlockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
DEBUG | 20150108-085751.403 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f748a-43c80203

Contact: <sip:010010000503010000@172.20.51.140:6062>;expires=3600

To: <sip:010010000503010000@172.20.40.30>;tag=cb571430

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 2 REGISTER

Content-Length: 0




DEBUG | 20150108-085751.403 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 200 tid=-1fa5bf-7b9f748a-43c80203 cseq=2 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 2 from(tu)
DEBUG | 20150108-085751.403 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=-1fa5bf-7b9f748a-43c80203 ms=32000
DEBUG | 20150108-085751.403 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:2442 | Got merged request removal request
DEBUG | 20150108-085751.403 | repro.exe | RESIP:TRANSACTION | 9912 | 
TimerQueue.cxx:97 | Adding application timer:  ms=32000
DEBUG | 20150108-085751.403 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:122 
|  ********** DialogSet::~DialogSet: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-1d636932*************
DEBUG | 20150108-085751.407 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.140:6062 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.140 sent-port=6062
DEBUG | 20150108-085751.408 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5bf-7b9f748a-43c80203

Contact: <sip:010010000503010000@172.20.51.140:6062>;expires=3600

To: <sip:010010000503010000@172.20.40.30>;tag=cb571430

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 2 REGISTER

Content-Length: 0



sigcomp id=
DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire) is for me
DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c0-7b9f7859-5d1b9268

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 3 REGISTER

Expires: 0

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152271:ca1622a8cb0a5faaf8892e890407149d",uri="sip:172.20.40.30",response="2e6ba3be40543cfb069ecb01d79ca4d5",algorithm=MD5,cnonce="7b9f7859",qop=auth,nc=00000002

Content-Length: 0




DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085752.376 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire) code=100 reason=
DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=-1fa5c0-7b9f7859-5d1b9268 
ms=3500
DEBUG | 20150108-085752.376 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c0-7b9f7859-5d1b9268

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 3 REGISTER

Expires: 0

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152271:ca1622a8cb0a5faaf8892e890407149d",uri="sip:172.20.40.30",response="2e6ba3be40543cfb069ecb01d79ca4d5",algorithm=MD5,cnonce="7b9f7859",qop=auth,nc=00000002

Content-Length: 0




INFO | 20150108-085752.376 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:359 | Requesting credential for 010010000503010000 @ 
172.20.40.30
INFO | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:52 | ServerAuth requested credentials SipReq:  REGISTER 
172.20.40.30 tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire)
DEBUG | 20150108-085752.377 | repro.exe | REPRO:APP | 8652 | 
repro/UserAuthGrabber.hxx:47 | Grabbed user info for 
010010000503010000@172.20.40.30 : 48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085752.377 | repro.exe | RESIP:TRANSACTION | 8652 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

UserAuthInfo 010010000503010000 @ 172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
INFO | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:130 | Checking for auth result in realm=172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085752.377 | repro.exe | RESIP | 9912 | Helper.cxx:774 | 
Authenticating: realm=172.20.40.30 expires=3000
INFO | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:215 | Authorized request for 172.20.40.30
INFO | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1591 | Got: SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire)
DEBUG | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1947 | DialogUsageManager::processRequest: SipReq:  
REGISTER 172.20.40.30 tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire)
DEBUG | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:84 | 
 ************* Created DialogSet(UAS) *************: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-9d7d3f21
DEBUG | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | DialogId.cxx:50 | 
DialogId::DialogId: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-170cff10-1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf
DEBUG | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:176 | got a registration
DEBUG | 20150108-085752.377 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:195 | InMemorySyncRegDb::lockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
DEBUG | 20150108-085752.378 | repro.exe | REPRO:APP | 9912 | Registrar.cxx:50 | 
Registrar::onRemove SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire)
DEBUG | 20150108-085752.378 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 3 from(wire) code=200 reason=
INFO | 20150108-085752.378 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:49 | accepted a registration 
sip:010010000503010000@172.20.40.30
DEBUG | 20150108-085752.378 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:216 | InMemorySyncRegDb::unlockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
DEBUG | 20150108-085752.378 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c0-7b9f7859-5d1b9268

To: <sip:010010000503010000@172.20.40.30>;tag=b12d092f

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 3 REGISTER

Content-Length: 0




DEBUG | 20150108-085752.378 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 200 tid=-1fa5c0-7b9f7859-5d1b9268 cseq=3 REGISTER / 3 from(tu)
DEBUG | 20150108-085752.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=-1fa5c0-7b9f7859-5d1b9268 ms=32000
DEBUG | 20150108-085752.378 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:2442 | Got merged request removal request
DEBUG | 20150108-085752.378 | repro.exe | RESIP:TRANSACTION | 9912 | 
TimerQueue.cxx:97 | Adding application timer:  ms=32000
DEBUG | 20150108-085752.378 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:122 
|  ********** DialogSet::~DialogSet: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-9d7d3f21*************
DEBUG | 20150108-085752.382 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.140:6062 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.140 sent-port=6062
DEBUG | 20150108-085752.382 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c0-7b9f7859-5d1b9268

To: <sip:010010000503010000@172.20.40.30>;tag=b12d092f

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191048-8c3314ac-17ae-1fa5bf-3c7d4815-1fa5bf

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 3 REGISTER

Content-Length: 0



sigcomp id=
DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c44-6e9db67f cseq=4 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 4 from(wire) is for me
DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c44-6e9db67f

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 4 REGISTER

Expires: 3600

Content-Length: 0




DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085753.378 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c44-6e9db67f cseq=4 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 4 from(wire) code=100 reason=
DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=-1fa5c1-7b9f7c44-6e9db67f 
ms=3500
DEBUG | 20150108-085753.378 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c44-6e9db67f

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 4 REGISTER

Expires: 3600

Content-Length: 0




INFO | 20150108-085753.378 | repro.exe | REPRO:APP | 9912 | AclStore.cxx:532 | 
AclStore - source address NOT trusted: 172.20.51.140:6062 UDP
DEBUG | 20150108-085753.378 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c44-6e9db67f cseq=4 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 4 from(wire) code=407 reason=
INFO | 20150108-085753.379 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:416 | Sending challenge to SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c44-6e9db67f cseq=4 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 4 from(wire)
DEBUG | 20150108-085753.379 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c44-6e9db67f

Proxy-Authenticate: Digest 
nonce="13065152273:df20c3ff587d11e358ac408af42d5255",algorithm=MD5,realm="172.20.40.30",qop="auth,auth-int"

To: <sip:010010000503010000@172.20.40.30>;tag=825ab04e

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 4 REGISTER

Content-Length: 0




DEBUG | 20150108-085753.379 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 407 tid=-1fa5c1-7b9f7c44-6e9db67f cseq=4 REGISTER / 4 from(tu)
INFO | 20150108-085753.379 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:46 | ServerAuth challenged request SipReq:  REGISTER 
172.20.40.30 tid=-1fa5c1-7b9f7c44-6e9db67f cseq=4 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 4 from(wire)
DEBUG | 20150108-085753.379 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=-1fa5c1-7b9f7c44-6e9db67f ms=32000
DEBUG | 20150108-085753.384 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.140:6062 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.140 sent-port=6062
DEBUG | 20150108-085753.384 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 407 Proxy Authentication Required

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c44-6e9db67f

Proxy-Authenticate: Digest 
nonce="13065152273:df20c3ff587d11e358ac408af42d5255",algorithm=MD5,realm="172.20.40.30",qop="auth,auth-int"

To: <sip:010010000503010000@172.20.40.30>;tag=825ab04e

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 4 REGISTER

Content-Length: 0



sigcomp id=
DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(wire) is for me
DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c5f-374b3e14

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 5 REGISTER

Expires: 3600

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152273:df20c3ff587d11e358ac408af42d5255",uri="sip:172.20.40.30",response="f27a11a9338858d2419bae7b124f0799",algorithm=MD5,cnonce="7b9f7c60",qop=auth,nc=00000001

Content-Length: 0




DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085753.406 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(wire) code=100 reason=
DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=-1fa5c1-7b9f7c5f-374b3e14 
ms=3500
DEBUG | 20150108-085753.406 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c5f-374b3e14

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 5 REGISTER

Expires: 3600

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152273:df20c3ff587d11e358ac408af42d5255",uri="sip:172.20.40.30",response="f27a11a9338858d2419bae7b124f0799",algorithm=MD5,cnonce="7b9f7c60",qop=auth,nc=00000001

Content-Length: 0




INFO | 20150108-085753.406 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:359 | Requesting credential for 010010000503010000 @ 
172.20.40.30
INFO | 20150108-085753.406 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:52 | ServerAuth requested credentials SipReq:  REGISTER 
172.20.40.30 tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(wire)
DEBUG | 20150108-085753.407 | repro.exe | REPRO:APP | 8628 | 
repro/UserAuthGrabber.hxx:47 | Grabbed user info for 
010010000503010000@172.20.40.30 : 48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085753.407 | repro.exe | RESIP:TRANSACTION | 8628 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

UserAuthInfo 010010000503010000 @ 172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
INFO | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:130 | Checking for auth result in realm=172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085753.407 | repro.exe | RESIP | 9912 | Helper.cxx:774 | 
Authenticating: realm=172.20.40.30 expires=3000
INFO | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:215 | Authorized request for 172.20.40.30
INFO | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1591 | Got: SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(wire)
DEBUG | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1947 | DialogUsageManager::processRequest: SipReq:  
REGISTER 172.20.40.30 tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(wire)
DEBUG | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:84 | 
 ************* Created DialogSet(UAS) *************: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-bb29d45e
DEBUG | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | DialogId.cxx:50 | 
DialogId::DialogId: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-d56fd248-1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1
DEBUG | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:176 | got a registration
DEBUG | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:195 | InMemorySyncRegDb::lockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
INFO | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:379 | Adding sip:010010000503010000@172.20.40.30 -> 
<sip:010010000503010000@172.20.51.140:6062>
DEBUG | 20150108-085753.407 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:380 | Contact has tuple [ V4 172.20.51.140:6062 UDP 
target domain=unspecified mFlowKey=560 ] and detected public address [ V4 
0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]
DEBUG | 20150108-085753.408 | repro.exe | REPRO:APP | 9912 | Registrar.cxx:84 | 
Registrar::onAdd SipReq:  REGISTER 172.20.40.30 tid=-1fa5c1-7b9f7c5f-374b3e14 
cseq=5 REGISTER contact=010010000503010000@172.20.51.140:6062 / 5 from(wire)
DEBUG | 20150108-085753.408 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(wire) code=200 reason=
INFO | 20150108-085753.408 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:49 | accepted a registration 
sip:010010000503010000@172.20.40.30
DEBUG | 20150108-085753.408 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:216 | InMemorySyncRegDb::unlockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
DEBUG | 20150108-085753.408 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c5f-374b3e14

Contact: <sip:010010000503010000@172.20.51.140:6062>;expires=3600

To: <sip:010010000503010000@172.20.40.30>;tag=a732e322

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 5 REGISTER

Content-Length: 0




DEBUG | 20150108-085753.408 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 200 tid=-1fa5c1-7b9f7c5f-374b3e14 cseq=5 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 5 from(tu)
DEBUG | 20150108-085753.408 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=-1fa5c1-7b9f7c5f-374b3e14 ms=32000
DEBUG | 20150108-085753.408 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:2442 | Got merged request removal request
DEBUG | 20150108-085753.408 | repro.exe | RESIP:TRANSACTION | 9912 | 
TimerQueue.cxx:97 | Adding application timer:  ms=32000
DEBUG | 20150108-085753.408 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:122 
|  ********** DialogSet::~DialogSet: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-bb29d45e*************
DEBUG | 20150108-085753.413 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.140:6062 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.140 sent-port=6062
DEBUG | 20150108-085753.413 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c1-7b9f7c5f-374b3e14

Contact: <sip:010010000503010000@172.20.51.140:6062>;expires=3600

To: <sip:010010000503010000@172.20.40.30>;tag=a732e322

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 5 REGISTER

Content-Length: 0



sigcomp id=
DEBUG | 20150108-085754.381 | repro.exe | RESIP:TRANSPORT | 1508 | 
Transport.cxx:382 | incoming from: [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ]
DEBUG | 20150108-085754.381 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:79 | Checking if SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire) is for me
DEBUG | 20150108-085754.381 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:84 | Checking rule...
DEBUG | 20150108-085754.381 | repro.exe | RESIP:TRANSACTION | 4516 | 
MessageFilterRule.cxx:45 | Matching rule for: 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c2-7b9f802e-7d8d64c8

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 6 REGISTER

Expires: 0

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152273:df20c3ff587d11e358ac408af42d5255",uri="sip:172.20.40.30",response="ae2ea1ce7b171940bb46f5f3a31d9eb8",algorithm=MD5,cnonce="7b9f802e",qop=auth,nc=00000002

Content-Length: 0




DEBUG | 20150108-085754.381 | repro.exe | RESIP:TRANSACTION | 4516 | 
TransactionUser.cxx:87 | Match!
DEBUG | 20150108-085754.381 | repro.exe | RESIP | 4516 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire) code=100 reason=
DEBUG | 20150108-085754.381 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer Trying tid=-1fa5c2-7b9f802e-7d8d64c8 
ms=3500
DEBUG | 20150108-085754.382 | repro.exe | RESIP:TRANSACTION | 4516 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

REGISTER sip:172.20.40.30 SIP/2.0

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c2-7b9f802e-7d8d64c8

Max-Forwards: 70

Contact: <sip:010010000503010000@172.20.51.140:6062>

To: <sip:010010000503010000@172.20.40.30>

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 6 REGISTER

Expires: 0

Proxy-Authorization: Digest 
username="010010000503010000",realm="172.20.40.30",nonce="13065152273:df20c3ff587d11e358ac408af42d5255",uri="sip:172.20.40.30",response="ae2ea1ce7b171940bb46f5f3a31d9eb8",algorithm=MD5,cnonce="7b9f802e",qop=auth,nc=00000002

Content-Length: 0




INFO | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:359 | Requesting credential for 010010000503010000 @ 
172.20.40.30
INFO | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:52 | ServerAuth requested credentials SipReq:  REGISTER 
172.20.40.30 tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire)
DEBUG | 20150108-085754.382 | repro.exe | REPRO:APP | 8628 | 
repro/UserAuthGrabber.hxx:47 | Grabbed user info for 
010010000503010000@172.20.40.30 : 48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085754.382 | repro.exe | RESIP:TRANSACTION | 8628 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 

UserAuthInfo 010010000503010000 @ 172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
INFO | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:130 | Checking for auth result in realm=172.20.40.30 
A1=48f57c4ade0db6fd35a4cc17b8d16d31
DEBUG | 20150108-085754.382 | repro.exe | RESIP | 9912 | Helper.cxx:774 | 
Authenticating: realm=172.20.40.30 expires=3000
INFO | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
ServerAuthManager.cxx:215 | Authorized request for 172.20.40.30
INFO | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1591 | Got: SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire)
DEBUG | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:1947 | DialogUsageManager::processRequest: SipReq:  
REGISTER 172.20.40.30 tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire)
DEBUG | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:84 | 
 ************* Created DialogSet(UAS) *************: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-0b480507
DEBUG | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | DialogId.cxx:50 | 
DialogId::DialogId: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-9a165446-1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1
DEBUG | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:176 | got a registration
DEBUG | 20150108-085754.382 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:195 | InMemorySyncRegDb::lockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
DEBUG | 20150108-085754.383 | repro.exe | REPRO:APP | 9912 | Registrar.cxx:50 | 
Registrar::onRemove SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire)
DEBUG | 20150108-085754.383 | repro.exe | RESIP | 9912 | Helper.cxx:373 | 
Helper::makeResponse(SipReq:  REGISTER 172.20.40.30 
tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER 
contact=010010000503010000@172.20.51.140:6062 / 6 from(wire) code=200 reason=
INFO | 20150108-085754.383 | repro.exe | RESIP:DUM | 9912 | 
ServerRegistration.cxx:49 | accepted a registration 
sip:010010000503010000@172.20.40.30
DEBUG | 20150108-085754.383 | repro.exe | RESIP:DUM | 9912 | 
InMemorySyncRegDb.cxx:216 | InMemorySyncRegDb::unlockRecord:  
aor=sip:010010000503010000@172.20.40.30 threadid=9912
DEBUG | 20150108-085754.383 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:983 | SEND: 

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c2-7b9f802e-7d8d64c8

To: <sip:010010000503010000@172.20.40.30>;tag=ba0bd356

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 6 REGISTER

Content-Length: 0




DEBUG | 20150108-085754.383 | repro.exe | RESIP | 9912 | SipStack.cxx:554 | 
SEND: SipResp: 200 tid=-1fa5c2-7b9f802e-7d8d64c8 cseq=6 REGISTER / 6 from(tu)
DEBUG | 20150108-085754.383 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:2442 | Got merged request removal request
DEBUG | 20150108-085754.383 | repro.exe | RESIP:TRANSACTION | 9912 | 
TimerQueue.cxx:97 | Adding application timer:  ms=32000
DEBUG | 20150108-085754.383 | repro.exe | RESIP:DUM | 9912 | DialogSet.cxx:122 
|  ********** DialogSet::~DialogSet: 
3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc-0b480507*************
DEBUG | 20150108-085754.383 | repro.exe | RESIP:TRANSACTION | 4516 | 
TimerQueue.cxx:41 | Adding timer: Timer J tid=-1fa5c2-7b9f802e-7d8d64c8 ms=32000
DEBUG | 20150108-085754.388 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:750 | Looked up source for destination: [ V4 
172.20.51.140:6062 UDP target domain=unspecified mFlowKey=560 ] -> [ V4 
172.20.40.30:0 UDP target domain=unspecified mFlowKey=560 ] 
sent-by=172.20.51.140 sent-port=6062
DEBUG | 20150108-085754.388 | repro.exe | RESIP:TRANSPORT | 4516 | 
TransportSelector.cxx:1162 | Transmitting to [ V4 172.20.51.140:6062 UDP target 
domain=unspecified mFlowKey=560 ] tlsDomain= via [ V4 172.20.40.30:5060 UDP 
target domain=unspecified mFlowKey=560 ]

SIP/2.0 200 OK

Via: SIP/2.0/UDP 
172.20.51.140:6062;rport=6062;branch=z9hG4bK-1fa5c2-7b9f802e-7d8d64c8

To: <sip:010010000503010000@172.20.40.30>;tag=ba0bd356

From: 
<sip:010010000503010000@172.20.40.30>;tag=1a191558-8c3314ac-17ae-1fa5c1-541f5e0e-1fa5c1

Call-ID: 3c9d8a8-8c3314ac-17ae-1fa5bc-78cbf107-1fa5bc

CSeq: 6 REGISTER

Content-Length: 0



sigcomp id=
INFO | 20150108-085814.385 | repro.exe | RESIP:TRANSACTION | 9480 | 
TuSelector.cxx:84 | Stats message 
WARNING | 20150108-085814.385 | repro.exe | RESIP:STATS | 9480 | 
StatisticsMessage.cxx:98 | RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 6 TIMERS 6
Transaction summary: reqi 7 reqo 0 rspi 0 rspo 7
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 
7/S4/F3 REGo 0/S0/F0 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 0/S0/F0 SUBo 0/S0/F0 NOTi 
0/S0/F0 NOTo 0/S0/F0 REFi 0/S0/F0 REFo 0/S0/F0 INFi 0/S0/F0 INFo 0/S0/F0 PRAi 
0/S0/F0 PRAo 0/S0/F0 SERi 0/S0/F0 SERo 0/S0/F0 UPDi 0/S0/F0 UPDo 0/S0/F0
Retransmissions: INVx 0 finx 0 nonx 0 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 0 PUBx 0 
SUBx 0 NOTx 0 REFx 0 INFx 0 PRAx 0 SERx 0 UPDx 0
WARNING | 20150108-085814.385 | repro.exe | RESIP:STATS | 9480 | 
GeneralCongestionManager.cxx:91 | FIFO STATISTICS
WARNING | 20150108-085814.385 | repro.exe | RESIP:STATS | 9480 | 
GeneralCongestionManager.cxx:101 | UdpTransport::mTxFifo: Size=0 
TimeDepth(sec)=0 ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME 
MaxTolerance=200 CurBehavior=NORMAL
WARNING | 20150108-085814.385 | repro.exe | RESIP:STATS | 9480 | 
GeneralCongestionManager.cxx:101 | UdpTransport::mTxFifo: Size=0 
TimeDepth(sec)=0 ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME 
MaxTolerance=200 CurBehavior=NORMAL
WARNING | 20150108-085814.385 | repro.exe | RESIP:STATS | 9480 | 
GeneralCongestionManager.cxx:101 | TransactionController::mStateMacFifo: Size=0 
TimeDepth(sec)=0 ExpWait(msec)=0 AvgSvcTime(usec)=7 Metric=WAIT_TIME 
MaxTolerance=200 CurBehavior=NORMAL
WARNING | 20150108-085814.385 | repro.exe | RESIP:STATS | 9480 | 
GeneralCongestionManager.cxx:101 | SipStack::mTUFifo: Size=0 TimeDepth(sec)=0 
ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME MaxTolerance=200 
CurBehavior=NORMAL
DEBUG | 20150108-085823.404 | repro.exe | RESIP:TRANSACTION | 9480 | 
TuSelector.cxx:70 | Send to TU: TU: DialogUsageManager size=0 


DEBUG | 20150108-085823.404 | repro.exe | RESIP:DUM | 9912 | 
DialogUsageManager.cxx:2450 | Merged request removed

Attachment: repro2.config
Description: Binary data

INFO | 20150108-085816.014 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:190 
| Starting repro version 0.9...
INFO | 20150108-085816.022 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:452 
| V4 enabled
INFO | 20150108-085816.022 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:453 
| V6 enabled
INFO | 20150108-085816.082 | repro.exe | RESIP:DNS | 6868 | AresDns.cxx:350 | 
DNS initialization: found  3 name servers
INFO | 20150108-085816.082 | repro.exe | RESIP:DNS | 6868 | AresDns.cxx:361 |  
name server: 202.102.128.68
INFO | 20150108-085816.082 | repro.exe | RESIP:DNS | 6868 | AresDns.cxx:361 |  
name server: 219.147.1.66
INFO | 20150108-085816.083 | repro.exe | RESIP:DNS | 6868 | AresDns.cxx:361 |  
name server: 192.168.2.101
DEBUG | 20150108-085816.083 | repro.exe | RESIP | 6868 | Compression.cxx:44 | 
COMPRESSION SUPPORT NOT COMPILED IN
DEBUG | 20150108-085816.083 | repro.exe | RESIP | 6868 | Compression.cxx:47 | 
Compression configuration object created; algorithm = 0
DEBUG | 20150108-085816.083 | repro.exe | RESIP:TRANSPORT | 6868 | 
TransportSelector.cxx:97 | No compression library available
INFO | 20150108-085816.085 | repro.exe | RESIP:DNS | 6868 | DnsUtil.cxx:156 | 
local hostname does not contain a domain part WIN-9ALSMG52R34
DEBUG | 20150108-085816.085 | repro.exe | RESIP:TRANSPORT | 6868 | 
InternalTransport.cxx:99 | Creating fd=428 V4/UDP
DEBUG | 20150108-085816.086 | repro.exe | RESIP:TRANSPORT | 6868 | 
InternalTransport.cxx:107 | Binding to 0.0.0.0
INFO | 20150108-085816.086 | repro.exe | RESIP:TRANSPORT | 6868 | 
UdpTransport.cxx:54 | Creating UDP transport host= port=9060 ipv4=1
DEBUG | 20150108-085816.086 | repro.exe | RESIP:TRANSPORT | 6868 | 
UdpTransport.cxx:68 | No compression library available: Transport: [ V4 
0.0.0.0:9060 UDP target domain=unspecified mFlowKey=428 ]
DEBUG | 20150108-085816.099 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: 127.0.0.1:9060
DEBUG | 20150108-085816.099 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: 127.0.0.1:9060
DEBUG | 20150108-085816.099 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: 192.168.56.1:9060
DEBUG | 20150108-085816.099 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: 192.168.2.1:9060
DEBUG | 20150108-085816.099 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: 172.20.51.140:9060
DEBUG | 20150108-085816.099 | repro.exe | RESIP:TRANSPORT | 6868 | 
TransportSelector.cxx:225 | Adding transport: [ V4 0.0.0.0:9060 UDP target 
domain=unspecified mFlowKey=0 ]
DEBUG | 20150108-085816.100 | repro.exe | RESIP:TRANSPORT | 6868 | 
InternalTransport.cxx:99 | Creating fd=448 V6/UDP
DEBUG | 20150108-085816.100 | repro.exe | RESIP:TRANSPORT | 6868 | 
InternalTransport.cxx:107 | Binding to ::
INFO | 20150108-085816.100 | repro.exe | RESIP:TRANSPORT | 6868 | 
UdpTransport.cxx:54 | Creating UDP transport host= port=9060 ipv4=0
DEBUG | 20150108-085816.100 | repro.exe | RESIP:TRANSPORT | 6868 | 
UdpTransport.cxx:68 | No compression library available: Transport: [ V6 :: 
port=9060 UDP target domain=unspecified mFlowKey=448 ]
DEBUG | 20150108-085816.113 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: fe80::100:7f:fffe:9060
DEBUG | 20150108-085816.114 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: ::1:9060
DEBUG | 20150108-085816.114 | repro.exe | RESIP | 6868 | SipStack.cxx:437 | 
Adding domain alias: fe80::8900:f080:e103:c745:9060
DEBUG | 20150108-085816.114 | repro.exe | RESIP:TRANSPORT | 6868 | 
TransportSelector.cxx:225 | Adding transport: [ V6 :: port=9060 UDP target 
domain=unspecified mFlowKey=0 ]
DEBUG | 20150108-085816.114 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:53 
| No BerkeleyDb prefix specified - using default
INFO | 20150108-085816.114 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:61 | 
Using BerkeleyDb prefixed with ./\repro
DEBUG | 20150108-085816.114 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_user.db
DEBUG | 20150108-085816.118 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_user.db
DEBUG | 20150108-085816.118 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_route.db
DEBUG | 20150108-085816.122 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_route.db
DEBUG | 20150108-085816.122 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_acl.db
DEBUG | 20150108-085816.126 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_acl.db
DEBUG | 20150108-085816.126 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_config.db
DEBUG | 20150108-085816.129 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_config.db
DEBUG | 20150108-085816.129 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_staticreg.db
DEBUG | 20150108-085816.133 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_staticreg.db
DEBUG | 20150108-085816.133 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_filter.db
DEBUG | 20150108-085816.136 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_filter.db
DEBUG | 20150108-085816.136 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:138 
| About to open Berkeley DB: ./\repro_silo.db
DEBUG | 20150108-085816.140 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:166 
| Opened Berkeley DB: ./\repro_silo.db
DEBUG | 20150108-085816.140 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:182 
| About to open secondary Berkeley DB: ./\repro_silo_idx1.db
DEBUG | 20150108-085816.143 | repro.exe | REPRO:APP | 6868 | BerkeleyDb.cxx:209 
| Opened secondary Berkeley DB: ./\repro_silo_idx1.db
DEBUG | 20150108-085816.145 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:41 | Instantiating new RequestProcessor chain
DEBUG | 20150108-085816.145 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: StrictRouteFixup
DEBUG | 20150108-085816.145 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: IsTrustedNode
DEBUG | 20150108-085816.145 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: 
DigestAuthenticator
DEBUG | 20150108-085816.145 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: AmIResponsible
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: RequestFilter
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: StaticRoute
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new RequestProcessor to chain: LocationServer
INFO | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:806 
| RequestProcessor chain: [StrictRouteFixup, IsTrustedNode, 
DigestAuthenticator, AmIResponsible, RequestFilter, StaticRoute, LocationServer]
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:41 | Instantiating new ResponseProcessor chain
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new ResponseProcessor to chain: 
OutboundTargetHandler
INFO | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:812 
| ResponseProcessor chain: [OutboundTargetHandler]
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:41 | Instantiating new TargetProcessor chain
DEBUG | 20150108-085816.146 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new TargetProcessor to chain: QValueTargetHandler
DEBUG | 20150108-085816.147 | repro.exe | REPRO:APP | 6868 | 
ProcessorChain.cxx:58 | Adding new TargetProcessor to chain: SimpleTargetHandler
INFO | 20150108-085816.147 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:818 
| TargetProcessor chain: [QValueTargetHandler, SimpleTargetHandler]
INFO | 20150108-085816.147 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:976 
| Adding domain 172.20.40.30 from config
INFO | 20150108-085816.147 | repro.exe | REPRO:APP | 6868 | ReproRunner.cxx:976 
| Adding domain 172.20.51.140 from config
DEBUG | 20150108-085816.148 | repro.exe | REPRO:APP | 6868 | HttpBase.cxx:78 | 
Creating fd=848 V4/
DEBUG | 20150108-085816.148 | repro.exe | REPRO:APP | 6868 | HttpBase.cxx:93 | 
Binding to 0.0.0.0
DEBUG | 20150108-085816.148 | repro.exe | REPRO:APP | 6868 | WebAdmin.cxx:90 |  
Looking to see if admin user exists (creating WebAdmin)
DEBUG | 20150108-085816.149 | repro.exe | REPRO:APP | 6868 | WebAdmin.cxx:111 | 
Changing the web admin password
DEBUG | 20150108-085816.150 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=892 
V4/
DEBUG | 20150108-085816.150 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to 0.0.0.0
DEBUG | 20150108-085816.151 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=912 
V6/
DEBUG | 20150108-085816.151 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to ::
DEBUG | 20150108-085816.152 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=956 
V4/
DEBUG | 20150108-085816.152 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to 0.0.0.0
DEBUG | 20150108-085816.153 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:48 | XmlRpcServerBase::XmlRpcServerBase: Creating fd=976 
V6/
DEBUG | 20150108-085816.153 | repro.exe | REPRO:APP | 6868 | 
XmlRpcServerBase.cxx:64 | XmlRpcServerBase::XmlRpcServerBase: Binding to ::
INFO | 20150108-085816.154 | repro.exe | REPRO:APP | 7444 | Proxy.cxx:143 | 
Proxy::thread start
ERR | 20150108-085817.156 | repro.exe | REPRO:APP | 6984 | 
RegSyncClient.cxx:115 | RegSyncClient: error connecting to 172.20.40.30:11111
DEBUG | 20150108-085817.547 | repro.exe | REPRO:APP | 3828 | 
XmlRpcServerBase.cxx:208 | XmlRpcServerBase::process: Received TCP connection 
as connection=1 fd=1140
DEBUG | 20150108-085817.548 | repro.exe | REPRO:APP | 3828 | 
RegSyncServer.cxx:91 | RegSyncServer::handleRequest:  connectionId=1, 
requestId=1, request=<InitialSync>

  <Request>

     <Version>3</Version>

  </Request>

</InitialSync>
INFO | 20150108-085817.548 | repro.exe | REPRO:APP | 3828 | 
RegSyncServer.cxx:118 | RegSyncServer::handleInitialSyncRequest
DEBUG | 20150108-085817.548 | repro.exe | REPRO:APP | 3828 | 
XmlRpcConnection.cxx:197 | XmlRpcConnection::processSomeWrites - Wrote it all
INFO | 20150108-085847.175 | repro.exe | REPRO:APP | 6984 | 
RegSyncClient.cxx:214 | RegSyncClient::handleXml: InitialSync complete.
INFO | 20150108-085916.157 | repro.exe | RESIP:TRANSACTION | 828 | 
TuSelector.cxx:84 | Stats message 
WARNING | 20150108-085916.157 | repro.exe | RESIP:STATS | 828 | 
StatisticsMessage.cxx:98 | RESIP:TRANSACTION
TU summary: 0 TRANSPORT 0 TRANSACTION 0 CLIENTTX 0 SERVERTX 0 TIMERS 0
Transaction summary: reqi 0 reqo 0 rspi 0 rspo 0
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 
0/S0/F0 REGo 0/S0/F0 PUBi 0/S0/F0 PUBo 0/S0/F0 SUBi 0/S0/F0 SUBo 0/S0/F0 NOTi 
0/S0/F0 NOTo 0/S0/F0 REFi 0/S0/F0 REFo 0/S0/F0 INFi 0/S0/F0 INFo 0/S0/F0 PRAi 
0/S0/F0 PRAo 0/S0/F0 SERi 0/S0/F0 SERo 0/S0/F0 UPDi 0/S0/F0 UPDo 0/S0/F0
Retransmissions: INVx 0 finx 0 nonx 0 BYEx 0 CANx 0 MSGx 0 OPTx 0 REGx 0 PUBx 0 
SUBx 0 NOTx 0 REFx 0 INFx 0 PRAx 0 SERx 0 UPDx 0
WARNING | 20150108-085916.157 | repro.exe | RESIP:STATS | 828 | 
GeneralCongestionManager.cxx:91 | FIFO STATISTICS
WARNING | 20150108-085916.157 | repro.exe | RESIP:STATS | 828 | 
GeneralCongestionManager.cxx:101 | UdpTransport::mTxFifo: Size=0 
TimeDepth(sec)=0 ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME 
MaxTolerance=200 CurBehavior=NORMAL
WARNING | 20150108-085916.158 | repro.exe | RESIP:STATS | 828 | 
GeneralCongestionManager.cxx:101 | UdpTransport::mTxFifo: Size=0 
TimeDepth(sec)=0 ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME 
MaxTolerance=200 CurBehavior=NORMAL
WARNING | 20150108-085916.158 | repro.exe | RESIP:STATS | 828 | 
GeneralCongestionManager.cxx:101 | TransactionController::mStateMacFifo: Size=0 
TimeDepth(sec)=0 ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME 
MaxTolerance=200 CurBehavior=NORMAL
WARNING | 20150108-085916.158 | repro.exe | RESIP:STATS | 828 | 
GeneralCongestionManager.cxx:101 | SipStack::mTUFifo: Size=0 TimeDepth(sec)=0 
ExpWait(msec)=0 AvgSvcTime(usec)=0 Metric=WAIT_TIME MaxTolerance=200 
CurBehavior=NORMAL
INFO | 20150108-085928.274 | repro.exe | REPRO:APP | 3828 | 
XmlRpcServerBase.cxx:343 | Connection reset 
INFO | 20150108-085928.274 | repro.exe | REPRO:APP | 3828 | 
XmlRpcConnection.cxx:107 | XmlRpcConnection::processSomeReads: Failed read on 
1140
ERR | 20150108-085928.274 | repro.exe | REPRO:APP | 6984 | 
RegSyncClient.cxx:142 | RegSyncClient: error receiving
ERR | 20150108-085929.291 | repro.exe | REPRO:APP | 6984 | 
RegSyncClient.cxx:115 | RegSyncClient: error connecting to 172.20.40.30:11111

Follow-Ups:
- Re: [reSIProcate] Register Synchronization
  - From: Scott Godin

References:
- [reSIProcate] Register Synchronization
  - From: 许
- Re: [reSIProcate] Register Synchronization
  - From: Scott Godin

Prev by Date: Re: [reSIProcate] Register Synchronization
Next by Date: Re: [reSIProcate] Register Synchronization
Previous by thread: Re: [reSIProcate] Register Synchronization
Next by thread: Re: [reSIProcate] Register Synchronization
Index(es):
- Date
- Thread