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/11/07 19:18:51 UTC
[JENKINS] Lucene » Lucene-Solr-Check-master - Build # 728 - Still Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Check-master/728/
2 tests failed.
FAILED: org.apache.solr.TestRandomDVFaceting.testRandomFaceting
Error Message:
java.lang.AssertionError: mismatch: 'j'!='o' @ facet_counts/facet_fields/small4_ss/[4]
Stack Trace:
java.lang.AssertionError: mismatch: 'j'!='o' @ facet_counts/facet_fields/small4_ss/[4]
at __randomizedtesting.SeedInfo.seed([DA4D0F21DAAD8AF0:D7252FF48F54424F]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:292)
at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:175)
at org.apache.solr.TestRandomDVFaceting.testRandomFaceting(TestRandomDVFaceting.java:158)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.cluster.events.ClusterEventProducerTest.testEvents
Error Message:
java.lang.AssertionError: Timed out waiting for expected event NODES_DOWN
Stack Trace:
java.lang.AssertionError: Timed out waiting for expected event NODES_DOWN
at __randomizedtesting.SeedInfo.seed([DA4D0F21DAAD8AF0:192A869FFEF528A0]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.apache.solr.cluster.events.AllEventsListener.waitForExpectedEvent(AllEventsListener.java:54)
at org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents(ClusterEventProducerTest.java:125)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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)
Build Log:
[...truncated 3881 lines...]
2> 1592319 ERROR (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.TestRandomDVFaceting ERROR: mismatch facet response: mismatch: 'j'!='o' @ facet_counts/facet_fields/small4_ss/[4]
2> expected ={
2> "response":{"numFound":13,"start":0,"numFoundExact":true,"docs":[]
2> },
2> "facet_counts":{
2> "facet_queries":{},
2> "facet_fields":{
2> "small4_ss":[
2> "e",1,
2> "g",1,
2> "j",0,
2> "m",1,
2> "s",0]},
2> "facet_ranges":{},
2> "facet_intervals":{},
2> "facet_heatmaps":{}}}
2>
2> response = {
2> "response":{"numFound":13,"start":0,"numFoundExact":true,"docs":[]
2> },
2> "facet_counts":{
2> "facet_queries":{},
2> "facet_fields":{
2> "small4_ss":[
2> "e",1,
2> "g",1,
2> "o",0,
2> "p",1,
2> "s",0]},
2> "facet_ranges":{},
2> "facet_intervals":{},
2> "facet_heatmaps":{}}}
2>
2> request = facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.sort=index&facet.field=small4_ss&facet.method=uif
2> 1592320 INFO (TEST-TestRandomDVFaceting.testRandomFaceting-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRandomFaceting
> java.lang.AssertionError: mismatch: 'j'!='o' @ facet_counts/facet_fields/small4_ss/[4]
> at __randomizedtesting.SeedInfo.seed([DA4D0F21DAAD8AF0:D7252FF48F54424F]:0)
> at org.junit.Assert.fail(Assert.java:89)
> at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:292)
> at org.apache.solr.TestRandomDVFaceting.doFacetTests(TestRandomDVFaceting.java:175)
> at org.apache.solr.TestRandomDVFaceting.testRandomFaceting(TestRandomDVFaceting.java:158)
> 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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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)
2> NOTE: reproduce with: gradlew test --tests TestRandomDVFaceting.testRandomFaceting -Dtests.seed=DA4D0F21DAAD8AF0 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=kl-GL -Dtests.timezone=Europe/Kaliningrad -Dtests.asserts=true -Dtests.file.encoding=UTF-8
2> 1592322 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
2> 1592322 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=539165136
2> 1592324 INFO (coreCloseExecutor-15693-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@28857b33
2> 1592324 INFO (coreCloseExecutor-15693-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@28857b33
2> 1592324 INFO (coreCloseExecutor-15693-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5bc47b7d: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@132c4f
2> 1592343 INFO (coreCloseExecutor-15693-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 1592357 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
2> 1592357 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5e623dec: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@5b0bf14d
2> 1592367 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
2> 1592367 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3c24c0ef: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@2299fa1f
2> 1592369 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
2> 1592369 INFO (SUITE-TestRandomDVFaceting-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@67f3997e: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@3cc7bd78
2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.TestRandomDVFaceting_DA4D0F21DAAD8AF0-001
2> NOTE: test params are: codec=Asserting(Lucene90): {small3_ss=Lucene84, foo_ds_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), foo_f_dv=PostingsFormat(name=MockRandom), small_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small3_is=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small_s=Lucene84, score_f=Lucene84, score_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), foo_i=PostingsFormat(name=MockRandom), foo_fs_dv=Lucene84, foo_l=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small4_ss=PostingsFormat(name=Asserting), small2_s=Lucene84, small2_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), foo_ls_dv=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), small2_is=PostingsFormat(name=Asserting), foo_ds=PostingsFormat(name=MockRandom), foo_fs=PostingsFormat(name=Asserting), foo_d_dv=PostingsFormat(name=Asserting), score_f_dv=PostingsFormat(name=MockRandom), foo_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), score_d_dv=PostingsFormat(name=Asserting), small2_ss=PostingsFormat(name=MockRandom), foo_f=Lucene84, foo_l_dv=PostingsFormat(name=Asserting), foo_ls=PostingsFormat(name=MockRandom)}, docValues:{small2_s_dv=DocValuesFormat(name=Asserting), score_f_p=DocValuesFormat(name=Asserting), id_dv=DocValuesFormat(name=Asserting), score_d_p=DocValuesFormat(name=Asserting), small2_is_p=DocValuesFormat(name=Lucene80), small3_is_dv=DocValuesFormat(name=Asserting), foo_ds_dv=DocValuesFormat(name=Lucene80), foo_f_dv=DocValuesFormat(name=Asserting), foo_ds_p=DocValuesFormat(name=Lucene80), foo_l_p=DocValuesFormat(name=Asserting), foo_i_p=DocValuesFormat(name=Lucene80), small2_i_dv=DocValuesFormat(name=Asserting), small4_ss_dv=DocValuesFormat(name=Lucene80), small_s_dv=DocValuesFormat(name=Asserting), foo_i_dv=DocValuesFormat(name=Lucene80), small2_ss_dv=DocValuesFormat(name=Lucene80), foo_fs_dv=DocValuesFormat(name=Lucene80), small2_is_dv=DocValuesFormat(name=Lucene80), small_i_p=DocValuesFormat(name=Asserting), small2_i_p=DocValuesFormat(name=Asserting), small_i_dv=DocValuesFormat(name=Asserting), small3_is_p=DocValuesFormat(name=Asserting), foo_ls_dv=DocValuesFormat(name=Lucene80), foo_f_p=DocValuesFormat(name=Asserting), foo_ls_p=DocValuesFormat(name=Lucene80), foo_d_p=DocValuesFormat(name=Asserting), foo_fs_p=DocValuesFormat(name=Lucene80), score_f_dv=DocValuesFormat(name=Asserting), foo_d_dv=DocValuesFormat(name=Asserting), score_d_dv=DocValuesFormat(name=Asserting), foo_l_dv=DocValuesFormat(name=Asserting), small3_ss_dv=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1980, maxMBSortInHeap=6.33214082934574, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=kl-GL, timezone=Europe/Kaliningrad
2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 11.0.6 (64-bit)/cpus=4,threads=1,free=125960576,total=536870912
2> NOTE: All tests run in this JVM: [AnalysisAfterCoreReloadTest, TestSlowCompositeReaderWrapper, TestGroupingSearch, MetricsDisabledCloudTest, SolrMetricsIntegrationTest, SolrSlf4jReporterTest, MetricsConfigTest, TestJettySolrRunner, TestReplicationHandlerBackup, TestExpandComponent, PhrasesIdentificationComponentTest, CloudReplicaSourceTest, TermsComponentTest, DistributedQueryComponentOptimizationTest, DistributedFacetPivotSmallTest, SuggestComponentTest, SearchHandlerTest, DistributedQueryElevationComponentTest, SuggestComponentContextFilterQueryTest, PropertiesRequestHandlerTest, TestConfigsApi, MBeansHandlerTest, SplitHandlerTest, ZookeeperStatusHandlerTest, CoreMergeIndexesAdminHandlerTest, TestBlobHandler, TestReqParamsAPI, RandomizedTaggerTest, TestReplicationHandlerDiskOverFlow, JsonLoaderTest, XmlUpdateRequestHandlerTest, V2StandaloneTest, TestStressThreadBackup, PingRequestHandlerTest, HighlighterTest, HighlighterConfigTest, BaseTestRuleBasedAuthorizationPlugin, CertAuthPluginTest, TestZkAclsWithHadoopAuth, PKIAuthenticationIntegrationTest, TestAuthorizationFramework, ConvertedLegacyTest, TestHighFrequencyDictionaryFactory, TestFuzzyAnalyzedSuggestions, TestAnalyzeInfixSuggestions, SpellCheckCollatorWithCollapseTest, FileBasedSpellCheckerTest, WordBreakSolrSpellCheckerTest, TestNumericRangeQuery64, TestNumericRangeQuery32, TestNumericTerms64, TestNumericTerms32, TestFieldCacheSortRandom, SmileWriterTest, TestRawResponseWriter, TestSubQueryTransformer, TestJavabinTupleStreamParser, TestCustomDocTransformer, TestDocumentBuilder, ProtectedTermFilterFactoryTest, TestCharFilters, OverseerSolrResponseUnsafeSerializationTest, TestConfigSetsAPI, SolrCloudExampleTest, TestCloudRecovery, TestConfigSetsAPIExclusivity, TestPullReplica, TestTolerantUpdateProcessorCloud, ChaosMonkeyNothingIsSafeTest, TestSegmentSorting, RouteFieldTest, DeleteNodeTest, ForceLeaderTest, TestLocalStatsCacheCloud, TestTlogReplica, ShardRoutingTest, ZkNodePropsTest, HdfsUnloadDistributedZkTest, HdfsBasicDistributedZkTest, HdfsThreadLeakTest, HdfsSyncSliceTest, OverseerCollectionConfigSetProcessorTest, TestLeaderElectionWithEmptyReplica, TestCloudSearcherWarming, NestedShardedAtomicUpdateTest, CleanupOldIndexTest, TestLeaderElectionZkExpiry, ForceLeaderWithTlogReplicasTest, DistributedQueueTest, ClusterStateMockUtilTest, TestAuthenticationFramework, LeaderVoteWaitTimeoutTest, DocValuesNotIndexedTest, BasicDistributedZkTest, LeaderFailureAfterFreshStartTest, TestRebalanceLeaders, SystemCollectionCompatTest, OverseerSolrResponseTest, ClusterStateTest, TestLocalFSCloudBackupRestore, CollectionsAPIDistributedZkTest, ConcurrentDeleteAndCreateCollectionTest, SimpleCollectionCreateDeleteTest, TestHdfsCloudBackupRestore, ZkStateWriterTest, MultiSolrCloudTestCaseTest, LeaderTragicEventTest, ActionThrottleTest, TestCloudInspectUtil, DeleteReplicaTest, URLClassifyProcessorTest, TestPartialUpdateDeduplication, AtomicUpdatesTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, ClassificationUpdateProcessorIntegrationTest, AtomicUpdateProcessorFactoryTest, UUIDUpdateProcessorFallbackTest, DocExpirationUpdateProcessorFactoryTest, DefaultValueUpdateProcessorTest, TestExceedMaxTermLength, RootFieldTest, TestInPlaceUpdatesDistrib, TestUpdate, PeerSyncWithLeaderAndIndexFingerprintCachingTest, AnalysisErrorHandlingTest, SolrIndexMetricsTest, TestLogWatcher, TestPointFields, DateRangeFieldTest, ChangedSchemaMergeTest, TestCloudSchemaless, PreAnalyzedFieldManagedSchemaCloudTest, TestSchemalessBufferedUpdates, PolyFieldTest, TestCollationFieldDocValues, TestCloudManagedSchema, OpenExchangeRatesOrgProviderTest, IndexSchemaRuntimeFieldTest, IndexSchemaTest, TestSurroundQueryParser, TestMinHashQParser, TestSolr4Spatial2, TestScoreJoinQPNoScore, BJQFilterAccessibleTest, AnalyticsMergeStrategyTest, TestDistribIDF, TestSearcherReuse, TestRecovery, TestCloudJSONFacetSKGEquiv, DistributedFacetSimpleRefinementLongTailTest, TestJsonRangeFacets, TestJsonRequest, TestXmlQParserPlugin, TestStressVersions, TestQueryUtils, ReturnFieldsTest, TestSolrFieldCacheBean, TestSolrQueryParser,
2> TestMinMaxOnMultiValuedField, TestReload, TestMaxScoreQueryParser, QueryEqualityTest, TestOverriddenPrefixQueryForCustomFieldType, TestIBSimilarityFactory, TestBooleanSimilarityFactory, TestNonDefinedSimilarityFactory, TestRangeQuery, SortSpecParsingTest, LargeFieldTest, TestDocSet, TestRandomFaceting, TestFieldResource, TestSchemaSimilarityResource, TestUniqueKeyFieldResource, TestFieldTypeCollectionResource, TestRestManager, MinimalSchemaTest, TestRandomDVFaceting]
WARNING: Test org.apache.solr.update.TestInPlaceUpdatesStandalone wrote 26,061,985 bytes of output.
WARNING: Test org.apache.solr.TestDistributedSearch wrote 27,813,417 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetSKG wrote 13,809,295 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetJoinDomain wrote 16,482,681 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestJsonFacets wrote 29,797,634 bytes of output.
org.apache.solr.cluster.events.ClusterEventProducerTest > testEvents FAILED
java.lang.AssertionError: Timed out waiting for expected event NODES_DOWN
at __randomizedtesting.SeedInfo.seed([DA4D0F21DAAD8AF0:192A869FFEF528A0]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.apache.solr.cluster.events.AllEventsListener.waitForExpectedEvent(AllEventsListener.java:54)
at org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents(ClusterEventProducerTest.java:125)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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)
org.apache.solr.cluster.events.ClusterEventProducerTest > test suite's output saved to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cluster.events.ClusterEventProducerTest.txt, copied below:
2> 2018482 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/server/solr/configsets/_default/conf'
2> 2018483 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/data-dir-171-001
2> 2018484 WARN (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
2> 2018484 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
2> 2018484 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) 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)
2> 2018484 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
2> 2018485 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/tempDir-001
2> 2018485 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
2> 2018485 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
2> 2018485 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
2> 2018486 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
2> 2018585 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port: 46399
2> 2018585 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46399
2> 2018585 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46399
2> 2018585 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46399
2> 2018587 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018592 INFO (zkConnectionManagerCallback-18340-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018592 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018601 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018604 INFO (zkConnectionManagerCallback-18342-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018604 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018607 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018608 INFO (zkConnectionManagerCallback-18344-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018608 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018711 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 2018711 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 2018711 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 2018711 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.Server jetty-9.4.32.v20200930; built: 2020-09-30T16:16:37.804Z; git: de97d26f7bd222a0e16831e353d702a7a422f711; jvm 11.0.6+8-LTS
2> 2018711 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 2018711 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 2018711 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 2018711 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.Server jetty-9.4.32.v20200930; built: 2020-09-30T16:16:37.804Z; git: de97d26f7bd222a0e16831e353d702a7a422f711; jvm 11.0.6+8-LTS
2> 2018711 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.Server jetty-9.4.32.v20200930; built: 2020-09-30T16:16:37.804Z; git: de97d26f7bd222a0e16831e353d702a7a422f711; jvm 11.0.6+8-LTS
2> 2018716 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 2018716 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
2> 2018716 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
2> 2018719 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@651b9339{/solr,null,AVAILABLE}
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7852d106{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:43197}
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.e.j.s.Server Started @2018765ms
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=43197}
2> 2018720 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 2018720 ERROR (jetty-launcher-18345-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 2018720 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 2018720 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr
2> 2018720 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-07T19:03:17.194720Z
2> 2018720 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@778f6c26{/solr,null,AVAILABLE}
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@441adbbe{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46709}
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.e.j.s.Server Started @2018766ms
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46709}
2> 2018721 ERROR (jetty-launcher-18345-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr
2> 2018721 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-07T19:03:17.195379Z
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@12359fa8{/solr,null,AVAILABLE}
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@245552fe{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46583}
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.e.j.s.Server Started @2018767ms
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46583}
2> 2018722 ERROR (jetty-launcher-18345-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr
2> 2018722 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-07T19:03:17.196823Z
2> 2018723 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018724 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018724 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018725 INFO (zkConnectionManagerCallback-18349-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018725 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018725 INFO (zkConnectionManagerCallback-18347-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018725 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018725 INFO (zkConnectionManagerCallback-18351-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018725 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018726 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
2> 2018728 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
2> 2018730 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
2> 2018730 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
2> 2018734 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
2> 2018734 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
2> 2018735 WARN (jetty-launcher-18345-thread-2-SendThread(127.0.0.1:46399)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1015b0486160005.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1015b0486160005, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1015b0486160005, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
2> 2018832 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
2> 2018833 WARN (jetty-launcher-18345-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@22e24d4a[provider=null,keyStore=null,trustStore=null]
2> 2018833 WARN (jetty-launcher-18345-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@22e24d4a[provider=null,keyStore=null,trustStore=null]
2> 2018836 WARN (jetty-launcher-18345-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3f284d51[provider=null,keyStore=null,trustStore=null]
2> 2018836 WARN (jetty-launcher-18345-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3f284d51[provider=null,keyStore=null,trustStore=null]
2> 2018838 INFO (jetty-launcher-18345-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46399/solr
2> 2018838 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018840 INFO (zkConnectionManagerCallback-18361-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018840 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018909 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46709_solr
2> 2018909 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.c.Overseer Overseer (id=72439144002224134-127.0.0.1:46709_solr-n_0000000000) starting
2> 2018915 INFO (OverseerStateUpdate-72439144002224134-127.0.0.1:46709_solr-n_0000000000) [n:127.0.0.1:46709_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:46709_solr
2> 2018915 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46709_solr
2> 2018916 INFO (OverseerStateUpdate-72439144002224134-127.0.0.1:46709_solr-n_0000000000) [n:127.0.0.1:46709_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 2018917 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
2> 2018917 WARN (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] 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
2> 2018929 INFO (jetty-launcher-18345-thread-3) [n:127.0.0.1:46709_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/tempDir-001/node3
2> 2018930 DEBUG (Core Container Async Task-18354-thread-1-processing-n:127.0.0.1:46709_solr) [n:127.0.0.1:46709_solr ] o.a.s.c.e.i.DelegatingClusterEventProducer -- starting CC-4453ecd6, Delegating 314ad16d, delegate org.apache.solr.cluster.events.NoOpProducer@3f8d3934
2> 2018930 DEBUG (Core Container Async Task-18354-thread-1-processing-n:127.0.0.1:46709_solr) [n:127.0.0.1:46709_solr ] o.a.s.c.e.i.DelegatingClusterEventProducer --- started delegate org.apache.solr.cluster.events.NoOpProducer@3f8d3934
2> 2018932 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
2> 2018933 WARN (jetty-launcher-18345-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@242606cd[provider=null,keyStore=null,trustStore=null]
2> 2018933 WARN (jetty-launcher-18345-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@242606cd[provider=null,keyStore=null,trustStore=null]
2> 2018936 WARN (jetty-launcher-18345-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@72be62f4[provider=null,keyStore=null,trustStore=null]
2> 2018936 WARN (jetty-launcher-18345-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@72be62f4[provider=null,keyStore=null,trustStore=null]
2> 2018937 INFO (jetty-launcher-18345-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46399/solr
2> 2018938 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2018939 INFO (zkConnectionManagerCallback-18379-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2018939 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2018942 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 2018946 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:43197_solr as DOWN
2> 2018946 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
2> 2018947 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43197_solr
2> 2018947 INFO (zkCallback-18360-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
2> 2018948 INFO (zkCallback-18378-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
2> 2018949 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
2> 2018949 WARN (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] 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
2> 2018963 INFO (jetty-launcher-18345-thread-1) [n:127.0.0.1:43197_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/tempDir-001/node1
2> 2019033 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
2> 2019033 WARN (jetty-launcher-18345-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@498f7ec2[provider=null,keyStore=null,trustStore=null]
2> 2019034 WARN (jetty-launcher-18345-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@498f7ec2[provider=null,keyStore=null,trustStore=null]
2> 2019036 WARN (jetty-launcher-18345-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@52b47818[provider=null,keyStore=null,trustStore=null]
2> 2019036 WARN (jetty-launcher-18345-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@52b47818[provider=null,keyStore=null,trustStore=null]
2> 2019038 INFO (jetty-launcher-18345-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46399/solr
2> 2019040 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2019041 INFO (zkConnectionManagerCallback-18395-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2019041 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2019045 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
2> 2019048 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:46583_solr as DOWN
2> 2019049 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
2> 2019049 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46583_solr
2> 2019050 INFO (zkCallback-18360-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
2> 2019050 INFO (zkCallback-18378-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
2> 2019050 INFO (zkCallback-18394-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
2> 2019051 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
2> 2019052 WARN (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] 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
2> 2019065 INFO (jetty-launcher-18345-thread-2) [n:127.0.0.1:46583_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/tempDir-001/node2
2> 2019072 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=3
2> 2019073 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
2> 2019076 INFO (zkConnectionManagerCallback-18406-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
2> 2019076 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 2019077 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
2> 2019078 INFO (SUITE-ClusterEventProducerTest-seed#[DA4D0F21DAAD8AF0]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46399/solr ready
2> 2019095 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEvents
2> 2019096 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
2> 2019114 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=9
2> 2019121 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=668897796
2> 2019121 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:43197_solr
2> 2019122 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.ZkController Publish this node as DOWN...
2> 2019122 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:43197_solr as DOWN
2> 2019124 INFO (zkCallback-18405-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
2> 2019125 INFO (zkCallback-18378-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
2> 2019129 INFO (zkCallback-18360-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
2> 2019129 DEBUG (zkCallback-18378-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-27de9204: org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@3c493387
2> 2019130 DEBUG (zkCallback-18378-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- delegate org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@3c493387 already in state STOPPED
2> 2019130 DEBUG (zkCallback-18394-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-c131a08: org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@23558c04
2> 2019130 DEBUG (zkCallback-18394-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- delegate org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@23558c04 already in state STOPPED
2> 2019130 INFO (zkCallback-18394-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
2> 2019131 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-4453ecd6: org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@5806a44e
2> 2019132 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- delegate org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@5806a44e already in state RUNNING
2> 2019132 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$5@698e85bf to org.apache.solr.cluster.events.AllEventsListener@4027cb23
2> 2019132 INFO (zkCallback-18405-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
2> 2019137 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
2> 2019137 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
2> 2019137 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
2> 2019137 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
2> 2019139 WARN (jetty-launcher-18345-thread-1-SendThread(127.0.0.1:46399)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1015b0486160007.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x1015b0486160007, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1015b0486160007, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
2> 2019241 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7852d106{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
2> 2019241 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@651b9339{/solr,null,STOPPED}
2> 2019241 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.e.j.s.session node0 Stopped scavenging
2> 2019241 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.MiniSolrCloudCluster waitForJettyToStop: 43197
2> 2049245 INFO (qtp714254812-33868) [n:127.0.0.1:46583_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=1
2> 2049249 INFO (qtp1256012949-33867) [n:127.0.0.1:46709_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=1
2> 2049250 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-4453ecd6: org.apache.solr.cluster.events.NoOpProducer@7bd74562
2> 2049250 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- started delegate org.apache.solr.cluster.events.NoOpProducer@7bd74562
2> 2049251 INFO (TEST-ClusterEventProducerTest.testEvents-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testEvents
> java.lang.AssertionError: Timed out waiting for expected event NODES_DOWN
> at __randomizedtesting.SeedInfo.seed([DA4D0F21DAAD8AF0:192A869FFEF528A0]:0)
> at org.junit.Assert.fail(Assert.java:89)
> at org.apache.solr.cluster.events.AllEventsListener.waitForExpectedEvent(AllEventsListener.java:54)
> at org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents(ClusterEventProducerTest.java:125)
> 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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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)
2> NOTE: reproduce with: gradlew test --tests ClusterEventProducerTest.testEvents -Dtests.seed=DA4D0F21DAAD8AF0 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-KI -Dtests.timezone=America/Argentina/Mendoza -Dtests.asserts=true -Dtests.file.encoding=UTF-8
2> 2049254 DEBUG (zkCallback-18394-thread-2) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-c131a08: org.apache.solr.cluster.events.NoOpProducer@61dc7ff4
2> 2049254 DEBUG (zkCallback-18394-thread-2) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- delegate org.apache.solr.cluster.events.NoOpProducer@61dc7ff4 already in state STOPPED
2> 2049266 INFO (TEST-ClusterEventProducerTest.testListenerPlugins-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testListenerPlugins
2> 2049267 INFO (TEST-ClusterEventProducerTest.testListenerPlugins-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
2> 2049272 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-4453ecd6: org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@53a0b7d
2> 2049272 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- delegate org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@53a0b7d already in state RUNNING
2> 2049272 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$5@2fdf9054 to org.apache.solr.cluster.events.AllEventsListener@8f14b64
2> 2049273 INFO (qtp714254812-33870) [n:127.0.0.1:46583_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=3
2> 2049273 DEBUG (zkCallback-18394-thread-2) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --setting new delegate for CC-c131a08: org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@6f1b9dbf
2> 2049273 DEBUG (zkCallback-18394-thread-2) [ ] o.a.s.c.e.i.DelegatingClusterEventProducer --- delegate org.apache.solr.cluster.events.impl.DefaultClusterEventProducer@6f1b9dbf already in state STOPPED
2> 2049279 INFO (qtp714254812-33871) [n:127.0.0.1:46583_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=1
2> 2049280 INFO (qtp714254812-33878) [n:127.0.0.1:46583_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=0
2> 2049281 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerTest$DummyEventListener starting 21fae665
2> 2049281 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$5@585249fa to org.apache.solr.cluster.events.AllEventsListener@8f14b64
2> 2049281 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$5@585249fa to org.apache.solr.cluster.events.ClusterEventProducerTest$DummyEventListener@21fae665
2> 2049282 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerTest$DummyEventListener skipped event, wrong type: CLUSTER_PROPERTIES_CHANGED
2> 2049283 INFO (qtp714254812-33865) [n:127.0.0.1:46583_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&name=testListenerPlugins_collection&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
2> 2049289 INFO (OverseerThreadFactory-18366-thread-1-processing-n:127.0.0.1:46709_solr) [n:127.0.0.1:46709_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testListenerPlugins_collection
2> 2049302 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$4@2857b0d0 to org.apache.solr.cluster.events.AllEventsListener@8f14b64
2> 2049302 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$4@2857b0d0 to org.apache.solr.cluster.events.ClusterEventProducerTest$DummyEventListener@21fae665
2> 2049303 DEBUG (zkCallback-18360-thread-1) [ ] o.a.s.c.e.ClusterEventProducerTest$DummyEventListener recorded event "org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$4@2857b0d0"
2> 2049408 INFO (OverseerStateUpdate-72439144002224134-127.0.0.1:46709_solr-n_0000000000) [n:127.0.0.1:46709_solr ] o.a.s.c.o.SliceMutator createReplica() {
2> "operation":"ADDREPLICA",
2> "collection":"testListenerPlugins_collection",
2> "shard":"shard1",
2> "core":"testListenerPlugins_collection_shard1_replica_n1",
2> "state":"down",
2> "base_url":"http://127.0.0.1:46709/solr",
2> "node_name":"127.0.0.1:46709_solr",
2> "type":"NRT",
2> "waitForFinalState":"false"}
2> 2049611 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=testListenerPlugins_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=testListenerPlugins_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
2> 2049611 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 1000 transient cores
2> 2049619 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
2> 2049626 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
2> 2049628 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
2> 2049628 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'testListenerPlugins_collection_shard1_replica_n1' using configuration from configset conf, trusted=true
2> 2049628 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [[testListenerPlugins_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/tempDir-001/node3/testListenerPlugins_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.cluster.events.ClusterEventProducerTest_DA4D0F21DAAD8AF0-001/tempDir-001/node3/testListenerPlugins_collection_shard1_replica_n1/data/]
2> 2049654 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
2> 2049654 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
2> 2049655 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
2> 2049655 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
2> 2049657 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
2> 2049657 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
2> 2049657 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
2> 2049658 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1682729418759340032
2> 2049659 INFO (searcherExecutor-18417-thread-1-processing-n:127.0.0.1:46709_solr x:testListenerPlugins_collection_shard1_replica_n1 c:testListenerPlugins_collection s:shard1 r:core_node2) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.SolrCore [testListenerPlugins_collection_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
2> 2049663 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testListenerPlugins_collection/terms/shard1 to Terms{values={core_node2=0}, version=0}
2> 2049663 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/testListenerPlugins_collection/leaders/shard1
2> 2049666 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
2> 2049666 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
2> 2049666 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46709/solr/testListenerPlugins_collection_shard1_replica_n1/
2> 2049666 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
2> 2049667 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:46709/solr/testListenerPlugins_collection_shard1_replica_n1/ has no replicas
2> 2049667 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/testListenerPlugins_collection/leaders/shard1/leader after winning as /collections/testListenerPlugins_collection/leader_elect/shard1/election/72439144002224134-core_node2-n_0000000000
2> 2049668 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:46709/solr/testListenerPlugins_collection_shard1_replica_n1/ shard1
2> 2049770 INFO (zkCallback-18360-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049770 INFO (zkCallback-18360-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049770 INFO (zkCallback-18360-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049772 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr c:testListenerPlugins_collection s:shard1 r:core_node2 x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
2> 2049774 INFO (qtp1256012949-33859) [n:127.0.0.1:46709_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=testListenerPlugins_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=testListenerPlugins_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=162
2> 2049776 INFO (qtp714254812-33865) [n:127.0.0.1:46583_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 2049874 INFO (zkCallback-18394-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049874 INFO (zkCallback-18360-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049874 INFO (zkCallback-18360-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049874 INFO (zkCallback-18360-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049874 INFO (zkCallback-18360-thread-4) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049875 INFO (qtp714254812-33865) [n:127.0.0.1:46583_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf&name=testListenerPlugins_collection&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=592
2> 2049875 INFO (TEST-ClusterEventProducerTest.testListenerPlugins-seed#[DA4D0F21DAAD8AF0]) [ ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: testListenerPlugins_collection
2> 2049877 INFO (qtp714254812-33868) [n:127.0.0.1:46583_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=testListenerPlugins_collection&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
2> 2049880 INFO (OverseerCollectionConfigSetProcessor-72439144002224134-127.0.0.1:46709_solr-n_0000000000) [n:127.0.0.1:46709_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
2> 2049881 INFO (OverseerThreadFactory-18366-thread-2-processing-n:127.0.0.1:46709_solr) [n:127.0.0.1:46709_solr ] o.a.s.c.a.c.OverseerCollectionMessageHandler Executing Collection Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true, asyncId=null
2> 2049881 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr x:testListenerPlugins_collection_shard1_replica_n1 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testListenerPlugins_collection.shard1.replica_n1 tag=null
2> 2049882 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.c.SolrCore [testListenerPlugins_collection_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@776d8620
2> 2049882 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.testListenerPlugins_collection.shard1.replica_n1 tag=SolrCore@776d8620
2> 2049882 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.testListenerPlugins_collection.shard1.leader tag=SolrCore@776d8620
2> 2049882 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 2049885 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testListenerPlugins_collection/terms/shard1 to Terms{values={}, version=1}
2> 2049886 INFO (qtp1256012949-33863) [n:127.0.0.1:46709_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&deleteMetricsHistory=true&core=testListenerPlugins_collection_shard1_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=5
2> 2049993 INFO (zkCallback-18360-thread-3) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049993 INFO (zkCallback-18360-thread-5) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049994 INFO (zkCallback-18360-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2049993 INFO (zkCallback-18360-thread-4) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/testListenerPlugins_collection/state.json] for collection [testListenerPlugins_collection] has occurred - updating... (live nodes size: [2])
2> 2050003 INFO (qtp714254812-33868) [n:127.0.0.1:46583_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=testListenerPlugins_collection&action=DELETE&wt=javabin&version=2} status=0 QTime=125
2> 2050005 DEBUG (zkCallback-18360-thread-5) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$3@620afd7f to org.apache.solr.cluster.events.AllEventsListener@8f14b64
2> 2050005 DEBUG (zkCallback-18360-thread-5) [ ] o.a.s.c.e.ClusterEventProducerBase --- firing event org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$3@620afd7f to org.apache.solr.cluster.events.ClusterEventProducerTest$DummyEventListener@21fae665
2> 2050005 DEBUG (zkCallback-18360-thread-5) [ ] o.a.s.c.e.ClusterEventProducerTest$DummyEventListener recorded event "org.apache.solr.cluster.events.impl.DefaultClusterEventProducer$3@620afd7f"
2> 2050010 INFO (qtp1256012949-33867) [n:127.0.0.1:4
[...truncated too long message...]
done in 27.935 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkLocalJavadocLinksSite
Processed 2443 links (1998 relative) to 3514 anchors in 243 files
> Task :solr:solr-ref-guide:prepareSiteSources
Syncing source files to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content using props:
htmlSolrJavadocs -> https://lucene.apache.org/solr/9_0_0/
htmlLuceneJavadocs -> https://lucene.apache.org/core/9_0_0/
htmlOutDir -> ../html-site
javadocLink -> https://docs.oracle.com/en/java/javase/11/docs/api/
solrGuideDraftStatus -> DRAFT
solrRootPath -> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/
solrDocsVersion -> 9.0
solrGuideVersionPath -> 9_0
buildDate -> 2020-11-07
buildYear -> 2020
ivyCommonsCodec -> 1.13
ivyDropwizardMetrics -> 4.1.5
ivyLog4j -> 2.13.2
ivyOpennlpTools -> 1.9.1
ivyTika -> 1.24
ivyZookeeper -> 3.6.2
Building up tree of all known pages
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by org.jruby.util.SecurityHelper (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-core/9.2.6.0/653601d48b38528e76840c6eac1ae46e2dae1a74/jruby-core-9.2.6.0.jar) to field java.lang.reflect.Field.modifiers
WARNING: Please consider reporting this to the maintainers of org.jruby.util.SecurityHelper
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Looping over pages to build nav data
Creating /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content/_data/scrollnav.json
Creating /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content/_data/sidebar.json
> Task :solr:solr-ref-guide:buildSite
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by com.headius.backport9.modules.Modules (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-complete/9.2.9.0/8e44ce7a1417966d89957bd766a148601e28828b/jruby-complete-9.2.9.0.jar) to method sun.nio.ch.NativeThread.signal(long)
WARNING: Please consider reporting this to the maintainers of com.headius.backport9.modules.Modules
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Configuration file: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content/_config.yml
Source: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content
Destination: ../html-site
Incremental build: disabled. Enable with --incremental
Generating...
asciidoctor: WARNING: skipping reference to missing attribute: config_name
asciidoctor: WARNING: skipping reference to missing attribute: file_name
done in 27.078 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkSite
Processed 2443 links (1760 relative) to 3514 anchors in 243 files
> Task :solr:solr-ref-guide:check
> Task :solr:solrj:check
> Task :solr:test-framework:check
> Task :solr:webapp:check
> Task :lucene:analysis:common:check
> Task :lucene:analysis:icu:check
> Task :lucene:analysis:kuromoji:check
> Task :lucene:analysis:morfologik:check
> Task :lucene:analysis:nori:check
> Task :lucene:analysis:opennlp:check
> Task :lucene:analysis:phonetic:check
> Task :lucene:analysis:smartcn:check
> Task :lucene:analysis:stempel:check
> Task :solr:contrib:analysis-extras:check
> Task :solr:contrib:analytics:check
> Task :solr:contrib:clustering:check
> Task :solr:contrib:extraction:check
> Task :solr:contrib:jaegertracer-configurator:check
> Task :solr:contrib:langid:check
> Task :solr:contrib:ltr:check
> Task :solr:contrib:prometheus-exporter:check
> Task :solr:docker:package:check
The slowest tests (exceeding 500 ms) during this run:
153.25s TestStressLiveNodes.testStress (:solr:core)
114.42s TestIntervalFaceting.testRandom (:solr:core)
91.32s TestRandomCollapseQParserPlugin.testRandomCollpaseWithSort (:solr:core)
91.09s TestDistributedSearch.test (:solr:core)
72.39s PeerSyncReplicationTest.test (:solr:core)
71.50s TestLeaderElectionZkExpiry.testLeaderElectionWithZkExpiry (:solr:core)
65.42s TestDistributedStatsComponentCardinality.test (:solr:core)
61.61s ZkControllerTest.testGetHostName (:solr:core)
61.46s ZkControllerTest.testReadConfigName (:solr:core)
60.97s ZkControllerTest.testPublishAndWaitForDownStates (:solr:core)
ERROR: The following test(s) have failed:
- org.apache.solr.TestRandomDVFaceting.testRandomFaceting (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.TestRandomDVFaceting.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.TestRandomDVFaceting.testRandomFaceting" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=DA4D0F21DAAD8AF0 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=US-ASCII
- org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cluster.events.ClusterEventProducerTest.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=DA4D0F21DAAD8AF0 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=US-ASCII
Deprecated Gradle features were used in this build, making it incompatible with Gradle 7.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/6.6.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD SUCCESSFUL in 1h 6m 53s
852 actionable tasks: 852 executed
Build step 'Invoke Gradle script' changed build result to SUCCESS
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2826)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2705)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2686)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3073)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1788)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:998)
at hudson.FilePath.act(FilePath.java:1069)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2684)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:265)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:78)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1905)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:428)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3075)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1071)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2684)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:265)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:78)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1905)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:428)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
[JENKINS] Lucene » Lucene-Solr-Check-master - Build # 730 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Check-master/730/
1 tests failed.
FAILED: org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents
Error Message:
java.lang.AssertionError: Timed out waiting for expected event NODES_DOWN
Stack Trace:
java.lang.AssertionError: Timed out waiting for expected event NODES_DOWN
at __randomizedtesting.SeedInfo.seed([525CEA838E48133A:913B633DAA10B16A]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.apache.solr.cluster.events.AllEventsListener.waitForExpectedEvent(AllEventsListener.java:54)
at org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents(ClusterEventProducerTest.java:125)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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)
Build Log:
[...truncated 2186 lines...]
ERROR: The following test(s) have failed:
- org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cluster.events.ClusterEventProducerTest.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.cluster.events.ClusterEventProducerTest.testEvents" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=525CEA838E48133A -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=US-ASCII
Deprecated Gradle features were used in this build, making it incompatible with Gradle 7.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/6.6.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD SUCCESSFUL in 1h 7m 10s
852 actionable tasks: 852 executed
Build step 'Invoke Gradle script' changed build result to SUCCESS
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2826)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2705)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2686)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3073)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene2
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1788)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:998)
at hudson.FilePath.act(FilePath.java:1069)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2684)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:265)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:78)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1905)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:428)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3075)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1071)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2684)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:265)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:78)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1905)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:428)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
[JENKINS] Lucene » Lucene-Solr-Check-master - Build # 729 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Check-master/729/
1 tests failed.
FAILED: org.apache.solr.TestRandomFaceting.testRandomFaceting
Error Message:
java.lang.AssertionError: mismatch: '1'!='2' @ facet_counts/facet_fields/alternate_key/[2]
Stack Trace:
java.lang.AssertionError: mismatch: '1'!='2' @ facet_counts/facet_fields/alternate_key/[2]
at __randomizedtesting.SeedInfo.seed([98BE4381E6A77B57:95D66354B35EB3E8]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.apache.solr.TestRandomFaceting.validateResponse(TestRandomFaceting.java:323)
at org.apache.solr.TestRandomFaceting.doFacetTests(TestRandomFaceting.java:295)
at org.apache.solr.TestRandomFaceting.doFacetTests(TestRandomFaceting.java:178)
at org.apache.solr.TestRandomFaceting.testRandomFaceting(TestRandomFaceting.java:161)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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)
Build Log:
[...truncated 18401 lines...]
2> 2109820 ERROR (TEST-TestRandomFaceting.testRandomFaceting-seed#[98BE4381E6A77B57]) [ ] o.a.s.TestRandomFaceting ERROR: mismatch facet response: mismatch: '1'!='2' @ facet_counts/facet_fields/alternate_key/[2]
2> expected ={
2> "response":{
2> "numFound":11,
2> "start":0,
2> "numFoundExact":true,
2> "docs":[]},
2> "facet_counts":{
2> "facet_queries":{},
2> "facet_fields":{"alternate_key":[
2> "0",
2> 1,
2> "1",
2> 1,
2> "4",
2> 1]},
2> "facet_ranges":{},
2> "facet_intervals":{},
2> "facet_heatmaps":{}}}
2> response = {
2> "response":{"numFound":11,"start":0,"numFoundExact":true,"docs":[]
2> },
2> "facet_counts":{
2> "facet_queries":{},
2> "facet_fields":{
2> "alternate_key":[
2> "0",1,
2> "2",1,
2> "4",1]},
2> "facet_ranges":{},
2> "facet_intervals":{},
2> "facet_heatmaps":{}}}
2>
2> request = facet=true&wt=json&indent=true&omitHeader=true&q=*:*&rows=0&facet.offset=0&facet.sort=count&facet.field={!key%3Dalternate_key}small2_is&facet.method=enum&facet.exists=true
2> 2109822 INFO (TEST-TestRandomFaceting.testRandomFaceting-seed#[98BE4381E6A77B57]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRandomFaceting
> java.lang.AssertionError: mismatch: '1'!='2' @ facet_counts/facet_fields/alternate_key/[2]
> at __randomizedtesting.SeedInfo.seed([98BE4381E6A77B57:95D66354B35EB3E8]:0)
> at org.junit.Assert.fail(Assert.java:89)
> at org.apache.solr.TestRandomFaceting.validateResponse(TestRandomFaceting.java:323)
> at org.apache.solr.TestRandomFaceting.doFacetTests(TestRandomFaceting.java:295)
> at org.apache.solr.TestRandomFaceting.doFacetTests(TestRandomFaceting.java:178)
> at org.apache.solr.TestRandomFaceting.testRandomFaceting(TestRandomFaceting.java:161)
> 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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
> at org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
> 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)
2> NOTE: reproduce with: gradlew test --tests TestRandomFaceting.testRandomFaceting -Dtests.seed=98BE4381E6A77B57 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-CX -Dtests.timezone=Asia/Yerevan -Dtests.asserts=true -Dtests.file.encoding=UTF-8
2> 2109824 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
2> 2109824 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1149333074
2> 2109824 INFO (coreCloseExecutor-22387-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3304abf3
2> 2109824 INFO (coreCloseExecutor-22387-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@3304abf3
2> 2109824 INFO (coreCloseExecutor-22387-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@45e624c0: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@40722533
2> 2109843 INFO (coreCloseExecutor-22387-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 2109844 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
2> 2109844 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5bf5c039: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@3766f06
2> 2109852 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
2> 2109852 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@78c1d074: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@1bab0ea2
2> 2109854 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
2> 2109854 INFO (SUITE-TestRandomFaceting-seed#[98BE4381E6A77B57]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f1eb20f: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@55f74c1e
2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/tmp/tests-tmp/solr.TestRandomFaceting_98BE4381E6A77B57-001
2> NOTE: test params are: codec=Asserting(Lucene90): {foo_i=Lucene84, small3_ss=PostingsFormat(name=Asserting), bool_b=PostingsFormat(name=LuceneFixedGap), small_i=PostingsFormat(name=LuceneFixedGap), long_s1=PostingsFormat(name=LuceneFixedGap), small2_i=PostingsFormat(name=LuceneFixedGap), small3_is=PostingsFormat(name=LuceneFixedGap), small_s1=Lucene84, foo_ti=Lucene84, small2_is=Lucene84, small_tf=Lucene84, score_f=PostingsFormat(name=LuceneFixedGap), small_f=Lucene84, str_s1=PostingsFormat(name=MockRandom), rare_s1=PostingsFormat(name=Asserting), small_d=PostingsFormat(name=MockRandom), id=PostingsFormat(name=Asserting), small2_ss=PostingsFormat(name=MockRandom), small2_s1=Lucene84}, docValues:{foo_ti=DocValuesFormat(name=Asserting), small2_is=DocValuesFormat(name=Asserting), foo_i=DocValuesFormat(name=Asserting), small_tf=DocValuesFormat(name=Asserting), score_f=DocValuesFormat(name=Lucene80), small_i=DocValuesFormat(name=Lucene80), small_f=DocValuesFormat(name=Asserting), small_d=DocValuesFormat(name=Asserting), small2_i=DocValuesFormat(name=Lucene80), small3_is=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=219, maxMBSortInHeap=5.775598893512333, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=en-CX, timezone=Asia/Yerevan
2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 11.0.6 (64-bit)/cpus=4,threads=1,free=95596744,total=536870912
2> NOTE: All tests run in this JVM: [TestGraphTermsQParserPlugin, TestDocSet, TestAddFieldRealTimeGet, QueryParsingTest, TestSurroundQueryParser, TestValueSourceCache, TestSimpleQParserPlugin, TestCloudJSONFacetSKG, SpatialHeatmapFacetsTest, TestJsonFacets, TestSweetSpotSimilarityFactory, TestBooleanSimilarityFactory, TestNonDefinedSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestQueryUtils, RankQueryTest, TestExtendedDismaxParser, TestSort, TestMinHashQParser, LargeFieldTest, MaxScoreCollectorTest, SpatialFilterTest, TestIndexSearcher, TestScoreJoinQPNoScore, TestScoreJoinQPScore, TestOrdValues, MergeStrategyTest, TestStressVersions, TestExactSharedStatsCache, ReturnFieldsTest, TestRealTimeGet, SolrTestCaseJ4Test, MinimalSchemaTest, EchoParamsTest, TestLegacyFieldCache, TestFieldCacheSort, TestFieldCache, ExplicitHLLTest, HLLUtilTest, DistanceUnitsTest, TestUtils, TestMaxTokenLenTokenizer, TestRTimerTree, TestFastOutputStream, TestSolrCLIRunExample, OrderedExecutorTest, DateMathParserTest, BasicFunctionalityTest, TestEmbeddedSolrServerAdminHandler, ConnectionReuseTest, TestPushWriter, TestExplainDocTransformer, TestChildDocTransformerHierarchy, TestCSVResponseWriter, TestSolrQueryResponse, SpellCheckCollatorWithCollapseTest, TestFileDictionaryLookup, TestAnalyzedSuggestions, SuggesterFSTTest, SpellingQueryConverterTest, CollectionsRepairEventListenerTest, TestCoreDiscovery, TestCodecSupport, DirectoryFactoriesTest, TestXIncludeConfig, TestJmxIntegration, TestConfig, CoreSorterTest, HdfsDirectoryFactoryTest, AlternateDirectoryTest, TestCustomStream, TestSolrIndexConfig, PluginInfoTest, CachingDirectoryFactoryTest, SolrInfoBeanTest, TokenizerChainTest, ProtectedTermFilterFactoryTest, JWTAuthPluginTest, TestAuthorizationFramework, TestRuleBasedAuthorizationWithKerberos, BasicAuthIntegrationTest, TestExternalRoleRuleBasedAuthorizationPlugin, JWTVerificationkeyResolverTest, SolrCoreMetricManagerTest, SolrMetricManagerTest, SolrGraphiteReporterTest, SolrMetricReporterTest, HighlighterConfigTest, TestPostingsSolrHighlighter, ClusterStateUpdateTest, TestDistribDocBasedVersion, TestRebalanceLeaders, TestTolerantUpdateProcessorRandomCloud, AliasIntegrationTest, OverseerTest, DistribDocExpirationUpdateProcessorTest, TestMiniSolrCloudClusterSSL, ZkFailoverTest, ClusterStateTest, TestStressCloudBlindAtomicUpdates, TestPrepRecovery, TestLocalStatsCacheCloud, LeaderTragicEventTest, DeleteShardTest, TestDeleteCollectionOnDownNodes, DistribCursorPagingTest, TestCloudConsistency, TestLazySolrCluster, UnloadDistributedZkTest, MissingSegmentRecoveryTest, SharedFSAutoReplicaFailoverTest, TestTlogReplica, DeleteStatusTest, OverseerRolesTest, TestExactSharedStatsCacheCloud, LeaderElectionContextKeyTest, TestStressInPlaceUpdates, HdfsRecoveryZkTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsWriteToMultipleCollectionsTest, HdfsRestartWhileUpdatingTest, ConcurrentCreateRoutedAliasTest, ZkStateReaderTest, TestSizeLimitedDistributedMap, LeaderFailureAfterFreshStartTest, ActionThrottleTest, HttpPartitionOnCommitTest, DeleteInactiveReplicaTest, MultiSolrCloudTestCaseTest, ShardSplitTest, CustomCollectionTest, AsyncCallRequestStatusResponseTest, SimpleCollectionCreateDeleteTest, TestPullReplica, TestDownShardTolerantSearch, TestExactStatsCacheCloud, TestSSLRandomization, TestShortCircuitedRequests, TestLuceneIndexBackCompat, NotRequiredUniqueKeyTest, SchemaVersionSpecificBehaviorTest, TestCloudManagedSchema, DocValuesTest, TestUseDocValuesAsStored, DocValuesMultiTest, TestTextField, TestSchemalessBufferedUpdates, PreAnalyzedFieldTest, PolyFieldTest, PreAnalyzedFieldManagedSchemaCloudTest, BooleanFieldTest, NumericFieldsTest, ResponseHeaderTest, HttpSolrCallGetCoreTest, DataDrivenBlockJoinTest, AnalysisErrorHandlingTest, AddBlockUpdateTest, UpdateParamsTest, TestHdfsUpdateLog, SolrIndexSplitterTest, MaxSizeAutoCommitTest, AddSchemaFieldsUpdateProcessorFactoryTest, ClassificationUpdateProcessorTest, UUIDUpdateProcessorFallbackTest, StatelessScriptUpdateProcessorFactoryTest, TimeRoutedAliasUpdateProcessorTest, CloneFieldUpdateProcessorFactoryTest,
2> URLClassifyProcessorTest, TestDocBasedVersionConstraints, PeerSyncWithLeaderTest, SolrIndexMetricsTest, TestConfigReload, TestBlobHandler, BackupRestoreUtils, XmlUpdateRequestHandlerTest, RequestLoggingTest, DebugComponentTest, ResponseBuilderTest, TestTrackingShardHandlerFactory, SuggestComponentContextFilterQueryTest, TestDistributedStatsComponentCardinality, DistributedQueryComponentOptimizationTest, TestHttpShardHandlerFactory, BadComponentTest, DistributedFacetPivotSmallTest, CustomHighlightComponentTest, TestConfigsApi, CoreAdminHandlerTest, PropertiesRequestHandlerTest, AdminHandlersProxyTest, SplitHandlerTest, MetricsHistoryHandlerTest, TestApiFramework, DaemonStreamApiTest, XmlInterpolationTest, TaggerTest, TestSolrConfigHandlerCloud, FieldAnalysisRequestHandlerTest, TestLegacyFieldReuse, TestNumericRangeQuery32, TestFieldCollectionResource, TestBulkSchemaAPI, TestManagedSynonymGraphFilterFactory, TestSchemaResource, TestSchemaSimilarityResource, TestRandomFaceting]
:solr:core:test (FAILURE): 4587 test(s), 1 failure(s), 212 skipped
4587 tests completed, 1 failed, 212 skipped
There were failing tests. See the results at: file:///home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/test-results/test/
> Task :solr:core:cleanTaskTmp
> Task :solr:server:test NO-SOURCE
> Task :solr:server:cleanTaskTmp
> Task :solr:solr-ref-guide:test NO-SOURCE
> Task :solr:solr-ref-guide:cleanTaskTmp
> Task :solr:solrj:test
:solr:solrj:test (SUCCESS): 1667 test(s), 20 skipped
> Task :solr:solrj:cleanTaskTmp
> Task :solr:test-framework:test
:solr:test-framework:test (SUCCESS): 9 test(s)
> Task :solr:test-framework:cleanTaskTmp
> Task :solr:webapp:test NO-SOURCE
> Task :solr:webapp:cleanTaskTmp
> Task :lucene:analysis:common:test
:lucene:analysis:common:test (SUCCESS): 1628 test(s), 9 skipped
> Task :lucene:analysis:common:cleanTaskTmp
> Task :lucene:analysis:icu:test
:lucene:analysis:icu:test (SUCCESS): 149 test(s), 11 skipped
> Task :lucene:analysis:icu:cleanTaskTmp
> Task :lucene:analysis:kuromoji:test
:lucene:analysis:kuromoji:test (SUCCESS): 160 test(s), 7 skipped
> Task :lucene:analysis:kuromoji:cleanTaskTmp
> Task :lucene:analysis:morfologik:test
:lucene:analysis:morfologik:test (SUCCESS): 18 test(s)
> Task :lucene:analysis:morfologik:cleanTaskTmp
> Task :lucene:analysis:nori:test
:lucene:analysis:nori:test (SUCCESS): 69 test(s), 4 skipped
> Task :lucene:analysis:nori:cleanTaskTmp
> Task :lucene:analysis:opennlp:test
:lucene:analysis:opennlp:test (SUCCESS): 26 test(s)
> Task :lucene:analysis:opennlp:cleanTaskTmp
> Task :lucene:analysis:phonetic:test
:lucene:analysis:phonetic:test (SUCCESS): 41 test(s)
> Task :lucene:analysis:phonetic:cleanTaskTmp
> Task :lucene:analysis:smartcn:test
:lucene:analysis:smartcn:test (SUCCESS): 21 test(s)
> Task :lucene:analysis:smartcn:cleanTaskTmp
> Task :lucene:analysis:stempel:test
:lucene:analysis:stempel:test (SUCCESS): 15 test(s)
> Task :lucene:analysis:stempel:cleanTaskTmp
> Task :solr:contrib:analysis-extras:test
:solr:contrib:analysis-extras:test (SUCCESS): 30 test(s)
> Task :solr:contrib:analysis-extras:cleanTaskTmp
> Task :solr:contrib:analytics:test
:solr:contrib:analytics:test (SUCCESS): 472 test(s)
> Task :solr:contrib:analytics:cleanTaskTmp
> Task :solr:contrib:clustering:test
:solr:contrib:clustering:test (SUCCESS): 15 test(s)
> Task :solr:contrib:clustering:cleanTaskTmp
> Task :solr:contrib:extraction:test
:solr:contrib:extraction:test (SUCCESS): 20 test(s)
> Task :solr:contrib:extraction:cleanTaskTmp
> Task :solr:contrib:jaegertracer-configurator:test
:solr:contrib:jaegertracer-configurator:test (SUCCESS): 3 test(s)
> Task :solr:contrib:jaegertracer-configurator:cleanTaskTmp
> Task :solr:contrib:langid:test
:solr:contrib:langid:test (SUCCESS): 43 test(s)
> Task :solr:contrib:langid:cleanTaskTmp
> Task :solr:contrib:ltr:test
:solr:contrib:ltr:test (SUCCESS): 127 test(s), 1 skipped
> Task :solr:contrib:ltr:cleanTaskTmp
> Task :solr:contrib:prometheus-exporter:test
:solr:contrib:prometheus-exporter:test (SUCCESS): 17 test(s), 5 skipped
> Task :solr:contrib:prometheus-exporter:cleanTaskTmp
> Task :cleanGradleTmp
> Task :lucene:backward-codecs:check
> Task :lucene:benchmark:check
> Task :lucene:classification:check
> Task :lucene:codecs:check
> Task :lucene:core:check
> Task :lucene:demo:check
> Task :lucene:core:renderSiteJavadoc
> Task :lucene:backward-codecs:renderSiteJavadoc
> Task :lucene:facet:renderSiteJavadoc
> Task :lucene:memory:renderSiteJavadoc
> Task :lucene:queries:renderSiteJavadoc
> Task :lucene:highlighter:renderSiteJavadoc
> Task :lucene:sandbox:renderSiteJavadoc
> Task :lucene:queryparser:renderSiteJavadoc
> Task :lucene:spatial3d:renderSiteJavadoc
> Task :lucene:spatial-extras:renderSiteJavadoc
> Task :lucene:analysis:common:renderSiteJavadoc
> Task :lucene:benchmark:renderSiteJavadoc
> Task :lucene:grouping:renderSiteJavadoc
> Task :lucene:classification:renderSiteJavadoc
> Task :lucene:codecs:renderSiteJavadoc
> Task :lucene:expressions:renderSiteJavadoc
> Task :lucene:demo:renderSiteJavadoc
> Task :lucene:documentation:changesToHtml
> Task :lucene:documentation:copyDocumentationAssets
> Task :lucene:documentation:markdownToHtml
> Task :lucene:documentation:createDocumentationIndex
> Task :lucene:join:renderSiteJavadoc
> Task :lucene:misc:renderSiteJavadoc
> Task :lucene:suggest:renderSiteJavadoc
> Task :lucene:analysis:icu:renderSiteJavadoc
> Task :lucene:analysis:kuromoji:renderSiteJavadoc
> Task :lucene:analysis:morfologik:renderSiteJavadoc
> Task :lucene:analysis:nori:renderSiteJavadoc
> Task :lucene:analysis:opennlp:renderSiteJavadoc
> Task :lucene:analysis:phonetic:renderSiteJavadoc
> Task :lucene:analysis:smartcn:renderSiteJavadoc
> Task :lucene:analysis:stempel:renderSiteJavadoc
> Task :lucene:luke:renderSiteJavadoc
> Task :lucene:monitor:renderSiteJavadoc
> Task :lucene:replicator:renderSiteJavadoc
> Task :lucene:test-framework:renderSiteJavadoc
> Task :lucene:documentation:documentation
> Task :lucene:documentation:checkBrokenLinks
> Task :lucene:documentation:check
> Task :lucene:expressions:check
> Task :lucene:facet:check
> Task :lucene:grouping:check
> Task :lucene:highlighter:check
> Task :lucene:join:check
> Task :lucene:luke:check
> Task :lucene:memory:check
> Task :lucene:misc:check
> Task :lucene:monitor:check
> Task :lucene:packaging:check
> Task :lucene:queries:check
> Task :lucene:queryparser:check
> Task :lucene:replicator:check
> Task :lucene:sandbox:check
> Task :lucene:spatial-extras:check
> Task :lucene:spatial3d:check
> Task :lucene:suggest:check
> Task :lucene:test-framework:check
> Task :solr:contrib:check
> Task :solr:core:check
> Task :solr:docker:check
> Task :solr:server:renderSiteJavadoc SKIPPED
> Task :solr:solrj:renderSiteJavadoc
> Task :solr:core:renderSiteJavadoc
> Task :solr:documentation:changesToHtml
> Task :solr:documentation:copyDocumentationAssets
> Task :solr:documentation:markdownToHtml
> Task :solr:documentation:createDocumentationIndex
> Task :solr:solr-ref-guide:renderSiteJavadoc SKIPPED
> Task :solr:test-framework:renderSiteJavadoc
> Task :solr:webapp:renderSiteJavadoc SKIPPED
> Task :solr:contrib:analysis-extras:renderSiteJavadoc
> Task :solr:contrib:analytics:renderSiteJavadoc
> Task :solr:contrib:clustering:renderSiteJavadoc
> Task :solr:contrib:extraction:renderSiteJavadoc
> Task :solr:contrib:jaegertracer-configurator:renderSiteJavadoc
> Task :solr:contrib:langid:renderSiteJavadoc
> Task :solr:contrib:ltr:renderSiteJavadoc
> Task :solr:contrib:prometheus-exporter:renderSiteJavadoc
> Task :solr:documentation:documentation
> Task :solr:documentation:checkBrokenLinks
> Task :solr:documentation:check
> Task :solr:example:check
> Task :solr:packaging:check
> Task :solr:server:check
> Task :lucene:documentation:assemble
> Task :solr:documentation:copyChangesToHtmlForMiniSite
> Task :solr:documentation:copyMiniDocumentationAssets
> Task :solr:documentation:createMiniDocumentationIndex
> Task :solr:documentation:documentationMinimal
> Task :solr:documentation:assemble
> Task :documentation
> Task :solr:solr-ref-guide:jrubyPrepare
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by com.headius.backport9.modules.Modules (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-complete/9.2.9.0/8e44ce7a1417966d89957bd766a148601e28828b/jruby-complete-9.2.9.0.jar) to method sun.nio.ch.NativeThread.signal(long)
WARNING: Please consider reporting this to the maintainers of com.headius.backport9.modules.Modules
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Successfully installed ffi-1.13.1-java
Successfully installed rb-inotify-0.10.1
Successfully installed rb-fsevent-0.10.4
Successfully installed sass-listen-4.0.0
Successfully installed forwardable-extended-2.6.0
Successfully installed listen-3.2.1
Ruby Sass has reached end-of-life and should no longer be used.
* If you use Sass as a command-line tool, we recommend using Dart Sass, the new
primary implementation: https://sass-lang.com/install
* If you use Sass as a plug-in for a Ruby web framework, we recommend using the
sassc gem: https://github.com/sass/sassc-ruby#readme
* For more details, please refer to the Sass blog:
https://sass-lang.com/blog/posts/7828841
Successfully installed sass-3.7.4
Successfully installed public_suffix-4.0.6
Successfully installed temple-0.8.2
Successfully installed asciidoctor-2.0.11
Successfully installed safe_yaml-1.0.5
Successfully installed rouge-1.11.1
Successfully installed pathutil-0.16.2
Successfully installed mercenary-0.3.6
Successfully installed liquid-4.0.3
Successfully installed kramdown-1.17.0
Successfully installed jekyll-watch-1.5.1
Successfully installed jekyll-sass-converter-1.5.2
Successfully installed colorator-1.1.0
Successfully installed addressable-2.7.0
Successfully installed concurrent-ruby-1.0.5-java
Successfully installed tilt-2.0.10
Successfully installed slim-4.0.1
Successfully installed jekyll-3.5.2
Successfully installed jekyll-asciidoc-3.0.0
25 gems installed
> Task :solr:solr-ref-guide:prepareLocalJavadocLinksSiteSources
Syncing source files to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/local-jdoc-links-site-content using props:
htmlSolrJavadocs -> link:../../../documentation/build/site
htmlLuceneJavadocs -> link:../../../../lucene/documentation/build/site
htmlOutDir -> ../local-jdoc-links-site
javadocLink -> https://docs.oracle.com/en/java/javase/11/docs/api/
solrGuideDraftStatus -> DRAFT
solrRootPath -> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/
solrDocsVersion -> 9.0
solrGuideVersionPath -> 9_0
buildDate -> 2020-11-07
buildYear -> 2020
ivyCommonsCodec -> 1.13
ivyDropwizardMetrics -> 4.1.5
ivyLog4j -> 2.13.2
ivyOpennlpTools -> 1.9.1
ivyTika -> 1.24
ivyZookeeper -> 3.6.2
Building up tree of all known pages
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by org.jruby.util.SecurityHelper (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-core/9.2.6.0/653601d48b38528e76840c6eac1ae46e2dae1a74/jruby-core-9.2.6.0.jar) to field java.lang.reflect.Field.modifiers
WARNING: Please consider reporting this to the maintainers of org.jruby.util.SecurityHelper
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Looping over pages to build nav data
Creating /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/local-jdoc-links-site-content/_data/scrollnav.json
Creating /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/local-jdoc-links-site-content/_data/sidebar.json
> Task :solr:solr-ref-guide:buildLocalJavadocLinksSite
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by com.headius.backport9.modules.Modules (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-complete/9.2.9.0/8e44ce7a1417966d89957bd766a148601e28828b/jruby-complete-9.2.9.0.jar) to method sun.nio.ch.NativeThread.signal(long)
WARNING: Please consider reporting this to the maintainers of com.headius.backport9.modules.Modules
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Configuration file: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/local-jdoc-links-site-content/_config.yml
Source: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/local-jdoc-links-site-content
Destination: ../local-jdoc-links-site
Incremental build: disabled. Enable with --incremental
Generating...
asciidoctor: WARNING: skipping reference to missing attribute: config_name
asciidoctor: WARNING: skipping reference to missing attribute: file_name
done in 26.523 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkLocalJavadocLinksSite
Processed 2443 links (1998 relative) to 3514 anchors in 243 files
> Task :solr:solr-ref-guide:prepareSiteSources
Syncing source files to /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content using props:
htmlSolrJavadocs -> https://lucene.apache.org/solr/9_0_0/
htmlLuceneJavadocs -> https://lucene.apache.org/core/9_0_0/
htmlOutDir -> ../html-site
javadocLink -> https://docs.oracle.com/en/java/javase/11/docs/api/
solrGuideDraftStatus -> DRAFT
solrRootPath -> /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/
solrDocsVersion -> 9.0
solrGuideVersionPath -> 9_0
buildDate -> 2020-11-07
buildYear -> 2020
ivyCommonsCodec -> 1.13
ivyDropwizardMetrics -> 4.1.5
ivyLog4j -> 2.13.2
ivyOpennlpTools -> 1.9.1
ivyTika -> 1.24
ivyZookeeper -> 3.6.2
Building up tree of all known pages
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by org.jruby.util.SecurityHelper (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-core/9.2.6.0/653601d48b38528e76840c6eac1ae46e2dae1a74/jruby-core-9.2.6.0.jar) to field java.lang.reflect.Field.modifiers
WARNING: Please consider reporting this to the maintainers of org.jruby.util.SecurityHelper
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Looping over pages to build nav data
Creating /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content/_data/scrollnav.json
Creating /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content/_data/sidebar.json
> Task :solr:solr-ref-guide:buildSite
WARNING: An illegal reflective access operation has occurred
WARNING: Illegal reflective access by com.headius.backport9.modules.Modules (file:/home/jenkins/.gradle/caches/modules-2/files-2.1/org.jruby/jruby-complete/9.2.9.0/8e44ce7a1417966d89957bd766a148601e28828b/jruby-complete-9.2.9.0.jar) to method sun.nio.ch.NativeThread.signal(long)
WARNING: Please consider reporting this to the maintainers of com.headius.backport9.modules.Modules
WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
WARNING: All illegal access operations will be denied in a future release
Configuration file: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content/_config.yml
Source: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/solr-ref-guide/build/html-site-content
Destination: ../html-site
Incremental build: disabled. Enable with --incremental
Generating...
asciidoctor: WARNING: skipping reference to missing attribute: config_name
asciidoctor: WARNING: skipping reference to missing attribute: file_name
done in 25.973 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkSite
Processed 2443 links (1760 relative) to 3514 anchors in 243 files
> Task :solr:solr-ref-guide:check
> Task :solr:solrj:check
> Task :solr:test-framework:check
> Task :solr:webapp:check
> Task :lucene:analysis:common:check
> Task :lucene:analysis:icu:check
> Task :lucene:analysis:kuromoji:check
> Task :lucene:analysis:morfologik:check
> Task :lucene:analysis:nori:check
> Task :lucene:analysis:opennlp:check
> Task :lucene:analysis:phonetic:check
> Task :lucene:analysis:smartcn:check
> Task :lucene:analysis:stempel:check
> Task :solr:contrib:analysis-extras:check
> Task :solr:contrib:analytics:check
> Task :solr:contrib:clustering:check
> Task :solr:contrib:extraction:check
> Task :solr:contrib:jaegertracer-configurator:check
> Task :solr:contrib:langid:check
> Task :solr:contrib:ltr:check
> Task :solr:contrib:prometheus-exporter:check
> Task :solr:docker:package:check
The slowest tests (exceeding 500 ms) during this run:
158.83s TestStressLiveNodes.testStress (:solr:core)
140.64s TestIntervalFaceting.testRandom (:solr:core)
86.02s TestDistributedSearch.test (:solr:core)
80.56s TestCloudJSONFacetSKG.testRandom (:solr:core)
72.55s TestLeaderElectionZkExpiry.testLeaderElectionWithZkExpiry (:solr:core)
71.40s TestRandomCollapseQParserPlugin.testRandomCollpaseWithSort (:solr:core)
68.97s TestRangeQuery.testRandomRangeQueries (:solr:core)
66.90s TestRandomDVFaceting.testRandomFaceting (:solr:core)
63.80s PeerSyncReplicationTest.test (:solr:core)
60.89s ZkControllerTest.testGetHostName (:solr:core)
ERROR: The following test(s) have failed:
- org.apache.solr.TestRandomFaceting.testRandomFaceting (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Check-master/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.TestRandomFaceting.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.TestRandomFaceting.testRandomFaceting" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=98BE4381E6A77B57 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=US-ASCII
Deprecated Gradle features were used in this build, making it incompatible with Gradle 7.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/6.6.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD SUCCESSFUL in 1h 6m 21s
852 actionable tasks: 852 executed
Build step 'Invoke Gradle script' changed build result to SUCCESS
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2826)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2705)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2686)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3073)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene1
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1788)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:998)
at hudson.FilePath.act(FilePath.java:1069)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2684)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:265)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:78)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1905)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:428)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3075)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1071)
at hudson.FilePath.act(FilePath.java:1058)
at hudson.FilePath.validateAntFileMask(FilePath.java:2684)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:265)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:78)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:741)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1905)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:428)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)