Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/3449/
Java: 64bit/jdk-15-ea+24 -XX:-UseCompressedOops
-XX:+UnlockExperimentalVMOptions -XX:+UseZGC
2 tests failed.
FAILED:
org.apache.solr.cloud.TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast
Error Message:
Request should fail after trying all replica nodes once
Stack Trace:
junit.framework.AssertionFailedError: Request should fail after trying all
replica nodes once
at
__randomizedtesting.SeedInfo.seed([FDEF16C39E082C11:2E323F693939456D]:0)
at
org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2743)
at
org.apache.solr.cloud.TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast(TestQueryingOnDownCollection.java:92)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:832)
FAILED: org.apache.solr.pkg.TestPackages.testPluginLoading
Error Message:
req:
org.apache.solr.filestore.TestDistribPackageStore$$Lambda$1531/0x00000008018bd7e8@17604aa6
. attempt: 9 Mismatch for value : '[config, queryResponseWriter, json1,
_packageinfo_, package]' in response , { "responseHeader":{ "status":0,
"QTime":0}, "config":{"queryResponseWriter":{"json1":{
"name":"json1",
"class":"mypkg:org.apache.solr.core.RuntimeLibResponseWriter"}}}}
Stack Trace:
java.lang.AssertionError: req:
org.apache.solr.filestore.TestDistribPackageStore$$Lambda$1531/0x00000008018bd7e8@17604aa6
. attempt: 9 Mismatch for value : '[config, queryResponseWriter, json1,
_packageinfo_, package]' in response , {
"responseHeader":{
"status":0,
"QTime":0},
"config":{"queryResponseWriter":{"json1":{
"name":"json1",
"class":"mypkg:org.apache.solr.core.RuntimeLibResponseWriter"}}}}
at
__randomizedtesting.SeedInfo.seed([FDEF16C39E082C11:2B69F63E7D16EB8B]:0)
at org.junit.Assert.fail(Assert.java:88)
at
org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:255)
at
org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:222)
at
org.apache.solr.pkg.TestPackages.verifyCmponent(TestPackages.java:463)
at
org.apache.solr.pkg.TestPackages.testPluginLoading(TestPackages.java:180)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:832)
Build Log:
[...truncated 13641 lines...]
[junit4] Suite: org.apache.solr.cloud.TestQueryingOnDownCollection
[junit4] 2> 145418 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/solr/configsets/_default/conf'
[junit4] 2> 145419 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/data-dir-15-001
[junit4] 2> 145419 WARN
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
[junit4] 2> 145419 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 145420 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 145420 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 145420 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001
[junit4] 2> 145421 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 145421 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 145421 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 145521 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port: 36239
[junit4] 2> 145521 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:36239
[junit4] 2> 145521 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36239
[junit4] 2> 145521 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 36239
[junit4] 2> 145523 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145526 INFO (zkConnectionManagerCallback-1673-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145526 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145539 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145543 INFO (zkConnectionManagerCallback-1675-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145543 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145544 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145551 INFO (zkConnectionManagerCallback-1677-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145551 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145664 WARN (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 145664 WARN (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 145664 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 145664 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 145664 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 145664 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 145665 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+24-1168
[junit4] 2> 145665 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+24-1168
[junit4] 2> 145667 WARN (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 145668 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 145668 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 145668 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+24-1168
[junit4] 2> 145691 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 145691 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 145691 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 145691 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 145691 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 145691 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 145692 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 145692 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 145692 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 145692 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2a2b54ac{/solr,null,AVAILABLE}
[junit4] 2> 145692 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@42555e1c{/solr,null,AVAILABLE}
[junit4] 2> 145692 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1e9cc418{/solr,null,AVAILABLE}
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@755e3cf6{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:37727}
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.e.j.s.Server Started @145970ms
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7aa68fbc{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:40557}
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.e.j.s.Server Started @145970ms
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40557}
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37727}
[junit4] 2> 145693 ERROR (jetty-launcher-1678-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 145693 ERROR (jetty-launcher-1678-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.6.0
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.6.0
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-06-18T06:24:51.311851Z
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
[junit4] 2> 145693 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-06-18T06:24:51.311922Z
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2a8e2d49{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:34875}
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.e.j.s.Server Started @145971ms
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=34875}
[junit4] 2> 145694 ERROR (jetty-launcher-1678-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.6.0
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr
[junit4] 2> 145694 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-06-18T06:24:51.312917Z
[junit4] 2> 145696 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145699 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145700 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145700 INFO (zkConnectionManagerCallback-1680-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145700 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145700 INFO (zkConnectionManagerCallback-1682-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145700 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145701 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 145701 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 145701 INFO (zkConnectionManagerCallback-1684-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145701 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145701 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 145972 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 145974 WARN (jetty-launcher-1678-thread-3) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@411fb80c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145974 WARN (jetty-launcher-1678-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@411fb80c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145975 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 145976 WARN (jetty-launcher-1678-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@7eeca8df[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145976 WARN (jetty-launcher-1678-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@7eeca8df[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145980 WARN (jetty-launcher-1678-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@a9a9a23[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145980 WARN (jetty-launcher-1678-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@a9a9a23[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145981 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36239/solr
[junit4] 2> 145982 WARN (jetty-launcher-1678-thread-3) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@6ee1c7eb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145982 WARN (jetty-launcher-1678-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@6ee1c7eb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 145983 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36239/solr
[junit4] 2> 145985 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145989 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 145989 INFO (zkConnectionManagerCallback-1703-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145989 INFO (jetty-launcher-1678-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 145989 INFO (zkConnectionManagerCallback-1706-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 145989 INFO (jetty-launcher-1678-thread-3) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146114 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 146115 INFO (zkConnectionManagerCallback-1711-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 146115 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 146129 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 146130 WARN (jetty-launcher-1678-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@231b0959[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 146130 WARN (jetty-launcher-1678-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@231b0959[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 146132 WARN (jetty-launcher-1678-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@1ac5d7af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 146132 WARN (jetty-launcher-1678-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1ac5d7af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 146133 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36239/solr
[junit4] 2> 146133 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146134 INFO (zkConnectionManagerCallback-1721-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 146134 INFO (jetty-launcher-1678-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146151 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:40557_solr
[junit4] 2> 146152 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.Overseer Overseer
(id=72100714767319048-127.0.0.1:40557_solr-n_0000000000) starting
[junit4] 2> 146155 INFO
(OverseerStateUpdate-72100714767319048-127.0.0.1:40557_solr-n_0000000000)
[n:127.0.0.1:40557_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:40557_solr
[junit4] 2> 146155 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40557_solr
[junit4] 2> 146156 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 146156 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 146157 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.CoreContainer Initializing authorization
plugin: solr.RuleBasedAuthorizationPlugin
[junit4] 2> 146168 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.CoreContainer Initializing authentication
plugin: solr.BasicAuthPlugin
[junit4] 2> 146191 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 146207 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40557.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146212 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40557.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146212 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40557.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146213 INFO (jetty-launcher-1678-thread-2)
[n:127.0.0.1:40557_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node2
[junit4] 2> 146214 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 146219 INFO (zkConnectionManagerCallback-1732-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 146219 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 146221 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 146224 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:37727_solr as DOWN
[junit4] 2> 146224 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 146224 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37727_solr
[junit4] 2> 146225 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 146225 INFO (zkCallback-1731-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 146225 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 146226 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.CoreContainer Initializing authorization
plugin: solr.RuleBasedAuthorizationPlugin
[junit4] 2> 146226 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.CoreContainer Initializing authentication
plugin: solr.BasicAuthPlugin
[junit4] 2> 146234 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 146247 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37727.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146252 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37727.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146253 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37727.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146254 INFO (jetty-launcher-1678-thread-3)
[n:127.0.0.1:37727_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node3
[junit4] 2> 146312 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 146313 INFO (zkConnectionManagerCallback-1743-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 146313 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 146315 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 146316 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:34875_solr as DOWN
[junit4] 2> 146317 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 146317 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34875_solr
[junit4] 2> 146318 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 146318 INFO (zkCallback-1742-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 146318 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 146318 INFO (zkCallback-1731-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 146319 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.CoreContainer Initializing authorization
plugin: solr.RuleBasedAuthorizationPlugin
[junit4] 2> 146319 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.CoreContainer Initializing authentication
plugin: solr.BasicAuthPlugin
[junit4] 2> 146327 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 146339 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34875.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146344 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34875.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146344 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_34875.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146345 INFO (jetty-launcher-1678-thread-1)
[n:127.0.0.1:34875_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node1
[junit4] 2> 146351 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=3
[junit4] 2> 146352 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 146352 INFO (zkConnectionManagerCallback-1756-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 146352 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 146353 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 146354 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36239/solr ready
[junit4] 2> 146373 INFO
(TEST-TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast-seed#[FDEF16C39E082C11])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
testQueryToDownCollectionShouldFailFast
[junit4] 2> 146383 INFO (qtp608819120-2958) [n:127.0.0.1:34875_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&name=infected&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 146384 INFO
(OverseerThreadFactory-1726-thread-1-processing-n:127.0.0.1:40557_solr)
[n:127.0.0.1:40557_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
infected
[junit4] 2> 146500 INFO (qtp608819120-2963) [n:127.0.0.1:34875_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/key
params={omitHeader=true&wt=json} status=0 QTime=0
[junit4] 2> 146501 INFO (qtp608819120-2962) [ ]
o.a.s.s.PKIAuthenticationPlugin New Key obtained from node:
127.0.0.1:34875_solr /
MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA0DQx6CTYV0fYHU3EBk+muiyEwaCthqApbcf7Yyu17TtmNOo5sLrCtAzh83036DcrqXzadYssjuRnpdulMPMAX1K3glYZpkfJgdmK8qaoeX+Mlgy9Ww08MY1CA/P8z8rk9yAKnwepDHyHpPQTQ804iX8KQ8Vv+/6mMU3NkVk0ashp+NoDHhmz5iVRs1IeStpz3Hrnz2Qz6O5QmVcWjdiiXkdXFdd0yEFqwetgDjmw+KMAyVDHJMKCQPA+Wgogn8o02IkPk3GQqTZK/3eoPJctZlx3dA9mykXpEF9dOQBCi+7so84f4sFvMC/pjsoGh6lhPgtxfaVw9FPkkFzLgjvzNQIDAQAB
[junit4] 2> 146505 INFO (qtp608819120-2962) [n:127.0.0.1:34875_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=1
[junit4] 2> 146511 INFO (qtp608819120-2963) [n:127.0.0.1:34875_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/key
params={omitHeader=true&wt=json} status=0 QTime=0
[junit4] 2> 146511 INFO (qtp1952542528-2964) [ ]
o.a.s.s.PKIAuthenticationPlugin New Key obtained from node:
127.0.0.1:34875_solr /
MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA0DQx6CTYV0fYHU3EBk+muiyEwaCthqApbcf7Yyu17TtmNOo5sLrCtAzh83036DcrqXzadYssjuRnpdulMPMAX1K3glYZpkfJgdmK8qaoeX+Mlgy9Ww08MY1CA/P8z8rk9yAKnwepDHyHpPQTQ804iX8KQ8Vv+/6mMU3NkVk0ashp+NoDHhmz5iVRs1IeStpz3Hrnz2Qz6O5QmVcWjdiiXkdXFdd0yEFqwetgDjmw+KMAyVDHJMKCQPA+Wgogn8o02IkPk3GQqTZK/3eoPJctZlx3dA9mykXpEF9dOQBCi+7so84f4sFvMC/pjsoGh6lhPgtxfaVw9FPkkFzLgjvzNQIDAQAB
[junit4] 2> 146512 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for
2147483647 transient cores
[junit4] 2> 146513 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 146524 INFO (qtp608819120-2963) [n:127.0.0.1:34875_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/key
params={omitHeader=true&wt=json} status=0 QTime=0
[junit4] 2> 146524 INFO (qtp2073677301-2966) [ ]
o.a.s.s.PKIAuthenticationPlugin New Key obtained from node:
127.0.0.1:34875_solr /
MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEA0DQx6CTYV0fYHU3EBk+muiyEwaCthqApbcf7Yyu17TtmNOo5sLrCtAzh83036DcrqXzadYssjuRnpdulMPMAX1K3glYZpkfJgdmK8qaoeX+Mlgy9Ww08MY1CA/P8z8rk9yAKnwepDHyHpPQTQ804iX8KQ8Vv+/6mMU3NkVk0ashp+NoDHhmz5iVRs1IeStpz3Hrnz2Qz6O5QmVcWjdiiXkdXFdd0yEFqwetgDjmw+KMAyVDHJMKCQPA+Wgogn8o02IkPk3GQqTZK/3eoPJctZlx3dA9mykXpEF9dOQBCi+7so84f4sFvMC/pjsoGh6lhPgtxfaVw9FPkkFzLgjvzNQIDAQAB
[junit4] 2> 146525 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node}
status=0 QTime=0
[junit4] 2> 146529 INFO
(OverseerStateUpdate-72100714767319048-127.0.0.1:40557_solr-n_0000000000)
[n:127.0.0.1:40557_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"infected",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"infected_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:37727/solr";,
[junit4] 2> "node_name":"127.0.0.1:37727_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 146530 INFO
(OverseerStateUpdate-72100714767319048-127.0.0.1:40557_solr-n_0000000000)
[n:127.0.0.1:40557_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"infected",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"infected_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:40557/solr";,
[junit4] 2> "node_name":"127.0.0.1:40557_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 146737 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
x:infected_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=infected_shard1_replica_n1&action=CREATE&numShards=2&collection=infected&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 146738 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
x:infected_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=infected_shard2_replica_n2&action=CREATE&numShards=2&collection=infected&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 146747 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 146748 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 146757 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 146757 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 146760 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 146760 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 146760 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.CoreContainer Creating SolrCore 'infected_shard1_replica_n1' using
configuration from configset conf, trusted=true
[junit4] 2> 146760 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.CoreContainer Creating SolrCore 'infected_shard2_replica_n2' using
configuration from configset conf, trusted=true
[junit4] 2> 146760 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40557.solr.core.infected.shard2.replica_n2' (registry
'solr.core.infected.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146760 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37727.solr.core.infected.shard1.replica_n1' (registry
'solr.core.infected.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@1068b92c
[junit4] 2> 146761 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.SolrCore [[infected_shard2_replica_n2] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node2/infected_shard2_replica_n2],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node2/infected_shard2_replica_n2/data/]
[junit4] 2> 146761 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.SolrCore [[infected_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node3/infected_shard1_replica_n1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001/tempDir-001/node3/infected_shard1_replica_n1/data/]
[junit4] 2> 146799 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 146799 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 146800 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 146800 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 146802 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 146802 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 146802 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 146803 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1669816901876842496
[junit4] 2> 146804 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 146804 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 146805 INFO
(searcherExecutor-1759-thread-1-processing-n:127.0.0.1:40557_solr
x:infected_shard2_replica_n2 c:infected s:shard2 r:core_node4)
[n:127.0.0.1:40557_solr c:infected s:shard2 r:core_node4
x:infected_shard2_replica_n2 ] o.a.s.c.SolrCore [infected_shard2_replica_n2]
Registered new searcher autowarm time: 0 ms
[junit4] 2> 146805 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 146805 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 146812 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/infected/terms/shard2 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 146812 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/infected/leaders/shard2
[junit4] 2> 146814 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 146814 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 146814 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:40557/solr/infected_shard2_replica_n2/
[junit4] 2> 146814 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 146814 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.SyncStrategy http://127.0.0.1:40557/solr/infected_shard2_replica_n2/
has no replicas
[junit4] 2> 146814 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/infected/leaders/shard2/leader after winning as
/collections/infected/leader_elect/shard2/election/72100714767319048-core_node4-n_0000000000
[junit4] 2> 146816 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:40557/solr/infected_shard2_replica_n2/ shard2
[junit4] 2> 146816 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 146816 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 146817 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 146817 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1669816901891522560
[junit4] 2> 146820 INFO
(searcherExecutor-1760-thread-1-processing-n:127.0.0.1:37727_solr
x:infected_shard1_replica_n1 c:infected s:shard1 r:core_node3)
[n:127.0.0.1:37727_solr c:infected s:shard1 r:core_node3
x:infected_shard1_replica_n1 ] o.a.s.c.SolrCore [infected_shard1_replica_n1]
Registered new searcher autowarm time: 0 ms
[junit4] 2> 146821 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/infected/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 146821 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/infected/leaders/shard1
[junit4] 2> 146823 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 146823 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 146823 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:37727/solr/infected_shard1_replica_n1/
[junit4] 2> 146823 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 146823 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.SyncStrategy http://127.0.0.1:37727/solr/infected_shard1_replica_n1/
has no replicas
[junit4] 2> 146823 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/infected/leaders/shard1/leader after winning as
/collections/infected/leader_elect/shard1/election/72100714767319050-core_node3-n_0000000000
[junit4] 2> 146824 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:37727/solr/infected_shard1_replica_n1/ shard1
[junit4] 2> 146926 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 146926 INFO (zkCallback-1731-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 146926 INFO (zkCallback-1710-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 146926 INFO (zkCallback-1731-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 146927 INFO (zkCallback-1710-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 146928 INFO (zkCallback-1731-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 146929 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 146930 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 146933 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=infected_shard2_replica_n2&action=CREATE&numShards=2&collection=infected&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=195
[junit4] 2> 146934 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=infected_shard1_replica_n1&action=CREATE&numShards=2&collection=infected&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=197
[junit4] 2> 146935 INFO (qtp608819120-2958) [n:127.0.0.1:34875_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
45 seconds. Check all shard replicas
[junit4] 2> 147032 INFO (zkCallback-1710-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1731-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1742-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1710-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1731-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1710-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1731-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147032 INFO (zkCallback-1731-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147033 INFO (qtp608819120-2958) [n:127.0.0.1:34875_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf&name=infected&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=651
[junit4] 2> 147062 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/infected/terms/shard1 to Terms{values={core_node3=1}, version=1}
[junit4] 2> 147062 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/infected/terms/shard2 to Terms{values={core_node4=1}, version=1}
[junit4] 2> 147062 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [infected_shard2_replica_n2] webapp=/solr
path=/update params={_stateVer_=infected:3&wt=javabin&version=2}{add=[2
(1669816902127452160), 3 (1669816902143180800), 5 (1669816902143180801), 6
(1669816902143180802), 7 (1669816902143180803), 9 (1669816902143180804), 17
(1669816902143180805), 18 (1669816902143180806), 19 (1669816902144229376), 21
(1669816902144229377), ... (44 adds)]} 0 21
[junit4] 2> 147063 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [infected_shard1_replica_n1] webapp=/solr
path=/update params={_stateVer_=infected:3&wt=javabin&version=2}{add=[0
(1669816902127452160), 1 (1669816902143180800), 4 (1669816902143180801), 8
(1669816902143180802), 10 (1669816902143180803), 11 (1669816902143180804), 12
(1669816902143180805), 13 (1669816902143180806), 14 (1669816902143180807), 15
(1669816902144229376), ... (56 adds)]} 0 21
[junit4] 2> 147092 INFO (qtp2073677301-2992) [n:127.0.0.1:37727_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/key
params={omitHeader=true&wt=json} status=0 QTime=0
[junit4] 2> 147092 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
] o.a.s.s.PKIAuthenticationPlugin New Key obtained from node:
127.0.0.1:37727_solr /
MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAg0iA+LOfnPXHfCbKBAt2KzK71ozqJZu7zuuWGtC57/0gOXuOXgx44elXOvNNfOTZV6FOflzQUIaSdUpBiV0t2HxPTRcsJOwABwqXkLWh3jWI81AnZX/+xrfgk51zlp4bRFNujkYMcWGxAOaCjBJVsBqn8l9nahJKJRaBvEqA76a/KOKNeOtK338nFk8ANsNvuAlmZSwesLpfAzGqIW76SseH/v8qltVSegCS5IHF7LLl/gfO0YQvDc4+sy8XZt9yHN3JD1lxoBWVxVuIJIBg29iZYBpyKoqE/tWkNYPjrFuBQ/jgEcF870RhLJwKzDvG9AFHsTuKKoXbqQ4Ri0tpGwIDAQAB
[junit4] 2> 147103 INFO
(searcherExecutor-1759-thread-1-processing-n:127.0.0.1:40557_solr
x:infected_shard2_replica_n2 c:infected s:shard2 r:core_node4)
[n:127.0.0.1:40557_solr c:infected s:shard2 r:core_node4
x:infected_shard2_replica_n2 ] o.a.s.c.SolrCore [infected_shard2_replica_n2]
Registered new searcher autowarm time: 0 ms
[junit4] 2> 147103 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.u.p.LogUpdateProcessorFactory [infected_shard2_replica_n2] webapp=/solr
path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:37727/solr/infected_shard1_replica_n1/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 10
[junit4] 2> 147109 INFO
(searcherExecutor-1760-thread-1-processing-n:127.0.0.1:37727_solr
x:infected_shard1_replica_n1 c:infected s:shard1 r:core_node3)
[n:127.0.0.1:37727_solr c:infected s:shard1 r:core_node3
x:infected_shard1_replica_n1 ] o.a.s.c.SolrCore [infected_shard1_replica_n1]
Registered new searcher autowarm time: 0 ms
[junit4] 2> 147114 INFO (qtp2073677301-2966) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.u.p.LogUpdateProcessorFactory [infected_shard1_replica_n1] webapp=/solr
path=/update
params={_stateVer_=infected:3&commit=true&wt=javabin&version=2}{commit=} 0 42
[junit4] 2> 147116 INFO (zkCallback-1731-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147116 INFO (zkCallback-1731-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147116 INFO (zkCallback-1731-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147116 INFO (zkCallback-1731-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147118 INFO (zkCallback-1710-thread-4) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147118 INFO (zkCallback-1710-thread-5) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147118 INFO (zkCallback-1710-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147118 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/collections/infected/state.json]
for collection [infected] has occurred - updating... (live nodes size: [3])
[junit4] 2> 147149 INFO (qtp1952542528-3000) [n:127.0.0.1:40557_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/key
params={omitHeader=true&wt=json} status=0 QTime=0
[junit4] 2> 147149 INFO (qtp1952542528-2998) [ ]
o.a.s.s.PKIAuthenticationPlugin New Key obtained from node:
127.0.0.1:40557_solr /
MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAp+nIFvqKHFLpUmy3Wc08WzIEFB90lWEiwLmsnmZgisSN8OS3c+7H3Df9/YPsMp2g1GwFzkUqU2ysMnw6AHu1YE5nojHaw2mi1zQsxe6ZDz3AM0zACnKH2Z2LuQ0oe2g4g3VZV7ICoT1Pa9hxWagI6/K5H11iY+1OG+gDYtLNNJwgmImII4xmPkHD58OkEgdqSGpBKtCYYtk7dhlXJST1+srmSZNx/U74zjFGkNXkSo5sTqcagk72eCwCURQ/MUr0mYqeCQI35gXoEkov6CuZ7Bfpjy/Y6p/TwgUFBS6znUkJxGPQHq2OoqZuSg3xHCRKJp4eT27m9hLwW16yFNMLcQIDAQAB
[junit4] 2> 147151 INFO (qtp1952542528-2998) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.S.Request [infected_shard2_replica_n2] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=http://127.0.0.1:40557/solr/infected_shard2_replica_n2/&rows=0&version=2&q=*:*&omitHeader=false&NOW=1592461492737&isShard=true&wt=javabin}
hits=44 status=0 QTime=0
[junit4] 2> 147152 INFO (qtp1952542528-3000) [n:127.0.0.1:40557_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/key
params={omitHeader=true&wt=json} status=0 QTime=0
[junit4] 2> 147152 INFO (qtp2073677301-2992) [n:127.0.0.1:37727_solr
] o.a.s.s.PKIAuthenticationPlugin New Key obtained from node:
127.0.0.1:40557_solr /
MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAp+nIFvqKHFLpUmy3Wc08WzIEFB90lWEiwLmsnmZgisSN8OS3c+7H3Df9/YPsMp2g1GwFzkUqU2ysMnw6AHu1YE5nojHaw2mi1zQsxe6ZDz3AM0zACnKH2Z2LuQ0oe2g4g3VZV7ICoT1Pa9hxWagI6/K5H11iY+1OG+gDYtLNNJwgmImII4xmPkHD58OkEgdqSGpBKtCYYtk7dhlXJST1+srmSZNx/U74zjFGkNXkSo5sTqcagk72eCwCURQ/MUr0mYqeCQI35gXoEkov6CuZ7Bfpjy/Y6p/TwgUFBS6znUkJxGPQHq2OoqZuSg3xHCRKJp4eT27m9hLwW16yFNMLcQIDAQAB
[junit4] 2> 147155 INFO (qtp2073677301-2992) [n:127.0.0.1:37727_solr
c:infected s:shard1 r:core_node3 x:infected_shard1_replica_n1 ]
o.a.s.c.S.Request [infected_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&fl=id&fl=score&shards.purpose=16388&start=0&fsv=true&shard.url=http://127.0.0.1:37727/solr/infected_shard1_replica_n1/&rows=0&version=2&q=*:*&omitHeader=false&NOW=1592461492737&isShard=true&wt=javabin}
hits=56 status=0 QTime=2
[junit4] 2> 147155 INFO (qtp1952542528-2964) [n:127.0.0.1:40557_solr
c:infected s:shard2 r:core_node4 x:infected_shard2_replica_n2 ]
o.a.s.c.S.Request [infected_shard2_replica_n2] webapp=/solr path=/select
params={q=*:*&rows=0&wt=javabin&version=2} hits=100 status=0 QTime=35
[junit4] 2> 147156 INFO
(TEST-TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast-seed#[FDEF16C39E082C11])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testQueryToDownCollectionShouldFailFast
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestQueryingOnDownCollection
-Dtests.method=testQueryToDownCollectionShouldFailFast
-Dtests.seed=FDEF16C39E082C11 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=en-SE -Dtests.timezone=America/Jujuy -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 0.80s J0 |
TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast <<<
[junit4] > Throwable #1: junit.framework.AssertionFailedError: Request
should fail after trying all replica nodes once
[junit4] > at
__randomizedtesting.SeedInfo.seed([FDEF16C39E082C11:2E323F693939456D]:0)
[junit4] > at
org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2743)
[junit4] > at
org.apache.solr.cloud.TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast(TestQueryingOnDownCollection.java:92)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:832)
[junit4] 2> 147260 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=900922362
[junit4] 2> 147260 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:40557_solr
[junit4] 2> 147260 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 147260 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.c.ZkController Publish node=127.0.0.1:40557_solr as DOWN
[junit4] 2> 147261 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1140775743
[junit4] 2> 147261 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:37727_solr
[junit4] 2> 147261 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 147261 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.c.ZkController Publish node=127.0.0.1:37727_solr as DOWN
[junit4] 2> 147266 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=153656139
[junit4] 2> 147266 INFO (coreCloseExecutor-1778-thread-1)
[n:127.0.0.1:37727_solr ] o.a.s.c.SolrCore [infected_shard1_replica_n1]
CLOSING SolrCore org.apache.solr.core.SolrCore@4b8ecbed
[junit4] 2> 147266 INFO (coreCloseExecutor-1778-thread-1)
[n:127.0.0.1:37727_solr ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.infected.shard1.replica_n1
tag=SolrCore@4b8ecbed
[junit4] 2> 147266 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:34875_solr
[junit4] 2> 147266 INFO (coreCloseExecutor-1778-thread-1)
[n:127.0.0.1:37727_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@72ac18d9: rootName =
solr_37727, domain = solr.core.infected.shard1.replica_n1, service url = null,
agent id = null] for registry
solr.core.infected.shard1.replica_n1/com.codahale.metrics.MetricRegistry@1cda0a38
[junit4] 2> 147266 INFO (coreCloseExecutor-1777-thread-1)
[n:127.0.0.1:40557_solr ] o.a.s.c.SolrCore [infected_shard2_replica_n2]
CLOSING SolrCore org.apache.solr.core.SolrCore@60dac3fa
[junit4] 2> 147266 INFO (coreCloseExecutor-1777-thread-1)
[n:127.0.0.1:40557_solr ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.core.infected.shard2.replica_n2
tag=SolrCore@60dac3fa
[junit4] 2> 147267 INFO (coreCloseExecutor-1777-thread-1)
[n:127.0.0.1:40557_solr ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7ee4a1df: rootName =
solr_40557, domain = solr.core.infected.shard2.replica_n2, service url = null,
agent id = null] for registry
solr.core.infected.shard2.replica_n2/com.codahale.metrics.MetricRegistry@76b34b5
[junit4] 2> 147267 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 147267 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.c.ZkController Publish node=127.0.0.1:34875_solr as DOWN
[junit4] 2> 147279 INFO (coreCloseExecutor-1777-thread-1)
[n:127.0.0.1:40557_solr ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.infected.shard2.leader
tag=SolrCore@60dac3fa
[junit4] 2> 147279 INFO (coreCloseExecutor-1777-thread-1)
[n:127.0.0.1:40557_solr ] o.a.s.u.DirectUpdateHandler2 Committing on
IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 147280 INFO (coreCloseExecutor-1778-thread-1)
[n:127.0.0.1:37727_solr ] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.infected.shard1.leader
tag=SolrCore@4b8ecbed
[junit4] 2> 147280 INFO (coreCloseExecutor-1778-thread-1)
[n:127.0.0.1:37727_solr ] o.a.s.u.DirectUpdateHandler2 Committing on
IndexWriter.close() ... SKIPPED (unnecessary).
[junit4] 2> 147283 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node
tag=null
[junit4] 2> 147283 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node
tag=null
[junit4] 2> 147283 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node
tag=null
[junit4] 2> 147283 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@c928722: rootName =
solr_37727, domain = solr.node, service url = null, agent id = null] for
registry solr.node/com.codahale.metrics.MetricRegistry@5a38579a
[junit4] 2> 147283 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@5cf17a21: rootName =
solr_34875, domain = solr.node, service url = null, agent id = null] for
registry solr.node/com.codahale.metrics.MetricRegistry@7f4b4c50
[junit4] 2> 147283 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@439cb0eb: rootName =
solr_40557, domain = solr.node, service url = null, agent id = null] for
registry solr.node/com.codahale.metrics.MetricRegistry@2015687a
[junit4] 2> 147291 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm
tag=null
[junit4] 2> 147291 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@32a41706: rootName =
solr_40557, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm/com.codahale.metrics.MetricRegistry@2b10fcda
[junit4] 2> 147291 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm
tag=null
[junit4] 2> 147291 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@58a13bbc: rootName =
solr_34875, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm/com.codahale.metrics.MetricRegistry@2b10fcda
[junit4] 2> 147291 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm
tag=null
[junit4] 2> 147291 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7a582c34: rootName =
solr_37727, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm/com.codahale.metrics.MetricRegistry@2b10fcda
[junit4] 2> 147293 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 147293 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@61bc948d: rootName =
solr_40557, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty/com.codahale.metrics.MetricRegistry@1413c2e6
[junit4] 2> 147293 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 147293 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 147293 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2a6d68c2: rootName =
solr_34875, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty/com.codahale.metrics.MetricRegistry@1413c2e6
[junit4] 2> 147293 INFO (jetty-closer-1769-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 147294 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty
tag=null
[junit4] 2> 147294 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@30a8c594: rootName =
solr_37727, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty/com.codahale.metrics.MetricRegistry@1413c2e6
[junit4] 2> 147294 INFO (jetty-closer-1769-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster
tag=null
[junit4] 2> 147296 INFO (closeThreadPool-1785-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72100714767319048-127.0.0.1:40557_solr-n_0000000000) closing
[junit4] 2> 147296 INFO
(OverseerStateUpdate-72100714767319048-127.0.0.1:40557_solr-n_0000000000)
[n:127.0.0.1:40557_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:40557_solr
[junit4] 2> 147296 INFO
(OverseerAutoScalingTriggerThread-72100714767319048-127.0.0.1:40557_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 147297 INFO (zkCallback-1731-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 147297 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 147297 INFO (zkCallback-1710-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 147303 INFO (closeThreadPool-1785-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=72100714767319048-127.0.0.1:40557_solr-n_0000000000) closing
[junit4] 2> 147398 INFO (jetty-closer-1769-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@2a8e2d49{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 147398 INFO (jetty-closer-1769-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2a2b54ac{/solr,null,UNAVAILABLE}
[junit4] 2> 147398 INFO (jetty-closer-1769-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 147497 INFO (jetty-closer-1769-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=72100714767319048-127.0.0.1:40557_solr-n_0000000000) closing
[junit4] 2> 147498 INFO (jetty-closer-1769-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@7aa68fbc{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 147498 INFO (jetty-closer-1769-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1e9cc418{/solr,null,UNAVAILABLE}
[junit4] 2> 147498 INFO (jetty-closer-1769-thread-1) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 147599 INFO (jetty-closer-1769-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@755e3cf6{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:0}
[junit4] 2> 147599 INFO (jetty-closer-1769-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@42555e1c{/solr,null,UNAVAILABLE}
[junit4] 2> 147599 INFO (jetty-closer-1769-thread-2) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 147600 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 147802 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 3 /solr/packages.json
[junit4] 2> 3 /solr/collections/infected/terms/shard2
[junit4] 2> 3 /solr/collections/infected/terms/shard1
[junit4] 2> 3 /solr/security.json
[junit4] 2> 2 /solr/configs/conf
[junit4] 2> 2 /solr/collections/infected/collectionprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 32 /solr/collections/infected/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 19 /solr/overseer/queue
[junit4] 2> 13 /solr/live_nodes
[junit4] 2> 8 /solr/collections
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 147804 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:36239
[junit4] 2> 147804 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36239
[junit4] 2> 147804 INFO
(SUITE-TestQueryingOnDownCollection-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 36239
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_FDEF16C39E082C11-001
[junit4] 2> Jun 18, 2020 6:24:53 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86):
{_version_=PostingsFormat(name=LuceneFixedGap),
_root_=PostingsFormat(name=LuceneFixedGap),
id=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{},
maxPointsInLeafNode=1884, maxMBSortInHeap=5.814609766237261,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@34baab85),
locale=en-SE, timezone=America/Jujuy
[junit4] 2> NOTE: Linux 5.3.0-59-generic amd64/Oracle Corporation 15-ea
(64-bit)/cpus=16,threads=1,free=335544320,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [V2StandaloneTest,
AutoAddReplicasPlanActionTest, NumericFieldsTest, EnumFieldTest,
ZkFailoverTest, InfixSuggestersTest, HttpPartitionWithTlogReplicasTest,
TestSolrConfigHandler, CreateRoutedAliasTest, TestCloudPseudoReturnFields,
TestManagedSynonymGraphFilterFactory, TestImplicitCoreProperties,
TestAnalyzedSuggestions, TestCaffeineCache, PrimUtilsTest, RangeFacetCloudTest,
TestQueryingOnDownCollection]
[junit4] Completed [79/910 (1!)] on J0 in 3.01s, 1 test, 1 failure <<<
FAILURES!
[...truncated 2420 lines...]
[junit4] Suite: org.apache.solr.pkg.TestPackages
[junit4] 2> 1152786 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ] o.a.s.SolrTestCase
Setting 'solr.default.confdir' system property to test-framework derived value
of
'/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/solr/configsets/_default/conf'
[junit4] 2> 1152788 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_FDEF16C39E082C11-001/data-dir-166-001
[junit4] 2> 1152788 WARN
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=8 numCloses=8
[junit4] 2> 1152788 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1152790 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0)
[junit4] 2> 1152790 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1152850 INFO
(TEST-TestPackages.testAPI-seed#[FDEF16C39E082C11]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testAPI
[junit4] 2> 1152851 INFO
(TEST-TestPackages.testAPI-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_FDEF16C39E082C11-001/tempDir-001
[junit4] 2> 1152851 INFO
(TEST-TestPackages.testAPI-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1152851 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 1152851 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1152951 INFO
(TEST-TestPackages.testAPI-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.ZkTestServer start zk server on port: 45713
[junit4] 2> 1152952 INFO
(TEST-TestPackages.testAPI-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.ZkTestServer waitForServerUp
[...truncated too long message...]
2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 8 /solr/configs/conf
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5
/solr/collections/testPluginLoadingColl/terms/shard2
[junit4] 2> 5
/solr/collections/testPluginLoadingColl/terms/shard1
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4 /solr/packages.json
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 40
/solr/collections/testPluginLoadingColl/state.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 4 /solr/packages.json
[junit4] 2> 2
/solr/overseer_elect/election/72100781608861707-127.0.0.1:41565_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 31 /solr/overseer/queue
[junit4] 2> 21 /solr/live_nodes
[junit4] 2> 10 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 1176807 INFO
(TEST-TestPackages.testPluginLoading-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:40853
[junit4] 2> 1176807 INFO
(TEST-TestPackages.testPluginLoading-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:40853
[junit4] 2> 1176807 INFO
(TEST-TestPackages.testPluginLoading-seed#[FDEF16C39E082C11]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 40853
[junit4] 2> 1176809 INFO
(TEST-TestPackages.testPluginLoading-seed#[FDEF16C39E082C11]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testPluginLoading
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPackages
-Dtests.method=testPluginLoading -Dtests.seed=FDEF16C39E082C11
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr-TG
-Dtests.timezone=Africa/Johannesburg -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 11.5s J1 | TestPackages.testPluginLoading <<<
[junit4] > Throwable #1: java.lang.AssertionError: req:
org.apache.solr.filestore.TestDistribPackageStore$$Lambda$1531/0x00000008018bd7e8@17604aa6
. attempt: 9 Mismatch for value : '[config, queryResponseWriter, json1,
_packageinfo_, package]' in response , {
[junit4] > "responseHeader":{
[junit4] > "status":0,
[junit4] > "QTime":0},
[junit4] > "config":{"queryResponseWriter":{"json1":{
[junit4] > "name":"json1",
[junit4] >
"class":"mypkg:org.apache.solr.core.RuntimeLibResponseWriter"}}}}
[junit4] > at
__randomizedtesting.SeedInfo.seed([FDEF16C39E082C11:2B69F63E7D16EB8B]:0)
[junit4] > at
org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:255)
[junit4] > at
org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:222)
[junit4] > at
org.apache.solr.pkg.TestPackages.verifyCmponent(TestPackages.java:463)
[junit4] > at
org.apache.solr.pkg.TestPackages.testPluginLoading(TestPackages.java:180)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:832)
[junit4] 2> 1176811 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1176811 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:40853
[junit4] 2> 1176811 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:40853
[junit4] 2> 1176811 INFO
(SUITE-TestPackages-seed#[FDEF16C39E082C11]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 40853
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_FDEF16C39E082C11-001
[junit4] 2> Jun 18, 2020 6:42:02 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86): {},
docValues:{}, maxPointsInLeafNode=1681, maxMBSortInHeap=5.871904135827224,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@bd3859d),
locale=fr-TG, timezone=Africa/Johannesburg
[junit4] 2> NOTE: Linux 5.3.0-59-generic amd64/Oracle Corporation 15-ea
(64-bit)/cpus=16,threads=1,free=369098752,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [XmlUpdateRequestHandlerTest,
AutoScalingHandlerTest, OpenExchangeRatesOrgProviderTest,
ExternalFileFieldSortTest, ZkNodePropsTest, MoreLikeThisComponentTest,
LeaderElectionContextKeyTest, TestSolrDeletionPolicy1,
DeleteInactiveReplicaTest, TestCloudRecovery, BadCopyFieldTest,
TestInfoStreamLogging, TestBlendedInfixSuggestions, TestCollapseQParserPlugin,
SimplePostToolTest, SpatialHeatmapFacetsTest, TestRandomFlRTGCloud,
PeerSyncTest, TestSolrCloudWithHadoopAuthPlugin, TestFoldingMultitermQuery,
TestExplainDocTransformer, AuditLoggerIntegrationTest, ScheduledTriggerTest,
TestElisionMultitermQuery, TestQueryUtils, StatsReloadRaceTest,
ConfigureRecoveryStrategyTest, TestSchemaManager, TestMiniSolrCloudClusterSSL,
ExplicitHLLTest, DebugComponentTest, TestDocTermOrdsUninvertLimit,
TestStressCloudBlindAtomicUpdates, TestHdfsCloudBackupRestore,
JWTAuthPluginTest, TestFieldResource, TestHighlightDedupGrouping,
TermVectorComponentTest, TriLevelCompositeIdRoutingTest, TestManagedSchema,
QueryResultKeyTest, ShardsWhitelistTest, TestBulkSchemaConcurrent,
TestBlobHandler, MoveReplicaHDFSFailoverTest, TestNoOpRegenerator,
TestRecovery, SuggesterFSTTest, BasicFunctionalityTest,
DistributedFacetPivotSmallAdvancedTest, TaggerTest, TestSolrFieldCacheBean,
TriggerEventQueueTest, TestRestManager, TestTrieFacet,
ClassificationUpdateProcessorFactoryTest, CdcrVersionReplicationTest,
UpdateRequestProcessorFactoryTest, TestExceedMaxTermLength,
SaslZkACLProviderTest, BlockJoinFacetRandomTest, SpellCheckCollatorTest,
MinimalSchemaTest, TestMinMaxOnMultiValuedField, BlockCacheTest,
TestSimpleQParserPlugin, NodeLostTriggerIntegrationTest,
BaseCdcrDistributedZkTest, TestCloudConsistency, TestReplicationHandlerBackup,
TestDeprecatedFilters, SchemaApiFailureTest, PeerSyncReplicationTest,
ZkDynamicConfigTest, TestTestInjection, AddReplicaTest,
BasicDistributedZk2Test, ChaosMonkeyNothingIsSafeTest,
ChaosMonkeySafeLeaderTest, ClusterStateMockUtilTest, ClusterStateTest,
ClusterStateUpdateTest, CollectionStateFormat2Test,
ConcurrentCreateRoutedAliasTest, ConfigSetsAPITest, DistributedVersionInfoTest,
HttpPartitionOnCommitTest, LeaderFailureAfterFreshStartTest, OverseerRolesTest,
RestartWhileUpdatingTest, SharedFSAutoReplicaFailoverTest, SliceStateTest,
SolrCLIZkUtilsTest, SolrXmlInZkTest, SplitShardTest,
TestConfigSetsAPIZkFailure, TestDownShardTolerantSearch,
TestDynamicFieldNamesIndexCorrectly, TestShortCircuitedRequests,
TestTolerantUpdateProcessorCloud, ZkCLITest, IndexSizeTriggerMixedBoundsTest,
TestCoreContainer, TestQuerySenderListener, TestReloadAndDeleteDocs,
TestDistribPackageStore, TestSQLHandlerNonCloud,
TestSolrConfigHandlerConcurrent, CoreAdminRequestStatusTest,
LoggingHandlerTest, MetricsHistoryHandlerTest, FacetPivotSmallTest,
ResponseBuilderTest, ResponseLogComponentTest,
SuggestComponentContextFilterQueryTest, SuggestComponentTest,
TestPostingsSolrHighlighter, UninvertDocValuesMergePolicyTest,
TestMultiValuedNumericRangeQuery, MetricsConfigTest, SolrCoreMetricManagerTest,
SolrJmxReporterCloudTest, TestPackages]
[junit4] Completed [759/910 (2!)] on J1 in 24.68s, 2 tests, 1 failure <<<
FAILURES!
[...truncated 45308 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/3449/consoleText
[repro] Revision: bdcbf1019bc7773f2c08a4d31c7b6981765b2a46
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops
-XX:+UnlockExperimentalVMOptions -XX:+UseZGC"
[repro] Repro line: ant test -Dtestcase=TestQueryingOnDownCollection
-Dtests.method=testQueryToDownCollectionShouldFailFast
-Dtests.seed=FDEF16C39E082C11 -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=en-SE -Dtests.timezone=America/Jujuy -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[repro] Repro line: ant test -Dtestcase=TestPackages
-Dtests.method=testPluginLoading -Dtests.seed=FDEF16C39E082C11
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr-TG
-Dtests.timezone=Africa/Johannesburg -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] TestPackages
[repro] TestQueryingOnDownCollection
[repro] ant compile-test
[...truncated 3450 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10
-Dtests.class="*.TestPackages|*.TestQueryingOnDownCollection"
-Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops
-XX:+UnlockExperimentalVMOptions -XX:+UseZGC" -Dtests.seed=FDEF16C39E082C11
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr-TG
-Dtests.timezone=Africa/Johannesburg -Dtests.asserts=true
-Dtests.file.encoding=ISO-8859-1
[...truncated 109 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.TestQueryingOnDownCollection
[repro] 0/5 failed: org.apache.solr.pkg.TestPackages
[repro] Exiting with code 0
[...truncated 43 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
