Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-7.x/143/
9 tests failed.
FAILED: org.apache.solr.cloud.AliasIntegrationTest.testModifyMetadataV2
Error Message:
Unexpected status: HTTP/1.1 400 Bad Request
Stack Trace:
java.lang.AssertionError: Unexpected status: HTTP/1.1 400 Bad Request
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:5BD1F03F8EB0AB32]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AliasIntegrationTest.assertSuccess(AliasIntegrationTest.java:315)
at
org.apache.solr.cloud.AliasIntegrationTest.testModifyMetadataV2(AliasIntegrationTest.java:236)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.FullSolrCloudDistribCmdsTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([D67CE28D900383A9]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.FullSolrCloudDistribCmdsTest
Error Message:
Java heap space
Stack Trace:
java.lang.OutOfMemoryError: Java heap space
FAILED: org.apache.solr.cloud.TestTlogReplica.testRecovery
Error Message:
Can not find doc 8 in https://127.0.0.1:36357/solr
Stack Trace:
java.lang.AssertionError: Can not find doc 8 in https://127.0.0.1:36357/solr
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:178C9B21BD53490E]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:885)
at
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:599)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testSearchRate
Error Message:
The trigger did not fire at all
Stack Trace:
java.lang.AssertionError: The trigger did not fire at all
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:8B34FC045FC525E6]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.autoscaling.sim.TestTriggerIntegration.testSearchRate(TestTriggerIntegration.java:1178)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED:
org.apache.solr.cloud.cdcr.CdcrReplicationHandlerTest.testReplicationWithBufferedUpdates
Error Message:
Timeout while trying to assert number of documents @ source_collection
Stack Trace:
java.lang.AssertionError: Timeout while trying to assert number of documents @
source_collection
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:575B293D5901F3E]:0)
at
org.apache.solr.cloud.cdcr.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:285)
at
org.apache.solr.cloud.cdcr.CdcrReplicationHandlerTest.testReplicationWithBufferedUpdates(CdcrReplicationHandlerTest.java:234)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.AssertionError: expected:<200> but was:<210>
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.cdcr.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:276)
... 42 more
FAILED: org.apache.solr.cloud.hdfs.HdfsRestartWhileUpdatingTest.test
Error Message:
There are still nodes recoverying - waited for 320 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 320
seconds
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:5E28DD573EFFEE51]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:185)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:921)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForThingsToLevelOut(AbstractFullDistribZkTestBase.java:1478)
at
org.apache.solr.cloud.RestartWhileUpdatingTest.test(RestartWhileUpdatingTest.java:144)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv
Error Message:
java.lang.RuntimeException: Error from server at
http://127.0.0.1:39598/solr/test_col: Async exception during distributed
update: Error from server at
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1: Server Error
request:
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1/update?update.distrib=TOLEADER&distrib.from=http%3A%2F%2F127.0.0.1%3A39598%2Fsolr%2Ftest_col_shard4_replica_n11%2F&wt=javabin&version=2
Remote error message: Failed synchronous update on shard StdNode:
http://127.0.0.1:37971/solr/test_col_shard1_replica_n3/ update:
org.apache.solr.client.solrj.request.UpdateRequest@21fd85a4
Stack Trace:
java.util.concurrent.ExecutionException: java.lang.RuntimeException: Error from
server at http://127.0.0.1:39598/solr/test_col: Async exception during
distributed update: Error from server at
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1: Server Error
request:
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1/update?update.distrib=TOLEADER&distrib.from=http%3A%2F%2F127.0.0.1%3A39598%2Fsolr%2Ftest_col_shard4_replica_n11%2F&wt=javabin&version=2
Remote error message: Failed synchronous update on shard StdNode:
http://127.0.0.1:37971/solr/test_col_shard1_replica_n3/ update:
org.apache.solr.client.solrj.request.UpdateRequest@21fd85a4
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:E06880CB1A5EB9B8]:0)
at java.util.concurrent.FutureTask.report(FutureTask.java:122)
at java.util.concurrent.FutureTask.get(FutureTask.java:192)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.checkField(TestStressCloudBlindAtomicUpdates.java:283)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_dv(TestStressCloudBlindAtomicUpdates.java:195)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: Error from server at
http://127.0.0.1:39598/solr/test_col: Async exception during distributed
update: Error from server at
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1: Server Error
request:
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1/update?update.distrib=TOLEADER&distrib.from=http%3A%2F%2F127.0.0.1%3A39598%2Fsolr%2Ftest_col_shard4_replica_n11%2F&wt=javabin&version=2
Remote error message: Failed synchronous update on shard StdNode:
http://127.0.0.1:37971/solr/test_col_shard1_replica_n3/ update:
org.apache.solr.client.solrj.request.UpdateRequest@21fd85a4
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates$Worker.run(TestStressCloudBlindAtomicUpdates.java:411)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
... 1 more
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:39598/solr/test_col: Async exception during
distributed update: Error from server at
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1: Server Error
request:
http://127.0.0.1:37009/solr/test_col_shard1_replica_n1/update?update.distrib=TOLEADER&distrib.from=http%3A%2F%2F127.0.0.1%3A39598%2Fsolr%2Ftest_col_shard4_replica_n11%2F&wt=javabin&version=2
Remote error message: Failed synchronous update on shard StdNode:
http://127.0.0.1:37971/solr/test_col_shard1_replica_n3/ update:
org.apache.solr.client.solrj.request.UpdateRequest@21fd85a4
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates$Worker.doRandomAtomicUpdate(TestStressCloudBlindAtomicUpdates.java:370)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates$Worker.run(TestStressCloudBlindAtomicUpdates.java:399)
... 6 more
FAILED: org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testCooldown
Error Message:
Stack Trace:
java.lang.AssertionError
at
__randomizedtesting.SeedInfo.seed([D67CE28D900383A9:E7C28F69EEA9F65B]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at
org.apache.solr.cloud.autoscaling.TriggerIntegrationTest.testCooldown(TriggerIntegrationTest.java:1177)
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:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12714 lines...]
[junit4] Suite: org.apache.solr.cloud.TestTlogReplica
[junit4] 2> 345224 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/init-core-data-001
[junit4] 2> 345241 WARN
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=11 numCloses=11
[junit4] 2> 345241 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 345244 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 345257 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001
[junit4] 2> 345257 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 345286 INFO (Thread-244) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 345286 INFO (Thread-244) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 345288 ERROR (Thread-244) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 345386 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:37345
[junit4] 2> 345395 INFO (zkConnectionManagerCallback-183-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 345416 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x1001bb45a2d0000, likely client has closed socket
[junit4] 2> 345453 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T18:27:37-03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 345471 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T18:27:37-03:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 345486 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 345486 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 345486 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 345487 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@279892b7{/solr,null,AVAILABLE}
[junit4] 2> 345501 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@24ae52e7{SSL,[ssl,
http/1.1]}{127.0.0.1:36357}
[junit4] 2> 345501 INFO (jetty-launcher-180-thread-1) [ ]
o.e.j.s.Server Started @358526ms
[junit4] 2> 345501 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=36357}
[junit4] 2> 345501 ERROR (jetty-launcher-180-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 345502 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 345502 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 345502 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 345502 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-08T22:03:23.675Z
[junit4] 2> 345534 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 345534 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 345534 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 345535 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@a31d63e{/solr,null,AVAILABLE}
[junit4] 2> 345535 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3ed9fca6{SSL,[ssl,
http/1.1]}{127.0.0.1:37697}
[junit4] 2> 345535 INFO (jetty-launcher-180-thread-2) [ ]
o.e.j.s.Server Started @358560ms
[junit4] 2> 345535 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37697}
[junit4] 2> 345536 ERROR (jetty-launcher-180-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 345536 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.3.0
[junit4] 2> 345536 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 345536 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 345536 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-02-08T22:03:23.709Z
[junit4] 2> 345594 INFO (zkConnectionManagerCallback-185-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 345594 INFO (zkConnectionManagerCallback-187-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 345611 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 345611 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 345660 INFO (jetty-launcher-180-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37345/solr
[junit4] 2> 345661 INFO (jetty-launcher-180-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37345/solr
[junit4] 2> 345662 INFO (zkConnectionManagerCallback-191-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 345680 INFO (zkConnectionManagerCallback-195-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 345682 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x1001bb45a2d0003, likely client has closed socket
[junit4] 2> 345682 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid
0x1001bb45a2d0004, likely client has closed socket
[junit4] 2> 345683 INFO
(zkConnectionManagerCallback-197-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 345683 INFO
(zkConnectionManagerCallback-199-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 346044 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 346044 INFO (jetty-launcher-180-thread-2)
[n:127.0.0.1:37697_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 346045 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:36357_solr
[junit4] 2> 346045 INFO (jetty-launcher-180-thread-2)
[n:127.0.0.1:37697_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37697_solr
[junit4] 2> 346067 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.c.Overseer Overseer
(id=72088055458889734-127.0.0.1:36357_solr-n_0000000000) starting
[junit4] 2> 346099 INFO
(zkCallback-196-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 346099 INFO
(zkCallback-198-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 346170 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36357_solr
[junit4] 2> 346171 INFO
(zkCallback-196-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 346184 INFO
(zkCallback-198-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 346285 INFO (jetty-launcher-180-thread-2)
[n:127.0.0.1:37697_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37697.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 346329 INFO (jetty-launcher-180-thread-2)
[n:127.0.0.1:37697_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37697.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 346329 INFO (jetty-launcher-180-thread-2)
[n:127.0.0.1:37697_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37697.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 346347 INFO (jetty-launcher-180-thread-2)
[n:127.0.0.1:37697_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001/node2/.
[junit4] 2> 346395 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36357.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 346435 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36357.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 346435 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_36357.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 346448 INFO (jetty-launcher-180-thread-1)
[n:127.0.0.1:36357_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001/node1/.
[junit4] 2> 346506 INFO (zkConnectionManagerCallback-205-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 346550 INFO (zkConnectionManagerCallback-209-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 346571 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 346571 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37345/solr ready
[junit4] 2> 346583 INFO
(SUITE-TestTlogReplica-seed#[D67CE28D900383A9]-worker) [ ]
o.a.s.c.TestTlogReplica Using legacyCloud?: false
[junit4] 2> 346663 INFO (qtp1021736748-885) [n:127.0.0.1:37697_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params
val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 346754 INFO (qtp1021736748-885) [n:127.0.0.1:37697_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2}
status=0 QTime=90
[junit4] 2> 346846 INFO
(TEST-TestTlogReplica.testDeleteById-seed#[D67CE28D900383A9]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testDeleteById
[junit4] 2> 346848 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
pullReplicas=0&replicationFactor=0&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_delete_by_id&nrtReplicas=0&action=CREATE&numShards=1&tlogReplicas=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 346859 INFO
(OverseerThreadFactory-209-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
tlog_replica_test_delete_by_id
[junit4] 2> 346982 INFO
(OverseerStateUpdate-72088055458889734-127.0.0.1:36357_solr-n_0000000000)
[n:127.0.0.1:36357_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"tlog_replica_test_delete_by_id",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"tlog_replica_test_delete_by_id_shard1_replica_t1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36357/solr";,
[junit4] 2> "type":"TLOG",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 346984 INFO
(OverseerStateUpdate-72088055458889734-127.0.0.1:36357_solr-n_0000000000)
[n:127.0.0.1:36357_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"tlog_replica_test_delete_by_id",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"tlog_replica_test_delete_by_id_shard1_replica_t2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:37697/solr";,
[junit4] 2> "type":"TLOG",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 347280 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_delete_by_id_shard1_replica_t2&action=CREATE&numShards=1&collection=tlog_replica_test_delete_by_id&shard=shard1&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 347280 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 347300 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_delete_by_id_shard1_replica_t1&action=CREATE&numShards=1&collection=tlog_replica_test_delete_by_id&shard=shard1&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 347330 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 347541 INFO
(zkCallback-198-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 347541 INFO
(zkCallback-196-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 347541 INFO
(zkCallback-196-thread-2-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 347541 INFO
(zkCallback-198-thread-2-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 348540 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.3.0
[junit4] 2> 348562 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.s.IndexSchema
[tlog_replica_test_delete_by_id_shard1_replica_t1] Schema name=minimal
[junit4] 2> 348582 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.s.IndexSchema Loaded
schema minimal/1.1 with uniqueid field id
[junit4] 2> 348582 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.CoreContainer
Creating SolrCore 'tlog_replica_test_delete_by_id_shard1_replica_t1' using
configuration from collection tlog_replica_test_delete_by_id, trusted=true
[junit4] 2> 348583 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.m.r.SolrJmxReporter
JMX monitoring for
'solr_36357.solr.core.tlog_replica_test_delete_by_id.shard1.replica_t1'
(registry 'solr.core.tlog_replica_test_delete_by_id.shard1.replica_t1') enabled
at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 348595 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 348595 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.SolrCore
[[tlog_replica_test_delete_by_id_shard1_replica_t1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001/node1/tlog_replica_test_delete_by_id_shard1_replica_t1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001/node1/./tlog_replica_test_delete_by_id_shard1_replica_t1/data/]
[junit4] 2> 348617 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.3.0
[junit4] 2> 348654 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.s.IndexSchema
[tlog_replica_test_delete_by_id_shard1_replica_t2] Schema name=minimal
[junit4] 2> 348669 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.s.IndexSchema Loaded
schema minimal/1.1 with uniqueid field id
[junit4] 2> 348669 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.CoreContainer
Creating SolrCore 'tlog_replica_test_delete_by_id_shard1_replica_t2' using
configuration from collection tlog_replica_test_delete_by_id, trusted=true
[junit4] 2> 348670 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.m.r.SolrJmxReporter
JMX monitoring for
'solr_37697.solr.core.tlog_replica_test_delete_by_id.shard1.replica_t2'
(registry 'solr.core.tlog_replica_test_delete_by_id.shard1.replica_t2') enabled
at server: com.sun.jmx.mbeanserver.JmxMBeanServer@6d3c8507
[junit4] 2> 348670 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 348670 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SolrCore
[[tlog_replica_test_delete_by_id_shard1_replica_t2] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001/node2/tlog_replica_test_delete_by_id_shard1_replica_t2],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_D67CE28D900383A9-001/tempDir-001/node2/./tlog_replica_test_delete_by_id_shard1_replica_t2/data/]
[junit4] 2> 349010 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 349011 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 349012 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 349012 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 349014 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.s.SolrIndexSearcher
Opening [Searcher@14769875[tlog_replica_test_delete_by_id_shard1_replica_t2]
main]
[junit4] 2> 349039 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 349040 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 349041 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000ms.
[junit4] 2> 349055 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1591871964161507328
[junit4] 2> 349057 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 349057 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 349058 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.u.CommitTracker Hard
AutoCommit: disabled
[junit4] 2> 349058 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 349093 INFO
(searcherExecutor-215-thread-1-processing-n:127.0.0.1:37697_solr
x:tlog_replica_test_delete_by_id_shard1_replica_t2 s:shard1
c:tlog_replica_test_delete_by_id r:core_node4) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SolrCore
[tlog_replica_test_delete_by_id_shard1_replica_t2] Registered new searcher
Searcher@14769875[tlog_replica_test_delete_by_id_shard1_replica_t2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 349094 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@1e1464e5[tlog_replica_test_delete_by_id_shard1_replica_t1]
main]
[junit4] 2> 349120 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 349128 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 349128 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000ms.
[junit4] 2> 349129 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1591871964239101952
[junit4] 2> 349130 INFO
(searcherExecutor-214-thread-1-processing-n:127.0.0.1:36357_solr
x:tlog_replica_test_delete_by_id_shard1_replica_t1 s:shard1
c:tlog_replica_test_delete_by_id r:core_node3) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.SolrCore
[tlog_replica_test_delete_by_id_shard1_replica_t1] Registered new searcher
Searcher@1e1464e5[tlog_replica_test_delete_by_id_shard1_replica_t1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 349161 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 349291 INFO
(zkCallback-198-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 349291 INFO
(zkCallback-196-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 349291 INFO
(zkCallback-198-thread-2-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 349291 INFO
(zkCallback-196-thread-2-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 349673 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 349673 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 349673 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SyncStrategy Sync
replicas to
https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/
[junit4] 2> 349674 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.PeerSync PeerSync:
core=tlog_replica_test_delete_by_id_shard1_replica_t2
url=https://127.0.0.1:37697/solr START
replicas=[https://127.0.0.1:36357/solr/tlog_replica_test_delete_by_id_shard1_replica_t1/]
nUpdates=100
[junit4] 2> 349901 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=81
[junit4] 2> 349974 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.PeerSync PeerSync:
core=tlog_replica_test_delete_by_id_shard1_replica_t2
url=https://127.0.0.1:37697/solr DONE. We have no versions. sync failed.
[junit4] 2> 349975 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SyncStrategy
Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 349975 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 349975 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 349975 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.ZkController
tlog_replica_test_delete_by_id_shard1_replica_t2 stopping background
replication from leader
[junit4] 2> 350015 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/
shard1
[junit4] 2> 350133 INFO
(zkCallback-198-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350133 INFO
(zkCallback-198-thread-2-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350145 INFO
(zkCallback-196-thread-2-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350145 INFO
(zkCallback-196-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350176 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.ZkController I am
the leader, no recovery necessary
[junit4] 2> 350205 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.ZkController
tlog_replica_test_delete_by_id_shard1_replica_t1 starting background
replication from leader
[junit4] 2> 350206 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_delete_by_id_shard1_replica_t2&action=CREATE&numShards=1&collection=tlog_replica_test_delete_by_id&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=2927
[junit4] 2> 350205 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.ReplicateFromLeader
Will start replication from leader with poll interval: 00:00:03
[junit4] 2> 350230 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.ReplicationHandler
Poll scheduled at an interval of 3000ms
[junit4] 2> 350230 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000ms.
[junit4] 2> 350267 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Replica core_node4 is leader but it's state is down, skipping replication
[junit4] 2> 350284 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=tlog_replica_test_delete_by_id_shard1_replica_t1&action=CREATE&numShards=1&collection=tlog_replica_test_delete_by_id&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=2984
[junit4] 2> 350321 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 350414 INFO
(zkCallback-198-thread-1-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350414 INFO
(zkCallback-198-thread-2-processing-n:127.0.0.1:36357_solr)
[n:127.0.0.1:36357_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350414 INFO
(zkCallback-196-thread-2-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350414 INFO
(zkCallback-196-thread-1-processing-n:127.0.0.1:37697_solr)
[n:127.0.0.1:37697_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/tlog_replica_test_delete_by_id/state.json] for collection
[tlog_replica_test_delete_by_id] has occurred - updating... (live nodes size:
[2])
[junit4] 2> 350902 INFO
(OverseerCollectionConfigSetProcessor-72088055458889734-127.0.0.1:36357_solr-n_0000000000)
[n:127.0.0.1:36357_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 351321 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={pullReplicas=0&replicationFactor=0&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_delete_by_id&nrtReplicas=0&action=CREATE&numShards=1&tlogReplicas=2&wt=javabin&version=2}
status=0 QTime=4473
[junit4] 2> 351369 INFO (qtp492913680-883) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/update
params={update.distrib=FROMLEADER&_version_=-1591871966548066304&distrib.from=https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/&wt=javabin&version=2}{deleteByQuery=*:*
(-1591871966548066304)} 0 9
[junit4] 2> 351383 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 351479 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1591871966703255552,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 351479 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 351480 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 351481 INFO (qtp1021736748-889) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t2] webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 351482 INFO (qtp1021736748-891) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t2] webapp=/solr path=/update
params={_stateVer_=tlog_replica_test_delete_by_id:5&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1591871966548066304),commit=} 0 151
[junit4] 2> 351540 INFO (qtp492913680-883) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/update
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/&wt=javabin&version=2}{add=[1
(1591871966755684352)]} 0 0
[junit4] 2> 351541 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t2] webapp=/solr path=/update
params={_stateVer_=tlog_replica_test_delete_by_id:5&wt=javabin&version=2}{add=[1
(1591871966755684352)]} 0 12
[junit4] 2> 351545 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 0
[junit4] 2> 351575 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1591871966803918848,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 351576 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.u.SolrIndexWriter
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@43e53a79
commitCommandVersion:1591871966803918848
[junit4] 2> 351678 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.s.SolrIndexSearcher
Opening [Searcher@927a67f[tlog_replica_test_delete_by_id_shard1_replica_t2]
main]
[junit4] 2> 351679 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 351680 INFO
(searcherExecutor-215-thread-1-processing-n:127.0.0.1:37697_solr
x:tlog_replica_test_delete_by_id_shard1_replica_t2 s:shard1
c:tlog_replica_test_delete_by_id r:core_node4) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.SolrCore
[tlog_replica_test_delete_by_id_shard1_replica_t2] Registered new searcher
Searcher@927a67f[tlog_replica_test_delete_by_id_shard1_replica_t2]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C1)))}
[junit4] 2> 351681 INFO (qtp1021736748-892) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t2] webapp=/solr path=/update
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 105
[junit4] 2> 351695 INFO (qtp1021736748-891) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2]
o.a.s.u.p.LogUpdateProcessorFactory
[tlog_replica_test_delete_by_id_shard1_replica_t2] webapp=/solr path=/update
params={_stateVer_=tlog_replica_test_delete_by_id:5&commit=true&wt=javabin&version=2}{commit=}
0 153
[junit4] 2> 351920 INFO (qtp492913680-879) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352036 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352139 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352252 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352356 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352459 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352561 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352663 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352765 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352867 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 352969 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 353071 INFO (qtp492913680-882) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 353173 INFO (qtp492913680-881) [n:127.0.0.1:36357_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t1] webapp=/solr path=/select
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 353209 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher Last
replication failed, so I'll force replication
[junit4] 2> 353209 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Updated masterUrl to
https://127.0.0.1:37697/solr/tlog_replica_test_delete_by_id_shard1_replica_t2/
[junit4] 2> 353214 INFO (qtp1021736748-888) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.S.Request
[tlog_replica_test_delete_by_id_shard1_replica_t2] webapp=/solr
path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 353214 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Master's generation: 2
[junit4] 2> 353214 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Master's version: 1518127409749
[junit4] 2> 353214 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Slave's generation: 1
[junit4] 2> 353214 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Slave's version: 0
[junit4] 2> 353214 INFO (indexFetcher-225-thread-1)
[n:127.0.0.1:36357_solr c:tlog_replica_test_delete_by_id s:shard1 r:core_node3
x:tlog_replica_test_delete_by_id_shard1_replica_t1] o.a.s.h.IndexFetcher
Starting replication process
[junit4] 2> 353241 INFO (qtp1021736748-891) [n:127.0.0.1:37697_solr
c:tlog_replica_test_delete_by_id s:shard1 r:core_node4
x:tlog_replica_test_delete_by_id_shard1_replica_t2] o.a.s.c.S.Request
[tlog_replica_test_delete
[...truncated too long message...]
FacetExistsSmallTest, TestConfig, BasicAuthStandaloneTest, TestNumericTerms64,
TestDownShardTolerantSearch, HdfsDirectoryFactoryTest, TestSolrXml,
SuggestComponentTest, TestRandomCollapseQParserPlugin, RuleEngineTest,
SSLMigrationTest, SimpleFacetsTest, ClassificationUpdateProcessorFactoryTest,
SimpleMLTQParserTest, TestPullReplica, TestLegacyNumericUtils,
TestSortableTextField, UpdateParamsTest, FullHLLTest, TestJoin,
SolrCoreMetricManagerTest, AddSchemaFieldsUpdateProcessorFactoryTest,
DistributedQueryElevationComponentTest, TestPseudoReturnFields,
ComputePlanActionTest, TestLeaderElectionZkExpiry,
TestInPlaceUpdatesStandalone, MissingSegmentRecoveryTest,
SpatialRPTFieldTypeTest, DebugComponentTest, DistributedVersionInfoTest,
TestSolrCloudWithKerberosAlt, TermVectorComponentDistributedTest,
CheckHdfsIndexTest, RankQueryTest, DirectUpdateHandlerTest, SuggesterWFSTTest,
ChangedSchemaMergeTest, TestSizeLimitedDistributedMap, TestJsonFacets,
CursorMarkTest, RequestLoggingTest, TestIndexingPerformance,
TestSortByMinMaxFunction, TestDocTermOrds, TestCollectionAPI,
CollectionReloadTest, FullSolrCloudDistribCmdsTest]
[junit4] 2> 16617470 WARN
(TEST-FullSolrCloudDistribCmdsTest.test-seed#[D67CE28D900383A9]) [ ]
o.a.s.c.CoreContainer Error removing live node. Continuing to close
CoreContainer
[junit4] 2> org.apache.zookeeper.KeeperException$ConnectionLossException:
KeeperErrorCode = ConnectionLoss
[junit4] 2> at
org.apache.zookeeper.KeeperException.create(KeeperException.java:102)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.multiInternal(ZooKeeper.java:995)
[junit4] 2> at
org.apache.zookeeper.ZooKeeper.multi(ZooKeeper.java:913)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.lambda$multi$9(SolrZkClient.java:558)
[junit4] 2> at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at
org.apache.solr.common.cloud.SolrZkClient.multi(SolrZkClient.java:558)
[junit4] 2> at
org.apache.solr.cloud.ZkController.removeEphemeralLiveNode(ZkController.java:995)
[junit4] 2> at
org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:749)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.destroy(SolrDispatchFilter.java:317)
[junit4] 2> at
org.apache.solr.cloud.ChaosMonkey.stopJettySolrRunner(ChaosMonkey.java:203)
[junit4] 2> at
org.apache.solr.cloud.ChaosMonkey.stop(ChaosMonkey.java:640)
[junit4] 2> at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.destroyServers(AbstractFullDistribZkTestBase.java:1601)
[junit4] 2> at
org.apache.solr.BaseDistributedSearchTestCase.distribTearDown(BaseDistributedSearchTestCase.java:311)
[junit4] 2> at
org.apache.solr.cloud.AbstractDistribZkTestBase.distribTearDown(AbstractDistribZkTestBase.java:315)
[junit4] 2> at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.distribTearDown(AbstractFullDistribZkTestBase.java:1575)
[junit4] 2> at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:970)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> 17554300 WARN
(zkConnectionManagerCallback-3153-thread-1-processing-n:127.0.0.1:36484_ok_-SendThread(127.0.0.1:34827))
[n:127.0.0.1:36484_ok_ ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 119562ms for sessionid 0x1001bf82e46002d
[junit4] 2> 17528537 WARN
(zkConnectionManagerCallback-3184-thread-1-processing-n:127.0.0.1:33614_ok_-SendThread(127.0.0.1:34827))
[n:127.0.0.1:33614_ok_ ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 48982ms for sessionid 0x1001bf82e460030
[junit4] 2> 17428233 WARN
(zkConnectionManagerCallback-3173-thread-1-processing-n:127.0.0.1:36247_ok_-SendThread(127.0.0.1:34827))
[n:127.0.0.1:36247_ok_ ] o.a.z.ClientCnxn Client session timed out, have
not heard from server in 112526ms for sessionid 0x1001bf82e46002f
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=FullSolrCloudDistribCmdsTest -Dtests.seed=D67CE28D900383A9
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
-Dtests.locale=es-SV -Dtests.timezone=Pacific/Gambier -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] ERROR 0.00s J0 | FullSolrCloudDistribCmdsTest (suite) <<<
[junit4] > Throwable #1: java.lang.OutOfMemoryError: Java heap space
[junit4] Completed [774/774 (8!)] on J0 in 13504.13s, 1 test, 2 errors <<<
FAILURES!
[...truncated 17 lines...]
[junit4] JVM J0: stdout was not empty, see:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/temp/junit4-J0-20180208_215724_992232686935564349916.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/heapdumps/java_pid17731.hprof
...
[junit4] Heap dump file created [592746987 bytes in 16.385 secs]
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J0: stderr was not empty, see:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/temp/junit4-J0-20180208_215724_9923022662631476100881.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4]
[junit4] Exception: java.lang.OutOfMemoryError thrown from the
UncaughtExceptionHandler in thread "Connection evictor"
[junit4] <<< JVM J0: EOF ----
[...truncated 8574 lines...]
BUILD FAILED
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:844:
The following error occurred while executing this line:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:788:
Some of the tests produced a heap dump, but did not fail. Maybe a suppressed
OutOfMemoryError? Dumps created:
* java_pid17731.hprof
Total time: 791 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
