Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/4952/
Java: 32bit/jdk1.8.0_51 -server -XX:+UseSerialGC

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

Error Message:
[index.20150728233218532, index.20150728233219567, index.properties, 
replication.properties] expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: [index.20150728233218532, index.20150728233219567, 
index.properties, replication.properties] expected:<1> but was:<2>
        at 
__randomizedtesting.SeedInfo.seed([4EB89D84FF4AD00A:95139D42FA62B9B9]: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:818)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:785)
        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:497)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        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:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10447 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\init-core-data-001
   [junit4]   2> 752283 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
   [junit4]   2> 752284 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\collection1
   [junit4]   2> 752291 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 752294 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@136eb39{/solr,null,AVAILABLE}
   [junit4]   2> 752295 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@145ffb8{HTTP/1.1}{127.0.0.1:52224}
   [junit4]   2> 752295 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.Server Started @755137ms
   [junit4]   2> 752295 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\collection1\data,
 hostContext=/solr, hostPort=52224}
   [junit4]   2> 752295 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@e2f2a
   [junit4]   2> 752296 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\'
   [junit4]   2> 752316 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\solr.xml
   [junit4]   2> 752322 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.
   [junit4]   2> 752322 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 404634
   [junit4]   2> 752322 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\]
   [junit4]   2> 752322 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\lib
   [junit4]   2> 752322 WARN  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to 
classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\lib).
   [junit4]   2> 752329 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
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,
   [junit4]   2> 752332 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 752332 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 752332 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 752332 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 752333 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.
   [junit4]   2> 752335 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1,
 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\,
 dataDir=data\}
   [junit4]   2> 752335 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\
   [junit4]   2> 752336 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 752336 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\'
   [junit4]   2> 752337 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 752337 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 752355 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 752362 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
   [junit4]   2> 752365 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 752366 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\conf\schema.xml
   [junit4]   2> 752368 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 752370 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 752373 INFO  (coreLoadExecutor-1530-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\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\conf'
   [junit4]   2> 752373 INFO  (coreLoadExecutor-1530-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\
   [junit4]   2> 752373 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 752373 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\],
 dataDir=[null]
   [junit4]   2> 752374 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 752374 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 752374 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\data\index/
   [junit4]   2> 752374 WARN  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\data\index'
 doesn't exist. Creating new index...
   [junit4]   2> 752374 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\data\index
   [junit4]   2> 752375 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=30, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=34.3896484375, 
floorSegmentMB=1.7421875, forceMergeDeletesPctAllowed=4.017269206169347, 
segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 752375 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_1,generation=1}
   [junit4]   2> 752375 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 752376 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 752377 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 752381 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752381 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752382 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752383 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752394 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 752394 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 752394 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 752395 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 752395 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 752395 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=2.9365234375, 
floorSegmentMB=0.3779296875, forceMergeDeletesPctAllowed=9.700978236645868, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 752396 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_1,generation=1}
   [junit4]   2> 752396 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 752396 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@1b27785[collection1] 
main
   [junit4]   2> 752396 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\conf
   [junit4]   2> 752396 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\conf}
   [junit4]   2> 752396 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-001\.\collection1\conf
   [junit4]   2> 752397 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 752397 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 752397 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 752397 INFO  (coreLoadExecutor-1530-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 752397 INFO  
(searcherExecutor-1531-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1b27785[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 752845 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\collection1
   [junit4]   2> 752860 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.Server jetty-9.2.11.v20150529
   [junit4]   2> 752864 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6d1744{/solr,null,AVAILABLE}
   [junit4]   2> 752864 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@bea365{HTTP/1.1}{127.0.0.1:52228}
   [junit4]   2> 752864 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.e.j.s.Server Started @755707ms
   [junit4]   2> 752864 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\collection1\data,
 hostContext=/solr, hostPort=52228}
   [junit4]   2> 752865 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@e2f2a
   [junit4]   2> 752865 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\'
   [junit4]   2> 752896 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\solr.xml
   [junit4]   2> 752905 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.
   [junit4]   2> 752906 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 22694271
   [junit4]   2> 752906 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\]
   [junit4]   2> 752906 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer loading shared library: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\lib
   [junit4]   2> 752906 WARN  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to 
classloader: lib (resolved as: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\lib).
   [junit4]   2> 752916 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
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,
   [junit4]   2> 752920 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 752921 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 752921 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 752922 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 752922 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.
   [junit4]   2> 752924 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, 
instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1,
 
absoluteInstDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\,
 dataDir=data\}
   [junit4]   2> 752925 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\
   [junit4]   2> 752926 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 752926 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\'
   [junit4]   2> 752927 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 752927 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 752962 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 752965 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
   [junit4]   2> 752970 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 752971 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\conf\schema.xml
   [junit4]   2> 752974 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 752979 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 752983 INFO  (coreLoadExecutor-1540-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\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\conf'
   [junit4]   2> 752983 INFO  (coreLoadExecutor-1540-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\
   [junit4]   2> 752983 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 752984 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\],
 dataDir=[null]
   [junit4]   2> 752984 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 752984 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 752984 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index/
   [junit4]   2> 752985 WARN  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index'
 doesn't exist. Creating new index...
   [junit4]   2> 752985 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index
   [junit4]   2> 752985 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=30, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=34.3896484375, 
floorSegmentMB=1.7421875, forceMergeDeletesPctAllowed=4.017269206169347, 
segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 752986 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_1,generation=1}
   [junit4]   2> 752986 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 752986 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 752987 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 752992 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752994 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752995 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 752997 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 753002 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 753002 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,defaults,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 753002 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 753003 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 753003 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 753003 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=2.9365234375, 
floorSegmentMB=0.3779296875, forceMergeDeletesPctAllowed=9.700978236645868, 
segmentsPerTier=50.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 753004 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_1,generation=1}
   [junit4]   2> 753004 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 753004 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@922698[collection1] 
main
   [junit4]   2> 753004 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\conf
   [junit4]   2> 753005 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\conf}
   [junit4]   2> 753005 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\conf
   [junit4]   2> 753005 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 753010 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll Scheduled at an interval of 
1000ms
   [junit4]   2> 753010 INFO  
(searcherExecutor-1541-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@922698[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 753010 INFO  (coreLoadExecutor-1540-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 753429 INFO  (qtp12581026-3419) [    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> 753433 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={wt=javabin&version=2} {add=[1]} 0 0
   [junit4]   2> 753436 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 753437 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_2,generation=2}
   [junit4]   2> 753437 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 753438 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@2c036d[collection1] main
   [junit4]   2> 753438 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 753438 INFO  
(searcherExecutor-1531-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2c036d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
   [junit4]   2> 753439 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2} {commit=} 0 2
   [junit4]   2> 753462 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 753465 INFO  (qtp12581026-3423) [    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> 753465 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 753465 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 753465 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 753473 INFO  (qtp12581026-3421) [    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=5 
   [junit4]   2> 753474 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 753475 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111774
   [junit4]   2> 753477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 753477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... 
core=collection1
   [junit4]   2> 753477 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=54.1923828125, 
floorSegmentMB=1.345703125, forceMergeDeletesPctAllowed=10.317081550258402, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_1,generation=1}
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_1,generation=1}
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Closing IndexWriter...
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... 
core=collection1
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 753478 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download to 
MockDirectoryWrapper(RAMDirectory@f010ad 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e4dc8c) 
fullCopy=false
   [junit4]   2> 753481 INFO  (qtp12581026-3424) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753484 INFO  (qtp12581026-3419) [    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> 753495 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753498 INFO  (qtp12581026-3422) [    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> 753500 INFO  (qtp12581026-3423) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753502 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753504 INFO  (qtp12581026-3424) [    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> 753507 INFO  (qtp12581026-3419) [    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> 753509 INFO  (qtp12581026-3420) [    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> 753512 INFO  (qtp12581026-3422) [    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> 753512 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download : 0 secs
   [junit4]   2> 753516 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 753516 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=684195054, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 753517 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2> 753517 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 753517 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 753517 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@db79f2[collection1] main
   [junit4]   2> 753518 INFO  
(searcherExecutor-1541-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@db79f2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
   [junit4]   2> 753518 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111774
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111774;done=true>>]
   [junit4]   2> 753518 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111774
   [junit4]   2> 753520 INFO  (qtp6640563-3437) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:52224/solr/collection1/replication&command=fetchindex}
 status=0 QTime=57 
   [junit4]   2> 753527 INFO  (qtp6640563-3438) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/select 
params={q=name:empty1&sort=id+desc&wt=javabin&version=2} hits=1 status=0 
QTime=0 
   [junit4]   2> 753527 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.SolrTestCaseJ4 Waited for 0ms and found 1 docs
   [junit4]   2> 753531 INFO  (qtp12581026-3423) [    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> 753532 INFO  (qtp12581026-3421) [    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> 753539 INFO  (qtp12581026-3424) [    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> 753539 INFO  (qtp6640563-3439) [    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=5 
   [junit4]   2> 753542 INFO  (qtp12581026-3419) [    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> 753544 INFO  (qtp6640563-3440) [    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> 753546 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 753548 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 753548 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: 
org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 753548 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 753548 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2} {commit=} 0 2
   [junit4]   2> 753551 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 753554 INFO  (qtp12581026-3422) [    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> 753554 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 753555 INFO  (qtp6640563-3441) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:52224/solr/collection1/replication&command=fetchindex}
 status=0 QTime=5 
   [junit4]   2> 753559 INFO  (qtp12581026-3423) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={wt=javabin&version=2} {add=[2]} 0 0
   [junit4]   2> 753561 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 753562 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_3,generation=3}
   [junit4]   2> 753562 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 753563 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@509302[collection1] main
   [junit4]   2> 753563 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 753563 INFO  
(searcherExecutor-1531-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@509302[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)
 Uninverting(_1(5.3.0):C1)))}
   [junit4]   2> 753563 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2} {commit=} 0 2
   [junit4]   2> 753565 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 753567 INFO  (qtp12581026-3424) [    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> 753567 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 753567 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 753567 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 753570 INFO  (qtp12581026-3419) [    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=0 
   [junit4]   2> 753570 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 753570 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111870
   [junit4]   2> 753571 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 753571 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... 
core=collection1
   [junit4]   2> 753571 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 753572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=54.1923828125, 
floorSegmentMB=1.345703125, forceMergeDeletesPctAllowed=10.317081550258402, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 753572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2> 753572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 753572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 753572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2> 753572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Closing IndexWriter...
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... 
core=collection1
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download to 
MockDirectoryWrapper(RAMDirectory@161a051 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@15165a1) 
fullCopy=false
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.tip because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.doc because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.tim because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 753573 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 753575 INFO  (qtp12581026-3420) [    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> 753578 INFO  (qtp12581026-3422) [    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> 753580 INFO  (qtp12581026-3423) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753582 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753584 INFO  (qtp12581026-3424) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 753586 INFO  (qtp12581026-3419) [    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> 753588 INFO  (qtp12581026-3420) [    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> 753590 INFO  (qtp12581026-3422) [    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> 753592 INFO  (qtp12581026-3423) [    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> 753594 INFO  (qtp12581026-3421) [    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> 753594 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download : 0 secs
   [junit4]   2> 753603 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 753605 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=684195054, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 753605 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 753605 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 753605 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 753606 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@174ce1d[collection1] main
   [junit4]   2> 753606 INFO  
(searcherExecutor-1541-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@174ce1d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)
 Uninverting(_1(5.3.0):C1)))}
   [junit4]   2> 753606 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111870
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111870;done=true>>]
   [junit4]   2> 753606 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111870
   [junit4]   2> 753607 INFO  (qtp6640563-3442) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:52224/solr/collection1/replication&command=fetchindex}
 status=0 QTime=42 
   [junit4]   2> 753609 INFO  (qtp6640563-3437) [    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> 753610 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[4EB89D84FF4AD00A]) [    ] 
o.a.s.SolrTestCaseJ4 Waited for 0ms and found 1 docs
   [junit4]   2> 753612 INFO  (qtp12581026-3424) [    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> 753614 INFO  (qtp12581026-3419) [    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> 753617 INFO  (qtp12581026-3420) [    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> 753618 INFO  (qtp6640563-3438) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=3 
   [junit4]   2> 753620 INFO  (qtp12581026-3422) [    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> 753622 INFO  (qtp6640563-3439) [    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> 753624 INFO  (qtp12581026-3423) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={wt=javabin&version=2} {add=[3]} 0 0
   [junit4]   2> 753627 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 753628 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=3
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_3,generation=3}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1df01a9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@18e82ce),segFN=segments_4,generation=4}
   [junit4]   2> 753628 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 4
   [junit4]   2> 753628 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@b7325f[collection1] realtime
   [junit4]   2> 753628 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 753629 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=/solr path=/update 
params={openSearcher=false&commit=true&wt=javabin&version=2} {commit=} 0 2
   [junit4]   2> 753633 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 753636 INFO  (qtp12581026-3424) [    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> 753637 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 753637 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 753637 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 753640 INFO  (qtp12581026-3419) [    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=0 
   [junit4]   2> 753640 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 28
   [junit4]   2> 753640 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-002\.\collection1\data\index.20150728233111940
   [junit4]   2> 753641 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 753641 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... 
core=collection1
   [junit4]   2> 753641 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 753644 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=21, maxMergedSegmentMB=54.1923828125, 
floorSegmentMB=1.345703125, forceMergeDeletesPctAllowed=10.317081550258402, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 753644 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 753644 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 753645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 753645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 753645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 753645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 753645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 753645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 753645 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> 754645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 754645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 754645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 754645 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> 755645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 755645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 755645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 755645 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> 756645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 756645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 756645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 756645 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> 757645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 757645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 757645 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 757645 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> 758646 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 758646 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 758646 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 758647 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> 759647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 759647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 759647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 759647 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> 760647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 760647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 760647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 760647 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> 761647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 761647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 761647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 761647 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> 762647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 762647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 762647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 762647 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> 763647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 763647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@19ea2ba 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@e2a86b),segFN=segments_3,generation=3}
   [junit4]   2> 763647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrCore newest commit generation = 3
   [junit4]   2> 763647 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> 764648 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> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Closing IndexWriter...
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... 
core=collection1
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download to 
MockDirectoryWrapper(RAMDirectory@196b5ac 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f93e48) 
fullCopy=false
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.tip because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.doc because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.tim because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 764648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.doc because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.tim because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.tip because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
   [junit4]   2> 764649 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
   [junit4]   2> 764651 INFO  (qtp12581026-3420) [    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> 764654 INFO  (qtp12581026-3422) [    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> 764656 INFO  (qtp12581026-3423) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764657 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764659 INFO  (qtp12581026-3424) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764661 INFO  (qtp12581026-3419) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764663 INFO  (qtp12581026-3420) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764665 INFO  (qtp12581026-3422) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764667 INFO  (qtp12581026-3423) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764669 INFO  (qtp12581026-3421) [    x:collection1] 
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0 
   [junit4]   2> 764669 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download : 11 secs
   [junit4]   2> 764671 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 764671 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=684195054, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4] 

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

insSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-027\collection1\data
   [junit4]   2> 822180 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-027\collection1\data\index
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-027\collection1\data\index;done=false>>]
   [junit4]   2> 822180 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-027\collection1\data\index
   [junit4]   2> 822181 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@16f8d3c{/solr,null,UNAVAILABLE}
   [junit4]   2> 822182 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   ] o.e.j.s.ServerConnector Stopped 
ServerConnector@4c7706{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 822182 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14309055
   [junit4]   2> 822183 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@c1d19
   [junit4]   2> 822183 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.u.UpdateHandler 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> 822183 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 822183 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has 
reached 0 - closing IndexWriter
   [junit4]   2> 822183 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 822185 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on 
request.
   [junit4]   2> 822185 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory Closing 
StandardDirectoryFactory - 2 directories currently being tracked
   [junit4]   2> 822185 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-028\collection1\data\index.20150728233219567
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-028\collection1\data\index.20150728233219567;done=false>>]
   [junit4]   2> 822185 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-028\collection1\data\index.20150728233219567
   [junit4]   2> 822185 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-028\collection1\data
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-028\collection1\data;done=false>>]
   [junit4]   2> 822186 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001\solr-instance-028\collection1\data
   [junit4]   2> 822186 INFO  
(TEST-TestReplicationHandler.doTestStressReplication-seed#[4EB89D84FF4AD00A]) [ 
   x:collection1] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@9936ac{/solr,null,UNAVAILABLE}
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestReplicationHandler -Dtests.method=doTestStressReplication 
-Dtests.seed=4EB89D84FF4AD00A -Dtests.slow=true -Dtests.locale=ar_SY 
-Dtests.timezone=Asia/Kuching -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 8.41s J0 | TestReplicationHandler.doTestStressReplication 
<<<
   [junit4]    > Throwable #1: java.lang.AssertionError: 
[index.20150728233218532, index.20150728233219567, index.properties, 
replication.properties] expected:<1> but was:<2>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([4EB89D84FF4AD00A:95139D42FA62B9B9]:0)
   [junit4]    >        at 
org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:818)
   [junit4]    >        at 
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:785)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 822199 INFO  
(SUITE-TestReplicationHandler-seed#[4EB89D84FF4AD00A]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_4EB89D84FF4AD00A-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=DefaultSimilarity, locale=ar_SY, timezone=Asia/Kuching
   [junit4]   2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_51 
(32-bit)/cpus=3,threads=1,free=10504720,total=173031424
   [junit4]   2> NOTE: All tests run in this JVM: [TestNamedUpdateProcessors, 
TestCollationField, AddSchemaFieldsUpdateProcessorFactoryTest, 
TestCloudInspectUtil, DocumentAnalysisRequestHandlerTest, 
SystemInfoHandlerTest, ClusterStateUpdateTest, TestExactSharedStatsCache, 
TestBinaryField, TestDistributedSearch, DeleteShardTest, TestSolrConfigHandler, 
SliceStateTest, TestUpdate, CollectionTooManyReplicasTest, 
PreAnalyzedFieldTest, IndexSchemaRuntimeFieldTest, TestExpandComponent, 
TestStressReorder, DOMUtilTest, RequiredFieldsTest, 
XmlUpdateRequestHandlerTest, ExitableDirectoryReaderTest, TestHashPartitioner, 
OutputWriterTest, TestSurroundQueryParser, TestSolrQueryParserResource, 
SuggesterFSTTest, DistributedExpandComponentTest, LeaderElectionTest, 
TestCopyFieldCollectionResource, ResponseLogComponentTest, 
CollectionsAPIAsyncDistributedZkTest, RecoveryAfterSoftCommitTest, 
ChaosMonkeyNothingIsSafeTest, TimeZoneUtilsTest, TestElisionMultitermQuery, 
TestIndexingPerformance, MigrateRouteKeyTest, TestConfigReload, 
CoreAdminRequestStatusTest, TestClusterStateMutator, TestExtendedDismaxParser, 
FullHLLTest, TestSolrIndexConfig, PingRequestHandlerTest, 
TestCursorMarkWithoutUniqueKey, ResponseHeaderTest, 
TestAnalyzeInfixSuggestions, TestIntervalFaceting, TestJmxMonitoredMap, 
LukeRequestHandlerTest, TestSearcherReuse, URLClassifyProcessorTest, 
TestPartialUpdateDeduplication, OverriddenZkACLAndCredentialsProvidersTest, 
TestFastLRUCache, CachingDirectoryFactoryTest, TestReqParamsAPI, 
CacheHeaderTest, BadCopyFieldTest, TestOmitPositions, UUIDFieldTest, 
TestReplicationHandler]
   [junit4] Completed [158/521] on J0 in 69.95s, 13 tests, 1 failure <<< 
FAILURES!

[...truncated 1151 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:727: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:671: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:59: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build.xml:227: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:517:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1447:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1002:
 There were test failures: 521 suites, 2066 tests, 1 failure, 70 ignored (35 
assumptions)

Total time: 69 minutes 24 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


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

Reply via email to