Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/277/

4 tests failed.
FAILED:  
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterRestart

Error Message:
Timeout waiting for CDCR replication to complete @source_collection:shard2

Stack Trace:
java.lang.RuntimeException: Timeout waiting for CDCR replication to complete 
@source_collection:shard2
        at 
__randomizedtesting.SeedInfo.seed([C4CB6E434FA11BEE:98D689C28181AFD8]:0)
        at 
org.apache.solr.cloud.BaseCdcrDistributedZkTest.waitForReplicationToComplete(BaseCdcrDistributedZkTest.java:795)
        at 
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterRestart(CdcrReplicationDistributedZkTest.java:236)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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:368)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR

Error Message:
There are still nodes recoverying - waited for 330 seconds

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330 
seconds
        at 
__randomizedtesting.SeedInfo.seed([C4CB6E434FA11BEE:1A41003E7403791D]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:187)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:144)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:139)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:856)
        at 
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR(LeaderInitiatedRecoveryOnShardRestartTest.java:158)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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:368)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
ObjectTracker found 1 object(s) that were not released!!! [NRTCachingDirectory] 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
  at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
  at 
org.apache.solr.core.MetricsDirectoryFactory.get(MetricsDirectoryFactory.java:201)
  at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:367)  
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:249) 
 at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:399) 
 at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:281)
  at java.lang.Thread.run(Thread.java:745)  

Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not 
released!!! [NRTCachingDirectory]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
        at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
        at 
org.apache.solr.core.MetricsDirectoryFactory.get(MetricsDirectoryFactory.java:201)
        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:367)
        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:249)
        at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:399)
        at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:281)
        at java.lang.Thread.run(Thread.java:745)


        at __randomizedtesting.SeedInfo.seed([C4CB6E434FA11BEE]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:269)
        at sun.reflect.GeneratedMethodAccessor35.invoke(Unknown Source)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
        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:368)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest.test

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([C4CB6E434FA11BEE:4C9F5199E15D7616]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest.test(HdfsWriteToMultipleCollectionsTest.java:137)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
        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:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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:368)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 12466 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/init-core-data-001
   [junit4]   2> 2152813 INFO  
(SUITE-TestReplicationHandler-seed#[C4CB6E434FA11BEE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 2152815 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
   [junit4]   2> 2152815 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/collection1
   [junit4]   2> 2152817 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2152819 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@54baeab2{/solr,null,AVAILABLE}
   [junit4]   2> 2152821 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@35b2bb4d{HTTP/1.1,[http/1.1]}{127.0.0.1:41811}
   [junit4]   2> 2152821 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.Server Started @2156726ms
   [junit4]   2> 2152821 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=41811}
   [junit4]   2> 2152822 ERROR 
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2152822 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
6.5.0
   [junit4]   2> 2152822 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2152822 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2152822 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-02-08T23:23:00.577Z
   [junit4]   2> 2152823 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/solr.xml
   [junit4]   2> 2152830 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2152848 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/.
   [junit4]   2> 2152848 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2152863 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 2152869 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2152871 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 2152872 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/./collection1
   [junit4]   2> 2152873 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 2152874 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6855700662523313]
   [junit4]   2> 2152897 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2152897 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2152897 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@721f3d35
   [junit4]   2> 2152898 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2293f9b0[collection1] main]
   [junit4]   2> 2152898 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-001/collection1/conf
   [junit4]   2> 2152898 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 2152898 INFO  (coreLoadExecutor-10031-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2152898 INFO  
(searcherExecutor-10032-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2293f9b0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2153132 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/collection1
   [junit4]   2> 2153134 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2153135 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@270133{/solr,null,AVAILABLE}
   [junit4]   2> 2153135 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3c81d232{HTTP/1.1,[http/1.1]}{127.0.0.1:54679}
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.Server Started @2157040ms
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=54679}
   [junit4]   2> 2153136 ERROR 
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
6.5.0
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-02-08T23:23:00.891Z
   [junit4]   2> 2153136 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/solr.xml
   [junit4]   2> 2153141 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2153160 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/.
   [junit4]   2> 2153160 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2153169 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 2153176 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2153178 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 2153179 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/./collection1
   [junit4]   2> 2153179 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 2153181 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6855700662523313]
   [junit4]   2> 2153207 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2153207 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2153207 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@257fec62
   [junit4]   2> 2153208 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6286f730[collection1] main]
   [junit4]   2> 2153208 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-002/collection1/conf
   [junit4]   2> 2153209 INFO  (coreLoadExecutor-10041-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 2153210 INFO  
(searcherExecutor-10042-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6286f730[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2153354 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 2153355 INFO  (indexFetcher-10046-thread-1) [    
x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 2153355 INFO  (indexFetcher-10046-thread-1) [    
x:collection1] o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 2153355 INFO  (indexFetcher-10046-thread-1) [    
x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 2153450 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 2153453 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 2153463 INFO  (qtp255834780-117199) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 2153464 INFO  (qtp1240720125-117216) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=2
   [junit4]   2> 2153466 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 2153467 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2153467 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7fd0c010
   [junit4]   2> 2153473 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d4acb75[collection1] main]
   [junit4]   2> 2153473 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2153473 INFO  
(searcherExecutor-10032-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1d4acb75[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C1)))}
   [junit4]   2> 2153473 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 6
   [junit4]   2> 2153486 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 2153488 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 2153488 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 2153488 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1486596181222
   [junit4]   2> 2153488 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 2153488 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 2153491 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=1
   [junit4]   2> 2153491 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 2153492 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@683d5462
   [junit4]   2> 2153493 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2153493 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@7339dc85 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@29a02ce4))
   [junit4]   2> 2153495 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153497 INFO  (qtp255834780-117199) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153499 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.tix&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153501 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153502 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153504 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153506 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.tbk&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153508 INFO  (qtp255834780-117199) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153512 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153515 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153515 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1572) : 0 secs (null bytes/sec) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@7339dc85 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@29a02ce4))
   [junit4]   2> 2153518 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=14, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=19.5205078125, 
floorSegmentMB=1.826171875, forceMergeDeletesPctAllowed=22.92769837925279, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6547863094652318
   [junit4]   2> 2153520 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2153520 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@57fa5778[collection1] main]
   [junit4]   2> 2153520 INFO  
(searcherExecutor-10042-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@57fa5778[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C1)))}
   [junit4]   2> 2153520 INFO  (qtp1240720125-117213) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:41811/solr/collection1/replication&command=fetchindex}
 status=0 QTime=46
   [junit4]   2> 2153529 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 2153529 INFO  (qtp1240720125-117217) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=2
   [junit4]   2> 2153531 INFO  (qtp255834780-117196) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 2153533 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2153533 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7fd0c010
   [junit4]   2> 2153540 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2a9e4460[collection1] main]
   [junit4]   2> 2153540 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2153540 INFO  
(searcherExecutor-10032-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2a9e4460[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.5.0):c2)))}
   [junit4]   2> 2153540 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 7
   [junit4]   2> 2153541 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 2153544 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 2153544 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 2153544 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1486596181288
   [junit4]   2> 2153544 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 2153544 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 2153546 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=0
   [junit4]   2> 2153547 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@774d13e0
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@15a598ea 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b137c2a))
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_FSTOrd50_0.doc because it already 
exists
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_FSTOrd50_0.tix because it already 
exists
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 2153548 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_FSTOrd50_0.tbk because it already 
exists
   [junit4]   2> 2153549 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 2153549 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 2153551 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_FSTOrd50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153560 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153562 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153565 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_FSTOrd50_0.tix&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153567 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153569 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153572 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153574 INFO  (qtp255834780-117196) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_FSTOrd50_0.tbk&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153576 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153578 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153579 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1635) : 0 secs (null bytes/sec) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@15a598ea 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b137c2a))
   [junit4]   2> 2153581 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=14, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=19.5205078125, 
floorSegmentMB=1.826171875, forceMergeDeletesPctAllowed=22.92769837925279, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6547863094652318
   [junit4]   2> 2153581 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2153582 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4914086e[collection1] main]
   [junit4]   2> 2153582 INFO  
(searcherExecutor-10042-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4914086e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.5.0):C1)
 Uninverting(_1(6.5.0):C1)))}
   [junit4]   2> 2153582 INFO  (qtp1240720125-117218) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:41811/solr/collection1/replication&command=fetchindex}
 status=0 QTime=41
   [junit4]   2> 2153586 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 2153586 INFO  (qtp1240720125-117219) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=2
   [junit4]   2> 2153588 INFO  (qtp255834780-117199) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 2153589 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 2153589 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@7fd0c010
   [junit4]   2> 2153591 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7987e678[collection1] main]
   [junit4]   2> 2153591 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 2153591 INFO  
(searcherExecutor-10032-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7987e678[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.5.0):c2)
 Uninverting(_3(6.5.0):C1)))}
   [junit4]   2> 2153591 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 1
   [junit4]   2> 2153592 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 2153594 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 2153594 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 2153594 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1486596181344
   [junit4]   2> 2153594 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 2153594 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 2153646 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=50
   [junit4]   2> 2153646 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 13
   [junit4]   2> 2153647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@b8b1002
   [junit4]   2> 2153647 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2153648 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@4fa25482 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e25313d))
   [junit4]   2> 2153649 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153651 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153653 INFO  (qtp255834780-117199) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_2.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153655 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153657 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153659 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153661 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3_FSTOrd50_0.tbk&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153663 INFO  (qtp255834780-117200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3_FSTOrd50_0.tix&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153664 INFO  (qtp255834780-117199) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3_FSTOrd50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153666 INFO  (qtp255834780-117198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153668 INFO  (qtp255834780-117202) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153670 INFO  (qtp255834780-117195) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=_3.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153671 INFO  (qtp255834780-117201) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 2153672 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=3358) : 0 secs (null bytes/sec) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@4fa25482 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e25313d))
   [junit4]   2> 2153673 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=14, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=19.5205078125, 
floorSegmentMB=1.826171875, forceMergeDeletesPctAllowed=22.92769837925279, 
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6547863094652318
   [junit4]   2> 2153674 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 2153676 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4ed4523e[collection1] main]
   [junit4]   2> 2153676 INFO  
(searcherExecutor-10042-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4ed4523e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.5.0):c2)
 Uninverting(_3(6.5.0):C1)))}
   [junit4]   2> 2153677 INFO  (qtp1240720125-117212) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:41811/solr/collection1/replication&command=fetchindex}
 status=0 QTime=85
   [junit4]   2> 2153678 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/collection1
   [junit4]   2> 2153680 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2153684 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@73b4f819{/solr,null,AVAILABLE}
   [junit4]   2> 2153684 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@59962f9a{HTTP/1.1,[http/1.1]}{127.0.0.1:37123}
   [junit4]   2> 2153684 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.Server Started @2157589ms
   [junit4]   2> 2153684 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/collection1/data,
 hostContext=/solr, hostPort=37123}
   [junit4]   2> 2153685 ERROR 
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2153685 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
6.5.0
   [junit4]   2> 2153685 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 2153685 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2153685 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-02-08T23:23:01.440Z
   [junit4]   2> 2153685 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/solr.xml
   [junit4]   2> 2153698 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2153716 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/.
   [junit4]   2> 2153717 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2153728 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 2153734 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2153736 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 2153737 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/./collection1
   [junit4]   2> 2153737 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 2153738 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6855700662523313]
   [junit4]   2> 2153761 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2153761 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2153762 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@6e3994ad
   [junit4]   2> 2153762 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6244a1c5[collection1] main]
   [junit4]   2> 2153762 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-003/collection1/conf
   [junit4]   2> 2153762 WARN  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the 
/replication suffix
   [junit4]   2> 2153763 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler  No value set for 'pollInterval'. 
Timer Task not started.
   [junit4]   2> 2153763 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml
   [junit4]   2> 2153763 INFO  (coreLoadExecutor-10055-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2153763 INFO  
(searcherExecutor-10056-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6244a1c5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2154036 WARN  (qtp1909877272-117242) [    x:collection1] 
o.a.s.h.ReplicationHandler Exception while invoking 'details' method for 
replication on master 
   [junit4]   2> 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:41811/solr: Expected mime type 
application/octet-stream but got text/html. <html>
   [junit4]   2> <head>
   [junit4]   2> <meta http-equiv="Content-Type" 
content="text/html;charset=ISO-8859-1"/>
   [junit4]   2> <title>Error 404 </title>
   [junit4]   2> </head>
   [junit4]   2> <body>
   [junit4]   2> <h2>HTTP ERROR: 404</h2>
   [junit4]   2> <p>Problem accessing /solr/replication. Reason:
   [junit4]   2> <pre>    Can not find: /solr/replication</pre></p>
   [junit4]   2> <hr /><a href="http://eclipse.org/jetty";>Powered by Jetty:// 
9.3.14.v20161028</a><hr/>
   [junit4]   2> </body>
   [junit4]   2> </html>
   [junit4]   2> 
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:578)
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
   [junit4]   2>        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1660)
   [junit4]   2>        at 
org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:922)
   [junit4]   2>        at 
org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:314)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.execute(SolrCore.java:2384)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:723)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:529)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2154036 INFO  (qtp1909877272-117242) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=2
   [junit4]   2> 2154038 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@59962f9a{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2154038 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=300557927
   [junit4]   2> 2154039 INFO  (coreCloseExecutor-10060-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@441e3ada
   [junit4]   2> 2154039 INFO  (coreCloseExecutor-10060-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 2154039 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 2154040 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@73b4f819{/solr,null,UNAVAILABLE}
   [junit4]   2> 2154040 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending doTestDetails
   [junit4]   2> 2154041 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@35b2bb4d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2154041 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=510500620
   [junit4]   2> 2154043 INFO  (coreCloseExecutor-10062-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@b306ef3
   [junit4]   2> 2154043 INFO  (coreCloseExecutor-10062-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 2154044 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 2154044 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@54baeab2{/solr,null,UNAVAILABLE}
   [junit4]   2> 2154045 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@3c81d232{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 2154045 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=154745013
   [junit4]   2> 2154045 INFO  (coreCloseExecutor-10064-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6626f93f
   [junit4]   2> 2154046 INFO  (coreCloseExecutor-10064-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 2154046 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 2154046 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[C4CB6E434FA11BEE]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@270133{/solr,null,UNAVAILABLE}
   [junit4]   2> 2154049 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestHandlerPathUnchanged
   [junit4]   2> 2154049 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/collection1
   [junit4]   2> 2154051 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2154055 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@104af98b{/solr,null,AVAILABLE}
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@49f87454{HTTP/1.1,[http/1.1]}{127.0.0.1:55095}
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.Server Started @2157960ms
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/collection1/data,
 hostContext=/solr, hostPort=55095}
   [junit4]   2> 2154056 ERROR 
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.5.0
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-02-08T23:23:01.811Z
   [junit4]   2> 2154056 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/solr.xml
   [junit4]   2> 2154061 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2154081 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/.
   [junit4]   2> 2154081 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2154092 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 2154099 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2154101 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 2154102 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/./collection1
   [junit4]   2> 2154102 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/./collection1/data/]
   [junit4]   2> 2154103 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6855700662523313]
   [junit4]   2> 2154126 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2154127 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2154127 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@31c3b99b
   [junit4]   2> 2154127 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6c35f731[collection1] main]
   [junit4]   2> 2154127 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-004/collection1/conf
   [junit4]   2> 2154128 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 2154128 INFO  (coreLoadExecutor-10071-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2154128 INFO  
(searcherExecutor-10072-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6c35f731[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2154371 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/collection1
   [junit4]   2> 2154373 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2154374 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1360d495{/solr,null,AVAILABLE}
   [junit4]   2> 2154374 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@583436b2{HTTP/1.1,[http/1.1]}{127.0.0.1:58473}
   [junit4]   2> 2154374 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.e.j.s.Server Started @2158279ms
   [junit4]   2> 2154377 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/collection1/data,
 hostContext=/solr, hostPort=58473}
   [junit4]   2> 2154378 ERROR 
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 2154378 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.5.0
   [junit4]   2> 2154378 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 2154378 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2154378 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-02-08T23:23:02.133Z
   [junit4]   2> 2154378 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/solr.xml
   [junit4]   2> 2154383 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2154399 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/.
   [junit4]   2> 2154400 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[C4CB6E434FA11BEE])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 2154410 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
   [junit4]   2> 2154416 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2154417 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 2154418 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/./collection1
   [junit4]   2> 2154419 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/./collection1/data/]
   [junit4]   2> 2154420 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6855700662523313]
   [junit4]   2> 2154443 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2154443 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2154444 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@366236c5
   [junit4]   2> 2154444 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7294e6c5[collection1] main]
   [junit4]   2> 2154445 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_C4CB6E434FA11BEE-001/solr-instance-005/collection1/conf
   [junit4]   2> 2154445 INFO  (coreLoadExecutor-10081-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 2154446 INFO  
(searcherExecutor-10082-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7294e6c5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2154460 INFO  (qtp864358047-117266) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 2154461 INFO  (indexFetcher-10086-thread-1) [    
x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 2154461 INFO  (indexFetcher-10086-thread-1) [    
x:collection1] o.a.s.h.In

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

pl.java:594)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
   [junit4]   2>        at 
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:171)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:872)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1726)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1705)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest.teardownClass(HdfsWriteToMultipleCollectionsTest.java:73)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:203)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3370)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:5729)
   [junit4]   2>        ... 53 more
   [junit4]   2> 4633800 INFO  
(SUITE-HdfsWriteToMultipleCollectionsTest-seed#[C4CB6E434FA11BEE]-worker) [    
] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsWriteToMultipleCollectionsTest_C4CB6E434FA11BEE-001
   [junit4]   2> Feb 09, 2017 12:04:21 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 35 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=it, 
timezone=Europe/Athens
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_102 (64-bit)/cpus=4,threads=2,free=100006304,total=527958016
   [junit4]   2> NOTE: All tests run in this JVM: [TestConfigOverlay, 
IndexSchemaTest, TestConfigSetsAPIZkFailure, BJQParserTest, 
BasicAuthIntegrationTest, TestMinMaxOnMultiValuedField, 
TestDistribDocBasedVersion, ShardRoutingCustomTest, HdfsLockFactoryTest, 
TestOnReconnectListenerSupport, TestLuceneMatchVersion, HighlighterTest, 
JvmMetricsTest, CdcrVersionReplicationTest, TestExactSharedStatsCache, 
OverseerModifyCollectionTest, TestRTGBase, DistributedMLTComponentTest, 
TestBulkSchemaAPI, TestSuggestSpellingConverter, TestFieldTypeResource, 
TestCSVResponseWriter, TestFieldCollectionResource, 
CollectionsAPIDistributedZkTest, SimpleMLTQParserTest, TestFastOutputStream, 
OpenCloseCoreStressTest, SolrCloudExampleTest, DeleteShardTest, 
SimplePostToolTest, TestRestoreCore, EchoParamsTest, TestXmlQParserPlugin, 
HdfsDirectoryFactoryTest, TestFuzzyAnalyzedSuggestions, 
TestSurroundQueryParser, TestCloudPseudoReturnFields, AnalyticsQueryTest, 
HdfsChaosMonkeySafeLeaderTest, DistributedIntervalFacetingTest, 
SolrIndexSplitterTest, TestStressUserVersions, TestSubQueryTransformer, 
TestRecoveryHdfs, TestHdfsCloudBackupRestore, SortByFunctionTest, 
DirectSolrSpellCheckerTest, LoggingHandlerTest, TestUninvertingReader, 
TestFreeTextSuggestions, TestSolrConfigHandlerCloud, FacetPivotSmallTest, 
TestSearchPerf, TestQueryUtils, CoreSorterTest, SliceStateTest, 
TestJavabinTupleStreamParser, BlockDirectoryTest, DateMathParserTest, 
SolrInfoMBeanTest, TestHdfsBackupRestoreCore, SaslZkACLProviderTest, 
ShufflingReplicaListTransformerTest, TestSchemaSimilarityResource, 
TestRequestStatusCollectionAPI, ZkCLITest, TestPartialUpdateDeduplication, 
TestDistributedGrouping, WordBreakSolrSpellCheckerTest, TestSystemIdResolver, 
SystemInfoHandlerTest, SolrIndexMetricsTest, TestExportWriter, 
TestCoreAdminApis, TestSimpleTrackingShardHandler, HttpSolrCallGetCoreTest, 
SolrIndexConfigTest, TestBM25SimilarityFactory, TestStressLiveNodes, 
LeaderFailureAfterFreshStartTest, DeleteLastCustomShardedReplicaTest, 
TestSweetSpotSimilarityFactory, ShardRoutingTest, 
TestWordDelimiterFilterFactory, BasicFunctionalityTest, 
TestLeaderInitiatedRecoveryThread, TestNoOpRegenerator, 
DistribDocExpirationUpdateProcessorTest, MigrateRouteKeyTest, 
RemoteQueryErrorTest, ChaosMonkeySafeLeaderTest, 
AsyncCallRequestStatusResponseTest, TestApiFramework, TestHdfsUpdateLog, 
BlockJoinFacetSimpleTest, BigEndianAscendingWordDeserializerTest, 
DistributedTermsComponentTest, WrapperMergePolicyFactoryTest, 
SpatialFilterTest, TestAnalyzeInfixSuggestions, TestLRUCache, TestTrie, 
BlobRepositoryCloudTest, SecurityConfHandlerTest, 
DistributedFacetPivotSmallAdvancedTest, TolerantUpdateProcessorTest, 
TestShortCircuitedRequests, TestSolrQueryParserDefaultOperatorResource, 
TestCoreContainer, TestRandomCollapseQParserPlugin, TestSolrCoreParser, 
ClusterStateUpdateTest, TestUseDocValuesAsStored, MultiTermTest, 
BasicDistributedZkTest, OverseerTest, LeaderElectionIntegrationTest, 
BasicZkTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest, 
TestReplicationHandler, TestFaceting, TestHashPartitioner, ZkControllerTest, 
TestJoin, TestStressVersions, SpellCheckComponentTest, SolrCmdDistributorTest, 
PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, TestFunctionQuery, 
TestBadConfig, SoftAutoCommitTest, SpellCheckCollatorTest, 
SolrRequestParserTest, DocValuesTest, TestRemoteStreaming, 
XsltUpdateRequestHandlerTest, IndexBasedSpellCheckerTest, 
StandardRequestHandlerTest, TestReversedWildcardFilterFactory, TestQueryTypes, 
TermsComponentTest, DocumentBuilderTest, TestIndexingPerformance, 
MoreLikeThisHandlerTest, FieldAnalysisRequestHandlerTest, TestJmxIntegration, 
MBeansHandlerTest, UniqFieldsUpdateProcessorFactoryTest, 
BinaryUpdateRequestHandlerTest, SearchHandlerTest, HighlighterConfigTest, 
SOLR749Test, TestQuerySenderListener, UpdateParamsTest, AlternateDirectoryTest, 
TestSolrIndexConfig, TestQuerySenderNoQuery, CopyFieldTest, 
ResponseLogComponentTest, BadComponentTest, TestMergePolicyConfig, SampleTest, 
TestDocSet, TestBinaryField, MinimalSchemaTest, TestElisionMultitermQuery, 
TestSolrCoreProperties, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, 
TestPhraseSuggestions, SpellPossibilityIteratorTest, TestCharFilters, 
TestCodecSupport, TestDFRSimilarityFactory, TestPerFieldSimilarity, 
TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, 
TestFastWriter, TimeZoneUtilsTest, ResourceLoaderTest, 
URLClassifyProcessorTest, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, 
CdcrRequestHandlerTest, ConcurrentDeleteAndCreateCollectionTest, 
DeleteStatusTest, DistributedQueueTest, DistributedVersionInfoTest, 
ForceLeaderTest, LeaderFailoverAfterPartitionTest, MissingSegmentRecoveryTest, 
ReplaceNodeTest, SSLMigrationTest, ShardSplitTest, 
TestRandomRequestDistribution, TestRebalanceLeaders, TestReplicaProperties, 
TestRequestForwarding, TestSSLRandomization, TestSolrCloudWithDelegationTokens, 
TestSolrCloudWithKerberosAlt, TestSolrCloudWithSecureImpersonation, 
TestTolerantUpdateProcessorCloud, TestTolerantUpdateProcessorRandomCloud, 
TlogReplayBufferedWhileIndexingTest, HdfsRecoverLeaseTest, HdfsSyncSliceTest, 
HdfsWriteToMultipleCollectionsTest]
   [junit4] Completed [542/690 (4!)] on J1 in 44.74s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 62927 lines...]


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

Reply via email to