Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/222/
5 tests failed.
FAILED:
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationStartStop
Error Message:
Timeout while trying to assert number of documents @ target_collection
Stack Trace:
java.lang.AssertionError: Timeout while trying to assert number of documents @
target_collection
at
__randomizedtesting.SeedInfo.seed([81DBE39246B6B3AD:2183D01526E3824]:0)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:271)
at
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationStartStop(CdcrReplicationDistributedZkTest.java:173)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
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:367)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.AssertionError: expected:<10> but was:<6>
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:262)
... 42 more
FAILED:
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterRestart
Error Message:
Timeout waiting for CDCR replication to complete @source_collection:shard1
Stack Trace:
java.lang.RuntimeException: Timeout waiting for CDCR replication to complete
@source_collection:shard1
at
__randomizedtesting.SeedInfo.seed([81DBE39246B6B3AD:DDC604138896079B]:0)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.waitForReplicationToComplete(BaseCdcrDistributedZkTest.java:795)
at
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterRestart(CdcrReplicationDistributedZkTest.java:235)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
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:367)
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.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:369)
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:251)
at
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
at
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
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.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:369)
at
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:251)
at
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
at
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([81DBE39246B6B3AD]: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:266)
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$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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.testSpecificConfigsets
Error Message:
KeeperErrorCode = NoNode for /collections/withconfigset2
Stack Trace:
org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode = NoNode
for /collections/withconfigset2
at
__randomizedtesting.SeedInfo.seed([81DBE39246B6B3AD:ACA5ACC8B19209A1]:0)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:111)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testSpecificConfigsets(CollectionsAPIDistributedZkTest.java:425)
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
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
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:367)
at java.lang.Thread.run(Thread.java:745)
FAILED:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
Expected to see collection awhollynewcollection_0 null Last available state:
DocCollection(awhollynewcollection_0//collections/awhollynewcollection_0/state.json/2)={
"replicationFactor":"1", "shards":{"shard1":{
"range":"80000000-7fffffff", "state":"active", "replicas":{}}},
"router":{"name":"compositeId"}, "maxShardsPerNode":"1",
"autoAddReplicas":"false"}
Stack Trace:
java.lang.AssertionError: Expected to see collection awhollynewcollection_0
null
Last available state:
DocCollection(awhollynewcollection_0//collections/awhollynewcollection_0/state.json/2)={
"replicationFactor":"1",
"shards":{"shard1":{
"range":"80000000-7fffffff",
"state":"active",
"replicas":{}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false"}
at
__randomizedtesting.SeedInfo.seed([81DBE39246B6B3AD:C9AE972640859C38]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:237)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:496)
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
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11514 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/init-core-data-001
[junit4] 2> 447974 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 447975 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001
[junit4] 2> 447975 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 447976 INFO (Thread-986) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 447976 INFO (Thread-986) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 448075 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.s.c.ZkTestServer start zk server on port:37170
[junit4] 2> 448088 INFO (jetty-launcher-556-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 448090 INFO (jetty-launcher-556-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 448091 INFO (jetty-launcher-556-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 448093 INFO (jetty-launcher-556-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 448093 INFO (jetty-launcher-556-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@233d5476{/solr,null,AVAILABLE}
[junit4] 2> 448095 INFO (jetty-launcher-556-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5970cc47{/solr,null,AVAILABLE}
[junit4] 2> 448097 INFO (jetty-launcher-556-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@63c53ed4{SSL,[ssl,
http/1.1]}{127.0.0.1:45966}
[junit4] 2> 448097 INFO (jetty-launcher-556-thread-4) [ ]
o.e.j.s.Server Started @452723ms
[junit4] 2> 448097 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45966}
[junit4] 2> 448097 ERROR (jetty-launcher-556-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 448097 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 448097 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 448098 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 448098 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-08T14:37:52.383Z
[junit4] 2> 448098 INFO (jetty-launcher-556-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@798d9c4{SSL,[ssl,
http/1.1]}{127.0.0.1:50566}
[junit4] 2> 448098 INFO (jetty-launcher-556-thread-1) [ ]
o.e.j.s.Server Started @452724ms
[junit4] 2> 448098 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=50566}
[junit4] 2> 448099 ERROR (jetty-launcher-556-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 448099 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 448099 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 448099 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 448099 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-08T14:37:52.384Z
[junit4] 2> 448104 INFO (jetty-launcher-556-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@25e4ff48{/solr,null,AVAILABLE}
[junit4] 2> 448108 INFO (jetty-launcher-556-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6b789a8e{/solr,null,AVAILABLE}
[junit4] 2> 448110 INFO (jetty-launcher-556-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5b9dfb7{SSL,[ssl,
http/1.1]}{127.0.0.1:39586}
[junit4] 2> 448110 INFO (jetty-launcher-556-thread-3) [ ]
o.e.j.s.Server Started @452736ms
[junit4] 2> 448110 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39586}
[junit4] 2> 448110 ERROR (jetty-launcher-556-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 448110 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 448110 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 448110 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 448111 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-08T14:37:52.396Z
[junit4] 2> 448113 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 448116 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 448120 INFO (jetty-launcher-556-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@560f492a{SSL,[ssl,
http/1.1]}{127.0.0.1:52571}
[junit4] 2> 448120 INFO (jetty-launcher-556-thread-2) [ ]
o.e.j.s.Server Started @452746ms
[junit4] 2> 448120 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=52571}
[junit4] 2> 448120 ERROR (jetty-launcher-556-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 448120 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 448121 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 448121 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 448121 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-08T14:37:52.406Z
[junit4] 2> 448139 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 448140 INFO (jetty-launcher-556-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37170/solr
[junit4] 2> 448153 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 448154 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 448164 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 448165 INFO (jetty-launcher-556-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37170/solr
[junit4] 2> 448167 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 448173 INFO (jetty-launcher-556-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37170/solr
[junit4] 2> 448174 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 448178 INFO (jetty-launcher-556-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37170/solr
[junit4] 2> 448209 INFO (jetty-launcher-556-thread-2)
[n:127.0.0.1:52571_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:52571_solr
[junit4] 2> 448211 INFO (jetty-launcher-556-thread-2)
[n:127.0.0.1:52571_solr ] o.a.s.c.Overseer Overseer
(id=97072439116627980-127.0.0.1:52571_solr-n_0000000000) starting
[junit4] 2> 448214 INFO (jetty-launcher-556-thread-1)
[n:127.0.0.1:50566_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:50566_solr
[junit4] 2> 448222 INFO
(zkCallback-577-thread-1-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 448226 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 448229 INFO (jetty-launcher-556-thread-3)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 448233 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 448236 INFO (jetty-launcher-556-thread-3)
[n:127.0.0.1:39586_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39586_solr
[junit4] 2> 448237 INFO (jetty-launcher-556-thread-4)
[n:127.0.0.1:45966_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45966_solr
[junit4] 2> 448238 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 448238 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 448241 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 448248 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 448249 INFO
(OverseerStateUpdate-97072439116627980-127.0.0.1:52571_solr-n_0000000000)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 448249 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 448252 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 448253 INFO (jetty-launcher-556-thread-2)
[n:127.0.0.1:52571_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:52571_solr
[junit4] 2> 448253 INFO
(zkCallback-577-thread-1-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 448256 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 448256 INFO
(zkCallback-577-thread-1-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 448256 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 448262 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 448285 INFO (jetty-launcher-556-thread-3)
[n:127.0.0.1:39586_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node3/.
[junit4] 2> 448288 INFO (jetty-launcher-556-thread-1)
[n:127.0.0.1:50566_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node1/.
[junit4] 2> 448297 INFO (jetty-launcher-556-thread-4)
[n:127.0.0.1:45966_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node4/.
[junit4] 2> 448332 INFO (jetty-launcher-556-thread-2)
[n:127.0.0.1:52571_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node2/.
[junit4] 2> 448339 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 448340 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37170/solr ready
[junit4] 2> 449099 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your
platform... using builtin-java classes where applicable
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 449802 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 449984 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
org.mortbay.log.Slf4jLog
[junit4] 2> 450009 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 450082 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 450164 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_39464_hdfs____nrrypi/webapp
[junit4] 2> 451071 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:39464
[junit4] 2> 451949 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 451953 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 451966 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_42588_datanode____f7g36m/webapp
[junit4] 2> 452345 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:42588
[junit4] 2> 452884 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 452886 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 452904 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_51798_datanode____gi4xnl/webapp
[junit4] 2> 453321 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[81DBE39246B6B3AD]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:51798
[junit4] 2> 454427 INFO (IPC Server handler 9 on 53754) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-e813d77b-eeaf-4e25-aec9-85c18cbb4e02 node
DatanodeRegistration(127.0.0.1:45972,
datanodeUuid=4dcd2f7b-cad3-41ce-920a-5b5d92297888, infoPort=47750,
infoSecurePort=0, ipcPort=60265,
storageInfo=lv=-56;cid=testClusterID;nsid=1187119198;c=0), blocks: 0,
hasStaleStorage: true, processing time: 3 msecs
[junit4] 2> 454427 INFO (IPC Server handler 4 on 53754) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-5cb8dcbf-f208-44d0-a2c3-35f7382343ad node
DatanodeRegistration(127.0.0.1:44938,
datanodeUuid=59d2c063-9902-489f-85dd-47effba5c18c, infoPort=44090,
infoSecurePort=0, ipcPort=53688,
storageInfo=lv=-56;cid=testClusterID;nsid=1187119198;c=0), blocks: 0,
hasStaleStorage: true, processing time: 1 msecs
[junit4] 2> 454428 INFO (IPC Server handler 4 on 53754) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-99fd0918-d71a-4c92-867b-60dae31d2ded node
DatanodeRegistration(127.0.0.1:44938,
datanodeUuid=59d2c063-9902-489f-85dd-47effba5c18c, infoPort=44090,
infoSecurePort=0, ipcPort=53688,
storageInfo=lv=-56;cid=testClusterID;nsid=1187119198;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 454436 INFO (IPC Server handler 9 on 53754) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-fd2d4a71-8ad8-4609-a352-0f53301120c1 node
DatanodeRegistration(127.0.0.1:45972,
datanodeUuid=4dcd2f7b-cad3-41ce-920a-5b5d92297888, infoPort=47750,
infoSecurePort=0, ipcPort=60265,
storageInfo=lv=-56;cid=testClusterID;nsid=1187119198;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 454798 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.addReplicaTest-seed#[81DBE39246B6B3AD])
[ ] o.a.s.SolrTestCaseJ4 ###Starting addReplicaTest
[junit4] 2> 454799 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.addReplicaTest-seed#[81DBE39246B6B3AD])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 454871 INFO (qtp450497154-3833) [n:127.0.0.1:52571_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&maxShardsPerNode=4&name=addReplicaColl&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 454881 INFO
(OverseerThreadFactory-1789-thread-1-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.CreateCollectionCmd Create collection
addReplicaColl
[junit4] 2> 455017 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica2&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 455073 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica1&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 455073 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica2&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2
[junit4] 2> 455086 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica1&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2
[junit4] 2> 455194 INFO
(zkCallback-577-thread-4-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 455194 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 455194 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 455195 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 456040 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 456056 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.IndexSchema [addReplicaColl_shard2_replica2] Schema name=minimal
[junit4] 2> 456059 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 456060 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard2_replica2' using
configuration from collection addReplicaColl
[junit4] 2> 456089 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 456118 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:53754/data
[junit4] 2> 456118 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 456118 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.SolrCore [[addReplicaColl_shard2_replica2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node2/addReplicaColl_shard2_replica2],
dataDir=[hdfs://localhost:53754/data/addReplicaColl/core_node1/data/]
[junit4] 2> 456120 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node1/data/snapshot_metadata
[junit4] 2> 456133 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 456139 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 456149 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.IndexSchema [addReplicaColl_shard2_replica1] Schema name=minimal
[junit4] 2> 456151 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.IndexSchema [addReplicaColl_shard1_replica2] Schema name=minimal
[junit4] 2> 456153 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 456155 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard1_replica2' using
configuration from collection addReplicaColl
[junit4] 2> 456155 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:53754/data
[junit4] 2> 456157 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 456158 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.SolrCore [[addReplicaColl_shard1_replica2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node3/addReplicaColl_shard1_replica2],
dataDir=[hdfs://localhost:53754/data/addReplicaColl/core_node2/data/]
[junit4] 2> 456158 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node2/data/snapshot_metadata
[junit4] 2> 456161 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.IndexSchema [addReplicaColl_shard1_replica1] Schema name=minimal
[junit4] 2> 456164 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 456168 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 456168 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 456168 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 x:addReplicaColl_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard1_replica1' using
configuration from collection addReplicaColl
[junit4] 2> 456168 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Creating new global HDFS BlockCache
[junit4] 2> 456169 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:53754/data
[junit4] 2> 456169 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 456169 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.SolrCore [[addReplicaColl_shard1_replica1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node4/addReplicaColl_shard1_replica1],
dataDir=[hdfs://localhost:53754/data/addReplicaColl/core_node3/data/]
[junit4] 2> 456169 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node3/data/snapshot_metadata
[junit4] 2> 456169 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 456169 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 456172 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 456176 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 x:addReplicaColl_shard2_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'addReplicaColl_shard2_replica1' using
configuration from collection addReplicaColl
[junit4] 2> 456176 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:53754/data
[junit4] 2> 456176 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 456178 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.SolrCore [[addReplicaColl_shard2_replica1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_81DBE39246B6B3AD-001/tempDir-001/node1/addReplicaColl_shard2_replica1],
dataDir=[hdfs://localhost:53754/data/addReplicaColl/core_node4/data/]
[junit4] 2> 456178 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node4/data/snapshot_metadata
[junit4] 2> 456179 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 456179 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 456194 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 456194 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 457845 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 457852 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 457854 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 457855 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 457866 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node1/data
[junit4] 2> 457866 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node4/data
[junit4] 2> 457869 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node3/data
[junit4] 2> 457880 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node2/data
[junit4] 2> 457951 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node1/data/index
[junit4] 2> 457966 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node3/data/index
[junit4] 2> 457973 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 457973 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 457974 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 457974 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 457977 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node2/data/index
[junit4] 2> 457988 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 457990 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 457990 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 457991 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:53754/data/addReplicaColl/core_node4/data/index
[junit4] 2> 457996 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 458010 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 458010 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 458019 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 458034 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 458382 INFO (IPC Server handler 3 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:45972 is
added to blk_1073741825_1001{UCState=COMMITTED, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-5cb8dcbf-f208-44d0-a2c3-35f7382343ad:NORMAL:127.0.0.1:44938|RBW],
ReplicaUC[[DISK]DS-e813d77b-eeaf-4e25-aec9-85c18cbb4e02:NORMAL:127.0.0.1:45972|RBW]]}
size 71
[junit4] 2> 458384 INFO (IPC Server handler 0 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:44938 is
added to blk_1073741825_1001 size 71
[junit4] 2> 458387 INFO (IPC Server handler 5 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:45972 is
added to blk_1073741827_1003{UCState=COMMITTED, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-5cb8dcbf-f208-44d0-a2c3-35f7382343ad:NORMAL:127.0.0.1:44938|RBW],
ReplicaUC[[DISK]DS-e813d77b-eeaf-4e25-aec9-85c18cbb4e02:NORMAL:127.0.0.1:45972|RBW]]}
size 71
[junit4] 2> 458387 INFO (IPC Server handler 5 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:45972 is
added to blk_1073741826_1002{UCState=COMMITTED, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-99fd0918-d71a-4c92-867b-60dae31d2ded:NORMAL:127.0.0.1:44938|RBW],
ReplicaUC[[DISK]DS-fd2d4a71-8ad8-4609-a352-0f53301120c1:NORMAL:127.0.0.1:45972|RBW]]}
size 71
[junit4] 2> 458387 INFO (IPC Server handler 5 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:45972 is
added to blk_1073741828_1004{UCState=COMMITTED, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-99fd0918-d71a-4c92-867b-60dae31d2ded:NORMAL:127.0.0.1:44938|RBW],
ReplicaUC[[DISK]DS-fd2d4a71-8ad8-4609-a352-0f53301120c1:NORMAL:127.0.0.1:45972|RBW]]}
size 71
[junit4] 2> 458388 INFO (IPC Server handler 7 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:44938 is
added to blk_1073741827_1003 size 71
[junit4] 2> 458388 INFO (IPC Server handler 7 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:44938 is
added to blk_1073741826_1002 size 71
[junit4] 2> 458388 INFO (IPC Server handler 7 on 53754) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:44938 is
added to blk_1073741828_1004 size 71
[junit4] 2> 458855 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 458855 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 458855 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 458855 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 458856 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 458856 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 458888 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 458888 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 458889 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 458889 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 458893 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 458894 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 458894 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 458894 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 458894 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 458894 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 458922 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 458922 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 458923 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 458923 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 459101 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@656246cb[addReplicaColl_shard2_replica2] main]
[junit4] 2> 459106 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@6d4a1167[addReplicaColl_shard2_replica1] main]
[junit4] 2> 459109 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@72aac1d7[addReplicaColl_shard1_replica1] main]
[junit4] 2> 459109 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 459110 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 459110 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 459111 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 459111 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 459113 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 459114 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 459114 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 459114 INFO
(searcherExecutor-1801-thread-1-processing-n:127.0.0.1:50566_solr
x:addReplicaColl_shard2_replica1 s:shard2 c:addReplicaColl r:core_node4)
[n:127.0.0.1:50566_solr c:addReplicaColl s:shard2 r:core_node4
x:addReplicaColl_shard2_replica1] o.a.s.c.SolrCore
[addReplicaColl_shard2_replica1] Registered new searcher
Searcher@6d4a1167[addReplicaColl_shard2_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 459114 INFO (qtp1891920556-3817) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1553159037542989824
[junit4] 2> 459116 INFO
(searcherExecutor-1800-thread-1-processing-n:127.0.0.1:45966_solr
x:addReplicaColl_shard1_replica1 s:shard1 c:addReplicaColl r:core_node3)
[n:127.0.0.1:45966_solr c:addReplicaColl s:shard1 r:core_node3
x:addReplicaColl_shard1_replica1] o.a.s.c.SolrCore
[addReplicaColl_shard1_replica1] Registered new searcher
Searcher@72aac1d7[addReplicaColl_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 459116 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1553159037545086976
[junit4] 2> 459117 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 459117 INFO
(searcherExecutor-1798-thread-1-processing-n:127.0.0.1:52571_solr
x:addReplicaColl_shard2_replica2 s:shard2 c:addReplicaColl r:core_node1)
[n:127.0.0.1:52571_solr c:addReplicaColl s:shard2 r:core_node1
x:addReplicaColl_shard2_replica2] o.a.s.c.SolrCore
[addReplicaColl_shard2_replica2] Registered new searcher
Searcher@656246cb[addReplicaColl_shard2_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 459117 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1553159037546135552
[junit4] 2> 459127 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7d1d0fc6[addReplicaColl_shard1_replica2] main]
[junit4] 2> 459130 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459130 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459130 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459131 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 459132 INFO
(zkCallback-577-thread-2-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459136 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 459136 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 459136 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:52571/solr/addReplicaColl_shard2_replica2/
[junit4] 2> 459136 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.PeerSync PeerSync: core=addReplicaColl_shard2_replica2
url=https://127.0.0.1:52571/solr START
replicas=[https://127.0.0.1:50566/solr/addReplicaColl_shard2_replica1/]
nUpdates=100
[junit4] 2> 459137 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 459138 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 459138 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.u.PeerSync PeerSync: core=addReplicaColl_shard2_replica2
url=https://127.0.0.1:52571/solr DONE. We have no versions. sync failed.
[junit4] 2> 459138 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 459138 INFO
(searcherExecutor-1799-thread-1-processing-n:127.0.0.1:39586_solr
x:addReplicaColl_shard1_replica2 s:shard1 c:addReplicaColl r:core_node2)
[n:127.0.0.1:39586_solr c:addReplicaColl s:shard1 r:core_node2
x:addReplicaColl_shard1_replica2] o.a.s.c.SolrCore
[addReplicaColl_shard1_replica2] Registered new searcher
Searcher@7d1d0fc6[addReplicaColl_shard1_replica2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 459138 INFO (qtp2022201651-3846) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1553159037568155648
[junit4] 2> 459174 INFO (qtp1891920556-3814) [n:127.0.0.1:50566_solr
c:addReplicaColl s:shard2 r:core_node4 x:addReplicaColl_shard2_replica1]
o.a.s.c.S.Request [addReplicaColl_shard2_replica1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=3
[junit4] 2> 459176 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 459176 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 459183 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:52571/solr/addReplicaColl_shard2_replica2/ shard2
[junit4] 2> 459286 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459286 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459286 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459286 INFO
(zkCallback-577-thread-2-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459336 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 459339 INFO (qtp450497154-3806) [n:127.0.0.1:52571_solr
c:addReplicaColl s:shard2 r:core_node1 x:addReplicaColl_shard2_replica2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard2_replica2&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard2&wt=javabin&version=2}
status=0 QTime=4323
[junit4] 2> 459442 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459443 INFO
(zkCallback-577-thread-3-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459443 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459443 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459632 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 459632 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 459632 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45966/solr/addReplicaColl_shard1_replica1/
[junit4] 2> 459633 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.PeerSync PeerSync: core=addReplicaColl_shard1_replica1
url=https://127.0.0.1:45966/solr START
replicas=[https://127.0.0.1:39586/solr/addReplicaColl_shard1_replica2/]
nUpdates=100
[junit4] 2> 459633 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.u.PeerSync PeerSync: core=addReplicaColl_shard1_replica1
url=https://127.0.0.1:45966/solr DONE. We have no versions. sync failed.
[junit4] 2> 459644 INFO (qtp2022201651-3843) [n:127.0.0.1:39586_solr
c:addReplicaColl s:shard1 r:core_node2 x:addReplicaColl_shard1_replica2]
o.a.s.c.S.Request [addReplicaColl_shard1_replica2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 459644 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 459644 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 459650 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:45966/solr/addReplicaColl_shard1_replica1/ shard1
[junit4] 2> 459763 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459763 INFO
(zkCallback-575-thread-1-processing-n:127.0.0.1:39586_solr)
[n:127.0.0.1:39586_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459764 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459764 INFO
(zkCallback-577-thread-2-processing-n:127.0.0.1:52571_solr)
[n:127.0.0.1:52571_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459811 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 459814 INFO (qtp2119425015-3824) [n:127.0.0.1:45966_solr
c:addReplicaColl s:shard1 r:core_node3 x:addReplicaColl_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=addReplicaColl_shard1_replica1&action=CREATE&numShards=2&collection=addReplicaColl&shard=shard1&wt=javabin&version=2}
status=0 QTime=4740
[junit4] 2> 459917 INFO
(zkCallback-568-thread-1-processing-n:127.0.0.1:50566_solr)
[n:127.0.0.1:50566_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for collection [addReplicaColl]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 459917 INFO
(zkCallback-576-thread-1-processing-n:127.0.0.1:45966_solr)
[n:127.0.0.1:45966_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/addReplicaColl/state.json] for
[...truncated too long message...]
xtHandler Stopped o.e.j.s.ServletContextHandler@798b998c{/rqzl,null,UNAVAILABLE}
[junit4] 2> 4574888 INFO
(TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[81DBE39246B6B3AD])
[ ] o.a.s.c.ChaosMonkey monkey: stop shard! 55344
[junit4] 2> 4574888 INFO
(zkCallback-4237-thread-1-processing-n:127.0.0.1:55344_rqzl)
[n:127.0.0.1:55344_rqzl ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (1)
[junit4] 2> 4574888 INFO
(TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[81DBE39246B6B3AD])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=883748042
[junit4] 2> 4574888 INFO
(zkCallback-4237-thread-2-processing-n:127.0.0.1:55344_rqzl)
[n:127.0.0.1:55344_rqzl ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:55344_rqzl
[junit4] 2> 4574891 INFO
(zkCallback-4237-thread-2-processing-n:127.0.0.1:55344_rqzl)
[n:127.0.0.1:55344_rqzl ] o.a.s.c.Overseer Overseer
(id=97072702031200288-127.0.0.1:55344_rqzl-n_0000000007) starting
[junit4] 2> 4576392 WARN
(zkCallback-4237-thread-1-processing-n:127.0.0.1:55344_rqzl)
[n:127.0.0.1:55344_rqzl ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 4576396 ERROR
(zkCallback-4237-thread-2-processing-n:127.0.0.1:55344_rqzl)
[n:127.0.0.1:55344_rqzl ] o.a.s.c.Overseer Could not create Overseer node
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException:
KeeperErrorCode = Session expired for /overseer
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$9.execute(SolrZkClient.java:391)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$9.execute(SolrZkClient.java:388)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:388)
[junit4] 2> at
org.apache.solr.cloud.Overseer.createOverseerNode(Overseer.java:728)
[junit4] 2> at
org.apache.solr.cloud.Overseer.start(Overseer.java:500)
[junit4] 2> at
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:751)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:56)
[junit4] 2> at
org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:348)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient$3.lambda$process$0(SolrZkClient.java:268)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 4576397 INFO
(TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[81DBE39246B6B3AD])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@7b6aa572{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 4576397 INFO
(TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[81DBE39246B6B3AD])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@28e54013{/rqzl,null,UNAVAILABLE}
[junit4] 2> 4576398 INFO
(TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[81DBE39246B6B3AD])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testTargetCollectionNotAvailable
[junit4] 2> 4576399 INFO
(TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[81DBE39246B6B3AD])
[ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49997 49997
[junit4] 2> 4576501 INFO (Thread-24217) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:49997 49997
[junit4] 2> 4576502 WARN (Thread-24217) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 29 /solr/clusterprops.json
[junit4] 2> 29 /solr/aliases.json
[junit4] 2> 16 /solr/configs/conf1
[junit4] 2> 8 /solr/collections/tmp_collection/state.json
[junit4] 2> 8 /solr/security.json
[junit4] 2> 2
/solr/collections/source_collection/leaders/shard2/leader
[junit4] 2> 2
/solr/collections/source_collection/leaders/shard1/leader
[junit4] 2> 2
/solr/collections/tmp_collection/leaders/shard2/leader
[junit4] 2> 2
/solr/collections/target_collection/leaders/shard2/leader
[junit4] 2> 2
/solr/collections/tmp_collection/leaders/shard1/leader
[junit4] 2> 2
/solr/collections/target_collection/leaders/shard1/leader
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 29 /solr/clusterstate.json
[junit4] 2> 8
/solr/collections/tmp_collection/cdcr/state/process
[junit4] 2> 8
/solr/collections/tmp_collection/cdcr/state/buffer
[junit4] 2> 5
/solr/collections/source_collection/cdcr/state/process
[junit4] 2> 4
/solr/collections/target_collection/cdcr/state/buffer
[junit4] 2> 4 /solr/collections/source_collection/state.json
[junit4] 2> 4
/solr/collections/source_collection/cdcr/state/buffer
[junit4] 2> 4
/solr/collections/target_collection/cdcr/state/process
[junit4] 2> 4 /solr/collections/target_collection/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 105 /solr/overseer/collection-queue-work
[junit4] 2> 68 /solr/overseer/queue
[junit4] 2> 29 /solr/collections
[junit4] 2> 28 /solr/live_nodes
[junit4] 2> 20 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 4576503 INFO
(SUITE-CdcrReplicationDistributedZkTest-seed#[81DBE39246B6B3AD]-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/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_81DBE39246B6B3AD-001
[junit4] 2> Dec 08, 2016 3:46:40 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=5, maxDocsPerChunk=377, blockSize=787),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
chunkSize=5, blockSize=787)),
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=zh-SG,
timezone=Etc/GMT-13
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=1,free=245657216,total=527958016
[junit4] 2> NOTE: All tests run in this JVM: [TestRTimerTree,
TestUseDocValuesAsStored, TestRealTimeGet, TestReplicationHandler,
TestPseudoReturnFields, ExitableDirectoryReaderTest,
DistributedSpellCheckComponentTest, ClassificationUpdateProcessorTest,
TestFoldingMultitermQuery, TestManagedResourceStorage, TestConfigSetProperties,
TestLazyCores, TestTolerantUpdateProcessorRandomCloud, TestPerFieldSimilarity,
UUIDFieldTest, TestLeaderElectionWithEmptyReplica, TestCSVLoader,
TestBinaryResponseWriter, TestLRUStatsCache, TestSchemaNameResource, TestJoin,
SimpleCollectionCreateDeleteTest, TestSchemaVersionResource, DateFieldTest,
ClusterStateTest, TestCustomSort, StandardRequestHandlerTest,
StatsReloadRaceTest, UtilsToolTest, TestSolrDeletionPolicy2,
TestGeoJSONResponseWriter, RulesTest, RollingRestartTest,
TestInfoStreamLogging, TestFieldResource, ChangedSchemaMergeTest,
TestEmbeddedSolrServerConstructors, DistributedVersionInfoTest,
TestStressLucene, HighlighterConfigTest, HttpPartitionTest,
TestBinaryResponseWriter, StressHdfsTest, TestSolrCoreProperties,
TestFileDictionaryLookup, TestIBSimilarityFactory,
TestStressCloudBlindAtomicUpdates, UniqFieldsUpdateProcessorFactoryTest,
DocumentAnalysisRequestHandlerTest, CloudMLTQParserTest, TestManagedSchemaAPI,
AnalyticsQueryTest, CloudExitableDirectoryReaderTest, TestDocSet,
TestSolrQueryResponse, TestSolrDynamicMBean, TestPushWriter, TestSmileRequest,
ConjunctionSolrSpellCheckerTest, TestSortByMinMaxFunction, TestFastLRUCache,
FileBasedSpellCheckerTest, TestRandomFlRTGCloud, TestSSLRandomization,
HdfsChaosMonkeyNothingIsSafeTest, XsltUpdateRequestHandlerTest,
OverriddenZkACLAndCredentialsProvidersTest, TestStandardQParsers,
SolrRequestParserTest, TestAuthorizationFramework, TestFieldCache,
CursorPagingTest, ActionThrottleTest, TestSha256AuthenticationProvider,
LeaderFailureAfterFreshStartTest, TestBackupRepositoryFactory, TestDistribIDF,
TestCloudSchemaless, HdfsTlogReplayBufferedWhileIndexingTest,
TestFieldCacheSort, NumericFieldsTest, TestCrossCoreJoin, AtomicUpdatesTest,
FastVectorHighlighterTest, CoreAdminCreateDiscoverTest, TestFunctionQuery,
TestConfigReload, DistributedQueryComponentCustomSortTest,
CdcrReplicationDistributedZkTest]
[junit4] Completed [630/660 (3!)] on J0 in 1512.37s, 11 tests, 1 failure, 1
error <<< FAILURES!
[...truncated 61272 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
