Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.5/9/

2 tests failed.
FAILED:  
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([4A22FD60ECBDF844:55988C973CDD3E81]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        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)


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

Error Message:
expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<2>
        at 
__randomizedtesting.SeedInfo.seed([4A22FD60ECBDF844:92D5398447663A18]: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.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestIndexFetchOnMasterRestart(TestReplicationHandler.java:624)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        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 10699 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/init-core-data-001
   [junit4]   2> 101503 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
   [junit4]   2> 101503 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1
   [junit4]   2> 101509 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 101511 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@11658c0a{/solr,null,AVAILABLE}
   [junit4]   2> 101513 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@5a130f18{HTTP/1.1}{127.0.0.1:54275}
   [junit4]   2> 101513 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.Server Started @107695ms
   [junit4]   2> 101513 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1/data,
 hostPort=54275, hostContext=/solr}
   [junit4]   2> 101513 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 101513 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001'
   [junit4]   2> 101513 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 101514 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 101514 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/solr.xml
   [junit4]   2> 101528 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/.
   [junit4]   2> 101529 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 335154809
   [junit4]   2> 101529 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001]
   [junit4]   2> 101529 WARN  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/lib
   [junit4]   2> 101529 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 101530 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 101531 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 101531 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 101531 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 101531 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 101532 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/.
   [junit4]   2> 101534 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {loadOnStartup=true, 
transient=false, name=collection1, schema=schema.xml, config=solrconfig.xml, 
configSetProperties=configsetprops.json, dataDir=data/}
   [junit4]   2> 101534 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1
   [junit4]   2> 101534 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 101535 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1'
   [junit4]   2> 101535 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0
   [junit4]   2> 101535 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 101535 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 101535 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 101544 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 101554 WARN  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 101556 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.3
   [junit4]   2> 101580 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 101585 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 101592 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 101594 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1'
   [junit4]   2> 101594 INFO  (coreLoadExecutor-226-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1
   [junit4]   2> 101594 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 101595 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 101595 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 101595 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1/data
   [junit4]   2> 101595 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 101595 WARN  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 101596 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 101596 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=0.07421875, 
floorSegmentMB=1.630859375, forceMergeDeletesPctAllowed=16.541361658868947, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 101596 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_1,generation=1}
   [junit4]   2> 101597 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 101602 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/./collection1/data/
   [junit4]   2> 101619 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 101622 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 101623 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 101624 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 101625 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 101635 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 101635 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/segments,/admin/threads,/admin/luke,/get,/update/json/docs,/replication,/admin/properties,/admin/mbeans,lazy,/update,/update/json,/config,/admin/logging,defaults,standard,/admin/file,/admin/plugins,/schema,/admin/ping,/update/csv,/admin/system
   [junit4]   2> 101636 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 101638 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 101638 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 101638 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=27, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.7470703125, 
floorSegmentMB=1.4033203125, forceMergeDeletesPctAllowed=22.302825763036694, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 101639 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_1,generation=1}
   [junit4]   2> 101639 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 101639 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@154b2e10[collection1] 
main
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1/conf
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1/conf}
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-001/collection1/conf
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 101640 INFO  (coreLoadExecutor-226-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 101641 INFO  
(searcherExecutor-227-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@154b2e10[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 102037 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1
   [junit4]   2> 102041 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 102050 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@599f1a28{/solr,null,AVAILABLE}
   [junit4]   2> 102051 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@5c6e660f{HTTP/1.1}{127.0.0.1:51887}
   [junit4]   2> 102051 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.Server Started @108233ms
   [junit4]   2> 102051 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=51887}
   [junit4]   2> 102051 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 102052 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002'
   [junit4]   2> 102052 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 102052 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 102052 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/solr.xml
   [junit4]   2> 102089 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/.
   [junit4]   2> 102089 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 423986034
   [junit4]   2> 102089 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002]
   [junit4]   2> 102089 WARN  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/lib
   [junit4]   2> 102089 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 102091 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 102091 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 102091 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 102092 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 102092 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 102092 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/.
   [junit4]   2> 102094 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {dataDir=data/, 
configSetProperties=configsetprops.json, config=solrconfig.xml, 
transient=false, schema=schema.xml, name=collection1, loadOnStartup=true}
   [junit4]   2> 102094 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1
   [junit4]   2> 102094 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 102095 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0
   [junit4]   2> 102095 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 102099 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1'
   [junit4]   2> 102100 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 102100 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 102109 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 102119 WARN  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 102121 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.3
   [junit4]   2> 102146 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 102151 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 102158 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 102160 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1'
   [junit4]   2> 102160 INFO  (coreLoadExecutor-236-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1
   [junit4]   2> 102161 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 102161 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 102161 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 102161 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data
   [junit4]   2> 102161 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 102162 WARN  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 102162 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 102162 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=15, maxMergedSegmentMB=0.07421875, 
floorSegmentMB=1.630859375, forceMergeDeletesPctAllowed=16.541361658868947, 
segmentsPerTier=48.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 102163 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_1,generation=1}
   [junit4]   2> 102163 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 102168 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 102170 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/
   [junit4]   2> 102171 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 102172 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 102173 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 102174 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 102177 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with 
startup=lazy 
   [junit4]   2> 102177 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/segments,/admin/threads,/admin/luke,/get,/update/json/docs,/replication,/admin/properties,/admin/mbeans,lazy,/update,/update/json,/config,/admin/logging,defaults,standard,/admin/file,/admin/plugins,/schema,/admin/ping,/update/csv,/admin/system
   [junit4]   2> 102178 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 102179 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 102179 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 102179 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=27, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.7470703125, 
floorSegmentMB=1.4033203125, forceMergeDeletesPctAllowed=22.302825763036694, 
segmentsPerTier=19.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 102179 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_1,generation=1}
   [junit4]   2> 102180 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 102180 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@78487764[collection1] 
main
   [junit4]   2> 102180 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1/conf
   [junit4]   2> 102180 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1/conf}
   [junit4]   2> 102180 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/collection1/conf
   [junit4]   2> 102180 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 102193 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 102193 INFO  (coreLoadExecutor-236-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 102193 INFO  
(searcherExecutor-237-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@78487764[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 102230 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=indexversion&version=2&wt=javabin&qt=/replication} status=0 
QTime=19
   [junit4]   2> 102604 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={version=2&sort=id+desc&wt=javabin&q=*:*} hits=0 status=0 QTime=0
   [junit4]   2> 102612 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&version=2&_trace=getDetails&wt=javabin&qt=/replication} 
status=0 QTime=0
   [junit4]   2> 102640 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&slave=false&version=2&wt=javabin&qt=/replication} 
status=0 QTime=0
   [junit4]   2> 102641 INFO  (qtp1917595739-468) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&version=2&_trace=getDetails&wt=javabin&qt=/replication} 
status=0 QTime=10
   [junit4]   2> 102667 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={version=2&wt=javabin}{add=[0]} 0 15
   [junit4]   2> 102679 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 102687 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_2,generation=2}
   [junit4]   2> 102687 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 102689 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@f6eec9b[collection1] main
   [junit4]   2> 102689 INFO  
(searcherExecutor-227-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@f6eec9b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.3):C1)))}
   [junit4]   2> 102689 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 102690 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={version=2&waitSearcher=true&softCommit=false&wt=javabin&commit=true}{commit=}
 0 11
   [junit4]   2> 102750 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 102763 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=indexversion&version=2&wt=javabin&qt=/replication} status=0 
QTime=0
   [junit4]   2> 102764 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 102764 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 102764 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 102823 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filelist&version=2&wt=javabin&qt=/replication} 
status=0 QTime=3
   [junit4]   2> 102824 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 8
   [junit4]   2> 102825 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551171
   [junit4]   2> 102826 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 102826 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.322265625, 
floorSegmentMB=0.4736328125, forceMergeDeletesPctAllowed=0.02242610159104208, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6317293479402678
   [junit4]   2> 102827 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_1,generation=1}
   [junit4]   2> 102827 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 102827 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 102827 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_1,generation=1}
   [junit4]   2> 102827 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 102828 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 102828 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@36a71db1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@158e6b7f)
   [junit4]   2> 102843 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0.fnm&wt=filestream&qt=/replication}
 status=0 QTime=3
   [junit4]   2> 102859 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0.nvd&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102867 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0.fdx&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102875 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0.nvm&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102883 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0.si&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102891 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0.fdt&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102896 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=_0_Memory_0.ram&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102905 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&command=filecontent&checksum=true&file=segments_2&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 102907 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1313) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@36a71db1 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@158e6b7f)
   [junit4]   2> 102909 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.25755457016797356]
   [junit4]   2> 102911 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_2,generation=2}
   [junit4]   2> 102911 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 102911 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 102912 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@7bd5ae33[collection1] main
   [junit4]   2> 102913 INFO  
(searcherExecutor-237-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7bd5ae33[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.3):C1)))}
   [junit4]   2> 102913 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551171
 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551171;done=true>>]
   [junit4]   2> 102913 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551171
   [junit4]   2> 102922 INFO  (qtp1917595739-469) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=fetchindex&masterUrl=http://127.0.0.1:54275/solr/collection1/replication&wait=true}
 status=0 QTime=183
   [junit4]   2> 103024 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&slave=false&version=2&wt=javabin&qt=/replication} 
status=0 QTime=0
   [junit4]   2> 103027 INFO  (qtp1917595739-470) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&version=2&_trace=getDetails&wt=javabin&qt=/replication} 
status=0 QTime=59
   [junit4]   2> 103050 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={version=2&wt=javabin}{add=[1]} 0 15
   [junit4]   2> 103059 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 103088 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_3,generation=3}
   [junit4]   2> 103088 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 103088 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@6abb259d[collection1] main
   [junit4]   2> 103089 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 103090 INFO  
(searcherExecutor-227-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6abb259d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.3):C1)
 Uninverting(_1(5.5.3):C1)))}
   [junit4]   2> 103090 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={version=2&waitSearcher=true&softCommit=false&wt=javabin&commit=true}{commit=}
 0 31
   [junit4]   2> 103098 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 103103 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=indexversion&version=2&wt=javabin&qt=/replication} status=0 
QTime=0
   [junit4]   2> 103104 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 103104 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 103104 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 103113 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filelist&version=2&wt=javabin&qt=/replication} 
status=0 QTime=2
   [junit4]   2> 103115 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 15
   [junit4]   2> 103115 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551462
   [junit4]   2> 103121 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 103123 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.322265625, 
floorSegmentMB=0.4736328125, forceMergeDeletesPctAllowed=0.02242610159104208, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6317293479402678
   [junit4]   2> 103124 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_2,generation=2}
   [junit4]   2> 103124 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 103124 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 103125 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_2,generation=2}
   [junit4]   2> 103125 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 103125 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@21ecd801 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44593b0d)
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 103126 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Memory_0.ram because it already 
exists
   [junit4]   2> 103130 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1.nvd&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103134 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1.fnm&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103138 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1_Memory_0.ram&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103141 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1.fdt&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103145 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1.fdx&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103149 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1.nvm&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103153 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=_1.si&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103156 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&command=filecontent&checksum=true&file=segments_3&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103157 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1376) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@21ecd801 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@44593b0d)
   [junit4]   2> 103160 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.25755457016797356]
   [junit4]   2> 103162 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_3,generation=3}
   [junit4]   2> 103162 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 103163 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 103164 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@33fa7137[collection1] main
   [junit4]   2> 103165 INFO  
(searcherExecutor-237-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@33fa7137[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.3):C1)
 Uninverting(_1(5.5.3):C1)))}
   [junit4]   2> 103165 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551462
 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551462;done=true>>]
   [junit4]   2> 103165 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551462
   [junit4]   2> 103165 INFO  (qtp1917595739-471) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=fetchindex&masterUrl=http://127.0.0.1:54275/solr/collection1/replication&wait=true}
 status=0 QTime=73
   [junit4]   2> 103174 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&slave=false&version=2&wt=javabin&qt=/replication} 
status=0 QTime=0
   [junit4]   2> 103175 INFO  (qtp1917595739-472) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=details&version=2&_trace=getDetails&wt=javabin&qt=/replication} 
status=0 QTime=6
   [junit4]   2> 103182 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={version=2&wt=javabin}{add=[2]} 0 0
   [junit4]   2> 103185 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 103189 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=4
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_3,generation=3}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@92658f5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@349a4184),segFN=segments_4,generation=4}
   [junit4]   2> 103189 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 103189 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@2bbad06f[collection1] main
   [junit4]   2> 103190 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 103190 INFO  
(searcherExecutor-227-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2bbad06f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.3):C1)
 Uninverting(_1(5.5.3):C1) Uninverting(_2(5.5.3):C1)))}
   [junit4]   2> 103190 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={version=2&waitSearcher=true&softCommit=false&wt=javabin&commit=true}{commit=}
 0 5
   [junit4]   2> 103194 INFO  (qtp1917595739-468) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=fetchindex&masterUrl=http://127.0.0.1:54275/solr/collection1/replication&wait=true}
 status=0 QTime=1
   [junit4]   2> 103195 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={command=indexversion&version=2&wt=javabin&qt=/replication} status=0 
QTime=0
   [junit4]   2> 103196 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 103196 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 103196 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 103196 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/collection1
   [junit4]   2> 103202 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 103203 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filelist&version=2&wt=javabin&qt=/replication} 
status=0 QTime=2
   [junit4]   2> 103204 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 22
   [junit4]   2> 103204 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@52fd9965{/solr,null,AVAILABLE}
   [junit4]   2> 103204 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551551
   [junit4]   2> 103205 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@49fb0dd7{HTTP/1.1}{127.0.0.1:45084}
   [junit4]   2> 103205 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.e.j.s.Server Started @109387ms
   [junit4]   2> 103205 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=45084, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/collection1/data,
 hostContext=/solr}
   [junit4]   2> 103205 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@7b3cb2c6
   [junit4]   2> 103205 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003'
   [junit4]   2> 103206 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 103206 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 103206 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 103214 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=33, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=80.322265625, 
floorSegmentMB=0.4736328125, forceMergeDeletesPctAllowed=0.02242610159104208, 
segmentsPerTier=34.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6317293479402678
   [junit4]   2> 103214 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/solr.xml
   [junit4]   2> 103227 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_3,generation=3}
   [junit4]   2> 103227 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 103227 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 103227 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_3,generation=3}
   [junit4]   2> 103227 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 3
   [junit4]   2> 103230 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1
   [junit4]   2> 103230 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@272d11fa 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ff7482d)
   [junit4]   2> 103230 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 103230 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 103230 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 103233 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 103233 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_Memory_0.ram because it already 
exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1_Memory_0.ram because it already 
exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
   [junit4]   2> 103234 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
   [junit4]   2> 103235 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/.
   [junit4]   2> 103235 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 125493425
   [junit4]   2> 103235 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003]
   [junit4]   2> 103235 WARN  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/lib
   [junit4]   2> 103236 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 103237 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 103237 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2.nvd&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103237 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 103237 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 103238 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 103238 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 103238 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/.
   [junit4]   2> 103240 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {loadOnStartup=true, 
dataDir=data/, schema=schema.xml, name=collection1, transient=false, 
configSetProperties=configsetprops.json, config=solrconfig.xml}
   [junit4]   2> 103240 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/./collection1
   [junit4]   2> 103240 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions
   [junit4]   2> 103242 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/collection1'
   [junit4]   2> 103242 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 103242 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 103253 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2.si&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103254 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0
   [junit4]   2> 103254 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 103273 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 103273 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2.fdt&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103287 INFO  (qtp506285208-450) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2_Memory_0.ram&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103295 INFO  (qtp506285208-451) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2.nvm&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103310 WARN  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 103311 INFO  (qtp506285208-452) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2.fdx&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103313 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.3
   [junit4]   2> 103325 INFO  (qtp506285208-448) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=_2.fnm&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103547 INFO  (qtp506285208-449) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&command=filecontent&checksum=true&file=segments_4&wt=filestream&qt=/replication}
 status=0 QTime=0
   [junit4]   2> 103547 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 103551 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1439) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@272d11fa 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7ff7482d)
   [junit4]   2> 103553 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 103555 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.25755457016797356]
   [junit4]   2> 103562 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_3,generation=3}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@1bbbdec9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4b1f6c58),segFN=segments_4,generation=4}
   [junit4]   2> 103562 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 4
   [junit4]   2> 103566 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 103569 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@6ba16d0b[collection1] main
   [junit4]   2> 103570 INFO  
(searcherExecutor-237-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6ba16d0b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.5.3):C1)
 Uninverting(_1(5.5.3):C1) Uninverting(_2(5.5.3):C1)))}
   [junit4]   2> 103572 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory looking to close 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551551
 
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551551;done=true>>]
   [junit4]   2> 103572 INFO  (indexFetcher-241-thread-1) [    x:collection1] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-002/./collection1/data/index.20160907072551551
   [junit4]   2> 103574 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 103577 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/collection1'
   [junit4]   2> 103577 INFO  (coreLoadExecutor-250-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/./collection1
   [junit4]   2> 103577 INFO  (coreLoadExecutor-250-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 103577 INFO  (coreLoadExecutor-250-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_4A22FD60ECBDF844-001/solr-instance-003/collection1],
 dat

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

eReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 287915 INFO  (Thread-1037) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 287915 INFO  (Thread-1037) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 288018 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:46674
   [junit4]   2> 288018 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 288034 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 288059 INFO  (zkCallback-253-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7cb55a54 
name:ZooKeeperConnection Watcher:127.0.0.1:46674 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 288059 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 288059 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 288186 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15704d64ec70000, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 288194 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 288202 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 288210 INFO  (zkCallback-254-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@27884bf0 
name:ZooKeeperConnection Watcher:127.0.0.1:46674 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 288210 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 288211 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 288211 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 288219 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 288230 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 288234 INFO  (zkCallback-255-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@392c2607 
name:ZooKeeperConnection Watcher:127.0.0.1:46674/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 288234 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 288234 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 288235 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 288237 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 288238 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 288240 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 288241 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 288243 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 288252 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 288252 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 288252 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 288256 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 288266 INFO  (zkCallback-255-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 288267 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 288275 INFO  (zkCallback-255-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 288311 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15704d64ec70002, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 288312 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46674 46674
   [junit4]   2> 288426 INFO  (Thread-1037) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:46674 46674
   [junit4]   2> 288427 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[4A22FD60ECBDF844]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 288429 INFO  
(SUITE-ZkStateReaderTest-seed#[4A22FD60ECBDF844]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_4A22FD60ECBDF844-001
   [junit4]   2> Sep 07, 2016 1:28:56 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): {}, 
docValues:{}, sim=DefaultSimilarity, locale=no-NO, timezone=America/Adak
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.7.0_80 (64-bit)/cpus=4,threads=1,free=123002520,total=343408640
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestComplexPhraseQParserPlugin, TestIntervalFaceting, 
AsyncCallRequestStatusResponseTest, DefaultValueUpdateProcessorTest, 
TestMiniSolrCloudClusterSSL, ChangedSchemaMergeTest, QueryResultKeyTest, 
TestBadConfig, TestArbitraryIndexDir, TestReplicationHandler, 
TestPhraseSuggestions, DeleteInactiveReplicaTest, 
DistributedQueryComponentCustomSortTest, ZkStateReaderTest]
   [junit4] Completed [53/575 (2!)] on J0 in 3.21s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 1696 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/build.xml:750: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/build.xml:694: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/build.xml:59: The 
following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/build.xml:233: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/solr/common-build.xml:534:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/lucene/common-build.xml:1477:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5/lucene/common-build.xml:1033:
 There were test failures: 575 suites (7 ignored), 2322 tests, 1 error, 1 
failure, 56 ignored (40 assumptions) [seed: 4A22FD60ECBDF844]

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



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to