[JENKINS] Lucene-Solr-6.x-Windows (32bit/jdk1.8.0_102) - Build # 393 - Unstable!

Policeman Jenkins Server Wed, 17 Aug 2016 21:12:36 -0700

Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/393/
Java: 32bit/jdk1.8.0_102 -server -XX:+UseParallelGC


1 tests failed.
FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestStressReplication

Error Message:
[index.20160817215954518, index.20160817215957416, index.properties, 
replication.properties, snapshot_metadata] expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: [index.20160817215954518, index.20160817215957416, 
index.properties, replication.properties, snapshot_metadata] expected:<1> but 
was:<2>
        at 
__randomizedtesting.SeedInfo.seed([A1FE6B3A944D115E:7A556BFC916578ED]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:909)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:876)
        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)




Build Log:
[...truncated 10775 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\init-core-data-001
   [junit4]   2> 222135 INFO  
(SUITE-TestReplicationHandler-seed#[A1FE6B3A944D115E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 222144 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
   [junit4]   2> 222145 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1
   [junit4]   2> 222171 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 222173 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1a7649b{/solr,null,AVAILABLE}
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@14425ff{HTTP/1.1,[http/1.1]}{127.0.0.1:63896}
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.Server Started @229827ms
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1\data,
 hostContext=/solr, hostPort=63896}
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@1d16e93
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001'
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 222175 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 222178 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\solr.xml
   [junit4]   2> 222191 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.
   [junit4]   2> 222191 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 4252903
   [junit4]   2> 222191 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001]
   [junit4]   2> 222191 WARN  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\lib
 to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\lib
   [junit4]   2> 222191 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
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,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 222195 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 222195 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 222195 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 222196 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 222196 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 222196 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.
   [junit4]   2> 222201 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
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> 222201 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1
   [junit4]   2> 222201 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 222202 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 222202 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 222205 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1'
   [junit4]   2> 222206 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 222206 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 222243 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 222247 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
   [junit4]   2> 222253 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 222263 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 222271 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 222283 INFO  (coreLoadExecutor-1234-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-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1'
   [junit4]   2> 222283 INFO  (coreLoadExecutor-1234-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1
   [junit4]   2> 222283 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 222285 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\]
   [junit4]   2> 222285 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 222285 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\snapshot_metadata
   [junit4]   2> 222285 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot 
metadata file...
   [junit4]   2> 222286 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 222286 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\index/
   [junit4]   2> 222286 WARN  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\index'
 doesn't exist. Creating new index...
   [junit4]   2> 222286 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\index
   [junit4]   2> 222287 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=232833850, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 222287 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_1,generation=1}
   [junit4]   2> 222288 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 222288 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-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 222290 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 222298 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222300 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222301 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222303 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222304 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 222304 INFO  (coreLoadExecutor-1234-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,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 222304 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 222305 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 222305 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 222305 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=32, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=36.2060546875, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=15.629354431145611, 
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 222305 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_1,generation=1}
   [junit4]   2> 222305 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 222305 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ccbf62[collection1] 
main]
   [junit4]   2> 222306 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1\conf
   [junit4]   2> 222306 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1\conf}
   [junit4]   2> 222306 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-001\collection1\conf
   [junit4]   2> 222308 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 222308 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 222308 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 222308 INFO  
(searcherExecutor-1235-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@ccbf62[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 222308 INFO  (coreLoadExecutor-1234-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 222704 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1
   [junit4]   2> 222716 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 222717 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@b65b97{/solr,null,AVAILABLE}
   [junit4]   2> 222718 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@b94da5{HTTP/1.1,[http/1.1]}{127.0.0.1:63899}
   [junit4]   2> 222720 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.e.j.s.Server Started @230372ms
   [junit4]   2> 222720 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1\data,
 hostContext=/solr, hostPort=63899}
   [junit4]   2> 222721 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@1d16e93
   [junit4]   2> 222721 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002'
   [junit4]   2> 222721 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 222721 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 222722 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\solr.xml
   [junit4]   2> 222728 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.
   [junit4]   2> 222728 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 16969347
   [junit4]   2> 222728 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002]
   [junit4]   2> 222729 WARN  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\lib
 to classpath: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\lib
   [junit4]   2> 222729 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
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,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 222730 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 222731 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 222731 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 222731 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 222731 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 222732 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.
   [junit4]   2> 222736 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
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> 222736 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1
   [junit4]   2> 222737 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 222737 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 222737 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 222737 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1'
   [junit4]   2> 222738 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 222738 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 222750 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 222752 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.2.0
   [junit4]   2> 222773 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 222776 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 222779 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 222781 INFO  (coreLoadExecutor-1244-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-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1'
   [junit4]   2> 222781 INFO  (coreLoadExecutor-1244-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1
   [junit4]   2> 222781 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\]
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\snapshot_metadata
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot 
metadata file...
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index/
   [junit4]   2> 222782 WARN  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index'
 doesn't exist. Creating new index...
   [junit4]   2> 222782 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index
   [junit4]   2> 222783 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=232833850, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 222783 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_1,generation=1}
   [junit4]   2> 222783 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 222784 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-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 222784 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 222786 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222786 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222788 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222789 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 222790 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 222790 INFO  (coreLoadExecutor-1244-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,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 222790 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 222790 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 222790 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 222790 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=32, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=36.2060546875, 
floorSegmentMB=2.1142578125, forceMergeDeletesPctAllowed=15.629354431145611, 
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 222791 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_1,generation=1}
   [junit4]   2> 222791 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 222791 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@46d31b[collection1] 
main]
   [junit4]   2> 222791 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1\conf
   [junit4]   2> 222791 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1\conf}
   [junit4]   2> 222791 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\collection1\conf
   [junit4]   2> 222792 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 222793 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 222794 INFO  
(searcherExecutor-1245-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@46d31b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 222794 INFO  (coreLoadExecutor-1244-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 223144 INFO  (qtp13899655-2822) [    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> 223241 INFO  (qtp13899655-2819) [    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> 223247 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 2
   [junit4]   2> 223252 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 223253 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_2,generation=2}
   [junit4]   2> 223254 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 223258 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3849cd[collection1] main]
   [junit4]   2> 223258 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 223258 INFO  
(searcherExecutor-1235-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3849cd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1)))}
   [junit4]   2> 223258 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 6
   [junit4]   2> 223269 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 223272 INFO  (qtp13899655-2816) [    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> 223273 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 223273 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 223273 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 223281 INFO  (qtp13899655-2814) [    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=7
   [junit4]   2> 223282 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 223284 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925070
   [junit4]   2> 223285 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 223285 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=73.2802734375, 
floorSegmentMB=1.728515625, forceMergeDeletesPctAllowed=24.882077241635724, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.14076060415307118
   [junit4]   2> 223285 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_1,generation=1}
   [junit4]   2> 223285 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 223285 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 223286 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_1,generation=1}
   [junit4]   2> 223286 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 223286 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 223286 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@47757e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2868d5)
   [junit4]   2> 223325 INFO  (qtp13899655-2815) [    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=21
   [junit4]   2> 223337 INFO  (qtp13899655-2824) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223340 INFO  (qtp13899655-2812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223344 INFO  (qtp13899655-2822) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223345 INFO  (qtp13899655-2818) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223349 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223354 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223356 INFO  (qtp13899655-2816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223358 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223361 INFO  (qtp13899655-2815) [    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> 223361 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1596) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@47757e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2868d5)
   [junit4]   2> 223364 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=43.3369140625, 
floorSegmentMB=1.6201171875, forceMergeDeletesPctAllowed=11.312112402154318, 
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 223372 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2> 223372 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 223373 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 223374 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@97316c[collection1] main]
   [junit4]   2> 223374 INFO  
(searcherExecutor-1245-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@97316c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1)))}
   [junit4]   2> 223374 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925070
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925070;done=true>>]
   [junit4]   2> 223374 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=false
   [junit4]   2> 223374 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925070
   [junit4]   2> 223374 INFO  (qtp17235943-2834) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:63896/solr/collection1/replication&command=fetchindex}
 status=0 QTime=107
   [junit4]   2> 223382 INFO  (qtp17235943-2836) [    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=1
   [junit4]   2> 223383 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 223385 INFO  (qtp13899655-2824) [    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> 223388 INFO  (qtp13899655-2812) [    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> 223392 INFO  (qtp13899655-2822) [    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> 223392 INFO  (qtp17235943-2838) [    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=4
   [junit4]   2> 223397 INFO  (qtp13899655-2818) [    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> 223400 INFO  (qtp17235943-2837) [    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> 223403 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 223404 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 223404 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: 
org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 223404 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 223404 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 223406 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 223412 INFO  (qtp13899655-2817) [    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> 223413 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 223413 INFO  (qtp17235943-2837) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:63896/solr/collection1/replication&command=fetchindex}
 status=0 QTime=7
   [junit4]   2> 223418 INFO  (qtp13899655-2816) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 2
   [junit4]   2> 223419 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 223422 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_3,generation=3}
   [junit4]   2> 223422 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 223422 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@19e86b5[collection1] main]
   [junit4]   2> 223422 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 223422 INFO  
(searcherExecutor-1235-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19e86b5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1)
 Uninverting(_1(6.2.0):C1)))}
   [junit4]   2> 223423 INFO  (qtp13899655-2814) [    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> 223425 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 223427 INFO  (qtp13899655-2815) [    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> 223428 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 223428 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 223428 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 223432 INFO  (qtp13899655-2824) [    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=2
   [junit4]   2> 223433 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 223433 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925220
   [junit4]   2> 223434 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 223437 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=73.2802734375, 
floorSegmentMB=1.728515625, forceMergeDeletesPctAllowed=24.882077241635724, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.14076060415307118
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@194084e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7e4eae)
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.doc because it already 
exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tim because it already 
exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tip because it already 
exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 223438 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 223441 INFO  (qtp13899655-2812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223443 INFO  (qtp13899655-2822) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223445 INFO  (qtp13899655-2818) [    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> 223447 INFO  (qtp13899655-2819) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223450 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223454 INFO  (qtp13899655-2816) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223457 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223461 INFO  (qtp13899655-2815) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223464 INFO  (qtp13899655-2824) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 223467 INFO  (qtp13899655-2812) [    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> 223468 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1678) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@194084e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7e4eae)
   [junit4]   2> 223474 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Exception while updating statistics
   [junit4]   2> java.io.IOException: file "replication.properties" was already 
written to
   [junit4]   2>        at 
org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:654)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:681)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:493)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:254)
   [junit4]   2>        at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
   [junit4]   2>        at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 223474 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=43.3369140625, 
floorSegmentMB=1.6201171875, forceMergeDeletesPctAllowed=11.312112402154318, 
segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 223476 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 223476 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 223476 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 223477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@ba7726[collection1] main]
   [junit4]   2> 223477 INFO  
(searcherExecutor-1245-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@ba7726[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.2.0):C1)
 Uninverting(_1(6.2.0):C1)))}
   [junit4]   2> 223477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925220
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925220;done=true>>]
   [junit4]   2> 223477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=false
   [junit4]   2> 223477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925220
   [junit4]   2> 223477 INFO  (qtp17235943-2833) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:63896/solr/collection1/replication&command=fetchindex}
 status=0 QTime=52
   [junit4]   2> 223482 INFO  (qtp17235943-2834) [    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=0
   [junit4]   2> 223483 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[A1FE6B3A944D115E]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 223488 INFO  (qtp13899655-2822) [    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> 223491 INFO  (qtp13899655-2818) [    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> 223495 INFO  (qtp13899655-2819) [    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> 223496 INFO  (qtp17235943-2835) [    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> 223498 INFO  (qtp13899655-2817) [    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> 223499 INFO  (qtp17235943-2836) [    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> 223502 INFO  (qtp13899655-2817) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 223504 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 223506 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=4
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_3,generation=3}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1edc7ec 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@920e9f),segFN=segments_4,generation=4}
   [junit4]   2> 223506 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 223506 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@19f4868[collection1] realtime]
   [junit4]   2> 223506 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 223506 INFO  (qtp13899655-2814) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={openSearcher=false&commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 223509 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 223510 INFO  (qtp13899655-2815) [    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> 223511 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 223511 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 223511 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 223514 INFO  (qtp13899655-2824) [    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> 223516 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 28
   [junit4]   2> 223516 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-002\.\collection1\data\index.20160817215925303
   [junit4]   2> 223519 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 223520 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=17, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=73.2802734375, 
floorSegmentMB=1.728515625, forceMergeDeletesPctAllowed=24.882077241635724, 
segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.14076060415307118
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 223521 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 223521 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> 224522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 224522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 224522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 224522 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> 225522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 225522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 225522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 225522 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> 226522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 226522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 226522 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 226522 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> 227523 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 227523 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 227523 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 227523 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> 228523 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 228523 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 228523 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 228523 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> 229526 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 229526 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 229527 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 229527 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> 230528 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 230528 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 230528 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 230528 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> 231528 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 231528 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 231528 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 231528 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> 232529 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 232529 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 232529 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 232529 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> 233529 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 233529 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@10e365b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4f586e),segFN=segments_3,generation=3}
   [junit4]   2> 233529 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 233529 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> 234530 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> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@22b136 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@786133)
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.doc because it already 
exists
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tim because it already 
exists
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Lucene50_0.tip because it already 
exists
   [junit4]   2> 234530 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1_Lucene50_0.doc because it already 
exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1_Lucene50_0.tim because it already 
exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
   [junit4]   2> 234531 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1_Lucene50_0.tip because it already 
exists
   [junit4]   2> 234533 INFO  (qtp13899655-2812) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 234537 INFO  (qtp13899655-2819) [    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> 

[...truncated too long message...]

n1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 
directories currently being tracked
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\index
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\index;done=false>>]
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\index
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\snapshot_metadata
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\snapshot_metadata;done=false>>]
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\snapshot_metadata
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\;done=false>>]
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 313936 INFO  (coreCloseExecutor-1886-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-029\.\collection1\data\
   [junit4]   2> 313937 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[A1FE6B3A944D115E])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@103807c{/solr,null,UNAVAILABLE}
   [junit4]   2> 313957 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[A1FE6B3A944D115E])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@996b1b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 313957 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[A1FE6B3A944D115E])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16125967
   [junit4]   2> 313979 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1e44166
   [junit4]   2> 313979 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 closing 
DirectUpdateHandler2{commits=0,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 313979 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 313979 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 
0 - closing IndexWriter
   [junit4]   2> 313979 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 313981 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 313981 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 
directories currently being tracked
   [junit4]   2> 313981 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\;done=false>>]
   [junit4]   2> 313981 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 313981 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\
   [junit4]   2> 313983 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\snapshot_metadata
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\snapshot_metadata;done=false>>]
   [junit4]   2> 313983 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 313983 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\snapshot_metadata
   [junit4]   2> 313983 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\index
 
[CachedDir<<refCount=0;path=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\index;done=false>>]
   [junit4]   2> 313983 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 313983 INFO  (coreCloseExecutor-1888-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001\solr-instance-030\.\collection1\data\index
   [junit4]   2> 313986 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterStartup-seed#[A1FE6B3A944D115E])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@f91f2d{/solr,null,UNAVAILABLE}
   [junit4]   2> 314012 INFO  
(SUITE-TestReplicationHandler-seed#[A1FE6B3A944D115E]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_A1FE6B3A944D115E-001
   [junit4]   2> NOTE: test params are: 
codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
 chunkSize=29308, maxDocsPerChunk=9, blockSize=5), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, 
chunkSize=29308, blockSize=5)), sim=ClassicSimilarity, locale=sr, 
timezone=America/Atikokan
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102 
(32-bit)/cpus=3,threads=1,free=156546104,total=281018368
   [junit4]   2> NOTE: All tests run in this JVM: [TestSolrConfigHandlerCloud, 
TestGraphMLResponseWriter, SoftAutoCommitTest, SolrCoreTest, 
TestNumericTerms64, TestReplicaProperties, SimpleCollectionCreateDeleteTest, 
TestRemoteStreaming, TestSolrDeletionPolicy1, LeaderElectionTest, FullHLLTest, 
CoreAdminCreateDiscoverTest, TestPhraseSuggestions, TestReplicationHandler]
   [junit4] Completed [43/629 (1!)] on J0 in 91.93s, 15 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 54347 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

[JENKINS] Lucene-Solr-6.x-Windows (32bit/jdk1.8.0_102) - Build # 393 - Unstable!

Reply via email to