Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Windows/5464/
Java: 64bit/jdk1.8.0_72 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC

2 tests failed.
FAILED:  org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test

Error Message:
some core start times did not change on reload

Stack Trace:
java.lang.AssertionError: some core start times did not change on reload
        at 
__randomizedtesting.SeedInfo.seed([D872F07BD079304B:5026CFA17E855DB3]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:742)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:159)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:964)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestStressReplication

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

Stack Trace:
java.lang.AssertionError: [index.20160205093807049, index.20160205093808250, 
index.properties, replication.properties] expected:<1> but was:<2>
        at 
__randomizedtesting.SeedInfo.seed([D872F07BD079304B:3D9F0BDD55159F8]: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:820)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:787)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 10678 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_D872F07BD079304B-001\init-core-data-001
   [junit4]   2> 672926 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
   [junit4]   2> 672927 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-001\collection1
   [junit4]   2> 672938 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 672940 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@176bf2dd{/solr,null,AVAILABLE}
   [junit4]   2> 672942 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@54217bb2{HTTP/1.1}{127.0.0.1:65198}
   [junit4]   2> 672942 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.Server Started @676706ms
   [junit4]   2> 672942 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-001\collection1\data,
 hostContext=/solr, hostPort=65198}
   [junit4]   2> 672943 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 672943 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-001'
   [junit4]   2> 672943 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 672943 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 672944 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-001\solr.xml
   [junit4]   2> 672953 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-001\.
   [junit4]   2> 672953 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 403239701
   [junit4]   2> 672953 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-001]
   [junit4]   2> 672953 WARN  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-001\lib
 to classpath: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-001\lib
   [junit4]   2> 672954 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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> 672956 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 672957 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 672957 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 672957 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 672957 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 672957 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-001\.
   [junit4]   2> 672961 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=false, dataDir=data\}
   [junit4]   2> 672961 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-001\.\collection1
   [junit4]   2> 672961 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 672962 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\collection1'
   [junit4]   2> 672962 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 672963 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 672963 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 672963 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 672976 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 672978 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 672984 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 672986 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 672989 INFO  (coreLoadExecutor-1248-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 672994 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\collection1'
   [junit4]   2> 672994 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\.\collection1
   [junit4]   2> 672994 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 672995 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\collection1],
 
dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-001\.\collection1\data\]
   [junit4]   2> 672995 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 672995 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 672995 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\.\collection1\data\index/
   [junit4]   2> 672995 WARN  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\.\collection1\data\index'
 doesn't exist. Creating new index...
   [junit4]   2> 672996 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\.\collection1\data\index
   [junit4]   2> 672997 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2064622534, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 672997 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_1,generation=1}
   [junit4]   2> 672997 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 672998 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_D872F07BD079304B-001\solr-instance-001\.\collection1\data\
   [junit4]   2> 672998 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 673002 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673003 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673004 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673005 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673018 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 673018 INFO  (coreLoadExecutor-1248-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> 673018 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 673019 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 673019 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 673019 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=15.3466796875, 
floorSegmentMB=0.5908203125, forceMergeDeletesPctAllowed=8.926955314073627, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 673019 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_1,generation=1}
   [junit4]   2> 673019 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 673019 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2aa8532[collection1] 
main
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\collection1\conf
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\collection1\conf}
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-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_D872F07BD079304B-001\solr-instance-001\collection1\conf
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 673020 INFO  
(searcherExecutor-1249-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2aa8532[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 673020 INFO  (coreLoadExecutor-1248-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 673474 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-002\collection1
   [junit4]   2> 673482 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 673484 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4c8eb88a{/solr,null,AVAILABLE}
   [junit4]   2> 673484 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@1bf14852{HTTP/1.1}{127.0.0.1:65201}
   [junit4]   2> 673484 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.Server Started @677248ms
   [junit4]   2> 673484 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-002\collection1\data,
 hostContext=/solr, hostPort=65201}
   [junit4]   2> 673484 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@73d16e93
   [junit4]   2> 673484 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-002'
   [junit4]   2> 673485 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 673485 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 673486 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-002\solr.xml
   [junit4]   2> 673489 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\.
   [junit4]   2> 673489 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 348711743
   [junit4]   2> 673489 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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_D872F07BD079304B-001\solr-instance-002]
   [junit4]   2> 673489 WARN  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\lib
 to classpath: 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\lib
   [junit4]   2> 673490 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
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> 673491 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 673491 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 673491 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 673492 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 673492 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 673492 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\.
   [junit4]   2> 673495 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=false, dataDir=data\}
   [junit4]   2> 673495 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\.\collection1
   [junit4]   2> 673495 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 673496 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\collection1'
   [junit4]   2> 673497 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 673497 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 673497 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0
   [junit4]   2> 673497 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 673507 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 673511 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.0
   [junit4]   2> 673517 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 673519 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 673520 INFO  (coreLoadExecutor-1258-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 673522 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\collection1'
   [junit4]   2> 673522 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\.\collection1
   [junit4]   2> 673522 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 673522 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\collection1],
 
dataDir=[C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\.\collection1\data\]
   [junit4]   2> 673523 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 673523 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 673523 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index/
   [junit4]   2> 673523 WARN  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index'
 doesn't exist. Creating new index...
   [junit4]   2> 673524 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index
   [junit4]   2> 673525 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2064622534, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 673525 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_1,generation=1}
   [junit4]   2> 673525 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 673525 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\
   [junit4]   2> 673526 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 673527 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673528 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673529 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673530 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 673530 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 673530 INFO  (coreLoadExecutor-1258-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> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=13, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=15.3466796875, 
floorSegmentMB=0.5908203125, forceMergeDeletesPctAllowed=8.926955314073627, 
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_1,generation=1}
   [junit4]   2> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 673531 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4258e30c[collection1] 
main
   [junit4]   2> 673532 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\collection1\conf
   [junit4]   2> 673532 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\collection1\conf}
   [junit4]   2> 673532 INFO  (coreLoadExecutor-1258-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_D872F07BD079304B-001\solr-instance-002\collection1\conf
   [junit4]   2> 673532 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 673537 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 673537 INFO  
(searcherExecutor-1259-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4258e30c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 673537 INFO  (coreLoadExecutor-1258-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 674001 INFO  (qtp1134280447-2582) [    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> 674004 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 1
   [junit4]   2> 674006 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 674007 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_2,generation=2}
   [junit4]   2> 674007 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 674008 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@7474b5bd[collection1] main
   [junit4]   2> 674008 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 674008 INFO  
(searcherExecutor-1249-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7474b5bd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C1)))}
   [junit4]   2> 674008 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 674030 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 674032 INFO  (qtp1134280447-2585) [    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> 674032 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 674032 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 674032 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 674038 INFO  (qtp1134280447-2586) [    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=4
   [junit4]   2> 674039 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 674039 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704318
   [junit4]   2> 674039 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 674040 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=48, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=67.5634765625, 
floorSegmentMB=0.337890625, forceMergeDeletesPctAllowed=24.701638200070516, 
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.22277667092497053
   [junit4]   2> 674040 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_1,generation=1}
   [junit4]   2> 674040 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 674040 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 674041 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_1,generation=1}
   [junit4]   2> 674041 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 674041 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 674041 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@554c73d6 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6c822faa)
   [junit4]   2> 674043 INFO  (qtp1134280447-2587) [    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> 674046 INFO  (qtp1134280447-2582) [    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> 674052 INFO  (qtp1134280447-2583) [    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> 674054 INFO  (qtp1134280447-2584) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 674055 INFO  (qtp1134280447-2585) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 674057 INFO  (qtp1134280447-2586) [    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> 674060 INFO  (qtp1134280447-2587) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 674062 INFO  (qtp1134280447-2582) [    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> 674064 INFO  (qtp1134280447-2583) [    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> 674066 INFO  (qtp1134280447-2584) [    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> 674066 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1617) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@554c73d6 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6c822faa)
   [junit4]   2> 674074 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 674074 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2> 674075 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 674075 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 674075 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@423dede9[collection1] main
   [junit4]   2> 674076 INFO  
(searcherExecutor-1259-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@423dede9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C1)))}
   [junit4]   2> 674076 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704318
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704318;done=true>>]
   [junit4]   2> 674076 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704318
   [junit4]   2> 674076 INFO  (qtp646892187-2600) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:65198/solr/collection1/replication&command=fetchindex}
 status=0 QTime=46
   [junit4]   2> 674085 INFO  (qtp646892187-2601) [    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> 674085 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 674087 INFO  (qtp1134280447-2585) [    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> 674090 INFO  (qtp1134280447-2586) [    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> 674096 INFO  (qtp1134280447-2587) [    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> 674096 INFO  (qtp646892187-2602) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=4
   [junit4]   2> 674098 INFO  (qtp1134280447-2582) [    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> 674100 INFO  (qtp646892187-2603) [    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> 674102 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 674102 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 674102 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: 
org.apache.solr.search.SolrIndexSearcher
   [junit4]   2> 674102 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 674103 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 674105 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 674108 INFO  (qtp1134280447-2584) [    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> 674108 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave in sync with master.
   [junit4]   2> 674108 INFO  (qtp646892187-2604) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:65198/solr/collection1/replication&command=fetchindex}
 status=0 QTime=3
   [junit4]   2> 674113 INFO  (qtp1134280447-2585) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 674115 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 674117 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_3,generation=3}
   [junit4]   2> 674117 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 674117 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@19a2c598[collection1] main
   [junit4]   2> 674117 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 674117 INFO  
(searcherExecutor-1249-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19a2c598[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C1)
 Uninverting(_1(5.5.0):C1)))}
   [junit4]   2> 674117 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={commit=true&wt=javabin&version=2}{commit=} 0 2
   [junit4]   2> 674118 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 674121 INFO  (qtp1134280447-2587) [    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> 674121 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 674121 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 674121 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 674124 INFO  (qtp1134280447-2582) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=1
   [junit4]   2> 674124 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 674124 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704403
   [junit4]   2> 674125 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=48, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=67.5634765625, 
floorSegmentMB=0.337890625, forceMergeDeletesPctAllowed=24.701638200070516, 
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.22277667092497053
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@5541e136 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2959c171)
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.doc because it 
already exists
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.tim because it 
already exists
   [junit4]   2> 674126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 674127 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.tip because it 
already exists
   [junit4]   2> 674127 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 674127 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 674129 INFO  (qtp1134280447-2583) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 674132 INFO  (qtp1134280447-2584) [    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> 674135 INFO  (qtp1134280447-2585) [    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> 674137 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 674141 INFO  (qtp1134280447-2587) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 674143 INFO  (qtp1134280447-2582) [    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> 674154 INFO  (qtp1134280447-2583) [    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> 674156 INFO  (qtp1134280447-2584) [    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> 674158 INFO  (qtp1134280447-2585) [    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> 674161 INFO  (qtp1134280447-2586) [    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> 674161 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1680) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@5541e136 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2959c171)
   [junit4]   2> 674164 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=15, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 674165 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 674165 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 674165 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 674165 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@28963fa3[collection1] main
   [junit4]   2> 674166 INFO  
(searcherExecutor-1259-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@28963fa3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.0):C1)
 Uninverting(_1(5.5.0):C1)))}
   [junit4]   2> 674166 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704403
 
[CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704403;done=true>>]
   [junit4]   2> 674166 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704403
   [junit4]   2> 674166 INFO  (qtp646892187-2605) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:65198/solr/collection1/replication&command=fetchindex}
 status=0 QTime=47
   [junit4]   2> 674170 INFO  (qtp646892187-2600) [    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> 674171 INFO  
(TEST-TestReplicationHandler.testEmptyCommits-seed#[D872F07BD079304B]) [    ] 
o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 674173 INFO  (qtp1134280447-2587) [    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> 674175 INFO  (qtp1134280447-2582) [    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> 674179 INFO  (qtp1134280447-2583) [    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> 674179 INFO  (qtp646892187-2601) [    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> 674181 INFO  (qtp1134280447-2584) [    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> 674183 INFO  (qtp646892187-2602) [    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> 674185 INFO  (qtp1134280447-2585) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 674187 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 674188 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_3,generation=3}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@4cbd750c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@8db1985),segFN=segments_4,generation=4}
   [junit4]   2> 674188 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 674188 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@484355[collection1] realtime
   [junit4]   2> 674188 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 674188 INFO  (qtp1134280447-2586) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={openSearcher=false&commit=true&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 674190 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 674193 INFO  (qtp1134280447-2587) [    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> 674193 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 674193 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 674193 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 674196 INFO  (qtp1134280447-2582) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=1
   [junit4]   2> 674196 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 28
   [junit4]   2> 674197 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_D872F07BD079304B-001\solr-instance-002\.\collection1\data\index.20160205093704475
   [junit4]   2> 674197 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 674197 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=48, maxMergeAtOnceExplicit=19, maxMergedSegmentMB=67.5634765625, 
floorSegmentMB=0.337890625, forceMergeDeletesPctAllowed=24.701638200070516, 
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.22277667092497053
   [junit4]   2> 674197 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 674197 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 674198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 674198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 674198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 674198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 674198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 674198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 674198 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> 675198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 675198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 675198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 675198 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> 676198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 676198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 676198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 676198 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> 677198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 677198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 677198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 677198 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> 678198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 678198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 678198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 678198 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> 679198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 679198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 679198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 679198 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> 680198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 680198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 680198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 680198 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> 681198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 681198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 681198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 681198 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> 682198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 682198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 682198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 682198 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> 683198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 683198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 683198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 683198 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> 684198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Found unused file: segments_2
   [junit4]   2> 684198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@3a53a103 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@73fffe65),segFN=segments_3,generation=3}
   [junit4]   2> 684198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 684198 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> 685198 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> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@620fb938 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@437c5fd6)
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.doc because it 
already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.tim because it 
already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Asserting_0.tip because it 
already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 685198 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for 

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

  2>    at 
org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:444)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:197)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:157)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:58)
   [junit4]   2>        at 
org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:388)
   [junit4]   2>        at 
org.apache.solr.common.cloud.SolrZkClient$3$1.run(SolrZkClient.java:264)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1739693 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.ServerConnector Stopped ServerConnector@30de2b6e{HTTP/1.1}{127.0.0.1:0}
   [junit4]   2> 1739693 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D872F07BD079304B]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4bb9956{/d_u,null,UNAVAILABLE}
   [junit4]   2> 1739698 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D872F07BD079304B]) 
[n:127.0.0.1:54650_d_u c:awholynewcollection_0 s:shard3 r:core_node2 
x:awholynewcollection_0_shard3_replica1] o.a.s.c.ZkTestServer connecting to 
127.0.0.1:54576 54576
   [junit4]   2> 1741949 INFO  (Thread-4509) [n:127.0.0.1:54624_d_u 
c:awholynewcollection_0 s:shard2 r:core_node4 
x:awholynewcollection_0_shard2_replica2] o.a.s.c.ZkTestServer connecting to 
127.0.0.1:54576 54576
   [junit4]   2> 1741950 WARN  (Thread-4509) [n:127.0.0.1:54624_d_u 
c:awholynewcollection_0 s:shard2 r:core_node4 
x:awholynewcollection_0_shard2_replica2] o.a.s.c.ZkTestServer Watch limit 
violations: 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       
/solr/collections/nodes_used_collection/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/overseer/collection-queue-work
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=CollectionsAPIDistributedZkTest -Dtests.method=test 
-Dtests.seed=D872F07BD079304B -Dtests.slow=true -Dtests.locale=it-IT 
-Dtests.timezone=Pacific/Galapagos -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] FAILURE 91.2s J1 | CollectionsAPIDistributedZkTest.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: some core start times 
did not change on reload
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([D872F07BD079304B:5026CFA17E855DB3]:0)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:742)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:159)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:964)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 1741952 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[D872F07BD079304B]-worker) 
[n:127.0.0.1:54650_d_u c:awholynewcollection_0 s:shard3 r:core_node2 
x:awholynewcollection_0_shard3_replica1] 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\J1\temp\solr.cloud.CollectionsAPIDistributedZkTest_D872F07BD079304B-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): 
{other_tl1=PostingsFormat(name=Direct), 
range_facet_l_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
_version_=PostingsFormat(name=Direct), multiDefault=FST50, a_t=FST50, 
intDefault=PostingsFormat(name=Direct), a_i1=FST50, 
id=PostingsFormat(name=LuceneVarGapDocFreqInterval), range_facet_i_dv=FST50, 
text=PostingsFormat(name=LuceneFixedGap), range_facet_l=FST50, 
timestamp=FST50}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, sim=DefaultSimilarity, locale=it-IT, 
timezone=Pacific/Galapagos
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_72 
(64-bit)/cpus=3,threads=1,free=194540616,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: [TermVectorComponentTest, 
TestJsonFacets, TestSolrJ, HighlighterConfigTest, 
TestOverriddenPrefixQueryForCustomFieldType, 
DistribDocExpirationUpdateProcessorTest, CloudExitableDirectoryReaderTest, 
DistanceFunctionTest, TestBulkSchemaConcurrent, MultiThreadedOCPTest, 
SolrInfoMBeanTest, FullSolrCloudDistribCmdsTest, TestSolrDeletionPolicy2, 
AutoCommitTest, TestDynamicLoading, TestSolrConfigHandlerCloud, 
SecurityConfHandlerTest, TestCloudManagedSchemaConcurrent, 
TestDistributedStatsComponentCardinality, TestInitQParser, 
HdfsTlogReplayBufferedWhileIndexingTest, BlockCacheTest, EnumFieldTest, 
RestartWhileUpdatingTest, BasicDistributedZk2Test, 
TestSimpleTrackingShardHandler, ZkSolrClientTest, TestBlendedInfixSuggestions, 
TestSha256AuthenticationProvider, RulesTest, TestJsonRequest, TestTrie, 
TestCopyFieldCollectionResource, OutputWriterTest, TestStressRecovery, 
MultiTermTest, DistributedFacetPivotWhiteBoxTest, CopyFieldTest, 
DistributedQueueTest, TestPerFieldSimilarity, BJQParserTest, TestUtils, 
TestSchemaSimilarityResource, TestSystemIdResolver, SpellingQueryConverterTest, 
OverseerTaskQueueTest, DirectSolrConnectionTest, TestCharFilters, 
RequestHandlersTest, TestSolr4Spatial, ShardRoutingCustomTest, TestOrdValues, 
RequestLoggingTest, ResponseLogComponentTest, DateRangeFieldTest, 
DateFieldTest, TestRebalanceLeaders, TestPKIAuthenticationPlugin, 
SolrCloudExampleTest, DistributedTermsComponentTest, TestConfigSetProperties, 
TestLMJelinekMercerSimilarityFactory, TestFieldCollectionResource, 
TestQueryTypes, AnalysisErrorHandlingTest, HdfsSyncSliceTest, 
SpellPossibilityIteratorTest, TestSolrIndexConfig, DeleteShardTest, 
OverriddenZkACLAndCredentialsProvidersTest, CSVRequestHandlerTest, 
MinimalSchemaTest, BlockJoinFacetRandomTest, TestDistributedMissingSort, 
SynonymTokenizerTest, HdfsRecoveryZkTest, HdfsLockFactoryTest, 
SpellCheckCollatorTest, TestRecovery, DistributedFacetPivotLargeTest, 
ConjunctionSolrSpellCheckerTest, TestLeaderInitiatedRecoveryThread, 
TestMissingGroups, UpdateRequestProcessorFactoryTest, PluginInfoTest, 
TestManagedResourceStorage, TestRangeQuery, TestExclusionRuleCollectionAccess, 
TestPivotHelperCode, PKIAuthenticationIntegrationTest, 
TestReversedWildcardFilterFactory, FileBasedSpellCheckerTest, TestNRTOpen, 
TestTrieFacet, NotRequiredUniqueKeyTest, TestDocBasedVersionConstraints, 
SSLMigrationTest, CollectionStateFormat2Test, DirectoryFactoryTest, 
HdfsDirectoryFactoryTest, TestRandomFaceting, ShowFileRequestHandlerTest, 
SimpleMLTQParserTest, SuggesterWFSTTest, WordBreakSolrSpellCheckerTest, 
TermVectorComponentDistributedTest, OpenExchangeRatesOrgProviderTest, 
IndexSchemaRuntimeFieldTest, MergeStrategyTest, DateMathParserTest, 
DefaultValueUpdateProcessorTest, ShardSplitTest, 
TestComplexPhraseQParserPlugin, DistributedMLTComponentTest, 
SortSpecParsingTest, TestOmitPositions, TestCollationFieldDocValues, 
FacetPivotSmallTest, TestPerFieldSimilarityWithDefaultOverride, 
TestObjectReleaseTracker, UUIDUpdateProcessorFallbackTest, 
SharedFSAutoReplicaFailoverUtilsTest, SuggesterTSTTest, ResourceLoaderTest, 
BasicFunctionalityTest, TestFreeTextSuggestions, TestDFISimilarityFactory, 
TestCSVResponseWriter, TestMiniSolrCloudClusterSSL, TestSolrCoreProperties, 
TestAtomicUpdateErrorCases, ForceLeaderTest, HdfsBasicDistributedZkTest, 
ConfigSetsAPITest, TestDistributedGrouping, HdfsChaosMonkeySafeLeaderTest, 
BigEndianAscendingWordDeserializerTest, BasicDistributedZkTest, 
ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, 
CollectionsAPIDistributedZkTest]
   [junit4] Completed [288/566 (2!)] on J1 in 91.18s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 879 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:750: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\build.xml:694: 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:233: The 
following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\solr\common-build.xml:534:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1477:
 The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-5.x-Windows\lucene\common-build.xml:1033:
 There were test failures: 566 suites (7 ignored), 2268 tests, 2 failures, 95 
ignored (51 assumptions) [seed: D872F07BD079304B]

Total time: 67 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


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

Reply via email to