lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Shalin Shekhar Mangar <sha...@apache.org>
Subject Re: [JENKINS] Lucene-Solr-master-Windows (32bit/jdk1.8.0_92) - Build # 5820 - Failure!
Date Thu, 05 May 2016 20:55:00 GMT
This is a new test that I added in SOLR-9036. It passes on my box but I
just tried it on a slower machine and it fails often. I'll disable it until
I can figure out how to fix.

On Fri, May 6, 2016 at 1:59 AM, Policeman Jenkins Server <
jenkins@thetaphi.de> wrote:

> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/5820/
> Java: 32bit/jdk1.8.0_92 -client -XX:+UseG1GC
>
> 1 tests failed.
> FAILED:
> org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchOnMasterRestart
>
> Error Message:
> IOException occured when talking to server at:
> http://127.0.0.1:51195/solr/collection1
>
> Stack Trace:
> org.apache.solr.client.solrj.SolrServerException: IOException occured when
> talking to server at: http://127.0.0.1:51195/solr/collection1
>         at
> __randomizedtesting.SeedInfo.seed([B5F54CB6F816554A:6D02885253CD9716]:0)
>         at
> org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:620)
>         at
> org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259)
>         at
> org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
>         at
> org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
>         at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
>         at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
>         at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:152)
>         at
> org.apache.solr.handler.TestReplicationHandler.index(TestReplicationHandler.java:176)
>         at
> org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchOnMasterRestart(TestReplicationHandler.java:609)
>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>         at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
>         at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>         at java.lang.reflect.Method.invoke(Method.java:498)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
>         at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
>         at
> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
>         at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
>         at
> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
>         at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
>         at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
>         at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
>         at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
>         at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>         at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
>         at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
>         at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
>         at
> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
>         at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>         at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
>         at java.lang.Thread.run(Thread.java:745)
> Caused by: java.net.SocketException: Software caused connection abort:
> recv failed
>         at java.net.SocketInputStream.socketRead0(Native Method)
>         at
> java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
>         at java.net.SocketInputStream.read(SocketInputStream.java:170)
>         at java.net.SocketInputStream.read(SocketInputStream.java:141)
>         at
> org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:139)
>         at
> org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:155)
>         at
> org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:284)
>         at
> org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
>         at
> org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
>         at
> org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
>         at
> org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:165)
>         at
> org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:167)
>         at
> org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
>         at
> org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
>         at
> org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
>         at
> org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
>         at
> org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
>         at
> org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
>         at
> org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
>         at
> org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
>         at
> org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
>         at
> org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:511)
>         ... 47 more
>
>
>
>
> Build Log:
> [...truncated 10948 lines...]
>    [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
>    [junit4]   2> Creating dataDir:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\init-core-data-001
>    [junit4]   2> 755287 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
>    [junit4]   2> 755288 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1
>    [junit4]   2> 755302 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.Server jetty-9.3.8.v20160314
>    [junit4]   2> 755304 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3cd7ce
> {/solr,null,AVAILABLE}
>    [junit4]   2> 755307 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.ServerConnector Started ServerConnector@19b85bf
> {HTTP/1.1,[http/1.1]}{127.0.0.1:51040}
>    [junit4]   2> 755307 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.Server Started @759170ms
>    [junit4]   2> 755307 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
> {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1\data,
> hostContext=/solr, hostPort=51040}
>    [junit4]   2> 755307 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
> sun.misc.Launcher$AppClassLoader@1d16e93
>    [junit4]   2> 755308 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001'
>    [junit4]   2> 755308 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
> (NoInitialContextEx)
>    [junit4]   2> 755308 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
>    [junit4]   2> 755309 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrXmlConfig Loading container configuration from
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\solr.xml
>    [junit4]   2> 755323 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.
>    [junit4]   2> 755323 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer New CoreContainer 19335512
>    [junit4]   2> 755323 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer Loading cores into CoreContainer
> [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001]
>    [junit4]   2> 755323 WARN
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer Couldn't add files from
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\lib
> to classpath:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\lib
>    [junit4]   2> 755324 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
> 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
> 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
> 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
>    [junit4]   2> 755330 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
> params:
>    [junit4]   2> 755332 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
>    [junit4]   2> 755332 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
> (org.slf4j.impl.Log4jLoggerFactory)]
>    [junit4]   2> 755332 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
> authorization module.
>    [junit4]   2> 755332 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer No authentication plugin used.
>    [junit4]   2> 755336 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.
>    [junit4]   2> 755340 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
> config=solrconfig.xml, loadOnStartup=true, schema=schema.xml,
> configSetProperties=configsetprops.json, transient=false, dataDir=data\}
>    [junit4]   2> 755340 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Found core collection1 in
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1
>    [junit4]   2> 755341 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
>    [junit4]   2> 755341 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.s.SolrDispatchFilter
> user.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0
>    [junit4]   2> 755341 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
>    [junit4]   2> 755342 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1'
>    [junit4]   2> 755343 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
>    [junit4]   2> 755343 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
>    [junit4]   2> 755384 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.SolrConfig current version of requestparams : -1
>    [junit4]   2> 755388 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
>    [junit4]   2> 755394 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
>    [junit4]   2> 755399 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.s.IndexSchema [collection1] Schema name=test
>    [junit4]   2> 755406 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.s.IndexSchema unique key field: id
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming
> default properties: Can't find resource 'configsetprops.json' in classpath
> or
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1'
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [    ]
> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration
> from instancedir
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
> [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1],
> dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1\data\]
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
> collection1
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1\data\
>    [junit4]   2> 755417 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
> new=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1\data\index/
>    [junit4]   2> 755417 WARN  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1\data\index'
> doesn't exist. Creating new index...
>    [junit4]   2> 755419 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1\data\index
>    [junit4]   2> 755419 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=40, maxMergeAtOnceExplicit=13,
> maxMergedSegmentMB=6.11328125, floorSegmentMB=0.6025390625,
> forceMergeDeletesPctAllowed=1.8275865179344652, segmentsPerTier=48.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19035061678183463
>    [junit4]   2> 755419 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_1,generation=1}
>    [junit4]   2> 755419 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 755422 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
> default, creating implicit default
>    [junit4]   2> 755425 INFO
> (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1]
> o.a.s.c.SolrCore Looking for old index directories to cleanup for core
> collection1 in
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\.\collection1\data\
>    [junit4]   2> 755434 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755435 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755437 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755438 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755440 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
> startup=lazy
>    [junit4]   2> 755441 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
>    [junit4]   2> 755441 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
>    [junit4]   2> 755443 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
>    [junit4]   2> 755443 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
>    [junit4]   2> 755443 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
> minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
>    [junit4]   2> 755443 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_1,generation=1}
>    [junit4]   2> 755444 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 755444 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@848aaf[collection1]
> main]
>    [junit4]   2> 755444 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage File-based storage
> initialized to use dir:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1\conf
>    [junit4]   2> 755444 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
> {storageDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1\conf}
>    [junit4]   2> 755444 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
> using
> file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-001\collection1\conf
>    [junit4]   2> 755445 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing 0 registered
> ManagedResources
>    [junit4]   2> 755445 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
> config files: schema.xml,xslt/dummy.xsl
>    [junit4]   2> 755445 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for
> 10000
>    [junit4]   2> 755445 INFO  (coreLoadExecutor-1661-thread-1) [
> x:collection1] o.a.s.c.CoreContainer registering core: collection1
>    [junit4]   2> 755446 INFO
> (searcherExecutor-1662-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@848aaf[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
>    [junit4]   2> 755845 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1
>    [junit4]   2> 755859 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.Server jetty-9.3.8.v20160314
>    [junit4]   2> 755860 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e0f2a
> {/solr,null,AVAILABLE}
>    [junit4]   2> 755862 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.ServerConnector Started ServerConnector@33875e
> {HTTP/1.1,[http/1.1]}{127.0.0.1:51043}
>    [junit4]   2> 755862 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.e.j.s.Server Started @759724ms
>    [junit4]   2> 755862 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
> {solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1\data,
> hostContext=/solr, hostPort=51043}
>    [junit4]   2> 755864 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
> sun.misc.Launcher$AppClassLoader@1d16e93
>    [junit4]   2> 755864 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002'
>    [junit4]   2> 755864 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
> (NoInitialContextEx)
>    [junit4]   2> 755867 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
>    [junit4]   2> 755867 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.SolrXmlConfig Loading container configuration from
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\solr.xml
>    [junit4]   2> 755874 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.
>    [junit4]   2> 755875 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer New CoreContainer 11452301
>    [junit4]   2> 755875 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer Loading cores into CoreContainer
> [instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002]
>    [junit4]   2> 755875 WARN
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer Couldn't add files from
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\lib
> to classpath:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\lib
>    [junit4]   2> 755876 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
> 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
> 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
> 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,
>    [junit4]   2> 755879 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
> params:
>    [junit4]   2> 755881 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
>    [junit4]   2> 755881 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
> (org.slf4j.impl.Log4jLoggerFactory)]
>    [junit4]   2> 755882 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for
> authorization module.
>    [junit4]   2> 755882 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreContainer No authentication plugin used.
>    [junit4]   2> 755883 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.
>    [junit4]   2> 755892 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1,
> config=solrconfig.xml, loadOnStartup=true, schema=schema.xml,
> configSetProperties=configsetprops.json, transient=false, dataDir=data\}
>    [junit4]   2> 755892 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Found core collection1 in
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1
>    [junit4]   2> 755893 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
>    [junit4]   2> 755894 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.s.SolrDispatchFilter
> user.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0
>    [junit4]   2> 755894 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
>    [junit4]   2> 755895 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1'
>    [junit4]   2> 755895 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
>    [junit4]   2> 755895 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
> system property or JNDI)
>    [junit4]   2> 755915 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.SolrConfig current version of requestparams : -1
>    [junit4]   2> 755917 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
>    [junit4]   2> 755924 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
>    [junit4]   2> 755928 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.s.IndexSchema [collection1] Schema name=test
>    [junit4]   2> 755931 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.s.IndexSchema unique key field: id
>    [junit4]   2> 755935 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming
> default properties: Can't find resource 'configsetprops.json' in classpath
> or
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1'
>    [junit4]   2> 755935 INFO  (coreLoadExecutor-1671-thread-1) [    ]
> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration
> from instancedir
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1
>    [junit4]   2> 755935 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
>    [junit4]   2> 755935 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
> [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1],
> dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\]
>    [junit4]   2> 755936 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
> collection1
>    [junit4]   2> 755936 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\
>    [junit4]   2> 755936 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
> new=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index/
>    [junit4]   2> 755936 WARN  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
> 'C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index'
> doesn't exist. Creating new index...
>    [junit4]   2> 755937 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index
>    [junit4]   2> 755937 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=40, maxMergeAtOnceExplicit=13,
> maxMergedSegmentMB=6.11328125, floorSegmentMB=0.6025390625,
> forceMergeDeletesPctAllowed=1.8275865179344652, segmentsPerTier=48.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19035061678183463
>    [junit4]   2> 755937 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_1,generation=1}
>    [junit4]   2> 755938 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 755939 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
> default, creating implicit default
>    [junit4]   2> 755941 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755943 INFO
> (OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1]
> o.a.s.c.SolrCore Looking for old index directories to cleanup for core
> collection1 in
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\
>    [junit4]   2> 755944 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755947 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755950 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
>    [junit4]   2> 755952 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with
> startup=lazy
>    [junit4]   2> 755952 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file
>    [junit4]   2> 755952 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
>    [junit4]   2> 755953 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
>    [junit4]   2> 755953 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
>    [junit4]   2> 755953 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
> minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
>    [junit4]   2> 755954 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_1,generation=1}
>    [junit4]   2> 755954 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 755954 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5980b5[collection1]
> main]
>    [junit4]   2> 755954 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage File-based storage
> initialized to use dir:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1\conf
>    [junit4]   2> 755954 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
> {storageDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1\conf}
>    [junit4]   2> 755954 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
> using
> file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\collection1\conf
>    [junit4]   2> 755956 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing 0 registered
> ManagedResources
>    [junit4]   2> 755958 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
> 1000ms
>    [junit4]   2> 755959 INFO  (coreLoadExecutor-1671-thread-1) [
> x:collection1] o.a.s.c.CoreContainer registering core: collection1
>    [junit4]   2> 755959 INFO
> (searcherExecutor-1672-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@5980b5[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
>    [junit4]   2> 756407 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/select
> params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
>    [junit4]   2> 756412 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={wt=javabin&version=2}{add=[1]} 0 2
>    [junit4]   2> 756414 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 756421 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_1,generation=1}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_2,generation=2}
>    [junit4]   2> 756421 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 2
>    [junit4]   2> 756425 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.s.SolrIndexSearcher Opening [Searcher@122bc0f[collection1] main]
>    [junit4]   2> 756426 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 end_commit_flush
>    [junit4]   2> 756426 INFO
> (searcherExecutor-1662-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@122bc0f[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
>    [junit4]   2> 756427 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 13
>    [junit4]   2> 756455 WARN  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without
> the /replication suffix
>    [junit4]   2> 756460 INFO  (qtp1657846-5169) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
> QTime=0
>    [junit4]   2> 756461 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
>    [junit4]   2> 756461 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
>    [junit4]   2> 756461 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Starting replication process
>    [junit4]   2> 756490 INFO  (qtp1657846-5170) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist}
> status=0 QTime=28
>    [junit4]   2> 756491 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in
> master: 4
>    [junit4]   2> 756493 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064706925
>    [junit4]   2> 756494 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter...
> core=collection1
>    [junit4]   2> 756497 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=28, maxMergeAtOnceExplicit=18,
> maxMergedSegmentMB=32.7490234375, floorSegmentMB=1.5126953125,
> forceMergeDeletesPctAllowed=1.8341148040372046, segmentsPerTier=45.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
>    [junit4]   2> 756497 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_1,generation=1}
>    [junit4]   2> 756498 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 756498 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be
> used.
>    [junit4]   2> 756499 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_1,generation=1}
>    [junit4]   2> 756499 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
>    [junit4]   2> 756499 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter...
> core=collection1
>    [junit4]   2> 756499 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
> MockDirectoryWrapper(RAMDirectory@fe1df7
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@901fde)
>    [junit4]   2> 756500 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=2&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756503 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756505 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=2&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756508 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756509 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Total time taken for download
> (fullCopy=false,bytesDownloaded=1847) : 0 secs (null bytes/sec) to
> MockDirectoryWrapper(RAMDirectory@fe1df7
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@901fde)
>    [junit4]   2> 756514 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
> minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.21270996579556575]
>    [junit4]   2> 756515 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_1,generation=1}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2> 756515 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
>    [junit4]   2> 756515 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be
> used.
>    [junit4]   2> 756516 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1046fa3[collection1]
> main]
>    [junit4]   2> 756517 INFO
> (searcherExecutor-1672-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@1046fa3[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
>    [junit4]   2> 756517 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064706925
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064706925;done=true>>]
>    [junit4]   2> 756517 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=false
>    [junit4]   2> 756517 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064706925
>    [junit4]   2> 756518 INFO  (qtp8806956-5182) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={wait=true&masterUrl=
> http://127.0.0.1:51040/solr/collection1/replication&command=fetchindex}
> status=0 QTime=63
>    [junit4]   2> 756529 INFO  (qtp8806956-5189) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/select
> params={q=name:empty1&sort=id+desc&wt=javabin&version=2} hits=1 status=0
> QTime=0
>    [junit4]   2> 756530 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
>    [junit4]   2> 756531 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=0
>    [junit4]   2> 756536 INFO  (qtp1657846-5168) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=3
>    [junit4]   2> 756540 INFO  (qtp1657846-5169) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={slave=false&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=0
>    [junit4]   2> 756540 INFO  (qtp8806956-5188) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=3
>    [junit4]   2> 756542 INFO  (qtp1657846-5170) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
> status=0 QTime=0
>    [junit4]   2> 756543 INFO  (qtp8806956-5187) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
> status=0 QTime=0
>    [junit4]   2> 756544 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 756545 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
>    [junit4]   2> 756546 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening:
> org.apache.solr.search.SolrIndexSearcher
>    [junit4]   2> 756546 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 end_commit_flush
>    [junit4]   2> 756547 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 2
>    [junit4]   2> 756550 WARN  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without
> the /replication suffix
>    [junit4]   2> 756552 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
> QTime=0
>    [junit4]   2> 756553 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
>    [junit4]   2> 756553 INFO  (qtp8806956-5186) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={wait=true&masterUrl=
> http://127.0.0.1:51040/solr/collection1/replication&command=fetchindex}
> status=0 QTime=4
>    [junit4]   2> 756556 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={wt=javabin&version=2}{add=[2]} 0 0
>    [junit4]   2> 756557 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 756560 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 756561 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 756561 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.s.SolrIndexSearcher Opening [Searcher@a18042[collection1] main]
>    [junit4]   2> 756561 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 end_commit_flush
>    [junit4]   2> 756561 INFO
> (searcherExecutor-1662-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@a18042[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)
> Uninverting(_1(7.0.0):c1)))}
>    [junit4]   2> 756562 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 4
>    [junit4]   2> 756564 WARN  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without
> the /replication suffix
>    [junit4]   2> 756566 INFO  (qtp1657846-5168) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
> QTime=0
>    [junit4]   2> 756567 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
>    [junit4]   2> 756567 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
>    [junit4]   2> 756567 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Starting replication process
>    [junit4]   2> 756569 INFO  (qtp1657846-5168) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist}
> status=0 QTime=1
>    [junit4]   2> 756571 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in
> master: 7
>    [junit4]   2> 756571 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707005
>    [junit4]   2> 756572 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter...
> core=collection1
>    [junit4]   2> 756573 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=28, maxMergeAtOnceExplicit=18,
> maxMergedSegmentMB=32.7490234375, floorSegmentMB=1.5126953125,
> forceMergeDeletesPctAllowed=1.8341148040372046, segmentsPerTier=45.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be
> used.
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=1
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter...
> core=collection1
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
> MockDirectoryWrapper(RAMDirectory@7af119
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@155cca9)
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.cfe because it
> already exists
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because
> it already exists
>    [junit4]   2> 756575 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.cfs because it
> already exists
>    [junit4]   2> 756577 INFO  (qtp1657846-5170) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=3&qt=/replication&file=_1.cfs&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756579 INFO  (qtp1657846-5170) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=3&qt=/replication&file=_1.cfe&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756581 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756584 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 756585 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Total time taken for download
> (fullCopy=false,bytesDownloaded=1928) : 0 secs (null bytes/sec) to
> MockDirectoryWrapper(RAMDirectory@7af119
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@155cca9)
>    [junit4]   2> 756592 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
> minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.21270996579556575]
>    [junit4]   2> 756597 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 756597 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 756597 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be
> used.
>    [junit4]   2> 756716 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@15214d0[collection1]
> main]
>    [junit4]   2> 756717 INFO
> (searcherExecutor-1672-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@15214d0[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)
> Uninverting(_1(7.0.0):c1)))}
>    [junit4]   2> 756718 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707005
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707005;done=true>>]
>    [junit4]   2> 756719 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=false
>    [junit4]   2> 756719 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707005
>    [junit4]   2> 756719 INFO  (qtp8806956-5185) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={wait=true&masterUrl=
> http://127.0.0.1:51040/solr/collection1/replication&command=fetchindex}
> status=0 QTime=155
>    [junit4]   2> 756722 INFO  (qtp8806956-5184) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/select
> params={q=name:empty2&sort=id+desc&wt=javabin&version=2} hits=1 status=0
> QTime=1
>    [junit4]   2> 756723 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
>    [junit4]   2> 756724 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=0
>    [junit4]   2> 756725 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=0
>    [junit4]   2> 756730 INFO  (qtp1657846-5169) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={slave=false&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=0
>    [junit4]   2> 756730 INFO  (qtp8806956-5193) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details}
> status=0 QTime=2
>    [junit4]   2> 756732 INFO  (qtp1657846-5168) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
> status=0 QTime=0
>    [junit4]   2> 756732 INFO  (qtp1657846-5170) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
> QTime=0
>    [junit4]   2> 756732 INFO  (qtp8806956-5191) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion}
> status=0 QTime=0
>    [junit4]   2> 756733 INFO  (indexFetcher-1676-thread-1) [
> x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
>    [junit4]   2> 756736 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={wt=javabin&version=2}{add=[3]} 0 2
>    [junit4]   2> 756737 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 756743 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_3,generation=3}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_4,generation=4}
>    [junit4]   2> 756743 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 4
>    [junit4]   2> 756743 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.s.SolrIndexSearcher Opening [Searcher@13b315a[collection1] realtime]
>    [junit4]   2> 756744 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 end_commit_flush
>    [junit4]   2> 756744 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update
> params={openSearcher=false&commit=true&wt=javabin&version=2}{commit=} 0 6
>    [junit4]   2> 756747 WARN  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without
> the /replication suffix
>    [junit4]   2> 756749 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
> QTime=0
>    [junit4]   2> 756750 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Master's generation: 4
>    [junit4]   2> 756750 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Slave's generation: 3
>    [junit4]   2> 756750 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Starting replication process
>    [junit4]   2> 756752 INFO  (qtp1657846-5167) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist}
> status=0 QTime=1
>    [junit4]   2> 756753 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in
> master: 10
>    [junit4]   2> 756753 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707187
>    [junit4]   2> 756753 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter...
> core=collection1
>    [junit4]   2> 756755 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=28, maxMergeAtOnceExplicit=18,
> maxMergedSegmentMB=32.7490234375, floorSegmentMB=1.5126953125,
> forceMergeDeletesPctAllowed=1.8341148040372046, segmentsPerTier=45.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
>    [junit4]   2> 756756 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 756756 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be
> used.
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 756757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 757757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 757757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 757757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 757757 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 758762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 758762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 758762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 758762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 759762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 759762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 759762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 759762 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 760773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 760773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 760773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 760773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 761773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 761773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 761773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 761773 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 762774 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 762774 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 762775 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 762775 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 763776 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 763778 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 763778 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 763778 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 764784 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 764788 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 764788 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 764788 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 765789 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 765790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 765790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 765790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 766790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Found unused file: segments_2
>    [junit4]   2> 766790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2> 766790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3
>    [junit4]   2> 766790 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Sleeping for 1000ms to wait for unused
> lucene index files to be delete-able
>    [junit4]   2> 767819 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher IndexFetcher slept for 11000ms for
> unused lucene index files to be delete-able
>    [junit4]   2> 767819 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter...
> core=collection1
>    [junit4]   2> 767820 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
> MockDirectoryWrapper(RAMDirectory@3dbdb4
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19c0e55)
>    [junit4]   2> 767820 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.cfe because it
> already exists
>    [junit4]   2> 767820 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because
> it already exists
>    [junit4]   2> 767820 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.cfs because it
> already exists
>    [junit4]   2> 767820 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.cfs because it
> already exists
>    [junit4]   2> 767825 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.cfe because it
> already exists
>    [junit4]   2> 767825 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.si because
> it already exists
>    [junit4]   2> 767827 INFO  (qtp1657846-5169) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 767832 INFO  (qtp1657846-5168) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=4&qt=/replication&file=_2.cfe&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 767834 INFO  (qtp1657846-5168) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=4&qt=/replication&file=_2.cfs&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 767835 INFO  (qtp1657846-5165) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent}
> status=0 QTime=0
>    [junit4]   2> 767837 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.h.IndexFetcher Total time taken for download
> (fullCopy=false,bytesDownloaded=2009) : 11 secs (182 bytes/sec) to
> MockDirectoryWrapper(RAMDirectory@3dbdb4
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@19c0e55)
>    [junit4]   2> 767841 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
> org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
> minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.21270996579556575]
>    [junit4]   2> 767870 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit:
> commits: num=2
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_3,generation=3}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@cfaa50
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@b78760
> ),segFN=segments_4,generation=4}
>    [junit4]   2> 767870 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 4
>    [junit4]   2> 767874 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be
> used.
>    [junit4]   2> 767880 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b394fb[collection1]
> main]
>    [junit4]   2> 767880 INFO
> (searcherExecutor-1672-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@1b394fb[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)
> Uninverting(_1(7.0.0):c1) Uninverting(_2(7.0.0):c1)))}
>    [junit4]   2> 767880 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707187
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707187;done=true>>]
>    [junit4]   2> 767880 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=false
>    [junit4]   2> 767880 INFO  (explicit-fetchindex-cmd) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-002\.\collection1\data\index.20160506064707187
>    [junit4]   2> 767880 INFO  (qtp8806956-5182) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication
> params={wait=true&masterUrl=
> http://127.0.0.1:51040/solr/collection1/replication&command=fetchindex}
> status=0 QTime=11134
>    [junit4]   2> 767884 INFO  (qtp1657846-5163) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/select
> params={q=name:empty3&sort=id+desc&wt=javabin&version=2} hits=0 status=0
> QTime=0
>    [junit4]   2> 767885 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
>    [junit4]   2> 767887 INFO  (qtp8806956-5189) [    x:collection1]
> o.a.s.c.S.Request [collection1]  webapp=/solr path=/select
> params={q=name:empty3&sort=id+desc&wt=javabin&version=2} hits=1 status=0
> QTime=0
>    [junit4]   2> 767887 INFO
> (TEST-TestReplicationHandler.testEmptyCommits-seed#[B5F54CB6F816554A]) [
> ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
>    [junit4]   2> 767897 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr
> path=/update params={wt=javabin&version=2}{add=[4]} 0 8
>    [junit4]   2> 767898 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.u.DirectUpdateHandler2 start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
>    [junit4]   2> 767922 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=4
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_2,generation=2}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_3,generation=3}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_4,generation=4}
>    [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@a21b34
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e0edb
> ),segFN=segments_5,generation=5}
>    [junit4]   2> 767922 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.c.SolrDeletionPolicy newest commit generation = 5
>    [junit4]   2> 767922 INFO  (qtp1657846-5166) [    x:collection1]
> o.a.s.s.SolrIndexSearcher Opening [Searcher@485c2[collection1] main]
>    [junit4]   2> 767923 INFO
> (searcherExecutor-1662-thread-1-processing-x:collection1) [
> x:collection1] o.a.s.c.SolrCore [collect
>
> [...truncated too long message...]
>
> rently being tracked
>    [junit4]   2> 818816 INFO  (coreCloseExecutor-2336-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-031\.\collection1\data\
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-031\.\collection1\data\;done=false>>]
>    [junit4]   2> 818816 INFO  (coreCloseExecutor-2336-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=true
>    [junit4]   2> 818816 INFO  (coreCloseExecutor-2336-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-031\.\collection1\data\
>    [junit4]   2> 818816 INFO  (coreCloseExecutor-2336-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-031\.\collection1\data\index
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-031\.\collection1\data\index;done=false>>]
>    [junit4]   2> 818816 INFO  (coreCloseExecutor-2336-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=true
>    [junit4]   2> 818816 INFO  (coreCloseExecutor-2336-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-031\.\collection1\data\index
>    [junit4]   2> 818821 INFO
> (TEST-TestReplicationHandler.doTestStressReplication-seed#[B5F54CB6F816554A])
> [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@95d151
> {/solr,null,UNAVAILABLE}
>    [junit4]   2> 818832 INFO
> (TEST-TestReplicationHandler.doTestStressReplication-seed#[B5F54CB6F816554A])
> [    ] o.e.j.s.ServerConnector Stopped ServerConnector@1621611
> {HTTP/1.1,[http/1.1]}{127.0.0.1:0}
>    [junit4]   2> 818832 INFO
> (TEST-TestReplicationHandler.doTestStressReplication-seed#[B5F54CB6F816554A])
> [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=17995372
>    [junit4]   2> 818836 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore
> org.apache.solr.core.SolrCore@cb84aa
>    [junit4]   2> 818836 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.u.DirectUpdateHandler2 closing
> DirectUpdateHandler2{commits=4,autocommits=0,soft
> autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=12,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
>    [junit4]   2> 818836 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
>    [junit4]   2> 818836 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has
> reached 0 - closing IndexWriter
>    [junit4]   2> 818836 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
> IndexWriterCloser
>    [junit4]   2> 818839 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on
> request.
>    [junit4]   2> 818840 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory
> - 2 directories currently being tracked
>    [junit4]   2> 818840 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-032\.\collection1\data\
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-032\.\collection1\data\;done=false>>]
>    [junit4]   2> 818841 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=true
>    [junit4]   2> 818841 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-032\.\collection1\data\
>    [junit4]   2> 818841 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-032\.\collection1\data\index.20160506064809183
> [CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-032\.\collection1\data\index.20160506064809183;done=false>>]
>    [junit4]   2> 818841 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory,
> CoreContainer#isShutdown=true
>    [junit4]   2> 818841 INFO  (coreCloseExecutor-2338-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001\solr-instance-032\.\collection1\data\index.20160506064809183
>    [junit4]   2> 818842 INFO
> (TEST-TestReplicationHandler.doTestStressReplication-seed#[B5F54CB6F816554A])
> [    ] o.e.j.s.h.ContextHandler Stopped
> o.e.j.s.ServletContextHandler@1b16bb7{/solr,null,UNAVAILABLE}
>    [junit4]   2> 818874 INFO
> (SUITE-TestReplicationHandler-seed#[B5F54CB6F816554A]-worker) [    ]
> o.a.s.SolrTestCaseJ4 ###deleteCore
>    [junit4]   2> NOTE: leaving temporary files on disk at:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_B5F54CB6F816554A-001
>    [junit4]   2> NOTE: test params are:
> codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
> chunkSize=2, maxDocsPerChunk=581, blockSize=4),
> termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST,
> chunkSize=2, blockSize=4)),
> sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=de-DE,
> timezone=Pacific/Ponape
>    [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_92
> (32-bit)/cpus=3,threads=1,free=323266328,total=389021696
>    [junit4]   2> NOTE: All tests run in this JVM:
> [TestUniqueKeyFieldResource, ChaosMonkeyNothingIsSafeTest,
> TestGroupingSearch, CloudExitableDirectoryReaderTest, QueryEqualityTest,
> TestSchemaResource, AsyncMigrateRouteKeyTest, LeaderElectionTest,
> TestStressVersions, DistribJoinFromCollectionTest,
> SimpleCollectionCreateDeleteTest, TestEmbeddedSolrServerConstructors,
> TestInfoStreamLogging, CdcrRequestHandlerTest,
> TestOverriddenPrefixQueryForCustomFieldType, TestQuerySenderNoQuery,
> TestHashPartitioner, TestTolerantUpdateProcessorRandomCloud,
> TestSolrQueryResponse, TestReqParamsAPI, SaslZkACLProviderTest,
> TestSchemaManager, TestWordDelimiterFilterFactory,
> TestFileDictionaryLookup, TestCustomDocTransformer,
> TestManagedSynonymFilterFactory, AddBlockUpdateTest,
> TestDynamicFieldResource, ReplicationFactorTest, TestAnalyzedSuggestions,
> PolyFieldTest, RequiredFieldsTest, BigEndianAscendingWordDeserializerTest,
> TestConfigSetProperties, HdfsChaosMonkeyNothingIsSafeTest,
> HdfsBasicDistributedZk2Test, TestFaceting, OverseerTest,
> XsltUpdateRequestHandlerTest, StandardRequestHandlerTest,
> CollectionsAPIAsyncDistributedZkTest, TestRuleBasedAuthorizationPlugin,
> TestGraphTermsQParserPlugin, MoreLikeThisHandlerTest,
> OutOfBoxZkACLAndCredentialsProvidersTest, RulesTest, ShardRoutingTest,
> TestLMDirichletSimilarityFactory, PeerSyncTest, CircularListTest,
> TestReplicationHandler]
>    [junit4] Completed [134/593 (1!)] on J0 in 63.66s, 15 tests, 1 error
> <<< FAILURES!
>
> [...truncated 1503 lines...]
> BUILD FAILED
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:740: The
> following error occurred while executing this line:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:684: The
> following error occurred while executing this line:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\build.xml:59: The
> following error occurred while executing this line:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build.xml:233:
> The following error occurred while executing this line:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\common-build.xml:529:
> The following error occurred while executing this line:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1457:
> The following error occurred while executing this line:
> C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1014:
> There were test failures: 593 suites (10 ignored), 2396 tests, 1 error, 124
> ignored (80 assumptions) [seed: B5F54CB6F816554A]
>
> Total time: 78 minutes 20 seconds
> Build step 'Invoke Ant' marked build as failure
> Archiving artifacts
> [WARNINGS] Skipping publisher since build result is FAILURE
> Recording test results
> Email was triggered for: Failure - Any
> Sending email for trigger: Failure - Any
>
>
>
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
>



-- 
Regards,
Shalin Shekhar Mangar.

Mime
View raw message