Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/37/
6 tests failed. FAILED: org.apache.solr.client.solrj.ConnectionReuseTest.test Error Message: We expected all communication via streaming client to use one connection! expected=283 got=280 Stack Trace: java.lang.AssertionError: We expected all communication via streaming client to use one connection! expected=283 got=280 at __randomizedtesting.SeedInfo.seed([DCE3894FBD1E9D4A:54B7B69513E2F0B2]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.client.solrj.ConnectionReuseTest.test(ConnectionReuseTest.java:150) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java: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:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test Error Message: Exactly one shard should have changed, instead: [shard2, shard1] nodes=([core_node3(shard2), core_node2(shard1), core_node4(shard1)]) expected:<1> but was:<2> Stack Trace: java.lang.AssertionError: Exactly one shard should have changed, instead: [shard2, shard1] nodes=([core_node3(shard2), core_node2(shard1), core_node4(shard1)]) expected:<1> but was:<2> at __randomizedtesting.SeedInfo.seed([DCE3894FBD1E9D4A:54B7B69513E2F0B2]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test(DistribDocExpirationUpdateProcessorTest.java:118) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java: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:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=17450, name=collection3, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=17450, name=collection3, state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest] Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:35990: collection already exists: awholynewstresscollection_collection3_0 at __randomizedtesting.SeedInfo.seed([DCE3894FBD1E9D4A]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:590) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:404) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:357) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1192) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:962) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:898) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593) at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:970) FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy Error Message: Could not find collection : c1 Stack Trace: org.apache.solr.common.SolrException: Could not find collection : c1 at __randomizedtesting.SeedInfo.seed([DCE3894FBD1E9D4A:B7AC2932C4114070]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:135) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy(ZkStateReaderTest.java:46) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler Error Message: ObjectTracker found 7 object(s) that were not released!!! [NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory] Stack Trace: java.lang.AssertionError: ObjectTracker found 7 object(s) that were not released!!! [NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory] at __randomizedtesting.SeedInfo.seed([DCE3894FBD1E9D4A]: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.afterClass(SolrTestCaseJ4.java:256) at sun.reflect.GeneratedMethodAccessor22.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834) 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.CollectionsAPIDistributedZkTest.test Error Message: replicaCount expected:<0> but was:<1> Stack Trace: java.lang.AssertionError: replicaCount expected:<0> but was:<1> at __randomizedtesting.SeedInfo.seed([DCE3894FBD1E9D4A:54B7B69513E2F0B2]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testNoConfigSetExist(CollectionsAPIDistributedZkTest.java:601) at org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:166) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java: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:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 11486 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/init-core-data-001 [junit4] 2> 1483918 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[DCE3894FBD1E9D4A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) [junit4] 2> 1483918 INFO (SUITE-CollectionsAPIDistributedZkTest-seed#[DCE3894FBD1E9D4A]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /k/yk [junit4] 2> 1483919 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1483919 INFO (Thread-2917) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1483919 INFO (Thread-2917) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1484020 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.ZkTestServer start zk server on port:54931 [junit4] 2> 1484020 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484026 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484035 INFO (zkCallback-1209-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@618e9edf name:ZooKeeperConnection Watcher:127.0.0.1:54931 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484035 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484035 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484035 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1484038 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1540fcdd7010000, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1484039 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484050 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484058 INFO (zkCallback-1210-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@29119708 name:ZooKeeperConnection Watcher:127.0.0.1:54931/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484058 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484059 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484059 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 1484059 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 1484060 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 1484061 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 1484061 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml [junit4] 2> 1484061 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 1484062 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml [junit4] 2> 1484062 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 1484063 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1484063 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1484064 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 1484064 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 1484065 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 1484065 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 1484065 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 1484066 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 1484066 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 1484066 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 1484067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 1484067 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 1484068 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1484068 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 1484068 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 1484069 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 1484074 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 1484074 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 1484086 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484095 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484103 INFO (zkCallback-1211-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@488b5f03 name:ZooKeeperConnection Watcher:127.0.0.1:54931/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484103 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484104 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484104 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484114 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484141 INFO (zkCallback-1212-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6cd7970e name:ZooKeeperConnection Watcher:127.0.0.1:54931 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484141 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484141 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484141 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1484143 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484166 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484176 INFO (zkCallback-1213-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3671f139 name:ZooKeeperConnection Watcher:127.0.0.1:54931/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484176 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484176 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484176 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf2/solrconfig.xml [junit4] 2> 1484176 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml [junit4] 2> 1484177 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf2/schema.xml [junit4] 2> 1484177 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml [junit4] 2> 1484178 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf2/enumsConfig.xml [junit4] 2> 1484178 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml [junit4] 2> 1484179 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1484179 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 1484180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf2/stopwords.txt [junit4] 2> 1484180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt [junit4] 2> 1484180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf2/protwords.txt [junit4] 2> 1484180 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt [junit4] 2> 1484181 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf2/currency.xml [junit4] 2> 1484181 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml [junit4] 2> 1484182 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf2/open-exchange-rates.json [junit4] 2> 1484182 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json [junit4] 2> 1484183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 1484183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt [junit4] 2> 1484183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf2/old_synonyms.txt [junit4] 2> 1484183 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt [junit4] 2> 1484184 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf2/synonyms.txt [junit4] 2> 1484184 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt [junit4] 2> 1484185 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/elevate.xml to /configs/conf2/elevate.xml [junit4] 2> 1484185 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml [junit4] 2> 1484367 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1 [junit4] 2> 1484382 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 1484479 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5516e0c9{/k/yk,null,AVAILABLE} [junit4] 2> 1484480 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.e.j.u.s.SslContextFactory x509=X509@58068d88(solrtest,h=[],w=[]) for SslContextFactory@478985fb(file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/server/etc/test/solrtest.keystore,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/server/etc/test/solrtest.keystore) [junit4] 2> 1484495 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.e.j.s.ServerConnector Started ServerConnector@2b8f2a4f{SSL,[ssl, http/1.1]}{127.0.0.1:49964} [junit4] 2> 1484495 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.e.j.s.Server Started @1490483ms [junit4] 2> 1484518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/tempDir-001/control/data, hostContext=/k/yk, hostPort=49964, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores} [junit4] 2> 1484518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 1484518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001' [junit4] 2> 1484518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1484518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1484518 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484523 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484540 INFO (zkCallback-1214-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73a26ced name:ZooKeeperConnection Watcher:127.0.0.1:54931/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484540 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484540 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484567 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 1484567 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/solr.xml [junit4] 2> 1484571 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores [junit4] 2> 1484571 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.CoreContainer New CoreContainer 1392767 [junit4] 2> 1484571 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001] [junit4] 2> 1484571 WARN (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/lib [junit4] 2> 1484572 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1484575 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1484576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1484576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1484576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54931/solr [junit4] 2> 1484576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 1484576 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1484841 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484842 INFO (zkCallback-1217-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@17f0cacd name:ZooKeeperConnection Watcher:127.0.0.1:54931 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484844 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484845 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1484846 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1540fcdd7010006, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1484850 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1484850 INFO (zkCallback-1218-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@c4d1fe name:ZooKeeperConnection Watcher:127.0.0.1:54931/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1484850 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1484852 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 1484859 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 1484868 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 1484870 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 1484871 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 1484874 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1484876 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1484876 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1484878 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1484880 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1484883 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1484886 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 1484887 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 1484889 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1484890 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000 [junit4] 2> 1484891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:49964_k%2Fyk [junit4] 2> 1484891 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 1484892 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.Overseer Overseer (id=95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) starting [junit4] 2> 1484894 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 1484911 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=10000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 1484918 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 1484919 INFO (OverseerCollectionConfigSetProcessor-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 1485003 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49964_k%2Fyk [junit4] 2> 1485004 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1485006 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:49964_k%2Fyk [junit4] 2> 1485019 INFO (zkCallback-1218-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 1485019 INFO (zkCallback-1218-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1485041 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1485041 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1485047 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores [junit4] 2> 1485056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=control_collection, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 1485056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1 [junit4] 2> 1485056 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1485063 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 1485063 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 1485071 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1 [junit4] 2> 1485071 INFO (TEST-CollectionsAPIDistributedZkTest.test-seed#[DCE3894FBD1E9D4A]) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1485071 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 1485071 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:49964/k/yk", [junit4] 2> "node_name":"127.0.0.1:49964_k%2Fyk", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 1485072 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:49964/k/yk", [junit4] 2> "node_name":"127.0.0.1:49964_k%2Fyk", [junit4] 2> "numShards":"1", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "operation":"state"} [junit4] 2> 1485072 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection [junit4] 2> 1485072 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 1485073 INFO (zkCallback-1218-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1486071 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 1486071 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection [junit4] 2> 1486074 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 1486074 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 1486075 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 1486075 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1' [junit4] 2> 1486075 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1486075 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1486076 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 1486123 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1486126 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 1486145 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 1486166 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1486443 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 1486451 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 1486452 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1486462 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1486464 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 1486475 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1486475 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json [junit4] 2> 1486476 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1 [junit4] 2> 1486476 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 1486477 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1486477 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1/data/] [junit4] 2> 1486477 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@614ac299 [junit4] 2> 1486477 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1/data [junit4] 2> 1486482 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1/data/index/ [junit4] 2> 1486482 WARN (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1486484 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1/data/index [junit4] 2> 1486485 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=29.4736328125, floorSegmentMB=0.970703125, forceMergeDeletesPctAllowed=11.990682822227466, segmentsPerTier=38.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1486485 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c1796d9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11d1a942),segFN=segments_1,generation=1} [junit4] 2> 1486485 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib" [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1486516 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1486517 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1486517 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1486517 WARN (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}} [junit4] 2> 1486518 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1486531 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1486531 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1486532 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1486543 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file [junit4] 2> 1486543 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1486554 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_DCE3894FBD1E9D4A-001/control-001/cores/collection1/data/ [junit4] 2> 1486554 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1486555 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1486562 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1486563 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1486718 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=45, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=35.5498046875, floorSegmentMB=1.384765625, forceMergeDeletesPctAllowed=4.059690790772287, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 1486749 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@4c1796d9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@11d1a942),segFN=segments_1,generation=1} [junit4] 2> 1486749 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1486749 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7121a37a[collection1] main] [junit4] 2> 1486749 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/control_collection] [junit4] 2> 1486750 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 1486750 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 1486750 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 1486750 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 1486750 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 1486751 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1531501904272556032 [junit4] 2> 1486753 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1531501904272556032 [junit4] 2> 1486753 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 1486754 INFO (coreLoadExecutor-2988-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1486758 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:https://127.0.0.1:49964/k/yk collection:control_collection shard:shard1 [junit4] 2> 1486759 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 1486761 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/control_collection/leader_elect/shard1/election/95718868831502343-core_node1-n_0000000000 [junit4] 2> 1486761 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1 and weAreReplacement=false and leaderVoteWait=180000 [junit4] 2> 1486762 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection"} current state version: 1 [junit4] 2> 1486762 INFO (zkCallback-1218-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1486764 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 1486764 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 1486764 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:49964/k/yk/collection1/ [junit4] 2> 1486764 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 1486764 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy https://127.0.0.1:49964/k/yk/collection1/ has no replicas [junit4] 2> 1486764 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 1486765 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/95718868831502343-core_node1-n_0000000000 [junit4] 2> 1486766 INFO (OverseerStateUpdate-95718868831502343-127.0.0.1:49964_k%2Fyk-n_0000000000) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "base_url":"https://127.0.0.1:49964/k/yk", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 2 [junit4] 2> 1486767 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:49964/k/yk/collection1/ shard1 [junit4] 2> 1486844 INFO (searcherExecutor-2989-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49964_k%2Fyk c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7121a37a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1486868 INFO (zkCallback-1218-thread-1-processing-n:127.0.0.1:49964_k%2Fyk) [n:127.0.0.1:49964_k%2Fyk ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 1486918 INFO (coreZkRegister-2982-thread-1-processing-n:127.0.0.1:49964_k%2Fyk x:collection1 s:shard1 c:cont [...truncated too long message...] loud.ConnectionManager@5a30ea82 name:ZooKeeperConnection Watcher:127.0.0.1:44487 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 5787997 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 5787998 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 5787998 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 5788039 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 5788045 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 5788056 INFO (zkCallback-4394-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3ecb9dc5 name:ZooKeeperConnection Watcher:127.0.0.1:44487/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 5788056 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 5788057 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 5788057 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 5788058 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 5788058 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 5788059 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 5788060 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 5788061 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 5788061 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 5788061 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 5788062 INFO (zkCallback-4394-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 5788063 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 5788063 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ZkStateReader addZkWatch [c1] [junit4] 2> 5788064 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 5788064 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1] [junit4] 2> 5788066 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44487 44487 [junit4] 2> 5788258 INFO (Thread-28649) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:44487 44487 [junit4] 2> 5788259 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[DCE3894FBD1E9D4A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 5788260 INFO (SUITE-ZkStateReaderTest-seed#[DCE3894FBD1E9D4A]-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/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_DCE3894FBD1E9D4A-001 [junit4] 2> Apr 13, 2016 2:38:53 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=Lucene60, sim=ClassicSimilarity, locale=ar-IQ, timezone=ACT [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=193877440,total=491782144 [junit4] 2> NOTE: All tests run in this JVM: [DocumentAnalysisRequestHandlerTest, TestMiniSolrCloudCluster, DistributedSuggestComponentTest, TestCryptoKeys, CdcrReplicationDistributedZkTest, CustomCollectionTest, CloneFieldUpdateProcessorFactoryTest, TestLuceneMatchVersion, TestStressUserVersions, RecoveryAfterSoftCommitTest, TestRawTransformer, RestartWhileUpdatingTest, TestAuthorizationFramework, TestBadConfig, TestFreeTextSuggestions, TestAnalyzeInfixSuggestions, TestCollationFieldDocValues, TestTestInjection, CoreAdminCreateDiscoverTest, TestDistribIDF, TestRangeQuery, AnalysisAfterCoreReloadTest, TestDefaultSearchFieldResource, OutputWriterTest, CdcrVersionReplicationTest, TestAtomicUpdateErrorCases, TestPhraseSuggestions, ConcurrentDeleteAndCreateCollectionTest, TestMergePolicyConfig, TestRandomDVFaceting, InfoHandlerTest, TestSearcherReuse, TestRandomFaceting, AlternateDirectoryTest, SignatureUpdateProcessorFactoryTest, DistributedQueryElevationComponentTest, TestCustomDocTransformer, ChangedSchemaMergeTest, EchoParamsTest, TestReplicationHandler, TestRTGBase, QueryEqualityTest, TestDocSet, CacheHeaderTest, OverseerRolesTest, DirectoryFactoryTest, TestCloudManagedSchema, TestQueryWrapperFilter, DistributedSpellCheckComponentTest, TestHighlightDedupGrouping, PingRequestHandlerTest, FileBasedSpellCheckerTest, DistributedFacetPivotWhiteBoxTest, TestConfig, HdfsThreadLeakTest, TestUseDocValuesAsStored, PrimUtilsTest, SaslZkACLProviderTest, TestBinaryField, TestValueSourceCache, TolerantUpdateProcessorTest, TestConfigSetProperties, TestJoin, TestManagedResource, EnumFieldTest, DistributedQueueTest, TestSortByMinMaxFunction, TestPseudoReturnFields, ParsingFieldUpdateProcessorsTest, RequiredFieldsTest, PreAnalyzedFieldTest, TestRealTimeGet, BlockJoinFacetRandomTest, QueryElevationComponentTest, DistributedFacetPivotLongTailTest, DisMaxRequestHandlerTest, TestOmitPositions, TestSolrConfigHandler, TestExceedMaxTermLength, URLClassifyProcessorTest, TestManagedStopFilterFactory, BlockDirectoryTest, LeaderElectionIntegrationTest, TestScoreJoinQPNoScore, TestSchemaSimilarityResource, HdfsCollectionsAPIDistributedZkTest, ZkNodePropsTest, PathHierarchyTokenizerFactoryTest, TestShortCircuitedRequests, SyncSliceTest, DefaultValueUpdateProcessorTest, HdfsLockFactoryTest, AsyncCallRequestStatusResponseTest, IndexSchemaTest, PeerSyncTest, SolrXmlInZkTest, TestTolerantUpdateProcessorCloud, SolrTestCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, ConnectionReuseTest, CollectionReloadTest, CollectionTooManyReplicasTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DistribCursorPagingTest, LeaderInitiatedRecoveryOnShardRestartTest, MultiThreadedOCPTest, TestCollectionAPI, TestConfigSetsAPI, TestDistribDocBasedVersion, TestLeaderElectionZkExpiry, TestLeaderInitiatedRecoveryThread, TestReplicaProperties, TriLevelCompositeIdRoutingTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsChaosMonkeySafeLeaderTest, HdfsNNFailoverTest, HdfsRecoveryZkTest, HdfsSyncSliceTest, TestClusterStateMutator, ZkStateReaderTest] [junit4] Completed [476/585 (6!)] on J0 in 3.59s, 5 tests, 1 error <<< FAILURES! [...truncated 340 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014: There were test failures: 585 suites (10 ignored), 2363 tests, 1 suite-level error, 2 errors, 3 failures, 31 ignored (16 assumptions) [seed: DCE3894FBD1E9D4A] Total time: 293 minutes 16 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org