You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2020/03/22 13:52:28 UTC
[JENKINS] Lucene-Solr-NightlyTests-master - Build # 2139 - Unstable
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2139/
3 tests failed.
FAILED: org.apache.lucene.document.TestXYMultiPolygonShapeQueries.testRandomBig
Error Message:
wrong hit (first of possibly more): FAIL: id=14900 should match but did not relation=CONTAINS query=XYShapeQuery: field=shape:[XYRectangle(x=-3.4028214E38 TO 3.4028222E38 y=-1.9697361E38 TO 5.1060108E7),] docID=14549 shape=[[-1.459497E38, 1.1701598E38] [-1.5778801E38, 1.164156E38] [-1.6950484E38, 1.1462064E38] [-1.8097996E38, 1.1164953E38] [-1.9209563E38, 1.0753274E38] [-2.027378E38, 1.0231252E38] [-2.127972E38, 9.604243E37] [-2.221707E38, 8.878682E37] [-2.3076204E38, 8.0620134E37] [-2.3848309E38, 7.1626173E37] [-2.4525463E38, 6.189724E37] [-2.5100717E38, 5.153315E37] [-2.5568168E38, 4.0640262E37] [-2.5923019E38, 2.933035E37] [-2.616163E38, 1.7719469E37] [-2.6281549E38, 5.9267616E36] [-2.6281549E38, -5.9267616E36] [-2.616163E38, -1.7719469E37] [-2.5923019E38, -2.933035E37] [-2.5568168E38, -4.0640262E37] [-2.5100717E38, -5.153315E37] [-2.4525463E38, -6.189724E37] [-2.3848309E38, -7.1626173E37] [-2.3076204E38, -8.0620134E37] [-2.221707E38, -8.878682E37] [-2.127972E38, -9.604243E37] [-2.027378E38, -1.0231252E38] [-1.9209563E38, -1.0753274E38] [-1.8097996E38, -1.1164953E38] [-1.6950484E38, -1.1462064E38] [-1.5778801E38, -1.164156E38] [-1.459497E38, -1.1701598E38] [-1.341114E38, -1.164156E38] [-1.2239457E38, -1.1462064E38] [-1.1091944E38, -1.1164953E38] [-9.980377E37, -1.0753274E38] [-8.916162E37, -1.0231252E38] [-7.91022E37, -9.604243E37] [-6.972872E37, -8.878682E37] [-6.1137374E37, -8.0620134E37] [-5.341631E37, -7.1626173E37] [-4.664477E37, -6.189724E37] [-4.0892236E37, -5.153315E37] [-3.6217728E37, -4.0640262E37] [-3.266922E37, -2.933035E37] [-3.0283123E37, -1.7719469E37] [-2.9083923E37, -5.9267616E36] [-2.9083923E37, 5.9267616E36] [-3.0283123E37, 1.7719469E37] [-3.266922E37, 2.933035E37] [-3.6217728E37, 4.0640262E37] [-4.0892236E37, 5.153315E37] [-4.664477E37, 6.189724E37] [-5.341631E37, 7.1626173E37] [-6.1137374E37, 8.0620134E37] [-6.972872E37, 8.878682E37] [-7.91022E37, 9.604243E37] [-8.916162E37, 1.0231252E38] [-9.980377E37, 1.0753274E38] [-1.1091944E38, 1.1164953E38] [-1.2239457E38, 1.1462064E38] [-1.341114E38, 1.164156E38] [-1.459497E38, 1.1701598E38] , [15.726675, 2.48501] [12.14697, 10.99417] [4.436552, 8.017627] [1.3602217, 8.244197] [0.38664487, 12.782556] [-5.1967983, 6.7252254] [-9.920011, 9.090112] [-5.945468, 2.7837448] [-8.63637, 0.19481237] [-5.625673, -2.8581166] [-5.8917036, -3.2021043] [-8.903727, -11.403193] [-8.837627, -13.95654] [0.046621047, -13.482348] [2.534327, -13.988675] [2.356762, -9.98954] [12.802241, -11.22249] [14.6886015, -0.42274302] [15.726675, 2.48501] , [-3.4028225E38, 1.0141205E32] [-3.4028229E38, 8.782541E31] [-3.4028233E38, 5.0706024E31] [-3.4028235E38, -1.86290899E16] [-3.4028233E38, -5.0706024E31] [-3.4028229E38, -8.782541E31] [-3.4028225E38, -1.0141205E32] [-3.402822E38, -8.782541E31] [-3.4028216E38, -5.0706024E31] [-3.4028214E38, 6.209697E15] [-3.4028216E38, 5.0706024E31] [-3.402822E38, 8.782541E31] [-3.4028225E38, 1.0141205E32] ] deleted?=false rect=Rectangle(lat=-1.9697361470393378E38 TO 5.1060108E7 lon=-3.4028214381443282E38 TO 3.4028222494407124E38)
Stack Trace:
java.lang.AssertionError: wrong hit (first of possibly more):
FAIL: id=14900 should match but did not
relation=CONTAINS
query=XYShapeQuery: field=shape:[XYRectangle(x=-3.4028214E38 TO 3.4028222E38 y=-1.9697361E38 TO 5.1060108E7),] docID=14549
shape=[[-1.459497E38, 1.1701598E38] [-1.5778801E38, 1.164156E38] [-1.6950484E38, 1.1462064E38] [-1.8097996E38, 1.1164953E38] [-1.9209563E38, 1.0753274E38] [-2.027378E38, 1.0231252E38] [-2.127972E38, 9.604243E37] [-2.221707E38, 8.878682E37] [-2.3076204E38, 8.0620134E37] [-2.3848309E38, 7.1626173E37] [-2.4525463E38, 6.189724E37] [-2.5100717E38, 5.153315E37] [-2.5568168E38, 4.0640262E37] [-2.5923019E38, 2.933035E37] [-2.616163E38, 1.7719469E37] [-2.6281549E38, 5.9267616E36] [-2.6281549E38, -5.9267616E36] [-2.616163E38, -1.7719469E37] [-2.5923019E38, -2.933035E37] [-2.5568168E38, -4.0640262E37] [-2.5100717E38, -5.153315E37] [-2.4525463E38, -6.189724E37] [-2.3848309E38, -7.1626173E37] [-2.3076204E38, -8.0620134E37] [-2.221707E38, -8.878682E37] [-2.127972E38, -9.604243E37] [-2.027378E38, -1.0231252E38] [-1.9209563E38, -1.0753274E38] [-1.8097996E38, -1.1164953E38] [-1.6950484E38, -1.1462064E38] [-1.5778801E38, -1.164156E38] [-1.459497E38, -1.1701598E38] [-1.341114E38, -1.164156E38] [-1.2239457E38, -1.1462064E38] [-1.1091944E38, -1.1164953E38] [-9.980377E37, -1.0753274E38] [-8.916162E37, -1.0231252E38] [-7.91022E37, -9.604243E37] [-6.972872E37, -8.878682E37] [-6.1137374E37, -8.0620134E37] [-5.341631E37, -7.1626173E37] [-4.664477E37, -6.189724E37] [-4.0892236E37, -5.153315E37] [-3.6217728E37, -4.0640262E37] [-3.266922E37, -2.933035E37] [-3.0283123E37, -1.7719469E37] [-2.9083923E37, -5.9267616E36] [-2.9083923E37, 5.9267616E36] [-3.0283123E37, 1.7719469E37] [-3.266922E37, 2.933035E37] [-3.6217728E37, 4.0640262E37] [-4.0892236E37, 5.153315E37] [-4.664477E37, 6.189724E37] [-5.341631E37, 7.1626173E37] [-6.1137374E37, 8.0620134E37] [-6.972872E37, 8.878682E37] [-7.91022E37, 9.604243E37] [-8.916162E37, 1.0231252E38] [-9.980377E37, 1.0753274E38] [-1.1091944E38, 1.1164953E38] [-1.2239457E38, 1.1462064E38] [-1.341114E38, 1.164156E38] [-1.459497E38, 1.1701598E38] , [15.726675, 2.48501] [12.14697, 10.99417] [4.436552, 8.017627] [1.3602217, 8.244197] [0.38664487, 12.782556] [-5.1967983, 6.7252254] [-9.920011, 9.090112] [-5.945468, 2.7837448] [-8.63637, 0.19481237] [-5.625673, -2.8581166] [-5.8917036, -3.2021043] [-8.903727, -11.403193] [-8.837627, -13.95654] [0.046621047, -13.482348] [2.534327, -13.988675] [2.356762, -9.98954] [12.802241, -11.22249] [14.6886015, -0.42274302] [15.726675, 2.48501] , [-3.4028225E38, 1.0141205E32] [-3.4028229E38, 8.782541E31] [-3.4028233E38, 5.0706024E31] [-3.4028235E38, -1.86290899E16] [-3.4028233E38, -5.0706024E31] [-3.4028229E38, -8.782541E31] [-3.4028225E38, -1.0141205E32] [-3.402822E38, -8.782541E31] [-3.4028216E38, -5.0706024E31] [-3.4028214E38, 6.209697E15] [-3.4028216E38, 5.0706024E31] [-3.402822E38, 8.782541E31] [-3.4028225E38, 1.0141205E32] ]
deleted?=false rect=Rectangle(lat=-1.9697361470393378E38 TO 5.1060108E7 lon=-3.4028214381443282E38 TO 3.4028222494407124E38)
at __randomizedtesting.SeedInfo.seed([35084C5E0AFC1DBB:B25F31D19BA5613B]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.apache.lucene.document.BaseShapeTestCase.verifyRandomBBoxQueries(BaseShapeTestCase.java:378)
at org.apache.lucene.document.BaseShapeTestCase.verifyRandomQueries(BaseShapeTestCase.java:268)
at org.apache.lucene.document.BaseShapeTestCase.verify(BaseShapeTestCase.java:236)
at org.apache.lucene.document.BaseShapeTestCase.doTestRandom(BaseShapeTestCase.java:139)
at org.apache.lucene.document.TestXYMultiPolygonShapeQueries.testRandomBig(TestXYMultiPolygonShapeQueries.java:145)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
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 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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
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([CA812CC780BD12BB:19887CD9C52E8E2C]:0)
at org.apache.solr.cloud.cdcr.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:277)
at org.apache.solr.cloud.cdcr.CdcrReplicationHandlerTest.testReplicationWithBufferedUpdates(CdcrReplicationHandlerTest.java:233)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
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 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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: java.lang.AssertionError: expected:<270> but was:<280>
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.cdcr.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:268)
... 42 more
FAILED: org.apache.solr.cloud.hdfs.HdfsBasicDistributedZk2Test.test
Error Message:
Timeout occurred while waiting response from server at: http://127.0.0.1:40559/jq_x/ra/control_collection
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occurred while waiting response from server at: http://127.0.0.1:40559/jq_x/ra/control_collection
at __randomizedtesting.SeedInfo.seed([CA812CC780BD12BB:42D5131D2E417F43]:0)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:676)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:265)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207)
at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:504)
at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:479)
at org.apache.solr.cloud.AbstractFullDistribZkTestBase.commit(AbstractFullDistribZkTestBase.java:1748)
at org.apache.solr.cloud.BasicDistributedZk2Test.test(BasicDistributedZk2Test.java:93)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
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 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:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.base/java.net.SocketInputStream.socketRead0(Native Method)
at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:115)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInputBufferImpl.java:137)
at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInputBufferImpl.java:153)
at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputBufferImpl.java:280)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:138)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
... 48 more
Build Log:
[...truncated 1196 lines...]
[junit4] Suite: org.apache.lucene.document.TestXYMultiPolygonShapeQueries
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestXYMultiPolygonShapeQueries -Dtests.method=testRandomBig -Dtests.seed=35084C5E0AFC1DBB -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/test-data/enwiki.random.lines.txt -Dtests.locale=vai -Dtests.timezone=Europe/Samara -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 356s J0 | TestXYMultiPolygonShapeQueries.testRandomBig <<<
[junit4] > Throwable #1: java.lang.AssertionError: wrong hit (first of possibly more):
[junit4] > FAIL: id=14900 should match but did not
[junit4] > relation=CONTAINS
[junit4] > query=XYShapeQuery: field=shape:[XYRectangle(x=-3.4028214E38 TO 3.4028222E38 y=-1.9697361E38 TO 5.1060108E7),] docID=14549
[junit4] > shape=[[-1.459497E38, 1.1701598E38] [-1.5778801E38, 1.164156E38] [-1.6950484E38, 1.1462064E38] [-1.8097996E38, 1.1164953E38] [-1.9209563E38, 1.0753274E38] [-2.027378E38, 1.0231252E38] [-2.127972E38, 9.604243E37] [-2.221707E38, 8.878682E37] [-2.3076204E38, 8.0620134E37] [-2.3848309E38, 7.1626173E37] [-2.4525463E38, 6.189724E37] [-2.5100717E38, 5.153315E37] [-2.5568168E38, 4.0640262E37] [-2.5923019E38, 2.933035E37] [-2.616163E38, 1.7719469E37] [-2.6281549E38, 5.9267616E36] [-2.6281549E38, -5.9267616E36] [-2.616163E38, -1.7719469E37] [-2.5923019E38, -2.933035E37] [-2.5568168E38, -4.0640262E37] [-2.5100717E38, -5.153315E37] [-2.4525463E38, -6.189724E37] [-2.3848309E38, -7.1626173E37] [-2.3076204E38, -8.0620134E37] [-2.221707E38, -8.878682E37] [-2.127972E38, -9.604243E37] [-2.027378E38, -1.0231252E38] [-1.9209563E38, -1.0753274E38] [-1.8097996E38, -1.1164953E38] [-1.6950484E38, -1.1462064E38] [-1.5778801E38, -1.164156E38] [-1.459497E38, -1.1701598E38] [-1.341114E38, -1.164156E38] [-1.2239457E38, -1.1462064E38] [-1.1091944E38, -1.1164953E38] [-9.980377E37, -1.0753274E38] [-8.916162E37, -1.0231252E38] [-7.91022E37, -9.604243E37] [-6.972872E37, -8.878682E37] [-6.1137374E37, -8.0620134E37] [-5.341631E37, -7.1626173E37] [-4.664477E37, -6.189724E37] [-4.0892236E37, -5.153315E37] [-3.6217728E37, -4.0640262E37] [-3.266922E37, -2.933035E37] [-3.0283123E37, -1.7719469E37] [-2.9083923E37, -5.9267616E36] [-2.9083923E37, 5.9267616E36] [-3.0283123E37, 1.7719469E37] [-3.266922E37, 2.933035E37] [-3.6217728E37, 4.0640262E37] [-4.0892236E37, 5.153315E37] [-4.664477E37, 6.189724E37] [-5.341631E37, 7.1626173E37] [-6.1137374E37, 8.0620134E37] [-6.972872E37, 8.878682E37] [-7.91022E37, 9.604243E37] [-8.916162E37, 1.0231252E38] [-9.980377E37, 1.0753274E38] [-1.1091944E38, 1.1164953E38] [-1.2239457E38, 1.1462064E38] [-1.341114E38, 1.164156E38] [-1.459497E38, 1.1701598E38] , [15.726675, 2.48501] [12.14697, 10.99417] [4.436552, 8.017627] [1.3602217, 8.244197] [0.38664487, 12.782556] [-5.1967983, 6.7252254] [-9.920011, 9.090112] [-5.945468, 2.7837448] [-8.63637, 0.19481237] [-5.625673, -2.8581166] [-5.8917036, -3.2021043] [-8.903727, -11.403193] [-8.837627, -13.95654] [0.046621047, -13.482348] [2.534327, -13.988675] [2.356762, -9.98954] [12.802241, -11.22249] [14.6886015, -0.42274302] [15.726675, 2.48501] , [-3.4028225E38, 1.0141205E32] [-3.4028229E38, 8.782541E31] [-3.4028233E38, 5.0706024E31] [-3.4028235E38, -1.86290899E16] [-3.4028233E38, -5.0706024E31] [-3.4028229E38, -8.782541E31] [-3.4028225E38, -1.0141205E32] [-3.402822E38, -8.782541E31] [-3.4028216E38, -5.0706024E31] [-3.4028214E38, 6.209697E15] [-3.4028216E38, 5.0706024E31] [-3.402822E38, 8.782541E31] [-3.4028225E38, 1.0141205E32] ]
[junit4] > deleted?=false rect=Rectangle(lat=-1.9697361470393378E38 TO 5.1060108E7 lon=-3.4028214381443282E38 TO 3.4028222494407124E38)
[junit4] > at __randomizedtesting.SeedInfo.seed([35084C5E0AFC1DBB:B25F31D19BA5613B]:0)
[junit4] > at org.apache.lucene.document.BaseShapeTestCase.verifyRandomBBoxQueries(BaseShapeTestCase.java:378)
[junit4] > at org.apache.lucene.document.BaseShapeTestCase.verifyRandomQueries(BaseShapeTestCase.java:268)
[junit4] > at org.apache.lucene.document.BaseShapeTestCase.verify(BaseShapeTestCase.java:236)
[junit4] > at org.apache.lucene.document.BaseShapeTestCase.doTestRandom(BaseShapeTestCase.java:139)
[junit4] > at org.apache.lucene.document.TestXYMultiPolygonShapeQueries.testRandomBig(TestXYMultiPolygonShapeQueries.java:145)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/lucene/build/core/test/J0/temp/lucene.document.TestXYMultiPolygonShapeQueries_35084C5E0AFC1DBB-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {id=Lucene84}, docValues:{shape=DocValuesFormat(name=Lucene80), id=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=383, maxMBSortInHeap=5.737823435273956, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@609a281b), locale=vai, timezone=Europe/Samara
[junit4] 2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=8,threads=1,free=172935696,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestBagOfPositions, TestIndexWriterNRTIsCurrent, TestDoc, TestHighLZ4, TestBinaryTerms, TestIndependenceChiSquared, TestByteArrayDataInput, TestFastCompressionMode, TestPositiveScoresOnlyCollector, TestDocumentWriter, TestXYLine, TestSetOnce, TestBitUtil, TestTermVectorsWriter, TestLucene84PostingsFormat, TestStringMSBRadixSorter, TestIndexWriterCommit, TestSimilarityProvider, TestPolygon, Test2BPagedBytes, TestFilterSpans, TestSingleInstanceLockFactory, TestTermsEnum, TestXYRectangle, TestAutomatonQuery, TestSnapshotDeletionPolicy, TestBooleanMinShouldMatch, TestSearchAfter, TestDelegatingAnalyzerWrapper, TestCodecHoldsOpenFiles, Test2BSortedDocValuesOrds, TestAnalyzerWrapper, TestForTooMuchCloning, TestSpansEnum, TestAxiomaticF1LOG, TestXYPointDistanceSort, TestWildcard, TestIndexWriterDeleteByQuery, TestCharTermAttributeImpl, TestSimpleWKTShapeParsing, TestQueryBuilder, TestTotalHits, TestLucene50StoredFieldsFormatHighCompression, TestUniqueTermCount, TestIndexSorting, TestIndexedDISI, TestClassicSimilarity, TestMaxScoreSumPropagator, TestConsistentFieldNumbers, TestIndexCommit, TestIntRange, TestComplexExplanationsOfNonMatches, TestReusableStringReader, TestNamedSPILoader, TestNormsFieldExistsQuery, TestBasicModelIn, TestIntBlockPool, TestAddIndexes, Test2BNumericDocValues, TestFieldReuse, TestLucene60FieldInfoFormat, TestIntRangeFieldQueries, TestXYShape, TestLatLonPointShapeQueries, TestParallelCompositeReader, TestTransactions, TestPendingDeletes, TestLSBRadixSorter, TestSortedSetDocValues, TestDocValuesRewriteMethod, TestNoMergePolicy, TestCircle2D, TestFeatureDoubleValues, TestSimpleExplanationsWithFillerDocs, TestIndexableField, TestConstantScoreQuery, TestDeterminism, TestLatLonPoint, TestLucene50CompoundFormat, TestStressIndexing, TestMergeSchedulerExternal, TestLMDirichletSimilarity, TestMultiset, TestMultiMMap, TestRegExp, TestMultiFields, TestCustomNorms, TestIndexWriterOnVMError, TestField, TestFilterDirectory, TestBooleanQueryVisitSubscorers, TestSparseFixedBitDocIdSet, TestRollingBuffer, TestAssertions, TestDemo, TestExternalCodecs, TestCharArraySet, TestCharFilter, TestCharacterUtils, TestWordlistLoader, TestStandardAnalyzer, TestBytesRefAttImpl, TestLucene80NormsFormatMergeInstance, TestForDeltaUtil, TestForUtil, TestPerFieldPostingsFormat, TestPerFieldPostingsFormat2, TestBinaryDocument, TestDateTools, TestDocument, TestDoubleRange, TestLatLonMultiLineShapeQueries, TestLatLonMultiPointShapeQueries, TestLatLonMultiPolygonShapeQueries, TestLatLonShapeEncoding, TestLongDistanceFeatureQuery, TestLongRange, TestXYLineShapeQueries, TestXYMultiLineShapeQueries, TestXYMultiPointShapeQueries, TestXYMultiPolygonShapeQueries]
[junit4] Completed [248/561 (1!)] on J0 in 530.23s, 5 tests, 1 failure <<< FAILURES!
[...truncated 12623 lines...]
[junit4] Suite: org.apache.solr.cloud.cdcr.CdcrReplicationHandlerTest
[junit4] 2> 2297232 INFO (SUITE-CdcrReplicationHandlerTest-seed#[CA812CC780BD12BB]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2297232 INFO (SUITE-CdcrReplicationHandlerTest-seed#[CA812CC780BD12BB]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2297232 INFO (SUITE-CdcrReplicationHandlerTest-seed#[CA812CC780BD12BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/data-dir-80-001
[junit4] 2> 2297233 INFO (SUITE-CdcrReplicationHandlerTest-seed#[CA812CC780BD12BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2297234 INFO (SUITE-CdcrReplicationHandlerTest-seed#[CA812CC780BD12BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 2297235 INFO (SUITE-CdcrReplicationHandlerTest-seed#[CA812CC780BD12BB]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 2297256 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2297256 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2297256 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2297356 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer start zk server on port:44463
[junit4] 2> 2297356 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44463
[junit4] 2> 2297356 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44463
[junit4] 2> 2297356 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 44463
[junit4] 2> 2297358 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2297360 INFO (zkConnectionManagerCallback-9434-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2297360 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2297362 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2297364 INFO (zkConnectionManagerCallback-9436-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2297364 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2297366 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-cdcr.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 2297367 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml
[junit4] 2> 2297377 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2297379 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 2297381 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 2297382 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 2297384 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 2297385 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2297387 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2297388 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 2297389 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 2297391 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2297392 INFO (zkConnectionManagerCallback-9440-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2297392 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2297495 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPartialReplicationAfterPeerSync
[junit4] 2> 2297909 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2297909 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2297909 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS
[junit4] 2> 2297910 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2297910 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2297910 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2297910 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5bc3ac2c{/,null,AVAILABLE}
[junit4] 2> 2297911 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@999b192{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:32807}
[junit4] 2> 2297911 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.Server Started @2297952ms
[junit4] 2> 2297911 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard1, hostContext=/, hostPort=32807, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-001/cores}
[junit4] 2> 2297912 ERROR (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2297912 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2297912 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0
[junit4] 2> 2297912 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2297912 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr
[junit4] 2> 2297912 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-03-22T11:08:40.217299Z
[junit4] 2> 2297913 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2297914 INFO (zkConnectionManagerCallback-9442-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2297914 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2298016 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2298016 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-001/solr.xml
[junit4] 2> 2298021 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2299636 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2299638 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1cc1672e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2299638 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1cc1672e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2299642 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2afb9060[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2299642 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2afb9060[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2299644 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44463/solr
[junit4] 2> 2299645 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2299647 INFO (zkConnectionManagerCallback-9449-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2299653 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2299757 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2299758 INFO (zkConnectionManagerCallback-9451-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2299758 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2299904 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:32807_
[junit4] 2> 2299904 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.Overseer Overseer (id=72493464480907269-127.0.0.1:32807_-n_0000000000) starting
[junit4] 2> 2299910 INFO (OverseerStateUpdate-72493464480907269-127.0.0.1:32807_-n_0000000000) [n:127.0.0.1:32807_ ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:32807_
[junit4] 2> 2299910 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32807_
[junit4] 2> 2299912 INFO (zkCallback-9450-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2299931 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2299931 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2299970 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2300073 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2300096 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2300096 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2300098 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [n:127.0.0.1:32807_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-001/cores
[junit4] 2> 2300694 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2300694 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2300694 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.4+10-LTS
[junit4] 2> 2300695 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2300695 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2300695 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2300695 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@633a9d49{/,null,AVAILABLE}
[junit4] 2> 2300696 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@195d718a{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:37919}
[junit4] 2> 2300697 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.s.Server Started @2300737ms
[junit4] 2> 2300697 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard2, hostContext=/, hostPort=37919, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-002/cores}
[junit4] 2> 2300697 ERROR (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2300697 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2300697 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 9.0.0
[junit4] 2> 2300705 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2300705 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr
[junit4] 2> 2300705 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-03-22T11:08:43.010824Z
[junit4] 2> 2300706 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2300708 INFO (zkConnectionManagerCallback-9457-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2300708 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2300809 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2300809 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-002/solr.xml
[junit4] 2> 2300814 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2301865 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2301875 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@23e75cea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2301875 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@23e75cea[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2301880 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@43b984fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2301880 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@43b984fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2301882 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44463/solr
[junit4] 2> 2301882 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2301884 INFO (zkConnectionManagerCallback-9464-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2301895 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2302026 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2302027 INFO (zkConnectionManagerCallback-9466-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2302027 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2302070 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2302082 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:37919_ as DOWN
[junit4] 2> 2302084 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2302084 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37919_
[junit4] 2> 2302085 INFO (zkCallback-9450-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2302085 INFO (zkCallback-9465-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2302096 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2302096 WARN (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2302230 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2302408 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2302506 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2302506 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2302525 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-002/cores
[junit4] 2> 2302746 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2302771 INFO (zkConnectionManagerCallback-9475-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2302771 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2302794 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2302795 INFO (TEST-CdcrReplicationHandlerTest.testPartialReplicationAfterPeerSync-seed#[CA812CC780BD12BB]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44463/solr ready
[junit4] 2> 2302981 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=tmp_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2303002 INFO (OverseerThreadFactory-6353-thread-1-processing-n:127.0.0.1:32807_) [n:127.0.0.1:32807_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection tmp_collection
[junit4] 2> 2303107 WARN (OverseerThreadFactory-6353-thread-1-processing-n:127.0.0.1:32807_) [n:127.0.0.1:32807_ ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (tmp_collection) without cores.
[junit4] 2> 2303109 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 2303110 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=tmp_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&wt=javabin&version=2} status=0 QTime=128
[junit4] 2> 2303112 INFO (qtp1414829400-22881) [n:127.0.0.1:32807_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:32807_&action=ADDREPLICA&collection=tmp_collection&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2303122 INFO (OverseerCollectionConfigSetProcessor-72493464480907269-127.0.0.1:32807_-n_0000000000) [n:127.0.0.1:32807_ ] 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> 2303123 INFO (OverseerThreadFactory-6353-thread-2-processing-n:127.0.0.1:32807_) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:32807_ for creating new replica of shard shard1 for collection tmp_collection
[junit4] 2> 2303125 INFO (OverseerThreadFactory-6353-thread-2-processing-n:127.0.0.1:32807_) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 2303374 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=tmp_collection_shard1_replica_n1&action=CREATE&collection=tmp_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2303374 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2304388 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 2304412 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 2304518 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2304539 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'tmp_collection_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 2304539 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.tmp_collection.shard1.replica_n1' (registry 'solr.core.tmp_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2304540 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[tmp_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-001/cores/tmp_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-001/cores/tmp_collection_shard1_replica_n1/data/]
[junit4] 2> 2304546 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1790029207, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2304657 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2304657 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2304751 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2304751 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2304753 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=8, maxMergeAtOnceExplicit=2, maxMergedSegmentMB=15.30078125, floorSegmentMB=0.5244140625, forceMergeDeletesPctAllowed=3.1133602030113448, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23484203980741009, deletesPctAllowed=22.013915114120053
[junit4] 2> 2304754 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@520e7fff[tmp_collection_shard1_replica_n1] main]
[junit4] 2> 2304756 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2304756 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2304757 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2304776 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.h.CdcrBufferStateManager Created znode /collections/tmp_collection/cdcr/state/buffer
[junit4] 2> 2304777 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.h.CdcrProcessStateManager Created znode /collections/tmp_collection/cdcr/state/process
[junit4] 2> 2304778 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1661862230971383808
[junit4] 2> 2304782 INFO (searcherExecutor-6367-thread-1-processing-n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 c:tmp_collection s:shard1) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [tmp_collection_shard1_replica_n1] Registered new searcher Searcher@520e7fff[tmp_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2304785 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/tmp_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 2304785 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/tmp_collection/leaders/shard1
[junit4] 2> 2304789 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2304789 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2304789 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:32807/tmp_collection_shard1_replica_n1/
[junit4] 2> 2304790 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2304790 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:32807/tmp_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 2304790 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/tmp_collection/leaders/shard1/leader after winning as /collections/tmp_collection/leader_elect/shard1/election/72493464480907269-core_node2-n_0000000000
[junit4] 2> 2304791 INFO (zkCallback-9450-thread-1) [ ] o.a.s.h.CdcrLeaderStateManager Received new leader state @ tmp_collection:shard1
[junit4] 2> 2304794 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:32807/tmp_collection_shard1_replica_n1/ shard1
[junit4] 2> 2304896 INFO (zkCallback-9450-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tmp_collection/state.json] for collection [tmp_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2304896 INFO (zkCallback-9450-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tmp_collection/state.json] for collection [tmp_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2304897 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2304899 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=tmp_collection_shard1_replica_n1&action=CREATE&collection=tmp_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1546
[junit4] 2> 2304901 INFO (qtp1414829400-22881) [n:127.0.0.1:32807_ c:tmp_collection ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:32807_&action=ADDREPLICA&collection=tmp_collection&shard=shard1&type=NRT&wt=javabin&version=2} status=0 QTime=1789
[junit4] 2> 2304902 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:37919_&action=ADDREPLICA&collection=tmp_collection&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2304913 INFO (OverseerThreadFactory-6353-thread-3-processing-n:127.0.0.1:32807_) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:37919_ for creating new replica of shard shard1 for collection tmp_collection
[junit4] 2> 2304913 INFO (OverseerCollectionConfigSetProcessor-72493464480907269-127.0.0.1:32807_-n_0000000000) [n:127.0.0.1:32807_ ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 2304914 INFO (OverseerThreadFactory-6353-thread-3-processing-n:127.0.0.1:32807_) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 2304989 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=tmp_collection_shard1_replica_n3&action=CREATE&collection=tmp_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2305095 INFO (zkCallback-9450-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tmp_collection/state.json] for collection [tmp_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2305095 INFO (zkCallback-9450-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tmp_collection/state.json] for collection [tmp_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2305095 INFO (zkCallback-9450-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/tmp_collection/state.json] for collection [tmp_collection] has occurred - updating... (live nodes size: [2])
[junit4] 2> 2306003 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 2306040 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 2306135 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 2306166 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.CoreContainer Creating SolrCore 'tmp_collection_shard1_replica_n3' using configuration from configset conf1, trusted=true
[junit4] 2> 2306166 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.tmp_collection.shard1.replica_n3' (registry 'solr.core.tmp_collection.shard1.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a4ba47c
[junit4] 2> 2306166 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.SolrCore [[tmp_collection_shard1_replica_n3] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-002/cores/tmp_collection_shard1_replica_n3], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrReplicationHandlerTest_CA812CC780BD12BB-001/jetty-002/cores/tmp_collection_shard1_replica_n3/data/]
[junit4] 2> 2306171 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1790029207, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2306275 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 2306275 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2306277 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2306277 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2306278 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=8, maxMergeAtOnceExplicit=2, maxMergedSegmentMB=15.30078125, floorSegmentMB=0.5244140625, forceMergeDeletesPctAllowed=3.1133602030113448, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23484203980741009, deletesPctAllowed=22.013915114120053
[junit4] 2> 2306279 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@52921e8d[tmp_collection_shard1_replica_n3] main]
[junit4] 2> 2306282 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2306282 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2306282 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2306293 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1661862232559976448
[junit4] 2> 2306297 INFO (searcherExecutor-6373-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.SolrCore [tmp_collection_shard1_replica_n3] Registered new searcher Searcher@52921e8d[tmp_collection_shard1_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2306321 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/tmp_collection/terms/shard1 to Terms{values={core_node2=0, core_node4=0}, version=1}
[junit4] 2> 2306321 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 r:core_node2 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.S.Request [tmp_collection_shard1_replica_n1] webapp= path=/cdcr params={action=LASTPROCESSEDVERSION&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2306321 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/tmp_collection/leaders/shard1
[junit4] 2> 2306333 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.ZkController Core needs to recover:tmp_collection_shard1_replica_n3
[junit4] 2> 2306333 INFO (updateExecutor-9460-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 2306333 INFO (recoveryExecutor-9462-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1 r:core_node4) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
[junit4] 2> 2306334 INFO (recoveryExecutor-9462-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1 r:core_node4) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy startupVersions is empty
[junit4] 2> 2306335 INFO (qtp1888986399-22917) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 x:tmp_collection_shard1_replica_n3 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=tmp_collection_shard1_replica_n3&action=CREATE&collection=tmp_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1346
[junit4] 2> 2306337 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ c:tmp_collection ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:37919_&action=ADDREPLICA&collection=tmp_collection&shard=shard1&type=NRT&wt=javabin&version=2} status=0 QTime=1434
[junit4] 2> 2306401 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 r:core_node2 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.S.Request [tmp_collection_shard1_replica_n1] webapp= path=/admin/ping params={wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 2306401 INFO (qtp1414829400-22883) [n:127.0.0.1:32807_ c:tmp_collection s:shard1 r:core_node2 x:tmp_collection_shard1_replica_n1 ] o.a.s.c.S.Request [tmp_collection_shard1_replica_n1] webapp= path=/admin/ping params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2306401 INFO (recoveryExecutor-9462-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1 r:core_node4) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Begin buffering updates. core=[tmp_collection_shard1_replica_n3]
[junit4] 2> 2306401 INFO (recoveryExecutor-9462-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1 r:core_node4) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2306401 INFO (recoveryExecutor-9462-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1 r:core_node4) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Publishing state of core [tmp_collection_shard1_replica_n3] as recovering, leader is [https://127.0.0.1:32807/tmp_collection_shard1_replica_n1/] and I am [https://127.0.0.1:37919/tmp_collection_shard1_replica_n3/]
[junit4] 2> 2306402 INFO (recoveryExecutor-9462-thread-1-processing-n:127.0.0.1:37919_ x:tmp_collection_shard1_replica_n3 c:tmp_collection s:shard1 r:core_node4) [n:127.0.0.1:37919_ c:tmp_collection s:shard1 r:core_node4 x:tmp_collection_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Sending prep recovery command to [https://127.0.0.1:32807]; [WaitForState: action=PREPRECOVERY&core=tmp_collection_shard1_replica_n1&nodeName=127.0.0.1:37919_&coreNodeName=core_node4&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 2306403 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 ] o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node4, state: recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 2306403 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 ] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=tmp_collection, shard=shard1, thisCore=tmp_collection_shard1_replica_n1, leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, currentState=down, localState=active, nodeName=127.0.0.1:37919_, coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps: core_node4:{
[junit4] 2> "core":"tmp_collection_shard1_replica_n3",
[junit4] 2> "base_url":"https://127.0.0.1:37919",
[junit4] 2> "node_name":"127.0.0.1:37919_",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}
[junit4] 2> 2306403 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 ] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=tmp_collection, shard=shard1, thisCore=tmp_collection_shard1_replica_n1, leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, currentState=down, localState=active, nodeName=127.0.0.1:37919_, coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps: core_node4:{
[junit4] 2> "core":"tmp_collection_shard1_replica_n3",
[junit4] 2> "base_url":"https://127.0.0.1:37919",
[junit4] 2> "node_name":"127.0.0.1:37919_",
[junit4] 2> "state":"down",
[junit4] 2> "type":"NRT"}
[junit4] 2> 2306403 INFO (qtp1414829400-22882) [n:127.0.0.1:32807_ x:tmp_collection_shard1_replica_n1 ] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=tmp_collection, shard=shard1, thisCore=tmp_collection_shard1_replica_n1, leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, currentState=down, localState=active, nodeName=127.0.0.1:37919_, coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps: core_nod
[...truncated too long message...]
138)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
[junit4] > at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
[junit4] > at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
[junit4] > at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
[junit4] > at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
[junit4] > at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
[junit4] > at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] > at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
[junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:564)
[junit4] > ... 48 more
[junit4] 2> 6476066 WARN (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 6476082 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@78823ada{datanode,/,null,UNAVAILABLE}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/datanode}
[junit4] 2> 6476082 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5c4c2009{HTTP/1.1,[http/1.1]}{localhost:0}
[junit4] 2> 6476082 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 6476082 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@64f7c898{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,UNAVAILABLE}
[junit4] 2> 6476083 WARN (BP-1695048393-127.0.0.1-1584879087671 heartbeating to lucene2-us-west.apache.org/127.0.0.1:43695) [ ] o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager interrupted
[junit4] 2> 6476083 WARN (BP-1695048393-127.0.0.1-1584879087671 heartbeating to lucene2-us-west.apache.org/127.0.0.1:43695) [ ] o.a.h.h.s.d.DataNode Ending block pool service for: Block pool BP-1695048393-127.0.0.1-1584879087671 (Datanode Uuid e0e6c01e-835d-4703-a4c1-39f8128adab0) service to lucene2-us-west.apache.org/127.0.0.1:43695
[junit4] 2> 6476152 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.w.WebAppContext@217112e{hdfs,/,null,UNAVAILABLE}{jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/hdfs}
[junit4] 2> 6476152 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@28651f1a{HTTP/1.1,[http/1.1]}{lucene2-us-west.apache.org:0}
[junit4] 2> 6476152 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 6476152 INFO (SUITE-HdfsBasicDistributedZk2Test-seed#[CA812CC780BD12BB]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2bfa4717{static,/static,jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-3.2.0-tests.jar!/webapps/static,UNAVAILABLE}
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsBasicDistributedZk2Test_CA812CC780BD12BB-001
[junit4] 2> Mar 22, 2020 12:18:19 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 32 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84): {rnd_b=Lucene84, oddField_s=PostingsFormat(name=Direct), SubjectTerms_mfacet=Lucene84, multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), a_t=Lucene84, _root_=Lucene84, foo_b=PostingsFormat(name=Direct), id=Lucene84, text=PostingsFormat(name=Direct)}, docValues:{other_tl1=DocValuesFormat(name=Lucene80), range_facet_l_dv=DocValuesFormat(name=Asserting), n_l1=DocValuesFormat(name=Lucene80), intDefault=DocValuesFormat(name=Lucene80), n_dt1=DocValuesFormat(name=Lucene80), a_i1=DocValuesFormat(name=Lucene80), n_td1=DocValuesFormat(name=Lucene80), n_d1=DocValuesFormat(name=Lucene80), range_facet_l=DocValuesFormat(name=Lucene80), n_f1=DocValuesFormat(name=Lucene80), n_ti1=DocValuesFormat(name=Asserting), n_tl1=DocValuesFormat(name=Lucene80), _version_=DocValuesFormat(name=Lucene80), n_tf1=DocValuesFormat(name=Lucene80), n_tdt1=DocValuesFormat(name=Lucene80), id_i1=DocValuesFormat(name=Lucene80), foo_d=DocValuesFormat(name=Asserting), range_facet_i_dv=DocValuesFormat(name=Lucene80), intDvoDefault=DocValuesFormat(name=Asserting), foo_f=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=630, maxMBSortInHeap=7.889372565458428, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@16581ae5), locale=el-CY, timezone=Asia/Novosibirsk
[junit4] 2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 11.0.4 (64-bit)/cpus=8,threads=5,free=209310496,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TestQuerySenderListener, SolrCoreMetricManagerTest, TestRealTimeGet, DataDrivenBlockJoinTest, TestPivotHelperCode, LoggingHandlerTest, DistributedQueueTest, QueryResultKeyTest, RootFieldTest, TestStressLiveNodes, TestSchemalessBufferedUpdates, TestFieldCollectionResource, GraphQueryTest, DistributedQueryComponentOptimizationTest, TestPushWriter, TestGraphMLResponseWriter, TestSolrXml, ShardRoutingTest, NumberUtilsTest, TestInfoStreamLogging, AutoscalingHistoryHandlerTest, BadComponentTest, TestAtomicUpdateErrorCases, RecoveryZkTest, TestScoreJoinQPNoScore, XmlUpdateRequestHandlerTest, TestManagedSynonymGraphFilterFactory, TimeZoneUtilsTest, OverseerStatusTest, MetricsHandlerTest, TestJsonFacetsStatsParsing, AnalyticsMergeStrategyTest, TestHighlightDedupGrouping, TestLeaderElectionZkExpiry, CustomCollectionTest, PreAnalyzedFieldManagedSchemaCloudTest, BasicDistributedZk2Test, TestFieldCacheReopen, IndexSchemaTest, TestRebalanceLeaders, TestFieldCacheVsDocValues, TestCloudDeleteByQuery, FieldAnalysisRequestHandlerTest, TestRemoteStreaming, SearchRateTriggerTest, TestNamedUpdateProcessors, JWTAuthPluginIntegrationTest, AuthToolTest, TestReload, HighlighterMaxOffsetTest, ExitableDirectoryReaderTest, ChaosMonkeyNothingIsSafeTest, NodeAddedTriggerTest, TestSegmentSorting, TestInPlaceUpdateWithRouteField, ZkFailoverTest, TestFieldTypeResource, MaxSizeAutoCommitTest, TestRestoreCore, TestCodecSupport, StatsComponentTest, TestFunctionQuery, DeleteInactiveReplicaTest, TestPullReplica, BitVectorTest, HDFSCollectionsAPITest, MergeStrategyTest, RankQueryTest, CursorMarkTest, DisMaxRequestHandlerTest, TestPayloadCheckQParserPlugin, CacheHeaderTest, SimpleMLTQParserTest, SystemInfoHandlerTest, TlogReplayBufferedWhileIndexingTest, CdcrRequestHandlerTest, ConjunctionSolrSpellCheckerTest, TestDistributedSearch, TestSkipOverseerOperations, TestConfigSetsAPI, TestSimExtremeIndexing, TestSweetSpotSimilarityFactory, DimensionalRoutedAliasUpdateProcessorTest, DistributedSuggestComponentTest, TestClusterStateMutator, CollectionsAPIDistributedZkTest, TestSubQueryTransformerCrossCore, TestCryptoKeys, AddReplicaTest, TestMaxScoreQueryParser, TestStressUserVersions, TestDocSet, TestConfigsApi, TestEmbeddedSolrServerAdminHandler, SSLMigrationTest, TestTolerantUpdateProcessorCloud, OverseerRolesTest, TestShardHandlerFactory, TestCloudPivotFacet, TestRSAKeyPair, PackageManagerCLITest, VMParamsZkACLAndCredentialsProvidersTest, SolrLogAuditLoggerPluginTest, LeaderTragicEventTest, TestLazyCores, HdfsRecoverLeaseTest, TestPhraseSuggestions, PathHierarchyTokenizerFactoryTest, EnumFieldTest, TestInPlaceUpdatesStandalone, CategoryRoutedAliasUpdateProcessorTest, RestartWhileUpdatingTest, OverriddenZkACLAndCredentialsProvidersTest, TestCoreContainer, TestSolrCoreParser, SolrPluginUtilsTest, CollectionReloadTest, TestStressLucene, TriggerSetPropertiesIntegrationTest, SpellPossibilityIteratorTest, MetricTriggerIntegrationTest, ClusterStateUpdateTest, ConfigureRecoveryStrategyTest, TestDistributedMap, TestUpdate, RegexBytesRefFilterTest, TestMultiWordSynonyms, SolrInfoBeanTest, TestReplicationHandlerBackup, CheckHdfsIndexTest, TestManagedResourceStorage, AutoAddReplicasPlanActionTest, TestSearcherReuse, TestQueryTypes, TestSortByMinMaxFunction, TermVectorComponentDistributedTest, TestMaxTokenLenTokenizer, TestSlowCompositeReaderWrapper, TestCaffeineCache, TestDocTermOrds, ClassificationUpdateProcessorTest, TestSolrCloudWithSecureImpersonation, ZkSolrClientTest, BasicAuthIntegrationTest, StatelessScriptUpdateProcessorFactoryTest, SimplePostToolTest, TestCustomStream, TestSystemCollAutoCreate, HdfsBasicDistributedZk2Test]
[junit4] Completed [588/905 (2!)] on J1 in 413.87s, 1 test, 1 error <<< FAILURES!
[...truncated 53701 lines...]