You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@solr.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2022/01/11 17:20:05 UTC
[JENKINS] Solr » Solr-Check-9.x - Build # 23 - Still Unstable!
Build: https://ci-builds.apache.org/job/Solr/job/Solr-Check-9.x/23/
3 tests failed.
FAILED: org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.classMethod
Error Message:
java.util.concurrent.TimeoutException: Timed out waiting for all collections to be fully removed.
Stack Trace:
java.util.concurrent.TimeoutException: Timed out waiting for all collections to be fully removed.
at __randomizedtesting.SeedInfo.seed([7C7ADFBA82104386]:0)
at org.apache.solr.cloud.MiniSolrCloudCluster.deleteAllCollections(MiniSolrCloudCluster.java:577)
at org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.tearDownCluster(TestSchemaDesignerConfigSetHelper.java:64)
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$7.evaluate(RandomizedRunner.java:905)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
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:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED: org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.classMethod
Error Message:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=34294, name=ZKEventListenerThread, state=RUNNABLE, group=TGRP-TestSchemaDesignerConfigSetHelper]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=34294, name=ZKEventListenerThread, state=RUNNABLE, group=TGRP-TestSchemaDesignerConfigSetHelper]
Caused by: java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([7C7ADFBA82104386]:0)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1755)
at org.apache.solr.core.SolrCore.lambda$getConfListener$21(SolrCore.java:3140)
at org.apache.solr.cloud.ZkController.lambda$fireEventListeners$18(ZkController.java:2495)
at java.base/java.lang.Thread.run(Thread.java:834)
FAILED: org.apache.solr.cloud.PackageManagerCLITest.testPackageManager
Error Message:
java.lang.AssertionError: Non-zero status returned for: [-solrUrl, https://127.0.0.1:37259/solr, deploy, question-answer, -y, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
Stack Trace:
java.lang.AssertionError: Non-zero status returned for: [-solrUrl, https://127.0.0.1:37259/solr, deploy, question-answer, -y, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
at __randomizedtesting.SeedInfo.seed([7C7ADFBA82104386:7FD094D480FE9C2D]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.apache.solr.cloud.PackageManagerCLITest.run(PackageManagerCLITest.java:156)
at org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:94)
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:44)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
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 org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
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:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 1114 lines...]
2> ERROR: System/Runtime.exit(1) or halt(1) calls are not allowed because they terminate the test runner's JVM.
2>
2> 1325325 INFO (TEST-PackageManagerCLITest.testPackageManager-seed#[7C7ADFBA82104386]) [] o.a.s.SolrTestCaseJ4 ###Ending testPackageManager
> java.lang.AssertionError: Non-zero status returned for: [-solrUrl, https://127.0.0.1:37259/solr, deploy, question-answer, -y, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
> at __randomizedtesting.SeedInfo.seed([7C7ADFBA82104386:7FD094D480FE9C2D]:0)
> at org.junit.Assert.fail(Assert.java:89)
> at org.junit.Assert.failNotEquals(Assert.java:835)
> at org.junit.Assert.assertEquals(Assert.java:647)
> at org.apache.solr.cloud.PackageManagerCLITest.run(PackageManagerCLITest.java:156)
> at org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:94)
> 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:44)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> 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 org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> 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:43)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
> 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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
> at java.base/java.lang.Thread.run(Thread.java:834)
2> NOTE: reproduce with: gradlew test --tests PackageManagerCLITest.testPackageManager -Dtests.seed=7C7ADFBA82104386 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=pa-Arab-PK -Dtests.timezone=Europe/Saratov -Dtests.asserts=true -Dtests.file.encoding=UTF-8
2> 1325332 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.e.j.s.AbstractConnector Stopped ServerConnector@30873383{HTTP/1.1, (http/1.1)}{0.0.0.0:۰}
2> 1325345 WARN (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker-SendThread(127.0.0.1:37461)) [] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x103a395ed300005.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x103a395ed300005, 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 0x103a395ed300005, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1280) [zookeeper-3.7.0.jar:3.7.0]
2> 1325447 INFO (jetty-closer-13747-thread-1) [] o.e.j.s.AbstractConnector Stopped ServerConnector@67fe4bba{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:۰}
2> 1325447 INFO (jetty-closer-13747-thread-1) [] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@386dfcd6{/solr,null,STOPPED}
2> 1325447 INFO (jetty-closer-13747-thread-1) [] o.e.j.s.session node0 Stopped scavenging
2> 1325448 INFO (jetty-closer-13747-thread-1) [] o.a.s.c.CoreContainer Shutting down CoreContainer instance=172081067
2> 1325448 INFO (jetty-closer-13747-thread-1) [] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:37259_solr
2> 1325449 INFO (jetty-closer-13747-thread-1) [] o.a.s.c.ZkController Publish this node as DOWN...
2> 1325449 INFO (jetty-closer-13747-thread-1) [] o.a.s.c.ZkController Publish node=127.0.0.1:37259_solr as DOWN
2> 1325449 INFO (zkCallback-13703-thread-1) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
2> 1325450 INFO (zkCallback-13703-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for collection [abc] has occurred - updating... (live nodes size: [0])
2> 1325451 INFO (zkCallback-13703-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for collection [def] has occurred - updating... (live nodes size: [0])
2> 1325452 INFO (coreCloseExecutor-13750-thread-1) [n:127.0.0.1:37259_solr] o.a.s.c.SolrCore [abc_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@ba1fcbb
2> 1325452 INFO (coreCloseExecutor-13750-thread-2) [n:127.0.0.1:37259_solr] o.a.s.c.SolrCore [def_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@6590a04b
2> 1325452 INFO (coreCloseExecutor-13750-thread-2) [n:127.0.0.1:37259_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.def.shard1.replica_n1 tag=SolrCore@6590a04b
2> 1325452 INFO (coreCloseExecutor-13750-thread-2) [n:127.0.0.1:37259_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.def.shard1.leader tag=SolrCore@6590a04b
2> 1325452 INFO (coreCloseExecutor-13750-thread-1) [n:127.0.0.1:37259_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.abc.shard1.replica_n1 tag=SolrCore@ba1fcbb
2> 1325452 INFO (coreCloseExecutor-13750-thread-1) [n:127.0.0.1:37259_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.abc.shard1.leader tag=SolrCore@ba1fcbb
2> 1325453 INFO (coreCloseExecutor-13750-thread-2) [n:127.0.0.1:37259_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 1325453 INFO (coreCloseExecutor-13750-thread-1) [n:127.0.0.1:37259_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 1325457 INFO (jetty-closer-13747-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
2> 1325457 INFO (jetty-closer-13747-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
2> 1325457 INFO (jetty-closer-13747-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
2> 1325457 INFO (jetty-closer-13747-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
2> 1325457 INFO (closeThreadPool-13752-thread-2) [] o.a.s.c.Overseer Overseer (id=73081883292860420-127.0.0.1:37259_solr-n_0000000000) closing
2> 1325460 INFO (OverseerStateUpdate-73081883292860420-127.0.0.1:37259_solr-n_0000000000) [n:127.0.0.1:37259_solr] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:37259_solr
2> 1325465 INFO (closeThreadPool-13752-thread-1) [] o.a.s.c.Overseer Overseer (id=73081883292860420-127.0.0.1:37259_solr-n_0000000000) closing
2> 1325562 INFO (jetty-closer-13747-thread-1) [] o.a.s.c.Overseer Overseer (id=73081883292860420-127.0.0.1:37259_solr-n_0000000000) closing
2> 1334014 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
2> 1334408 WARN (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Watch limit violations:
2> Maximum concurrent create/delete watches above limit:
2>
2> 2 /solr/aliases.json
2> 2 /solr/collections/def/terms/shard1
2> 2 /solr/collections/abc/terms/shard1
2>
2> Maximum concurrent data watches above limit:
2>
2> 7 /solr/collections/abc/state.json
2> 7 /solr/collections/def/state.json
2> 2 /solr/clusterprops.json
2>
2> Maximum concurrent children watches above limit:
2>
2> 8 /solr/overseer/collection-queue-work
2> 6 /solr/collections
2> 6 /solr/collections/abc/state.json
2> 6 /solr/collections/def/state.json
2> 4 /solr/live_nodes
2>
2> 1334412 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:37461
2> 1334412 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37461
2> 1334412 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer connecting to 127.0.0.1 37461
2> 1334413 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-272 after mutting 0 log messages
2> 1334413 INFO (SUITE-PackageManagerCLITest-seed#[7C7ADFBA82104386]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-273 for ERROR logs matching regex: ignore_exception
2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.PackageManagerCLITest_7C7ADFBA82104386-001
2> NOTE: test params are: codec=Asserting(Lucene90): {}, docValues:{}, maxPointsInLeafNode=2028, maxMBSortInHeap=6.392414805536338, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=pa-Arab-PK, timezone=Europe/Saratov
2> NOTE: Linux 4.15.0-147-generic amd64/Oracle Corporation 11.0.12 (64-bit)/cpus=4,threads=2,free=264326832,total=481296384
2> NOTE: All tests run in this JVM: [TestGraphTermsQParserPlugin, TestDocSet, TestAddFieldRealTimeGet, QueryParsingTest, TestSurroundQueryParser, TestValueSourceCache, TestSimpleQParserPlugin, TestCloudJSONFacetSKG, SpatialHeatmapFacetsTest, TestJsonFacets, TestSweetSpotSimilarityFactory, TestBooleanSimilarityFactory, TestNonDefinedSimilarityFactory, TestXmlQParserPlugin, TestSearchPerf, TestFiltering, TestTermQParserPlugin, SolrIndexSearcherTest, TestComplexPhraseQParserPlugin, TestLegacyNumericRangeQueryBuilder, TestElisionMultitermQuery, TestStressLucene, TestPayloadScoreQParserPlugin, TestNestedDocsSort, BJQParserTest, TestJsonRequest, TestMinMaxOnMultiValuedField, MergeStrategyTest, TestStressVersions, TestExactSharedStatsCache, ReturnFieldsTest, TestComplexPhraseLeadingWildcard, TestSimpleTrackingShardHandler, TestGroupingSearch, TestDistribPackageStore, TestDocTermOrdsUninvertLimit, TestFieldCacheSortRandom, TestFieldCacheReopen, SparseHLLTest, FullHLLTest, TimeZoneUtilsTest, TestTestInjection, TestSolrJacksonAnnotation, DynamicMapsTest, TestFastOutputStream, SolrLogPostToolTest, CircularListTest, TestHttpServletCarrier, TestRandomDVFaceting, TestEmbeddedSolrServerConstructors, TestGeoJSONResponseWriter, TestPHPSerializedResponseWriter, TestChildDocTransformer, TestCustomDocTransformer, TestRetrieveFieldsOptimizer, TestSuggestSpellingConverter, IndexBasedSpellCheckerTest, SuggesterTest, TestHighFrequencyDictionaryFactory, TestFreeTextSuggestions, WordBreakSolrSpellCheckerTest, SimpleClusterAbstractionsTest, TestInfoStreamLogging, TestCoreDiscovery, TestSolrDeletionPolicy2, TestSolrCloudSnapshots, TestLazyCores, SOLR749Test, ExitableDirectoryReaderTest, RequestHandlersTest, SolrCoreCheckLockOnStartupTest, ConfigureRecoveryStrategyTest, ShardBackupIdTest, TestQuerySenderNoQuery, TestConfigOverlay, TestConfigSets, OutputWriterTest, TestDistributedMissingSort, PathHierarchyTokenizerFactoryTest, TestDeprecatedFilters, BasicAuthStandaloneTest, MultiDestinationAuditLoggerTest, TestZkAclsWithHadoopAuth, CertAuthPluginTest, TestSha256AuthenticationProvider, JWTVerificationkeyResolverTest, SolrCoreMetricManagerTest, MetricsConfigTest, SolrJmxReporterCloudTest, HighlighterMaxOffsetTest, HighlighterWithoutStoredIdTest, SolrTestCaseJ4DeleteCoreTest, OverseerCollectionConfigSetProcessorTest, TestPullReplicaErrorHandling, TriLevelCompositeIdRoutingTest, SaslZkACLProviderTest, NestedShardedAtomicUpdateTest, DocValuesNotIndexedTest, SSLMigrationTest, TestStressLiveNodes, TlogReplayBufferedWhileIndexingTest, DistribJoinFromCollectionTest, TestCloudPseudoReturnFields, AssignBackwardCompatibilityTest, PeerSyncReplicationTest, LeaderTragicEventTest, DeleteShardTest, TestDeleteCollectionOnDownNodes, DistribCursorPagingTest, TestCloudConsistency, TestLazySolrCluster, UnloadDistributedZkTest, ChaosMonkeyNothingIsSafeTest, ReindexCollectionTest, TestCloudPhrasesIdentificationComponent, TestRandomRequestDistribution, SyncSliceTest, RecoveryAfterSoftCommitTest, CollectionStateZnodeTest, TestAuthenticationFramework, HdfsUnloadDistributedZkTest, HdfsSyncSliceTest, HdfsBasicDistributedZk2Test, HdfsChaosMonkeySafeLeaderTest, ZkControllerTest, TestTlogReplayVsRecovery, TestClusterStateMutator, TestLRUStatsCacheCloud, DeleteLastCustomShardedReplicaTest, ReplicationFactorTest, PackageManagerCLITest]
WARNING: Test org.apache.solr.cloud.TestRandomFlRTGCloud wrote 41,300,271 bytes of output.
WARNING: Test org.apache.solr.TestRandomFaceting wrote 30,019,782 bytes of output.
WARNING: Test org.apache.solr.schema.TestCloudSchemaless wrote 13,027,874 bytes of output.
WARNING: Test org.apache.solr.update.TestInPlaceUpdatesStandalone wrote 22,786,979 bytes of output.
org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper > classMethod FAILED
java.util.concurrent.TimeoutException: Timed out waiting for all collections to be fully removed.
at __randomizedtesting.SeedInfo.seed([7C7ADFBA82104386]:0)
at org.apache.solr.cloud.MiniSolrCloudCluster.deleteAllCollections(MiniSolrCloudCluster.java:577)
at org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.tearDownCluster(TestSchemaDesignerConfigSetHelper.java:64)
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$7.evaluate(RandomizedRunner.java:905)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
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:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper > classMethod FAILED
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=34294, name=ZKEventListenerThread, state=RUNNABLE, group=TGRP-TestSchemaDesignerConfigSetHelper]
Caused by:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([7C7ADFBA82104386]:0)
at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1755)
at org.apache.solr.core.SolrCore.lambda$getConfListener$21(SolrCore.java:3140)
at org.apache.solr.cloud.ZkController.lambda$fireEventListeners$18(ZkController.java:2495)
at java.base/java.lang.Thread.run(Thread.java:834)
org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper > test suite's output saved to /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.txt, copied below:
2> 1960652 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/server/solr/configsets/_default/conf'
2> 1960652 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
2> 1960653 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-574 after mutting 0 log messages
2> 1960653 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-575 for ERROR logs matching regex: ignore_exception
2> 1960653 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/data-dir-255-001
2> 1960654 WARN (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=32 numCloses=32
2> 1960654 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
2> 1960654 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
2> 1960655 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001
2> 1960655 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
2> 1960655 INFO (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
2> 1960655 INFO (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Starting server
2> 1960656 WARN (ZkTestServer Run Thread) [] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
2> 1960755 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer start zk server on port: 46279
2> 1960755 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:46279
2> 1960755 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46279
2> 1960755 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46279
2> 1960757 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 1960758 INFO (zkConnectionManagerCallback-21790-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1960758 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1960760 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 1960760 INFO (zkConnectionManagerCallback-21792-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1960761 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1960761 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 1960762 INFO (zkConnectionManagerCallback-21794-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1960762 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1960866 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 1960866 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 1960866 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 11.0.12+8-LTS-237
2> 1960867 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 1960867 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.session No SessionScavenger set, using defaults
2> 1960867 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.session node0 Scavenging every 600000ms
2> 1960867 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6a58b16f{/solr,null,AVAILABLE}
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.AbstractConnector Started ServerConnector@43969cc1{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:34851}
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.e.j.s.Server Started @1960900ms
2> 1960868 ERROR (jetty-launcher-21795-thread-1) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.s.CoreContainerProvider ___ _ Welcome to Apache Solr™ version 9.1.0
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _ Starting in cloud mode on port null
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.s.CoreContainerProvider |___/\___/_|_| Start time: 2022-01-11T17:04:40.242404Z
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1 (source: servlet config: solr.solr.home)
2> 1960868 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 1960869 INFO (zkConnectionManagerCallback-21797-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1960869 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1960869 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.NodeConfig solr.xml found in ZooKeeper. Loading...
2> 1960872 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.SolrXmlConfig Metrics collection is disabled.
2> 1960974 WARN (jetty-launcher-21795-thread-1) [] o.e.j.u.s.S.config Trusting all certificates configured for Client@1f2e1887[provider=null,keyStore=null,trustStore=null]
2> 1960974 WARN (jetty-launcher-21795-thread-1) [] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1f2e1887[provider=null,keyStore=null,trustStore=null]
2> 1960976 WARN (jetty-launcher-21795-thread-1) [] o.e.j.u.s.S.config Trusting all certificates configured for Client@11b115c5[provider=null,keyStore=null,trustStore=null]
2> 1960976 WARN (jetty-launcher-21795-thread-1) [] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@11b115c5[provider=null,keyStore=null,trustStore=null]
2> 1960977 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46279/solr
2> 1960977 INFO (jetty-launcher-21795-thread-1) [] o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater with useDistributedStateUpdate=true. Solr will be using distributed cluster state updates.
2> 1960978 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 1960979 INFO (zkConnectionManagerCallback-21807-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1960979 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1960990 WARN (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
2> 1960992 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater with useDistributedStateUpdate=true. Solr will be using distributed cluster state updates.
2> 1960994 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34851_solr
2> 1960994 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.Overseer Overseer (id=73081925156274180-127.0.0.1:34851_solr-n_0000000000) starting
2> 1960999 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34851_solr
2> 1960999 INFO (OverseerStateUpdate-73081925156274180-127.0.0.1:34851_solr-n_0000000000) [n:127.0.0.1:34851_solr] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:34851_solr
2> 1961000 INFO (OverseerStateUpdate-73081925156274180-127.0.0.1:34851_solr-n_0000000000) [n:127.0.0.1:34851_solr] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 1961000 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.p.PackageLoader /packages.json updated to version -1
2> 1961001 WARN (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_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> 1961054 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Creating DistributedCollectionConfigSetCommandRunner. Collection and ConfigSet APIs are running distributed (not Overseer based)
2> 1961054 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater with useDistributedStateUpdate=true. Solr will be using distributed cluster state updates.
2> 1961076 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1
2> 1961079 ERROR (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.s.CoreContainerProvider Could not start Solr. Check solr/home property and the logs
2> 1961079 ERROR (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.SolrCore null
2> => java.lang.RuntimeException: Encountered IOException: No content to map due to end-of-input
2> at [Source: (byte[])""; line: 1, column: 0]
2> java.lang.RuntimeException: Encountered IOException: No content to map due to end-of-input
2> at [Source: (byte[])""; line: 1, column: 0]
2> at org.apache.solr.servlet.RateLimitManager.onChange(RateLimitManager.java:71) ~[main/:?]
2> at org.apache.solr.common.cloud.ZkStateReader.registerClusterPropertiesListener(ZkStateReader.java:718) ~[solr-solrj-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at org.apache.solr.servlet.CoreContainerProvider.init(CoreContainerProvider.java:230) [main/:?]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:393) [main/:?]
2> at org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:194) [jetty-util-9.4.44.v20210927.jar:9.4.44.v20210927]
2> at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:74) [jetty-util-9.4.44.v20210927.jar:9.4.44.v20210927]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner.retryOnPortBindFailure(JettySolrRunner.java:599) [main/:?]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:537) [main/:?]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:505) [main/:?]
2> at org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:476) [solr-test-framework-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:296) [solr-test-framework-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at java.util.concurrent.FutureTask.run(FutureTask.java:264) [?:?]
2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:235) [solr-solrj-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
2> at java.lang.Thread.run(Thread.java:834) [?:?]
2> 1961080 INFO (jetty-launcher-21795-thread-1) [n:127.0.0.1:34851_solr] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34851, zkHost=127.0.0.1:46279/solr}
2> 1961080 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
2> 1961080 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.MiniSolrCloudCluster waitForNode: 127.0.0.1:34851_solr
2> 1961081 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to ZooKeeper
2> 1961082 INFO (zkConnectionManagerCallback-21821-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1961082 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1961082 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 1961083 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46279/solr ready
2> 1961083 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Waiting up to 45000ms for client to connect to ZooKeeper
2> 1961084 INFO (zkConnectionManagerCallback-21823-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1961084 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1961305 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr] o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API locally for CREATE asyncId=null
2> 1961308 INFO (DistributedCollectionApiCommandExecutor-21814-thread-1-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:.system] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
2> 1961415 INFO (DistributedCollectionApiCommandExecutor-21814-thread-1-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:.system] o.a.s.c.o.SliceMutator createReplica() {
2> "core":".system_shard1_replica_n1",
2> "node_name":"127.0.0.1:34851_solr",
2> "collection":".system",
2> "shard":"shard1",
2> "state":"down",
2> "type":"NRT",
2> "operation":"ADDREPLICA",
2> "waitForFinalState":"false"}
2> 1961466 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr x:.system_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
2> 1961466 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr x:.system_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 2147483647 cores with initial capacity of 1024
2> 1961476 WARN (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version.
2> 1961476 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
2> 1961477 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema.xml not found - loading non-managed schema schema.xml instead
2> 1961478 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.IndexSchema Schema name=_system collection or core
2> 1961478 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
2> 1961480 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema.xml
2> 1961482 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
2> 1961483 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from configset .system, trusted=true
2> 1961483 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1/.system_shard1_replica_n1/data/]
2> 1961510 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
2> 1961510 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
2> 1961510 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs;
2> 1961511 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
2> 1961512 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
2> 1961512 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
2> 1961513 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema.xml
2> 1961513 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
2> 1961513 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
2> 1961513 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1721678619881766912
2> 1961515 INFO (searcherExecutor-21825-thread-1-processing-127.0.0.1:34851_solr .system_shard1_replica_n1 .system shard1 core_node2) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore [.system_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
2> 1961519 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0} for registerTerm
2> 1961519 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
2> 1961522 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
2> 1961522 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
2> 1961522 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:34851/solr/.system_shard1_replica_n1/
2> 1961525 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
2> 1961525 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:34851/solr/.system_shard1_replica_n1/ has no replicas
2> 1961525 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/73081925156274180-core_node2-n_0000000000
2> 1961528 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:34851/solr/.system_shard1_replica_n1/ shard1
2> 1961531 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
2> 1961535 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=69
2> 1961537 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 1961537 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={pullReplicas=0&name=.system&nrtReplicas=1&action=CREATE&numShards=1&tlogReplicas=0&wt=javabin&version=2} status=0 QTime=235
2> 1961537 INFO (SUITE-TestSchemaDesignerConfigSetHelper-seed#[7C7ADFBA82104386]-worker) [] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
2> 1961549 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.SolrTestCaseJ4 ###Starting testSetupMutable
2> 1961635 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
2> 1961638 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.s.IndexSchema Schema name=default-config
2> 1961673 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
2> 1961675 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.s.ManagedIndexSchema Persisted managed schema version 1 at /configs/._designer_testSetupMutable/managed-schema.xml
2> 1961676 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to ZooKeeper
2> 1961677 INFO (zkConnectionManagerCallback-21834-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 1961677 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 1961678 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 1961678 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46279/solr ready
2> 1961693 INFO (qtp1816365645-34167) [n:127.0.0.1:34851_solr] o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API locally for CREATE asyncId=null
2> 1961695 INFO (DistributedCollectionApiCommandExecutor-21814-thread-2-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable] o.a.s.c.a.c.CreateCollectionCmd Create collection ._designer_testSetupMutable
2> 1961801 INFO (DistributedCollectionApiCommandExecutor-21814-thread-2-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable] o.a.s.c.o.SliceMutator createReplica() {
2> "core":"._designer_testSetupMutable_shard1_replica_n1",
2> "node_name":"127.0.0.1:34851_solr",
2> "collection":"._designer_testSetupMutable",
2> "shard":"shard1",
2> "state":"down",
2> "type":"NRT",
2> "operation":"ADDREPLICA",
2> "waitForFinalState":"false"}
2> 1961804 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=._designer_testSetupMutable&newCollection=true&name=._designer_testSetupMutable_shard1_replica_n1&action=CREATE&numShards=1&collection=._designer_testSetupMutable&shard=shard1&wt=javabin&version=2&replicaType=NRT
2> 1961812 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
2> 1961816 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.IndexSchema Schema name=default-config
2> 1961818 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitNorms to be specified in schema, hardcoded behavior is omitNorms=true
2> 1961818 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitTermFreqAndPositions to be specified in schema, hardcoded behavior is omitTermFreqAndPositions=true
2> 1961818 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termOffsets to be specified in schema, hardcoded behavior is termOffsets=false
2> 1961818 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termPositions to be specified in schema, hardcoded behavior is termPositions=false
2> 1961818 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitPositions to be specified in schema, hardcoded behavior is omitPositions=true
2> 1961851 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
2> 1961851 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore '._designer_testSetupMutable_shard1_replica_n1' using configuration from configset ._designer_testSetupMutable, trusted=true
2> 1961851 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SolrCore [[._designer_testSetupMutable_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1/._designer_testSetupMutable_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1/._designer_testSetupMutable_shard1_replica_n1/data/]
2> 1961889 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
2> 1961889 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
2> 1961890 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
2> 1961890 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
2> 1961891 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/._designer_testSetupMutable
2> 1961891 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/._designer_testSetupMutable
2> 1961892 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/._designer_testSetupMutable/managed-schema.xml
2> 1961892 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Current schema version 1 is already the latest
2> 1961892 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.DirectSolrSpellChecker init: {name=default, field=_text_, classname=solr.DirectSolrSpellChecker, distanceMeasure=internal, accuracy=0.5, maxQueryFrequency=0.01, maxEdits=2, minPrefix=1, maxInspections=5, minQueryLength=4}
2> 1961893 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
2> 1961893 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1721678620280225792
2> 1961894 INFO (searcherExecutor-21836-thread-1-processing-127.0.0.1:34851_solr ._designer_testSetupMutable_shard1_replica_n1 ._designer_testSetupMutable shard1 core_node2) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener done.
2> 1961894 INFO (searcherExecutor-21836-thread-1-processing-127.0.0.1:34851_solr ._designer_testSetupMutable_shard1_replica_n1 ._designer_testSetupMutable shard1 core_node2) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
2> 1961895 INFO (searcherExecutor-21836-thread-1-processing-127.0.0.1:34851_solr ._designer_testSetupMutable_shard1_replica_n1 ._designer_testSetupMutable shard1 core_node2) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SolrCore [._designer_testSetupMutable_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
2> 1961898 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/._designer_testSetupMutable/terms/shard1 to Terms{values={core_node2=0}, version=0} for registerTerm
2> 1961898 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/._designer_testSetupMutable/leaders/shard1
2> 1961901 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
2> 1961901 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
2> 1961901 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:34851/solr/._designer_testSetupMutable_shard1_replica_n1/
2> 1961902 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
2> 1961902 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:34851/solr/._designer_testSetupMutable_shard1_replica_n1/ has no replicas
2> 1961902 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/._designer_testSetupMutable/leaders/shard1/leader after winning as /collections/._designer_testSetupMutable/leader_elect/shard1/election/73081925156274180-core_node2-n_0000000000
2> 1961904 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:34851/solr/._designer_testSetupMutable_shard1_replica_n1/ shard1
2> 1961907 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
2> 1961910 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=._designer_testSetupMutable&newCollection=true&name=._designer_testSetupMutable_shard1_replica_n1&action=CREATE&numShards=1&collection=._designer_testSetupMutable&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=105
2> 1961910 INFO (qtp1816365645-34167) [n:127.0.0.1:34851_solr] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 1961911 INFO (qtp1816365645-34167) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=._designer_testSetupMutable&name=._designer_testSetupMutable&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=218
2> 1961911 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 1961912 INFO (qtp1816365645-34165) [n:127.0.0.1:34851_solr] o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API locally for DELETE asyncId=null
2> 1961913 INFO (DistributedCollectionApiCommandExecutor-21814-thread-3-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable] o.a.s.c.a.c.CollectionHandlingUtils Executing Collection Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true, asyncId=null
2> 1961914 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.._designer_testSetupMutable.shard1.replica_n1 tag=null
2> 1961914 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr] o.a.s.c.SolrCore [._designer_testSetupMutable_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@239613a4
2> 1961914 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.._designer_testSetupMutable.shard1.replica_n1 tag=SolrCore@239613a4
2> 1961914 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.._designer_testSetupMutable.shard1.leader tag=SolrCore@239613a4
2> 1961914 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 1961916 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr] o.a.s.c.ZkShardTerms Successful update of terms at /collections/._designer_testSetupMutable/terms/shard1 to Terms{values={}, version=1} for removeTerm
2> 1961917 INFO (zkCallback-21806-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961917 INFO (qtp1816365645-34166) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={deleteInstanceDir=true&core=._designer_testSetupMutable_shard1_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2} status=0 QTime=3
2> 1961919 INFO (zkCallback-21806-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961919 INFO (zkCallback-21806-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961919 INFO (zkCallback-21806-thread-4) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961919 INFO (DistributedCollectionApiCommandExecutor-21814-thread-3-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable] o.a.s.c.c.ZkStateReader /collections/._designer_testSetupMutable/state.json is deleted, stop watching children
2> 1961919 INFO (zkCallback-21806-thread-6) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961919 INFO (zkCallback-21806-thread-5) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961919 INFO (zkCallback-21806-thread-3) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDeleted path:/collections/._designer_testSetupMutable/state.json] for collection [._designer_testSetupMutable] has occurred - updating... (live nodes size: [1])
2> 1961925 INFO (qtp1816365645-34165) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=._designer_testSetupMutable&action=DELETE&wt=javabin&version=2} status=0 QTime=13
2> 1961926 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.c.c.ZkStateReader /collections/._designer_testSetupMutable/state.json is deleted, stop watching children
2> 1961928 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr] o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API locally for CREATE asyncId=null
2> 1961929 INFO (DistributedCollectionApiCommandExecutor-21814-thread-4-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable] o.a.s.c.a.c.CreateCollectionCmd Create collection ._designer_testSetupMutable
2> 1962037 INFO (DistributedCollectionApiCommandExecutor-21814-thread-4-processing-127.0.0.1:34851_solr) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable] o.a.s.c.o.SliceMutator createReplica() {
2> "core":"._designer_testSetupMutable_shard1_replica_n1",
2> "node_name":"127.0.0.1:34851_solr",
2> "collection":"._designer_testSetupMutable",
2> "shard":"shard1",
2> "state":"down",
2> "type":"NRT",
2> "operation":"ADDREPLICA",
2> "waitForFinalState":"false"}
2> 1962043 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=._designer_testSetupMutable&newCollection=true&name=._designer_testSetupMutable_shard1_replica_n1&action=CREATE&numShards=1&collection=._designer_testSetupMutable&shard=shard1&wt=javabin&version=2&replicaType=NRT
2> 1962054 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
2> 1962055 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.IndexSchema Schema name=default-config
2> 1962057 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitNorms to be specified in schema, hardcoded behavior is omitNorms=true
2> 1962057 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitTermFreqAndPositions to be specified in schema, hardcoded behavior is omitTermFreqAndPositions=true
2> 1962057 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termOffsets to be specified in schema, hardcoded behavior is termOffsets=false
2> 1962057 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow termPositions to be specified in schema, hardcoded behavior is termPositions=false
2> 1962057 WARN (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.AbstractSpatialPrefixTreeFieldType FieldType SpatialRecursivePrefixTreeFieldType does not allow omitPositions to be specified in schema, hardcoded behavior is omitPositions=true
2> 1962090 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
2> 1962090 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore '._designer_testSetupMutable_shard1_replica_n1' using configuration from configset ._designer_testSetupMutable, trusted=true
2> 1962091 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SolrCore [[._designer_testSetupMutable_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1/._designer_testSetupMutable_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.handler.designer.TestSchemaDesignerConfigSetHelper_7C7ADFBA82104386-001/tempDir-001/node1/._designer_testSetupMutable_shard1_replica_n1/data/]
2> 1962129 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
2> 1962129 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
2> 1962129 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
2> 1962130 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
2> 1962131 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/._designer_testSetupMutable
2> 1962131 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/._designer_testSetupMutable
2> 1962131 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/._designer_testSetupMutable/managed-schema.xml
2> 1962132 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.ZkIndexSchemaReader Current schema version 1 is already the latest
2> 1962132 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.s.DirectSolrSpellChecker init: {name=default, field=_text_, classname=solr.DirectSolrSpellChecker, distanceMeasure=internal, accuracy=0.5, maxQueryFrequency=0.01, maxEdits=2, minPrefix=1, maxInspections=5, minQueryLength=4}
2> 1962132 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
2> 1962133 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1721678620531884032
2> 1962134 INFO (searcherExecutor-21842-thread-1-processing-127.0.0.1:34851_solr ._designer_testSetupMutable_shard1_replica_n1 ._designer_testSetupMutable shard1 core_node2) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.QuerySenderListener QuerySenderListener done.
2> 1962134 INFO (searcherExecutor-21842-thread-1-processing-127.0.0.1:34851_solr ._designer_testSetupMutable_shard1_replica_n1 ._designer_testSetupMutable shard1 core_node2) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
2> 1962135 INFO (searcherExecutor-21842-thread-1-processing-127.0.0.1:34851_solr ._designer_testSetupMutable_shard1_replica_n1 ._designer_testSetupMutable shard1 core_node2) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SolrCore [._designer_testSetupMutable_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
2> 1962138 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/._designer_testSetupMutable/terms/shard1 to Terms{values={core_node2=0}, version=0} for registerTerm
2> 1962138 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/._designer_testSetupMutable/leaders/shard1
2> 1962142 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
2> 1962142 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
2> 1962142 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:34851/solr/._designer_testSetupMutable_shard1_replica_n1/
2> 1962142 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
2> 1962143 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:34851/solr/._designer_testSetupMutable_shard1_replica_n1/ has no replicas
2> 1962143 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/._designer_testSetupMutable/leaders/shard1/leader after winning as /collections/._designer_testSetupMutable/leader_elect/shard1/election/73081925156274180-core_node2-n_0000000000
2> 1962145 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:34851/solr/._designer_testSetupMutable_shard1_replica_n1/ shard1
2> 1962148 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr c:._designer_testSetupMutable s:shard1 r:core_node2 x:._designer_testSetupMutable_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
2> 1962150 INFO (qtp1816365645-34169) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=._designer_testSetupMutable&newCollection=true&name=._designer_testSetupMutable_shard1_replica_n1&action=CREATE&numShards=1&collection=._designer_testSetupMutable&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=107
2> 1962151 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 1962151 INFO (qtp1816365645-34168) [n:127.0.0.1:34851_solr] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=._designer_testSetupMutable&name=._designer_testSetupMutable&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=224
2> 1962152 INFO (TEST-TestSchemaDesignerConfigSetHelper.testSetupMutable-seed#[7C7ADFBA82104386]) [] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 1962156 IN
[...truncated too long message...]
ation: ../html-site
Incremental build: disabled. Enable with --incremental
Generating...
asciidoctor: WARNING: skipping reference to missing attribute: role
asciidoctor: WARNING: skipping reference to missing attribute: node
done in 18.545 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkSite
Processed 5736 links (5055 relative) to 3886 anchors in 245 files
> Task :solr:solr-ref-guide:test NO-SOURCE
> Task :solr:solr-ref-guide:wipeTaskTemp
> Task :solr:solr-ref-guide:check
> Task :solr:solrj:test
:solr:solrj:test (SUCCESS): 1705 test(s), 21 skipped
> Task :solr:solrj:wipeTaskTemp
> Task :solr:solrj:check
> Task :solr:test-framework:test
:solr:test-framework:test (SUCCESS): 15 test(s)
> Task :solr:test-framework:wipeTaskTemp
> Task :solr:test-framework:check
> Task :solr:webapp:test NO-SOURCE
> Task :solr:webapp:wipeTaskTemp
> Task :solr:webapp:check
> Task :solr:contrib:analysis-extras:test
:solr:contrib:analysis-extras:test (SUCCESS): 30 test(s)
> Task :solr:contrib:analysis-extras:wipeTaskTemp
> Task :solr:contrib:analysis-extras:check
> Task :solr:contrib:analytics:test
:solr:contrib:analytics:test (SUCCESS): 472 test(s)
> Task :solr:contrib:analytics:wipeTaskTemp
> Task :solr:contrib:analytics:check
> Task :solr:contrib:clustering:test
:solr:contrib:clustering:test (SUCCESS): 15 test(s)
> Task :solr:contrib:clustering:wipeTaskTemp
> Task :solr:contrib:clustering:check
> Task :solr:contrib:extraction:test
:solr:contrib:extraction:test (SUCCESS): 20 test(s)
> Task :solr:contrib:extraction:wipeTaskTemp
> Task :solr:contrib:extraction:check
> Task :solr:contrib:gcs-repository:test
:solr:contrib:gcs-repository:test (SUCCESS): 13 test(s)
> Task :solr:contrib:gcs-repository:wipeTaskTemp
> Task :solr:contrib:gcs-repository:check
> Task :solr:contrib:jaegertracer-configurator:test
:solr:contrib:jaegertracer-configurator:test (SUCCESS): 1 test(s)
> Task :solr:contrib:jaegertracer-configurator:wipeTaskTemp
> Task :solr:contrib:jaegertracer-configurator:check
> Task :solr:contrib:langid:test
:solr:contrib:langid:test (SUCCESS): 43 test(s)
> Task :solr:contrib:langid:wipeTaskTemp
> Task :solr:contrib:langid:check
> Task :solr:contrib:ltr:test
:solr:contrib:ltr:test (SUCCESS): 164 test(s)
> Task :solr:contrib:ltr:wipeTaskTemp
> Task :solr:contrib:ltr:check
> Task :solr:contrib:prometheus-exporter:test
:solr:contrib:prometheus-exporter:test (SUCCESS): 20 test(s)
> Task :solr:contrib:prometheus-exporter:wipeTaskTemp
> Task :solr:contrib:prometheus-exporter:check
> Task :solr:contrib:s3-repository:test
:solr:contrib:s3-repository:test (SUCCESS): 42 test(s)
> Task :solr:contrib:s3-repository:wipeTaskTemp
> Task :solr:contrib:s3-repository:check
> Task :solr:contrib:scripting:test
:solr:contrib:scripting:test (SUCCESS): 22 test(s), 1 skipped
> Task :solr:contrib:scripting:wipeTaskTemp
> Task :solr:contrib:scripting:check
The slowest tests (exceeding 500 ms) during this run:
199.47s TestRebalanceLeaders.testRebalanceLeaders (:solr:core)
138.64s TestStressLiveNodes.testStress (:solr:core)
122.72s TestIntervalFaceting.testRandom (:solr:core)
96.60s TestPackages.testPluginLoading (:solr:core)
74.33s TestRandomFaceting.testRandomFaceting (:solr:core)
65.83s TestDistributedSearch.test (:solr:core)
65.66s TestRangeQuery.testCompareTypesRandomRangeQueries (:solr:core)
64.40s PeerSyncReplicationTest.test (:solr:core)
63.51s TestTlogReplica.testRebalanceLeaders (:solr:core)
54.29s HttpPartitionWithTlogReplicasTest.test (:solr:core)
The slowest suites (exceeding 1s) during this run:
220.96s TestJsonFacets (:solr:core)
203.28s TestRebalanceLeaders (:solr:core)
186.75s ShardSplitTest (:solr:core)
172.32s TestPackages (:solr:core)
148.43s TestReplicationHandler (:solr:core)
139.58s TestStressLiveNodes (:solr:core)
123.83s TestIntervalFaceting (:solr:core)
122.39s CollectionsAPIDistributedZkTest (:solr:core)
117.20s TestTlogReplica (:solr:core)
116.76s SoftAutoCommitTest (:solr:core)
ERROR: The following test(s) have failed:
- org.apache.solr.cloud.PackageManagerCLITest.testPackageManager (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.PackageManagerCLITest.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.cloud.PackageManagerCLITest.testPackageManager" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=7C7ADFBA82104386 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=ISO-8859-1
- org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.classMethod (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=7C7ADFBA82104386 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=ISO-8859-1
- org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.classMethod (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.handler.designer.TestSchemaDesignerConfigSetHelper.classMethod" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=7C7ADFBA82104386 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=ISO-8859-1
Deprecated Gradle features were used in this build, making it incompatible with Gradle 8.0.
You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins.
See https://docs.gradle.org/7.2/userguide/command_line_interface.html#sec:command_line_warnings
BUILD SUCCESSFUL in 52m 42s
412 actionable tasks: 412 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:3069)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2948)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2929)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3317)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-1
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1800)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:1001)
at hudson.FilePath.act(FilePath.java:1159)
at hudson.FilePath.act(FilePath.java:1148)
at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
at hudson.model.Build$BuildExecution.post2(Build.java:177)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
at hudson.model.Run.execute(Run.java:1931)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3319)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:376)
at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
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:1161)
at hudson.FilePath.act(FilePath.java:1148)
at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
at hudson.model.Build$BuildExecution.post2(Build.java:177)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
at hudson.model.Run.execute(Run.java:1931)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
[Checks API] No suitable checks publisher found.
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] Solr » Solr-Check-9.x - Build # 25 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Solr/job/Solr-Check-9.x/25/
1 tests failed.
FAILED: org.apache.solr.cloud.PackageManagerCLITest.testPackageManager
Error Message:
java.lang.AssertionError: Non-zero status returned for: [-solrUrl, https://127.0.0.1:45109/solr, deploy, --update, -y, question-answer, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
Stack Trace:
java.lang.AssertionError: Non-zero status returned for: [-solrUrl, https://127.0.0.1:45109/solr, deploy, --update, -y, question-answer, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
at __randomizedtesting.SeedInfo.seed([C5F4F4F7D5B7C8BC:C65EBF99D7591717]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.apache.solr.cloud.PackageManagerCLITest.run(PackageManagerCLITest.java:156)
at org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:120)
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:44)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
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 org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
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:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 1296 lines...]
2> ERROR: System/Runtime.exit(1) or halt(1) calls are not allowed because they terminate the test runner's JVM.
2>
2> 747768 INFO (TEST-PackageManagerCLITest.testPackageManager-seed#[C5F4F4F7D5B7C8BC]) [] o.a.s.SolrTestCaseJ4 ###Ending testPackageManager
> java.lang.AssertionError: Non-zero status returned for: [-solrUrl, https://127.0.0.1:45109/solr, deploy, --update, -y, question-answer, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
> at __randomizedtesting.SeedInfo.seed([C5F4F4F7D5B7C8BC:C65EBF99D7591717]:0)
> at org.junit.Assert.fail(Assert.java:89)
> at org.junit.Assert.failNotEquals(Assert.java:835)
> at org.junit.Assert.assertEquals(Assert.java:647)
> at org.apache.solr.cloud.PackageManagerCLITest.run(PackageManagerCLITest.java:156)
> at org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:120)
> 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:44)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> 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 org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> 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:43)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
> 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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
> at java.base/java.lang.Thread.run(Thread.java:834)
2> NOTE: reproduce with: gradlew test --tests PackageManagerCLITest.testPackageManager -Dtests.seed=C5F4F4F7D5B7C8BC -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=tg -Dtests.timezone=America/Rainy_River -Dtests.asserts=true -Dtests.file.encoding=UTF-8
2> 747774 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.e.j.s.AbstractConnector Stopped ServerConnector@2ed2a112{HTTP/1.1, (http/1.1)}{0.0.0.0:0}
2> 747775 WARN (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker-SendThread(127.0.0.1:36451)) [] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10a02f12a660005.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10a02f12a660005, 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 0x10a02f12a660005, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1280) [zookeeper-3.7.0.jar:3.7.0]
2> 747877 INFO (jetty-closer-7672-thread-1) [] o.e.j.s.AbstractConnector Stopped ServerConnector@33a27241{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:0}
2> 747877 INFO (jetty-closer-7672-thread-1) [] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@b2200a5{/solr,null,STOPPED}
2> 747877 INFO (jetty-closer-7672-thread-1) [] o.e.j.s.session node0 Stopped scavenging
2> 747878 INFO (jetty-closer-7672-thread-1) [] o.a.s.c.CoreContainer Shutting down CoreContainer instance=943353296
2> 747878 INFO (jetty-closer-7672-thread-1) [] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:45109_solr
2> 747879 INFO (jetty-closer-7672-thread-1) [] o.a.s.c.ZkController Publish this node as DOWN...
2> 747879 INFO (jetty-closer-7672-thread-1) [] o.a.s.c.ZkController Publish node=127.0.0.1:45109_solr as DOWN
2> 747879 INFO (zkCallback-7607-thread-7) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
2> 747882 INFO (coreCloseExecutor-7675-thread-1) [n:127.0.0.1:45109_solr] o.a.s.c.SolrCore [abc_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@25635c78
2> 747882 INFO (coreCloseExecutor-7675-thread-1) [n:127.0.0.1:45109_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.abc.shard1.replica_n1 tag=SolrCore@25635c78
2> 747882 INFO (coreCloseExecutor-7675-thread-1) [n:127.0.0.1:45109_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.abc.shard1.leader tag=SolrCore@25635c78
2> 747882 INFO (coreCloseExecutor-7675-thread-2) [n:127.0.0.1:45109_solr] o.a.s.c.SolrCore [def_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@545ae861
2> 747882 INFO (coreCloseExecutor-7675-thread-2) [n:127.0.0.1:45109_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.def.shard1.replica_n1 tag=SolrCore@545ae861
2> 747882 INFO (coreCloseExecutor-7675-thread-2) [n:127.0.0.1:45109_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.def.shard1.leader tag=SolrCore@545ae861
2> 747883 INFO (coreCloseExecutor-7675-thread-1) [n:127.0.0.1:45109_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 747883 INFO (coreCloseExecutor-7675-thread-2) [n:127.0.0.1:45109_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 747884 INFO (jetty-closer-7672-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
2> 747884 INFO (jetty-closer-7672-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
2> 747884 INFO (jetty-closer-7672-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
2> 747884 INFO (jetty-closer-7672-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
2> 747885 INFO (closeThreadPool-7677-thread-2) [] o.a.s.c.Overseer Overseer (id=74875578626736132-127.0.0.1:45109_solr-n_0000000000) closing
2> 747885 INFO (OverseerStateUpdate-74875578626736132-127.0.0.1:45109_solr-n_0000000000) [n:127.0.0.1:45109_solr] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:45109_solr
2> 747886 INFO (closeThreadPool-7677-thread-1) [] o.a.s.c.Overseer Overseer (id=74875578626736132-127.0.0.1:45109_solr-n_0000000000) closing
2> 747987 INFO (jetty-closer-7672-thread-1) [] o.a.s.c.Overseer Overseer (id=74875578626736132-127.0.0.1:45109_solr-n_0000000000) closing
2> 757499 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
2> 757701 WARN (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Watch limit violations:
2> Maximum concurrent create/delete watches above limit:
2>
2> 5 /solr/configs/conf1
2> 2 /solr/aliases.json
2> 2 /solr/collections/def/terms/shard1
2> 2 /solr/collections/abc/terms/shard1
2>
2> Maximum concurrent data watches above limit:
2>
2> 18 /solr/collections/def/state.json
2> 16 /solr/collections/abc/state.json
2> 2 /solr/packages.json
2> 2 /solr/clusterprops.json
2>
2> Maximum concurrent children watches above limit:
2>
2> 19 /solr/overseer/queue
2> 8 /solr/overseer/collection-queue-work
2> 6 /solr/collections
2> 6 /solr/collections/abc/state.json
2> 6 /solr/collections/def/state.json
2> 4 /solr/live_nodes
2>
2> 757703 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:36451
2> 757703 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36451
2> 757703 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36451
2> 757705 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-219 after mutting 0 log messages
2> 757705 INFO (SUITE-PackageManagerCLITest-seed#[C5F4F4F7D5B7C8BC]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-220 for ERROR logs matching regex: ignore_exception
2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.PackageManagerCLITest_C5F4F4F7D5B7C8BC-001
2> NOTE: test params are: codec=Lucene90, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=tg, timezone=America/Rainy_River
2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 11.0.12 (64-bit)/cpus=4,threads=2,free=124725472,total=435159040
2> NOTE: All tests run in this JVM: [WrapperMergePolicyFactoryTest, SolrTestCaseJ4DeleteCoreTest, JvmMetricsTest, SolrGraphiteReporterTest, SolrTestCaseJ4Test, TestEmbeddedSolrServerSchemaAPI, DistributedSpellCheckComponentTest, TestExpandComponent, PhrasesIdentificationComponentTest, UpdateLogCloudTest, FacetPivotSmallTest, TermVectorComponentTest, TestHttpShardHandlerFactory, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotLongTailTest, TestTrackingShardHandlerFactory, QueryComponentPartialResultsTest, TestSQLHandler, PropertiesRequestHandlerTest, TestConfigsApi, V2CollectionsAPIMappingTest, CoreAdminRequestStatusTest, ThreadDumpHandlerTest, LukeRequestHandlerTest, CoreAdminHandlerTest, CoreMergeIndexesAdminHandlerTest, V2CollectionBackupsAPIMappingTest, RequestLoggingTest, TaggingAttributeTest, TestHealthCheckHandlerLegacyMode, FieldAnalysisRequestHandlerTest, TestIncrementalCoreBackup, TestCSVLoader, V2StandaloneTest, TestStressThreadBackup, PingRequestHandlerTest, TestSchemaDesignerSettingsDAO, TestConfigReload, TestUnifiedSolrHighlighter, TestUnifiedSolrHighlighterWithoutStoredId, AllowListUrlCheckerTest, CertAuthPluginTest, TestImpersonationWithHadoopAuth, TestDelegationWithHadoopAuth, TestSha256AuthenticationProvider, AuditLoggerPluginTest, TestTolerantSearch, SuggesterTSTTest, SuggesterFSTTest, TestFreeTextSuggestions, ConjunctionSolrSpellCheckerTest, IndexBasedSpellCheckerTest, SpellPossibilityIteratorTest, TestNumericTokenStream, TestLegacyTerms, TestFieldCacheWithThreads, TestDocTermOrdsUninvertLimit, TestFieldCacheSort, BasicFunctionalityTest, JSONWriterTest, TestSubQueryTransformerCrossCore, TestPHPSerializedResponseWriter, TestSolrQueryResponse, TestRawTransformer, TokenizerChainTest, TestDeprecatedFilters, TestReversedWildcardFilterFactory, DistribDocExpirationUpdateProcessorTest, ReplaceNodeTest, TestRequestForwarding, DeleteStatusTest, OverseerModifyCollectionTest, SolrXmlInZkTest, TestTolerantUpdateProcessorRandomCloud, TriLevelCompositeIdRoutingTest, RecoveryAfterSoftCommitTest, UnloadDistributedZkTest, SaslZkACLProviderTest, TestRandomFlRTGCloud, TestPullReplicaWithAuth, SliceStateTest, TestSkipOverseerOperations, RecoveryZkTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsRecoverLeaseTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsWriteToMultipleCollectionsTest, CollectionStateZnodeTest, TestLeaderElectionWithEmptyReplica, ReindexCollectionTest, TestTlogReplayVsRecovery, CleanupOldIndexTest, TestLeaderElectionZkExpiry, ForceLeaderWithTlogReplicasTest, DistributedQueueTest, VMParamsZkACLAndCredentialsProvidersTest, CreateRoutedAliasTest, HttpPartitionOnCommitTest, TestSolrCloudWithDelegationTokens, RemoteQueryErrorTest, DeleteInactiveReplicaTest, DistribJoinFromCollectionTest, TestLRUStatsCacheCloud, MultiThreadedOCPTest, PackageManagerCLITest]
WARNING: Test org.apache.solr.update.TestInPlaceUpdatesStandalone wrote 23,570,114 bytes of output.
WARNING: Test org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates wrote 15,756,214 bytes of output.
WARNING: Test org.apache.solr.schema.TestCloudSchemaless wrote 12,611,554 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetJoinDomain wrote 17,353,646 bytes of output.
WARNING: Test org.apache.solr.TestDistributedSearch wrote 27,492,819 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestCloudJSONFacetSKG wrote 16,835,155 bytes of output.
WARNING: Test org.apache.solr.search.facet.TestJsonFacets wrote 29,148,224 bytes of output.
WARNING: Test org.apache.solr.search.TestRangeQuery wrote 16,786,113 bytes of output.
WARNING: Test org.apache.solr.TestRandomFaceting wrote 28,546,189 bytes of output.
WARNING: Test org.apache.solr.TestRandomDVFaceting wrote 12,829,056 bytes of output.
WARNING: Test org.apache.solr.search.TestRandomCollapseQParserPlugin wrote 20,937,066 bytes of output.
WARNING: Test org.apache.solr.request.TestIntervalFaceting wrote 16,469,465 bytes of output.
:solr:core:test (FAILURE): 4815 test(s), 1 failure(s), 208 skipped
4815 tests completed, 1 failed, 208 skipped
There were failing tests. See the results at: file:///home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/
> Task :solr:core:wipeTaskTemp
> Task :solr:core:check
> Task :solr:distribution:check
> Task :solr:docker:check
> Task :solr:server:renderSiteJavadoc SKIPPED
> Task :solr:solrj:renderSiteJavadoc
> Task :solr:core:renderSiteJavadoc
> Task :solr:test-framework:renderSiteJavadoc
> Task :solr:benchmark: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: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:gcs-repository: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:contrib:s3-repository:renderSiteJavadoc
> Task :solr:contrib:scripting:renderSiteJavadoc
> Task :solr:documentation:documentation
> Task :solr:documentation:checkBrokenLinks
> Task :solr:documentation:check
> Task :solr:example:check
> Task :solr:packaging:check
> Task :solr:server:test NO-SOURCE
> Task :solr:server:wipeTaskTemp
> Task :solr:server:check
> Task :solr:documentation:collectLuceneJavadocs
> 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.15.5-java
Successfully installed rb-inotify-0.10.1
Successfully installed rb-fsevent-0.11.0
Successfully installed sass-listen-4.0.0
Successfully installed forwardable-extended-2.6.0
Successfully installed rexml-3.2.5
Successfully installed listen-3.7.0
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 eventmachine-1.2.7-java
Successfully installed public_suffix-4.0.6
Successfully installed temple-0.8.2
Successfully installed asciidoctor-2.0.17
Successfully installed safe_yaml-1.0.5
Successfully installed rouge-3.27.0
Successfully installed pathutil-0.16.2
Successfully installed mercenary-0.3.6
Successfully installed liquid-4.0.3
Successfully installed kramdown-2.3.1
Successfully installed jekyll-watch-2.2.1
Successfully installed jekyll-sass-converter-1.5.2
Successfully installed colorator-1.1.0
Successfully installed addressable-2.8.0
Successfully installed http_parser.rb-0.6.0-java
Successfully installed em-websocket-0.5.3
Successfully installed concurrent-ruby-1.1.9
Successfully installed i18n-0.9.5
Successfully installed tilt-2.0.10
Successfully installed slim-4.1.0
Successfully installed jekyll-3.9.1
Successfully installed jekyll-asciidoc-3.0.0
30 gems installed
> Task :solr:solr-ref-guide:prepareLocalJavadocLinksSiteSources
Syncing source files to /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/local-jdoc-links-site-content using props:
htmlOutDir -> ../local-jdoc-links-site
javadocLink -> https://docs.oracle.com/en/java/javase/11/docs/api/java.base/
solrGuideDraftStatus -> DRAFT
solrRootPath -> /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/
solrDocsVersion -> 9.1
solrGuideVersionPath -> 9_1
buildDate -> 2022-01-12
buildYear -> 2022
htmlSolrJavadocs -> link:../../../documentation/build/site
htmlLuceneJavadocs -> link:../../../documentation/build/lucene-javadocs
ivyCommonsCodec -> 1.13
ivyDropwizardMetrics -> 4.1.5
ivyHadoop -> 3.2.0
ivyLog4j -> 2.17.1
ivyOpennlpTools -> 1.9.1
ivyTika -> 1.27
ivyZookeeper -> 3.7.0
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/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/local-jdoc-links-site-content/_data/scrollnav.json
Creating /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/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/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/local-jdoc-links-site-content/_config.yml
Source: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/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: role
asciidoctor: WARNING: skipping reference to missing attribute: node
done in 20.967 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkLocalJavadocLinksSite
Processed 5736 links (5294 relative) to 3886 anchors in 245 files
> Task :solr:solr-ref-guide:prepareSiteSources
Syncing source files to /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/html-site-content using props:
htmlOutDir -> ../html-site
javadocLink -> https://docs.oracle.com/en/java/javase/11/docs/api/java.base/
solrGuideDraftStatus -> DRAFT
solrRootPath -> /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/
solrDocsVersion -> 9.1
solrGuideVersionPath -> 9_1
buildDate -> 2022-01-12
buildYear -> 2022
htmlSolrJavadocs -> https://solr.apache.org/docs/9_1_0/
htmlLuceneJavadocs -> https://lucene.apache.org/core/9_0_0
ivyCommonsCodec -> 1.13
ivyDropwizardMetrics -> 4.1.5
ivyHadoop -> 3.2.0
ivyLog4j -> 2.17.1
ivyOpennlpTools -> 1.9.1
ivyTika -> 1.27
ivyZookeeper -> 3.7.0
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/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/html-site-content/_data/scrollnav.json
Creating /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/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/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/html-site-content/_config.yml
Source: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/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: role
asciidoctor: WARNING: skipping reference to missing attribute: node
done in 20.959 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkSite
Processed 5736 links (5055 relative) to 3886 anchors in 245 files
> Task :solr:solr-ref-guide:test NO-SOURCE
> Task :solr:solr-ref-guide:wipeTaskTemp
> Task :solr:solr-ref-guide:check
> Task :solr:solrj:test
:solr:solrj:test (SUCCESS): 1705 test(s), 24 skipped
> Task :solr:solrj:wipeTaskTemp
> Task :solr:solrj:check
> Task :solr:test-framework:test
:solr:test-framework:test (SUCCESS): 15 test(s)
> Task :solr:test-framework:wipeTaskTemp
> Task :solr:test-framework:check
> Task :solr:webapp:test NO-SOURCE
> Task :solr:webapp:wipeTaskTemp
> Task :solr:webapp:check
> Task :solr:contrib:analysis-extras:test
:solr:contrib:analysis-extras:test (SUCCESS): 30 test(s)
> Task :solr:contrib:analysis-extras:wipeTaskTemp
> Task :solr:contrib:analysis-extras:check
> Task :solr:contrib:analytics:test
:solr:contrib:analytics:test (SUCCESS): 472 test(s)
> Task :solr:contrib:analytics:wipeTaskTemp
> Task :solr:contrib:analytics:check
> Task :solr:contrib:clustering:test
:solr:contrib:clustering:test (SUCCESS): 15 test(s)
> Task :solr:contrib:clustering:wipeTaskTemp
> Task :solr:contrib:clustering:check
> Task :solr:contrib:extraction:test
:solr:contrib:extraction:test (SUCCESS): 20 test(s)
> Task :solr:contrib:extraction:wipeTaskTemp
> Task :solr:contrib:extraction:check
> Task :solr:contrib:gcs-repository:test
:solr:contrib:gcs-repository:test (SUCCESS): 13 test(s), 3 skipped
> Task :solr:contrib:gcs-repository:wipeTaskTemp
> Task :solr:contrib:gcs-repository:check
> Task :solr:contrib:jaegertracer-configurator:test
:solr:contrib:jaegertracer-configurator:test (SUCCESS): 1 test(s)
> Task :solr:contrib:jaegertracer-configurator:wipeTaskTemp
> Task :solr:contrib:jaegertracer-configurator:check
> Task :solr:contrib:langid:test
:solr:contrib:langid:test (SUCCESS): 43 test(s)
> Task :solr:contrib:langid:wipeTaskTemp
> Task :solr:contrib:langid:check
> Task :solr:contrib:ltr:test
:solr:contrib:ltr:test (SUCCESS): 164 test(s)
> Task :solr:contrib:ltr:wipeTaskTemp
> Task :solr:contrib:ltr:check
> Task :solr:contrib:prometheus-exporter:test
:solr:contrib:prometheus-exporter:test (SUCCESS): 20 test(s)
> Task :solr:contrib:prometheus-exporter:wipeTaskTemp
> Task :solr:contrib:prometheus-exporter:check
> Task :solr:contrib:s3-repository:test
:solr:contrib:s3-repository:test (SUCCESS): 42 test(s)
> Task :solr:contrib:s3-repository:wipeTaskTemp
> Task :solr:contrib:s3-repository:check
> Task :solr:contrib:scripting:test
:solr:contrib:scripting:test (SUCCESS): 22 test(s), 1 skipped
> Task :solr:contrib:scripting:wipeTaskTemp
> Task :solr:contrib:scripting:check
The slowest tests (exceeding 500 ms) during this run:
133.16s TestIntervalFaceting.testRandom (:solr:core)
121.96s TestStressLiveNodes.testStress (:solr:core)
112.36s HttpPartitionTest.test (:solr:core)
87.36s TestPackages.testPluginLoading (:solr:core)
69.36s TestDistributedSearch.test (:solr:core)
68.29s PeerSyncReplicationTest.test (:solr:core)
62.82s DistribCursorPagingTest.test (:solr:core)
57.42s TestRandomFaceting.testRandomFaceting (:solr:core)
55.36s HttpPartitionWithTlogReplicasTest.test (:solr:core)
54.57s ReplicationFactorTest.test (:solr:core)
The slowest suites (exceeding 1s) during this run:
169.45s ShardSplitTest (:solr:core)
163.52s TestPackages (:solr:core)
146.04s TestJsonFacets (:solr:core)
139.16s TestReplicationHandler (:solr:core)
134.60s TestIntervalFaceting (:solr:core)
122.97s TestStressLiveNodes (:solr:core)
117.52s SoftAutoCommitTest (:solr:core)
112.58s HttpPartitionTest (:solr:core)
96.27s TestRecovery (:solr:core)
91.92s DistribDocExpirationUpdateProcessorTest (:solr:core)
ERROR: The following test(s) have failed:
- org.apache.solr.cloud.PackageManagerCLITest.testPackageManager (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.PackageManagerCLITest.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.cloud.PackageManagerCLITest.testPackageManager" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=C5F4F4F7D5B7C8BC -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=UTF-8
Deprecated Gradle features were used in this build, making it incompatible with Gradle 8.0.
You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins.
See https://docs.gradle.org/7.2/userguide/command_line_interface.html#sec:command_line_warnings
BUILD SUCCESSFUL in 54m 55s
412 actionable tasks: 412 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:3069)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2948)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2929)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3317)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1800)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:1001)
at hudson.FilePath.act(FilePath.java:1159)
at hudson.FilePath.act(FilePath.java:1148)
at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
at hudson.model.Build$BuildExecution.post2(Build.java:177)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
at hudson.model.Run.execute(Run.java:1931)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3319)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:376)
at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
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:1161)
at hudson.FilePath.act(FilePath.java:1148)
at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
at hudson.model.Build$BuildExecution.post2(Build.java:177)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
at hudson.model.Run.execute(Run.java:1931)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
[Checks API] No suitable checks publisher found.
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] Solr » Solr-Check-9.x - Build # 24 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Solr/job/Solr-Check-9.x/24/
2 tests failed.
FAILED: org.apache.solr.cloud.api.collections.TestCollectionAPI.test
Error Message:
org.apache.solr.client.solrj.SolrServerException: IOException occurred when talking to server at: http://127.0.0.1:38497
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occurred when talking to server at: http://127.0.0.1:38497
at __randomizedtesting.SeedInfo.seed([FCB98BBEBCF8C986:74EDB4641204A47E]:0)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:682)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:239)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:222)
at app//org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:389)
at app//org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:359)
at app//org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1132)
at app//org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:898)
at app//org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:832)
at app//org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:226)
at app//org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:243)
at app//org.apache.solr.cloud.api.collections.TestCollectionAPI.clusterStatusWithCollectionHealthState(TestCollectionAPI.java:381)
at app//org.apache.solr.cloud.api.collections.TestCollectionAPI.test(TestCollectionAPI.java:96)
at java.base@11.0.12/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base@11.0.12/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base@11.0.12/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base@11.0.12/java.lang.reflect.Method.invoke(Method.java:566)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at app//org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1081)
at app//org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1052)
at app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:44)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
at app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base@11.0.12/java.lang.Thread.run(Thread.java:834)
Caused by: org.apache.http.NoHttpResponseException: 127.0.0.1:38497 failed to respond
at app//org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:141)
at app//org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at app//org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at app//org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at app//org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
at app//org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at app//org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at app//org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at app//org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
at app//org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at app//org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at app//org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at app//org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at app//org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:551)
... 59 more
FAILED: org.apache.solr.cloud.PackageManagerCLITest.testPackageManager
Error Message:
java.lang.AssertionError: Non-zero status returned for: [-solrUrl, http://127.0.0.1:37567/solr, deploy, question-answer, -y, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
Stack Trace:
java.lang.AssertionError: Non-zero status returned for: [-solrUrl, http://127.0.0.1:37567/solr, deploy, question-answer, -y, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
at __randomizedtesting.SeedInfo.seed([FCB98BBEBCF8C986:FF13C0D0BE16162D]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.apache.solr.cloud.PackageManagerCLITest.run(PackageManagerCLITest.java:156)
at org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:94)
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:44)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
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 org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
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:43)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 1072 lines...]
2> ERROR: System/Runtime.exit(1) or halt(1) calls are not allowed because they terminate the test runner's JVM.
2>
2> 745175 INFO (TEST-PackageManagerCLITest.testPackageManager-seed#[FCB98BBEBCF8C986]) [] o.a.s.SolrTestCaseJ4 ###Ending testPackageManager
> java.lang.AssertionError: Non-zero status returned for: [-solrUrl, http://127.0.0.1:37567/solr, deploy, question-answer, -y, -collections, abc, -p, RH-HANDLER-PATH=/mypath2] expected:<0> but was:<1>
> at __randomizedtesting.SeedInfo.seed([FCB98BBEBCF8C986:FF13C0D0BE16162D]:0)
> at org.junit.Assert.fail(Assert.java:89)
> at org.junit.Assert.failNotEquals(Assert.java:835)
> at org.junit.Assert.assertEquals(Assert.java:647)
> at org.apache.solr.cloud.PackageManagerCLITest.run(PackageManagerCLITest.java:156)
> at org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:94)
> 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:44)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> 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 org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> 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:43)
> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
> 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.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.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.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
> at java.base/java.lang.Thread.run(Thread.java:834)
2> NOTE: reproduce with: gradlew test --tests PackageManagerCLITest.testPackageManager -Dtests.seed=FCB98BBEBCF8C986 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=az-Cyrl -Dtests.timezone=Pacific/Guam -Dtests.asserts=true -Dtests.file.encoding=UTF-8
2> 745177 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.e.j.s.AbstractConnector Stopped ServerConnector@1251ebd2{HTTP/1.1, (http/1.1)}{0.0.0.0:0}
2> 745294 INFO (jetty-closer-7617-thread-1) [] o.e.j.s.AbstractConnector Stopped ServerConnector@5f700cd5{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
2> 745294 INFO (jetty-closer-7617-thread-1) [] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@bd9bf6a{/solr,null,STOPPED}
2> 745294 INFO (jetty-closer-7617-thread-1) [] o.e.j.s.session node0 Stopped scavenging
2> 745295 INFO (jetty-closer-7617-thread-1) [] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1200545705
2> 745295 INFO (jetty-closer-7617-thread-1) [] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:37567_solr
2> 745296 INFO (jetty-closer-7617-thread-1) [] o.a.s.c.ZkController Publish this node as DOWN...
2> 745296 INFO (jetty-closer-7617-thread-1) [] o.a.s.c.ZkController Publish node=127.0.0.1:37567_solr as DOWN
2> 745296 INFO (zkCallback-7571-thread-2) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
2> 745297 INFO (zkCallback-7571-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for collection [abc] has occurred - updating... (live nodes size: [0])
2> 745298 INFO (zkCallback-7571-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for collection [def] has occurred - updating... (live nodes size: [0])
2> 745299 INFO (coreCloseExecutor-7620-thread-1) [n:127.0.0.1:37567_solr] o.a.s.c.SolrCore [abc_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@6030e7d9
2> 745299 INFO (coreCloseExecutor-7620-thread-1) [n:127.0.0.1:37567_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.abc.shard1.replica_n1 tag=SolrCore@6030e7d9
2> 745299 INFO (coreCloseExecutor-7620-thread-2) [n:127.0.0.1:37567_solr] o.a.s.c.SolrCore [def_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@3fcb152f
2> 745299 INFO (coreCloseExecutor-7620-thread-1) [n:127.0.0.1:37567_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.abc.shard1.leader tag=SolrCore@6030e7d9
2> 745299 INFO (coreCloseExecutor-7620-thread-2) [n:127.0.0.1:37567_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.def.shard1.replica_n1 tag=SolrCore@3fcb152f
2> 745299 INFO (coreCloseExecutor-7620-thread-2) [n:127.0.0.1:37567_solr] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.def.shard1.leader tag=SolrCore@3fcb152f
2> 745300 INFO (coreCloseExecutor-7620-thread-2) [n:127.0.0.1:37567_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 745300 INFO (coreCloseExecutor-7620-thread-1) [n:127.0.0.1:37567_solr] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close() ... SKIPPED (unnecessary).
2> 745301 INFO (jetty-closer-7617-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
2> 745301 INFO (jetty-closer-7617-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
2> 745301 INFO (jetty-closer-7617-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
2> 745301 INFO (jetty-closer-7617-thread-1) [] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
2> 745304 INFO (closeThreadPool-7622-thread-1) [] o.a.s.c.Overseer Overseer (id=74874220763742212-127.0.0.1:37567_solr-n_0000000000) closing
2> 745304 INFO (OverseerStateUpdate-74874220763742212-127.0.0.1:37567_solr-n_0000000000) [n:127.0.0.1:37567_solr] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:37567_solr
2> 745305 INFO (closeThreadPool-7622-thread-2) [] o.a.s.c.Overseer Overseer (id=74874220763742212-127.0.0.1:37567_solr-n_0000000000) closing
2> 745306 WARN (jetty-launcher-7560-thread-1-SendThread(127.0.0.1:38893)) [] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10a01b503750004.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10a01b503750004, 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 0x10a01b503750004, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1280) [zookeeper-3.7.0.jar:3.7.0]
2> 745406 INFO (jetty-closer-7617-thread-1) [] o.a.s.c.Overseer Overseer (id=74874220763742212-127.0.0.1:37567_solr-n_0000000000) closing
2> 754290 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
2> 754291 WARN (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker-SendThread(127.0.0.1:38893)) [] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10a01b503750000.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10a01b503750000, 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 0x10a01b503750000, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1280) [zookeeper-3.7.0.jar:3.7.0]
2> 754393 WARN (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker-SendThread(127.0.0.1:38893)) [] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10a01b503750001.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10a01b503750001, 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 0x10a01b503750001, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1280) [zookeeper-3.7.0.jar:3.7.0]
2> 754494 WARN (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Watch limit violations:
2> Maximum concurrent create/delete watches above limit:
2>
2> 2 /solr/aliases.json
2> 2 /solr/collections/def/terms/shard1
2> 2 /solr/clusterprops.json
2> 2 /solr/collections/abc/terms/shard1
2>
2> Maximum concurrent data watches above limit:
2>
2> 7 /solr/collections/abc/state.json
2> 7 /solr/collections/def/state.json
2>
2> Maximum concurrent children watches above limit:
2>
2> 6 /solr/collections
2> 6 /solr/collections/abc/state.json
2> 6 /solr/collections/def/state.json
2> 4 /solr/live_nodes
2>
2> 754497 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:38893
2> 754497 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38893
2> 754497 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.c.ZkTestServer connecting to 127.0.0.1 38893
2> 754498 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-219 after mutting 0 log messages
2> 754498 INFO (SUITE-PackageManagerCLITest-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-220 for ERROR logs matching regex: ignore_exception
2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.PackageManagerCLITest_FCB98BBEBCF8C986-001
2> NOTE: test params are: codec=Asserting(Lucene90): {}, docValues:{}, maxPointsInLeafNode=1825, maxMBSortInHeap=5.668630098259385, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=az-Cyrl, timezone=Pacific/Guam
2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 11.0.12 (64-bit)/cpus=4,threads=2,free=221061272,total=435159040
2> NOTE: All tests run in this JVM: [WrapperMergePolicyFactoryTest, SolrTestCaseJ4DeleteCoreTest, JvmMetricsTest, SolrGraphiteReporterTest, SolrTestCaseJ4Test, TestEmbeddedSolrServerSchemaAPI, DistributedSpellCheckComponentTest, TestExpandComponent, PhrasesIdentificationComponentTest, UpdateLogCloudTest, FacetPivotSmallTest, TermVectorComponentTest, TestHttpShardHandlerFactory, DistributedFacetPivotSmallAdvancedTest, DistributedFacetPivotLongTailTest, TestTrackingShardHandlerFactory, QueryComponentPartialResultsTest, TestSQLHandler, PropertiesRequestHandlerTest, TestConfigsApi, V2CollectionsAPIMappingTest, CoreAdminRequestStatusTest, ThreadDumpHandlerTest, LukeRequestHandlerTest, CoreAdminHandlerTest, CoreMergeIndexesAdminHandlerTest, V2CollectionBackupsAPIMappingTest, RequestLoggingTest, TaggingAttributeTest, TestHealthCheckHandlerLegacyMode, FieldAnalysisRequestHandlerTest, TestIncrementalCoreBackup, TestCSVLoader, V2StandaloneTest, TestStressThreadBackup, PingRequestHandlerTest, TestSchemaDesignerSettingsDAO, TestConfigReload, TestUnifiedSolrHighlighter, TestUnifiedSolrHighlighterWithoutStoredId, AllowListUrlCheckerTest, CertAuthPluginTest, TestImpersonationWithHadoopAuth, TestDelegationWithHadoopAuth, TestSha256AuthenticationProvider, AuditLoggerPluginTest, TestTolerantSearch, SuggesterTSTTest, SuggesterFSTTest, TestFreeTextSuggestions, ConjunctionSolrSpellCheckerTest, IndexBasedSpellCheckerTest, SpellPossibilityIteratorTest, TestNumericTokenStream, TestLegacyTerms, TestFieldCacheWithThreads, TestDocTermOrdsUninvertLimit, TestFieldCacheSort, BasicFunctionalityTest, JSONWriterTest, TestSubQueryTransformerCrossCore, TestPHPSerializedResponseWriter, TestSolrQueryResponse, TestRawTransformer, TokenizerChainTest, TestDeprecatedFilters, TestReversedWildcardFilterFactory, DistribDocExpirationUpdateProcessorTest, ReplaceNodeTest, TestRequestForwarding, DeleteStatusTest, OverseerModifyCollectionTest, SolrXmlInZkTest, TestTolerantUpdateProcessorRandomCloud, TriLevelCompositeIdRoutingTest, RecoveryAfterSoftCommitTest, UnloadDistributedZkTest, SaslZkACLProviderTest, TestRandomFlRTGCloud, TestPullReplicaWithAuth, SliceStateTest, TestSkipOverseerOperations, RecoveryZkTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsRecoverLeaseTest, HdfsChaosMonkeyNothingIsSafeTest, HdfsWriteToMultipleCollectionsTest, CollectionStateZnodeTest, TestLeaderElectionWithEmptyReplica, ReindexCollectionTest, TestTlogReplayVsRecovery, CleanupOldIndexTest, TestLeaderElectionZkExpiry, ForceLeaderWithTlogReplicasTest, DistributedQueueTest, VMParamsZkACLAndCredentialsProvidersTest, CreateRoutedAliasTest, HttpPartitionOnCommitTest, TestSolrCloudWithDelegationTokens, RemoteQueryErrorTest, DeleteInactiveReplicaTest, DistribJoinFromCollectionTest, TestLRUStatsCacheCloud, MultiThreadedOCPTest, PackageManagerCLITest]
org.apache.solr.cloud.api.collections.TestCollectionAPI > test FAILED
org.apache.solr.client.solrj.SolrServerException: IOException occurred when talking to server at: http://127.0.0.1:38497
at __randomizedtesting.SeedInfo.seed([FCB98BBEBCF8C986:74EDB4641204A47E]:0)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:682)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:239)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:222)
at app//org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:389)
at app//org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:359)
at app//org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1132)
at app//org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:898)
at app//org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:832)
at app//org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:226)
at app//org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:243)
at app//org.apache.solr.cloud.api.collections.TestCollectionAPI.clusterStatusWithCollectionHealthState(TestCollectionAPI.java:381)
at app//org.apache.solr.cloud.api.collections.TestCollectionAPI.test(TestCollectionAPI.java:96)
at java.base@11.0.12/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base@11.0.12/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base@11.0.12/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base@11.0.12/java.lang.reflect.Method.invoke(Method.java:566)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at app//org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1081)
at app//org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1052)
at app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:44)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45)
at app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43)
at app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44)
at app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60)
at app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47)
at app//org.junit.rules.RunRules.evaluate(RunRules.java:20)
at app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at app//com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base@11.0.12/java.lang.Thread.run(Thread.java:834)
Caused by:
org.apache.http.NoHttpResponseException: 127.0.0.1:38497 failed to respond
at app//org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:141)
at app//org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
at app//org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
at app//org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
at app//org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:157)
at app//org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
at app//org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
at app//org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
at app//org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:186)
at app//org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
at app//org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
at app//org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
at app//org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
at app//org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
at app//org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:551)
... 59 more
org.apache.solr.cloud.api.collections.TestCollectionAPI > test suite's output saved to /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.api.collections.TestCollectionAPI.txt, copied below:
2> 780889 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/server/solr/configsets/_default/conf'
2> 780889 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
2> 780890 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-224 after mutting 0 log messages
2> 780890 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-225 for ERROR logs matching regex: ignore_exception
2> 780891 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/data-dir-101-001
2> 780892 WARN (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
2> 780892 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
2> 780892 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
2> 780893 INFO (SUITE-TestCollectionAPI-seed#[FCB98BBEBCF8C986]-worker) [] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
2> 780900 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-225 after mutting 0 log messages
2> 780900 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-226 for ERROR logs matching regex: ignore_exception
2> 780901 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
2> 780901 INFO (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
2> 780901 INFO (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Starting server
2> 780902 WARN (ZkTestServer Run Thread) [] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
2> 781001 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer start zk server on port: 40923
2> 781001 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:40923
2> 781001 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:40923
2> 781001 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer connecting to 127.0.0.1 40923
2> 781006 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 781009 INFO (zkConnectionManagerCallback-8280-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 781009 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 781016 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 781020 INFO (zkConnectionManagerCallback-8282-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 781020 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 781021 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
2> 781022 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml
2> 781024 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
2> 781025 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
2> 781026 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
2> 781030 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
2> 781032 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
2> 781034 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
2> 781036 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
2> 781037 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
2> 781038 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkTestServer put /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/resources/test/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
2> 781039 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
2> 781267 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 781267 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 781267 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 11.0.12+8-LTS-237
2> 781268 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 781268 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.session No SessionScavenger set, using defaults
2> 781268 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.session node0 Scavenging every 660000ms
2> 781268 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@dc43b88{/,null,AVAILABLE}
2> 781268 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.AbstractConnector Started ServerConnector@4f27ace1{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:۳۹۴۶۳}
2> 781268 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.s.Server Started @۷۸۱۲۹۹ms
2> 781269 ERROR (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 781269 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 781269 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.s.CoreContainerProvider ___ _ Welcome to Apache Solr™ version 9.1.0
2> 781269 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _ Starting in cloud mode on port null
2> 781269 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr
2> 781269 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.s.CoreContainerProvider |___/\___/_|_| Start time: 2022-01-11T20:15:57.811238Z
2> 781269 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/control-001 (source: servlet config: solr.solr.home)
2> 781272 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 781276 INFO (zkConnectionManagerCallback-8284-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 781276 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 781377 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.NodeConfig Loading solr.xml from SolrHome (not found in ZooKeeper)
2> 781377 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/control-001/solr.xml
2> 781382 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7, but no JMX reporters were configured - adding default JMX reporter.
2> 781815 WARN (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.u.s.S.config Trusting all certificates configured for Client@1dea142a[provider=null,keyStore=null,trustStore=null]
2> 781815 WARN (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1dea142a[provider=null,keyStore=null,trustStore=null]
2> 781817 WARN (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.u.s.S.config Trusting all certificates configured for Client@3c2af124[provider=null,keyStore=null,trustStore=null]
2> 781817 WARN (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3c2af124[provider=null,keyStore=null,trustStore=null]
2> 781819 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40923/solr
2> 781819 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 781822 INFO (zkConnectionManagerCallback-8294-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 781824 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 781925 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater with useDistributedStateUpdate=false. Solr will be using Overseer based cluster state updates.
2> 781926 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 781927 INFO (zkConnectionManagerCallback-8296-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 781927 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 781941 WARN (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
2> 781943 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater with useDistributedStateUpdate=false. Solr will be using Overseer based cluster state updates.
2> 781945 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39463_
2> 781945 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.Overseer Overseer (id=74874223242969092-127.0.0.1:39463_-n_0000000000) starting
2> 781950 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39463_
2> 781950 INFO (OverseerStateUpdate-74874223242969092-127.0.0.1:39463_-n_0000000000) [n:127.0.0.1:39463_] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:39463_
2> 781952 INFO (OverseerStateUpdate-74874223242969092-127.0.0.1:39463_-n_0000000000) [n:127.0.0.1:39463_] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 781953 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.p.PackageLoader /packages.json updated to version -1
2> 781954 WARN (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] 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> 782051 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7
2> 782090 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7
2> 782090 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7
2> 782092 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/control-001/cores
2> 782130 ERROR (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.s.CoreContainerProvider Could not start Solr. Check solr/home property and the logs
2> 782131 ERROR (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.SolrCore null
2> => java.lang.RuntimeException: Encountered IOException: No content to map due to end-of-input
2> at [Source: (byte[])""; line: 1, column: 0]
2> java.lang.RuntimeException: Encountered IOException: No content to map due to end-of-input
2> at [Source: (byte[])""; line: 1, column: 0]
2> at org.apache.solr.servlet.RateLimitManager.onChange(RateLimitManager.java:71) ~[main/:?]
2> at org.apache.solr.common.cloud.ZkStateReader.registerClusterPropertiesListener(ZkStateReader.java:718) ~[solr-solrj-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at org.apache.solr.servlet.CoreContainerProvider.init(CoreContainerProvider.java:230) [main/:?]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:393) [main/:?]
2> at org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:194) [jetty-util-9.4.44.v20210927.jar:9.4.44.v20210927]
2> at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:74) [jetty-util-9.4.44.v20210927.jar:9.4.44.v20210927]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner.retryOnPortBindFailure(JettySolrRunner.java:599) [main/:?]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:537) [main/:?]
2> at org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:505) [main/:?]
2> at org.apache.solr.cloud.AbstractFullDistribZkTestBase.createServers(AbstractFullDistribZkTestBase.java:334) [solr-test-framework-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1079) [solr-test-framework-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1052) [solr-test-framework-9.1.0-SNAPSHOT.jar:9.1.0-SNAPSHOT e8672108bede52e406da536411392ad6381f7bd9 [snapshot build, details omitted]]
2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.6.jar:?]
2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:44) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:45) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [randomizedtesting-runner-2.7.6.jar:?]
2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:43) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:44) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:60) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:47) [lucene-test-framework-9.0.0.jar:9.0.0 0b18b3b965cedaf5eb129aa41243a44c83ca826d - jpountz - 2021-12-01 14:23:49]
2> at org.junit.rules.RunRules.evaluate(RunRules.java:20) [junit-4.13.1.jar:4.13.1]
2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370) [randomizedtesting-runner-2.7.6.jar:?]
2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826) [randomizedtesting-runner-2.7.6.jar:?]
2> at java.lang.Thread.run(Thread.java:834) [?:?]
2> 782135 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [n:127.0.0.1:39463_] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solr.data.dir=/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/tempDir-001/control/data, hostPort=39463, coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/control-001/cores}
2> 782174 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to ZooKeeper
2> 782184 INFO (zkConnectionManagerCallback-8308-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 782184 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 782185 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 782186 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40923/solr ready
2> 782205 INFO (OverseerThreadFactory-8301-thread-1) [] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
2> 782331 INFO (OverseerStateUpdate-74874223242969092-127.0.0.1:39463_-n_0000000000) [n:127.0.0.1:39463_] o.a.s.c.o.SliceMutator createReplica() {
2> "core":"control_collection_shard1_replica_n1",
2> "node_name":"127.0.0.1:39463_",
2> "collection":"control_collection",
2> "shard":"shard1",
2> "state":"down",
2> "type":"NRT",
2> "operation":"ADDREPLICA",
2> "waitForFinalState":"false"}
2> 782437 INFO (zkCallback-8295-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
2> 782448 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ x:control_collection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
2> 782448 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ x:control_collection_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 4 cores with initial capacity of 4
2> 782473 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
2> 782473 WARN (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SolrConfig solrconfig.xml: <jmx> is no longer supported, use solr.xml:/metrics/reporter section instead
2> 782477 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.s.IndexSchema Schema name=test
2> 782481 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
2> 782507 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' using configuration from configset conf1, trusted=true
2> 782507 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 'solr.core.control_collection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7
2> 782508 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/control-001/cores/control_collection_shard1_replica_n1/data/]
2> 782509 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=46, maxMergedSegmentMB=75.744140625, floorSegmentMB=2.158203125, forceMergeDeletesPctAllowed=8.39857767519238, segmentsPerTier=39.0, maxCFSSegmentSizeMB=1.6689453125, noCFSRatio=0.0, deletesPctAllowed=49.27994624922203
2> 782510 WARN (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A, b=B}}}
2> 782552 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
2> 782553 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
2> 782554 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
2> 782554 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
2> 782555 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=26, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
2> 782557 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
2> 782557 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
2> 782558 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
2> 782558 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1721690655660441600
2> 782562 INFO (searcherExecutor-8310-thread-1-processing-127.0.0.1:39463_ control_collection_shard1_replica_n1 control_collection shard1 core_node2) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
2> 782566 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, version=0} for registerTerm
2> 782567 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/control_collection/leaders/shard1
2> 782572 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
2> 782572 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
2> 782572 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39463/control_collection_shard1_replica_n1/
2> 782572 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
2> 782573 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:39463/control_collection_shard1_replica_n1/ has no replicas
2> 782573 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/control_collection/leaders/shard1/leader after winning as /collections/control_collection/leader_elect/shard1/election/74874223242969092-core_node2-n_0000000000
2> 782577 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39463/control_collection_shard1_replica_n1/ shard1
2> 782679 INFO (zkCallback-8295-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
2> 782679 INFO (zkCallback-8295-thread-3) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
2> 782688 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_ c:control_collection s:shard1 r:core_node2 x:control_collection_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
2> 782691 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=243
2> 782693 INFO (qtp1809595411-13131) [n:127.0.0.1:39463_] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 782791 INFO (zkCallback-8295-thread-2) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
2> 782791 INFO (zkCallback-8295-thread-3) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
2> 782791 INFO (zkCallback-8295-thread-1) [] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/control_collection/state.json] for collection [control_collection] has occurred - updating... (live nodes size: [1])
2> 782792 INFO (qtp1809595411-13131) [n:127.0.0.1:39463_] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:39463_&wt=javabin&version=2} status=0 QTime=597
2> 782792 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
2> 782898 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to ZooKeeper
2> 782899 INFO (zkConnectionManagerCallback-8319-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 782899 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 782900 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
2> 782901 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40923/solr ready
2> 782901 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
2> 782905 INFO (OverseerThreadFactory-8301-thread-2) [] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
2> 782905 INFO (OverseerCollectionConfigSetProcessor-74874223242969092-127.0.0.1:39463_-n_0000000000) [] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
2> 783108 WARN (OverseerThreadFactory-8301-thread-2) [] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
2> 783110 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
2> 783113 INFO (qtp1809595411-13134) [n:127.0.0.1:39463_] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&wt=javabin&version=2} status=0 QTime=210
2> 783114 INFO (watches-8316-thread-1) [] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
2> 783114 INFO (watches-8316-thread-1) [] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
2> 783115 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
2> 783115 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
2> 783115 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
2> 783115 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
2> 783116 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrCloudTestCase active slice count: 2 expected: 2
2> 783116 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
2> 783116 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=2
2> 783300 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/shard-1-001 of type NRT for shard2
2> 783301 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 783301 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 783301 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 11.0.12+8-LTS-237
2> 783302 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 783302 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.session No SessionScavenger set, using defaults
2> 783302 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.session node0 Scavenging every 660000ms
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@79d3c1cc{/,null,AVAILABLE}
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.AbstractConnector Started ServerConnector@304a0615{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:۴۲۸۸۳}
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.e.j.s.Server Started @۷۸۳۳۳۳ms
2> 783303 ERROR (closeThreadPool-8320-thread-1) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.a.s.s.CoreContainerProvider ___ _ Welcome to Apache Solr™ version 9.1.0
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _ Starting in cloud mode on port null
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.a.s.s.CoreContainerProvider |___/\___/_|_| Start time: 2022-01-11T20:15:59.845729Z
2> 783303 INFO (closeThreadPool-8320-thread-1) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/shard-1-001 (source: servlet config: solr.solr.home)
2> 783304 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 783308 INFO (zkConnectionManagerCallback-8322-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 783308 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 783309 WARN (closeThreadPool-8320-thread-1-SendThread(127.0.0.1:40923)) [] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x10a01b5973b0007.
2> => EndOfStreamException: Unable to read additional data from server sessionid 0x10a01b5973b0007, 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 0x10a01b5973b0007, likely server has closed socket
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.7.0.jar:3.7.0]
2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1280) [zookeeper-3.7.0.jar:3.7.0]
2> 783409 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.NodeConfig Loading solr.xml from SolrHome (not found in ZooKeeper)
2> 783409 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/shard-1-001/solr.xml
2> 783413 INFO (closeThreadPool-8320-thread-1) [] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7, but no JMX reporters were configured - adding default JMX reporter.
2> 783491 INFO (TEST-TestCollectionAPI.test-seed#[FCB98BBEBCF8C986]) [] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/shard-2-001 of type NRT for shard1
2> 783492 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
2> 783492 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
2> 783492 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 8da83308eeca865e495e53ef315a249d63ba9332; jvm 11.0.12+8-LTS-237
2> 783496 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.session DefaultSessionIdManager workerName=node0
2> 783496 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.session No SessionScavenger set, using defaults
2> 783496 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.session node0 Scavenging every 660000ms
2> 783496 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4855d4e6{/,null,AVAILABLE}
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.AbstractConnector Started ServerConnector@57c3d359{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:۳۸۴۹۷}
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.e.j.s.Server Started @۷۸۳۵۲۷ms
2> 783497 ERROR (closeThreadPool-8320-thread-2) [] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.a.s.s.CoreContainerProvider Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.a.s.s.CoreContainerProvider ___ _ Welcome to Apache Solr™ version 9.1.0
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.a.s.s.CoreContainerProvider / __| ___| |_ _ Starting in cloud mode on port null
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.a.s.s.CoreContainerProvider \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.a.s.s.CoreContainerProvider |___/\___/_|_| Start time: 2022-01-11T20:16:00.039550Z
2> 783497 INFO (closeThreadPool-8320-thread-2) [] o.a.s.s.CoreContainerProvider Solr Home: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/shard-2-001 (source: servlet config: solr.solr.home)
2> 783498 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to ZooKeeper
2> 783499 INFO (zkConnectionManagerCallback-8327-thread-1) [] o.a.s.c.c.ConnectionManager zkClient has connected
2> 783499 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
2> 783600 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.NodeConfig Loading solr.xml from SolrHome (not found in ZooKeeper)
2> 783600 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/tmp/tests-tmp/solr.cloud.api.collections.TestCollectionAPI_FCB98BBEBCF8C986-001/shard-2-001/solr.xml
2> 783603 INFO (closeThreadPool-8320-thread-2) [] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@5a375de7, but no JMX reporters were configured - adding default JMX reporter.
2> 783683 WARN (closeThreadPool-8320-thread-1) [] o.e.j.u.s.S.config Trusting all certificates configured for Client@46497b54[provider=null,keyStore=nul
[...truncated too long message...]
ce7a1417966d89957bd766a148601e28828b/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/Solr/Solr-Check-9.x/solr/solr-ref-guide/build/html-site-content/_config.yml
Source: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/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: role
asciidoctor: WARNING: skipping reference to missing attribute: node
done in 21.266 seconds.
Auto-regeneration: disabled. Use --watch to enable.
> Task :solr:solr-ref-guide:checkSite
Processed 5736 links (5055 relative) to 3886 anchors in 245 files
> Task :solr:solr-ref-guide:test NO-SOURCE
> Task :solr:solr-ref-guide:wipeTaskTemp
> Task :solr:solr-ref-guide:check
> Task :solr:solrj:test
:solr:solrj:test (SUCCESS): 1705 test(s), 16 skipped
> Task :solr:solrj:wipeTaskTemp
> Task :solr:solrj:check
> Task :solr:test-framework:test
:solr:test-framework:test (SUCCESS): 15 test(s)
> Task :solr:test-framework:wipeTaskTemp
> Task :solr:test-framework:check
> Task :solr:webapp:test NO-SOURCE
> Task :solr:webapp:wipeTaskTemp
> Task :solr:webapp:check
> Task :solr:contrib:analysis-extras:test
:solr:contrib:analysis-extras:test (SUCCESS): 30 test(s)
> Task :solr:contrib:analysis-extras:wipeTaskTemp
> Task :solr:contrib:analysis-extras:check
> Task :solr:contrib:analytics:test
:solr:contrib:analytics:test (SUCCESS): 472 test(s)
> Task :solr:contrib:analytics:wipeTaskTemp
> Task :solr:contrib:analytics:check
> Task :solr:contrib:clustering:test
:solr:contrib:clustering:test (SUCCESS): 15 test(s)
> Task :solr:contrib:clustering:wipeTaskTemp
> Task :solr:contrib:clustering:check
> Task :solr:contrib:extraction:test
:solr:contrib:extraction:test (SUCCESS): 20 test(s)
> Task :solr:contrib:extraction:wipeTaskTemp
> Task :solr:contrib:extraction:check
> Task :solr:contrib:gcs-repository:test
:solr:contrib:gcs-repository:test (SUCCESS): 13 test(s)
> Task :solr:contrib:gcs-repository:wipeTaskTemp
> Task :solr:contrib:gcs-repository:check
> Task :solr:contrib:jaegertracer-configurator:test
:solr:contrib:jaegertracer-configurator:test (SUCCESS): 1 test(s)
> Task :solr:contrib:jaegertracer-configurator:wipeTaskTemp
> Task :solr:contrib:jaegertracer-configurator:check
> Task :solr:contrib:langid:test
:solr:contrib:langid:test (SUCCESS): 43 test(s)
> Task :solr:contrib:langid:wipeTaskTemp
> Task :solr:contrib:langid:check
> Task :solr:contrib:ltr:test
:solr:contrib:ltr:test (SUCCESS): 164 test(s)
> Task :solr:contrib:ltr:wipeTaskTemp
> Task :solr:contrib:ltr:check
> Task :solr:contrib:prometheus-exporter:test
:solr:contrib:prometheus-exporter:test (SUCCESS): 20 test(s)
> Task :solr:contrib:prometheus-exporter:wipeTaskTemp
> Task :solr:contrib:prometheus-exporter:check
> Task :solr:contrib:s3-repository:test
:solr:contrib:s3-repository:test (SUCCESS): 42 test(s)
> Task :solr:contrib:s3-repository:wipeTaskTemp
> Task :solr:contrib:s3-repository:check
> Task :solr:contrib:scripting:test
:solr:contrib:scripting:test (SUCCESS): 22 test(s), 1 skipped
> Task :solr:contrib:scripting:wipeTaskTemp
> Task :solr:contrib:scripting:check
The slowest tests (exceeding 500 ms) during this run:
202.02s TestRebalanceLeaders.testRebalanceLeaders (:solr:core)
154.24s TestStressLiveNodes.testStress (:solr:core)
108.24s TestIntervalFaceting.testRandom (:solr:core)
87.41s TestPackages.testPluginLoading (:solr:core)
63.66s TestDistributedStatsComponentCardinality.test (:solr:core)
62.59s PeerSyncReplicationTest.test (:solr:core)
57.33s HttpPartitionWithTlogReplicasTest.test (:solr:core)
53.11s TestRandomFaceting.testRandomFaceting (:solr:core)
53.07s HttpPartitionTest.test (:solr:core)
52.83s TestCloudJSONFacetSKG.testRandom (:solr:core)
The slowest suites (exceeding 1s) during this run:
206.56s TestRebalanceLeaders (:solr:core)
164.03s TestPackages (:solr:core)
158.69s ShardSplitTest (:solr:core)
156.02s TestJsonFacets (:solr:core)
155.23s TestStressLiveNodes (:solr:core)
136.03s TestReplicationHandler (:solr:core)
117.30s SoftAutoCommitTest (:solr:core)
109.69s TestIntervalFaceting (:solr:core)
89.45s DistribDocExpirationUpdateProcessorTest (:solr:core)
88.68s CollectionsAPIDistributedZkTest (:solr:core)
ERROR: The following test(s) have failed:
- org.apache.solr.cloud.PackageManagerCLITest.testPackageManager (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.PackageManagerCLITest.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.cloud.PackageManagerCLITest.testPackageManager" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=FCB98BBEBCF8C986 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=US-ASCII
- org.apache.solr.cloud.api.collections.TestCollectionAPI.test (:solr:core)
Test output: /home/jenkins/jenkins-slave/workspace/Solr/Solr-Check-9.x/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.cloud.api.collections.TestCollectionAPI.txt
Reproduce with: gradlew :solr:core:test --tests "org.apache.solr.cloud.api.collections.TestCollectionAPI.test" -Ptests.jvms=4 -Ptests.haltonfailure=false -Ptests.jvmargs=-XX:TieredStopAtLevel=1 -Ptests.seed=FCB98BBEBCF8C986 -Ptests.multiplier=2 -Ptests.badapples=false -Ptests.file.encoding=US-ASCII
Deprecated Gradle features were used in this build, making it incompatible with Gradle 8.0.
You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins.
See https://docs.gradle.org/7.2/userguide/command_line_interface.html#sec:command_line_warnings
BUILD SUCCESSFUL in 54m 20s
412 actionable tasks: 412 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:3069)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2948)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2929)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3317)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene-solr-2
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1800)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:356)
at hudson.remoting.Channel.call(Channel.java:1001)
at hudson.FilePath.act(FilePath.java:1159)
at hudson.FilePath.act(FilePath.java:1148)
at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
at hudson.model.Build$BuildExecution.post2(Build.java:177)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
at hudson.model.Run.execute(Run.java:1931)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3319)
at hudson.remoting.UserRequest.perform(UserRequest.java:211)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:376)
at hudson.remoting.InterceptingExecutorService.lambda$wrap$0(InterceptingExecutorService.java:78)
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:1161)
at hudson.FilePath.act(FilePath.java:1148)
at hudson.FilePath.validateAntFileMask(FilePath.java:2927)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:270)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:80)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:803)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:752)
at hudson.model.Build$BuildExecution.post2(Build.java:177)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:697)
at hudson.model.Run.execute(Run.java:1931)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
[Checks API] No suitable checks publisher found.
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)