You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/02/18 12:19:16 UTC
[JENKINS-Experimental-GC] Lucene-Solr-master-Linux
(64bit/jdk-13.0.2) - Build # 25757 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25757/
Java: 64bit/jdk-13.0.2 -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([BDC1749D6362541E:6E1C5D37C4533D62]:0)
at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.java:2750)
at org.apache.solr.cloud.TestQueryingOnDownCollection.testQueryToDownCollectionShouldFailFast(TestQueryingOnDownCollection.java:91)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:830)
FAILED: org.apache.solr.pkg.TestPackages.testPluginLoading
Error Message:
req: org.apache.solr.filestore.TestDistribPackageStore$$Lambda$1378/0x00007f2b771ce4b0@55bafede . 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$1378/0x00007f2b771ce4b0@55bafede . 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([BDC1749D6362541E:6B479460807C9384]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:242)
at org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:213)
at org.apache.solr.pkg.TestPackages.verifyCmponent(TestPackages.java:431)
at org.apache.solr.pkg.TestPackages.testPluginLoading(TestPackages.java:153)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1754)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:370)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:830)
Build Log:
[...truncated 14001 lines...]
[junit4] Suite: org.apache.solr.pkg.TestPackages
[junit4] 2> 546227 INFO (SUITE-TestPackages-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/server/solr/configsets/_default/conf'
[junit4] 2> 546228 INFO (SUITE-TestPackages-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/data-dir-106-001
[junit4] 2> 546228 WARN (SUITE-TestPackages-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=144 numCloses=144
[junit4] 2> 546228 INFO (SUITE-TestPackages-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 546229 INFO (SUITE-TestPackages-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 546229 INFO (SUITE-TestPackages-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 546231 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAPI
[junit4] 2> 546232 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001
[junit4] 2> 546232 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 546232 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 546232 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 546332 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.ZkTestServer start zk server on port:44259
[junit4] 2> 546332 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44259
[junit4] 2> 546332 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44259
[junit4] 2> 546332 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 44259
[junit4] 2> 546335 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546336 INFO (zkConnectionManagerCallback-3240-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546336 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546341 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546349 INFO (zkConnectionManagerCallback-3242-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546349 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546349 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546352 INFO (zkConnectionManagerCallback-3244-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546352 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546464 WARN (jetty-launcher-3245-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 546464 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 546464 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 546464 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 546464 WARN (jetty-launcher-3245-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 546464 WARN (jetty-launcher-3245-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 546465 WARN (jetty-launcher-3245-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 546465 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 546481 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 546481 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 546481 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 546483 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 546483 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 546483 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 546483 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4ca69f90{/solr,null,AVAILABLE}
[junit4] 2> 546485 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 546485 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 546485 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 546485 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 546485 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 546485 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 546487 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@47cebeab{/solr,null,AVAILABLE}
[junit4] 2> 546487 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@285e30e7{/solr,null,AVAILABLE}
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@250ec0b7{/solr,null,AVAILABLE}
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4d334643{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:45949}
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.e.j.s.Server Started @546805ms
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45949}
[junit4] 2> 546488 ERROR (jetty-launcher-3245-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr
[junit4] 2> 546488 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-18T11:50:33.834398Z
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6bf5927f{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:33087}
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.e.j.s.Server Started @546810ms
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6b7aec22{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:38359}
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33087}
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.e.j.s.Server Started @546810ms
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38359}
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3132dd5c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:34933}
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.e.j.s.Server Started @546810ms
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34933}
[junit4] 2> 546493 ERROR (jetty-launcher-3245-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 546493 ERROR (jetty-launcher-3245-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-18T11:50:33.839425Z
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-18T11:50:33.839425Z
[junit4] 2> 546493 ERROR (jetty-launcher-3245-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr
[junit4] 2> 546493 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-02-18T11:50:33.839639Z
[junit4] 2> 546494 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546494 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546495 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546502 INFO (zkConnectionManagerCallback-3247-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546503 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546504 INFO (zkConnectionManagerCallback-3250-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546505 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546505 INFO (zkConnectionManagerCallback-3253-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546505 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546505 INFO (zkConnectionManagerCallback-3251-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546505 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546507 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 546507 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 546507 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 546507 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 546640 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 546641 WARN (jetty-launcher-3245-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@136074e2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546641 WARN (jetty-launcher-3245-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@136074e2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546642 WARN (jetty-launcher-3245-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@18246b3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546642 WARN (jetty-launcher-3245-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@18246b3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546643 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44259/solr
[junit4] 2> 546643 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546644 INFO (zkConnectionManagerCallback-3260-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546644 INFO (jetty-launcher-3245-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546752 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 546752 WARN (jetty-launcher-3245-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6c97e0a3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546752 WARN (jetty-launcher-3245-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6c97e0a3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546754 WARN (jetty-launcher-3245-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7b2e222b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546754 WARN (jetty-launcher-3245-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7b2e222b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546754 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44259/solr
[junit4] 2> 546755 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546755 INFO (zkConnectionManagerCallback-3267-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546755 INFO (jetty-launcher-3245-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546921 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 546922 WARN (jetty-launcher-3245-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5fbf7d77[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546922 WARN (jetty-launcher-3245-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5fbf7d77[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546923 WARN (jetty-launcher-3245-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@28d4e2ba[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546923 WARN (jetty-launcher-3245-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@28d4e2ba[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546924 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44259/solr
[junit4] 2> 546924 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546925 INFO (zkConnectionManagerCallback-3275-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546925 INFO (jetty-launcher-3245-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 546950 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 546950 WARN (jetty-launcher-3245-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@e509387[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546950 WARN (jetty-launcher-3245-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@e509387[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546951 WARN (jetty-launcher-3245-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@67363f88[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546951 WARN (jetty-launcher-3245-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@67363f88[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 546952 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44259/solr
[junit4] 2> 546952 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 546953 INFO (zkConnectionManagerCallback-3281-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 546953 INFO (jetty-launcher-3245-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 547014 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 547015 INFO (zkConnectionManagerCallback-3283-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 547015 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 547037 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34933_solr
[junit4] 2> 547037 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.Overseer Overseer (id=72102198043607051-127.0.0.1:34933_solr-n_0000000000) starting
[junit4] 2> 547039 INFO (OverseerStateUpdate-72102198043607051-127.0.0.1:34933_solr-n_0000000000) [n:127.0.0.1:34933_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:34933_solr
[junit4] 2> 547039 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34933_solr
[junit4] 2> 547040 INFO (zkCallback-3282-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 547040 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 547040 WARN (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 547046 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 547057 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34933.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547061 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34933.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547061 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34933.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547061 INFO (jetty-launcher-3245-thread-1) [n:127.0.0.1:34933_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node1/.
[junit4] 2> 547114 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 547115 INFO (zkConnectionManagerCallback-3289-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 547115 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 547116 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 547117 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:33087_solr as DOWN
[junit4] 2> 547117 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 547117 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33087_solr
[junit4] 2> 547117 INFO (zkCallback-3282-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 547117 INFO (zkCallback-3288-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 547118 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 547118 WARN (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 547122 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 547131 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33087.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547135 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33087.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547135 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_33087.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547135 INFO (jetty-launcher-3245-thread-3) [n:127.0.0.1:33087_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node3/.
[junit4] 2> 547214 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 547215 INFO (zkConnectionManagerCallback-3295-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 547215 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 547216 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 547217 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:38359_solr as DOWN
[junit4] 2> 547217 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 547217 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38359_solr
[junit4] 2> 547218 INFO (zkCallback-3282-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 547218 INFO (zkCallback-3288-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 547218 INFO (zkCallback-3294-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 547218 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 547218 WARN (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 547223 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 547232 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38359.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547236 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38359.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547236 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_38359.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547236 INFO (jetty-launcher-3245-thread-4) [n:127.0.0.1:38359_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node4/.
[junit4] 2> 547314 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 547315 INFO (zkConnectionManagerCallback-3301-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 547315 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 547316 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 547317 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:45949_solr as DOWN
[junit4] 2> 547318 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 547318 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45949_solr
[junit4] 2> 547318 INFO (zkCallback-3282-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 547318 INFO (zkCallback-3288-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 547318 INFO (zkCallback-3294-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 547318 INFO (zkCallback-3300-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 547318 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 547318 WARN (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.CoreContainer Not all security plugins configured! authentication=disabled authorization=disabled. Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 547323 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 547333 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45949.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547337 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45949.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547337 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45949.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@4453e6e7
[junit4] 2> 547338 INFO (jetty-launcher-3245-thread-2) [n:127.0.0.1:45949_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node2/.
[junit4] 2> 547355 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 547355 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 547356 INFO (zkConnectionManagerCallback-3310-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 547356 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 547356 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 547356 INFO (TEST-TestPackages.testAPI-seed#[BDC1749D6362541E]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44259/solr ready
[junit4] 2> 547365 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547367 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547368 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547370 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547370 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547370 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547370 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547371 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547371 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547371 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547371 ERROR (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.a.AnnotatedApi Error executing command
[junit4] 2> => org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error executing command, errors: [{add={package=test_pkg, version=0.12, files=[/mypkg/v.0.12/jar_a.jar, /mypkg/v.0.12/jar_b.jar]}, errorMessages=[No such file: /mypkg/v.0.12/jar_a.jar, No such file: /mypkg/v.0.12/jar_b.jar]}],
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.invoke(AnnotatedApi.java:237)
[junit4] 2> org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error executing command
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.invoke(AnnotatedApi.java:237) ~[java/:?]
[junit4] 2> at org.apache.solr.api.AnnotatedApi.call(AnnotatedApi.java:159) ~[java/:?]
[junit4] 2> at org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351) ~[java/:?]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166) ~[java/:?]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322) ~[jetty-rewrite-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:500) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806) ~[jetty-util-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938) ~[jetty-util-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at java.lang.Thread.run(Thread.java:830) [?:?]
[junit4] 2> 547371 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=400 QTime=11
[junit4] 2> 547379 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547380 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547381 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547381 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547381 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547382 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 547384 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={getFrom=127.0.0.1:33087_solr} status=0 QTime=0
[junit4] 2> 547385 INFO (updateExecutor-3271-thread-1-processing-n:127.0.0.1:45949_solr) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_a.jar from 127.0.0.1:33087_solr
[junit4] 2> 547385 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={getFrom=127.0.0.1:33087_solr} status=0 QTime=0
[junit4] 2> 547385 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_a.jar from 127.0.0.1:33087_solr
[junit4] 2> 547386 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={getFrom=127.0.0.1:33087_solr} status=0 QTime=0
[junit4] 2> 547386 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_a.jar from 127.0.0.1:33087_solr
[junit4] 2> 547386 INFO (qtp1697804457-11595) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/.jar_a.jar.json params={} status=0 QTime=0
[junit4] 2> 547386 INFO (qtp1697804457-11593) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/.jar_a.jar.json params={} status=0 QTime=0
[junit4] 2> 547386 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/mypkg/v.0.12/jar_a.jar params={wt=javabin&version=2} status=0 QTime=10
[junit4] 2> 547387 INFO (qtp1697804457-11597) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/.jar_a.jar.json params={} status=0 QTime=0
[junit4] 2> 547388 INFO (qtp1697804457-11595) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={} status=0 QTime=0
[junit4] 2> 547388 INFO (qtp1697804457-11593) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={} status=0 QTime=0
[junit4] 2> 547388 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={} status=0 QTime=0
[junit4] 2> 547388 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547394 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 547394 INFO (updateExecutor-3271-thread-1-processing-n:127.0.0.1:45949_solr) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 547394 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547394 INFO (updateExecutor-3271-thread-1-processing-n:127.0.0.1:45949_solr) [n:127.0.0.1:45949_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547394 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 547394 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 547492 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 547494 INFO (qtp1697804457-11595) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547496 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547497 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547499 ERROR (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.a.AnnotatedApi Error executing command
[junit4] 2> => org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error executing command, errors: [{add={package=test_pkg, version=0.12, files=[/mypkg/v.0.12/jar_a.jar]}, errorMessages=[/mypkg/v.0.12/jar_a.jar has no signature]}],
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.invoke(AnnotatedApi.java:237)
[junit4] 2> org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error executing command
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.invoke(AnnotatedApi.java:237) ~[java/:?]
[junit4] 2> at org.apache.solr.api.AnnotatedApi.call(AnnotatedApi.java:159) ~[java/:?]
[junit4] 2> at org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:343) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:808) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:559) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:419) ~[java/:?]
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:351) ~[java/:?]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:166) ~[java/:?]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1607) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1297) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) ~[jetty-servlet-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1577) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1212) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322) ~[jetty-rewrite-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:500) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:270) ~[jetty-server-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) ~[jetty-io-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806) ~[jetty-util-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938) ~[jetty-util-9.4.24.v20191120.jar:9.4.24.v20191120]
[junit4] 2> at java.lang.Thread.run(Thread.java:830) [?:?]
[junit4] 2> 547499 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=400 QTime=1
[junit4] 2> 547503 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:33087_solr} status=0 QTime=0
[junit4] 2> 547504 INFO (updateExecutor-3271-thread-1-processing-n:127.0.0.1:45949_solr) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:33087_solr
[junit4] 2> 547504 INFO (qtp1073030354-11599) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:33087_solr} status=0 QTime=0
[junit4] 2> 547504 INFO (qtp1697804457-11593) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=0
[junit4] 2> 547504 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:33087_solr
[junit4] 2> 547504 INFO (qtp1706888933-11603) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:33087_solr} status=0 QTime=0
[junit4] 2> 547504 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:33087_solr
[junit4] 2> 547504 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=0
[junit4] 2> 547504 INFO (qtp1697804457-11597) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 547504 INFO (qtp1697804457-11595) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={sync=true} status=0 QTime=2
[junit4] 2> 547504 INFO (qtp1697804457-11593) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=0
[junit4] 1> sync resp: http://127.0.0.1:33087/api/node/files/_trusted_/keys/pub_key512.der?sync=true ,is: null
[junit4] 2> 547505 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 547505 INFO (qtp1697804457-11595) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 547505 INFO (updateExecutor-3271-thread-1-processing-n:127.0.0.1:45949_solr) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 547505 INFO (updateExecutor-3271-thread-1-processing-n:127.0.0.1:45949_solr) [n:127.0.0.1:45949_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 547505 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 547505 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 547505 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 547505 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 547506 INFO (qtp1073030354-11599) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547508 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547509 INFO (qtp1706888933-11603) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547510 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547513 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547514 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547515 INFO (qtp1697804457-11597) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547515 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547516 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547516 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547516 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 547518 INFO (qtp1073030354-11599) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={getFrom=127.0.0.1:45949_solr} status=0 QTime=0
[junit4] 2> 547518 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_b.jar from 127.0.0.1:45949_solr
[junit4] 2> 547518 INFO (qtp1697804457-11587) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={getFrom=127.0.0.1:45949_solr} status=0 QTime=0
[junit4] 2> 547518 INFO (updateExecutor-3256-thread-3-processing-n:127.0.0.1:33087_solr) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_b.jar from 127.0.0.1:45949_solr
[junit4] 2> 547519 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_b.jar from 127.0.0.1:45949_solr
[junit4] 2> 547519 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/.jar_b.jar.json params={} status=0 QTime=0
[junit4] 2> 547519 INFO (qtp1706888933-11603) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={getFrom=127.0.0.1:45949_solr} status=0 QTime=0
[junit4] 2> 547519 INFO (qtp1140105293-11613) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/.jar_b.jar.json params={} status=0 QTime=0
[junit4] 2> 547519 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/.jar_b.jar.json params={} status=0 QTime=0
[junit4] 2> 547519 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/mypkg/v.0.12/jar_b.jar params={sig=L3q/qIGs4NaF6JiO0ZkMUFa88j0OmYc%2BI6O7BOdNuMct/xoZ4h73aZHZGc0%2BnmI1f/U3bOlMPINlSOM6LK3JpQ%3D%3D&wt=javabin&version=2} status=0 QTime=7
[junit4] 2> 547519 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={} status=0 QTime=0
[junit4] 2> 547519 INFO (qtp1140105293-11614) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={} status=0 QTime=0
[junit4] 2> 547520 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={} status=0 QTime=0
[junit4] 2> 547521 INFO (qtp1073030354-11599) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547521 INFO (updateExecutor-3256-thread-3-processing-n:127.0.0.1:33087_solr) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 547521 INFO (updateExecutor-3256-thread-3-processing-n:127.0.0.1:33087_solr) [n:127.0.0.1:33087_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547521 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 547521 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547521 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 547521 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 547626 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547629 INFO (qtp1697804457-11593) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547631 INFO (qtp1706888933-11603) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547635 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.12/jar_b.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547643 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547644 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547652 DEBUG (zkCallback-3300-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 547652 DEBUG (zkCallback-3294-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 547652 DEBUG (zkCallback-3288-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 547652 DEBUG (zkCallback-3282-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 547656 INFO (qtp1697804457-11595) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547661 INFO (qtp1706888933-11603) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547662 INFO (qtp1140105293-11613) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547662 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 547662 INFO (zkCallback-3282-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 547662 INFO (zkCallback-3282-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 547662 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 547662 INFO (zkCallback-3294-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 547662 INFO (zkCallback-3294-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 547663 INFO (zkCallback-3288-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 547663 INFO (zkCallback-3288-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 547663 INFO (zkCallback-3300-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 547663 INFO (zkCallback-3300-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 547663 INFO (zkCallback-3288-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.12 added for package: test_pkg with artifacts [/mypkg/v.0.12/jar_b.jar]
[junit4] 2> 547663 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.p.PackageLoader A new version: 0.12 added for package: test_pkg with artifacts [/mypkg/v.0.12/jar_b.jar]
[junit4] 2> 547663 INFO (zkCallback-3300-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.12 added for package: test_pkg with artifacts [/mypkg/v.0.12/jar_b.jar]
[junit4] 2> 547663 INFO (zkCallback-3294-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.12 added for package: test_pkg with artifacts [/mypkg/v.0.12/jar_b.jar]
[junit4] 2> 547663 INFO (zkCallback-3282-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.12 added for package: test_pkg with artifacts [/mypkg/v.0.12/jar_b.jar]
[junit4] 2> 547665 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547665 INFO (zkCallback-3282-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547665 INFO (zkCallback-3294-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547665 INFO (zkCallback-3288-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547669 INFO (zkCallback-3300-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547669 INFO (zkCallback-3294-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547669 INFO (zkCallback-3282-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547669 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547669 INFO (zkCallback-3288-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547670 INFO (zkCallback-3300-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547671 INFO (zkCallback-3300-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node2/filestore/mypkg/v.0.12]
[junit4] 2> 547671 INFO (zkCallback-3288-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node3/filestore/mypkg/v.0.12]
[junit4] 2> 547671 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node1/filestore/mypkg/v.0.12]
[junit4] 2> 547671 INFO (zkCallback-3294-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node4/filestore/mypkg/v.0.12]
[junit4] 2> 547671 INFO (zkCallback-3282-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J5/temp/solr.pkg.TestPackages_BDC1749D6362541E-001/tempDir-001/node1/filestore/mypkg/v.0.12]
[junit4] 2> 547671 INFO (zkCallback-3300-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 547671 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 547671 INFO (zkCallback-3294-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 547672 INFO (zkCallback-3282-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 547672 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=0 QTime=34
[junit4] 2> 547672 INFO (zkCallback-3288-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 547675 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 547676 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.13/jar_a.jar
[junit4] 2> 547676 INFO (qtp1697804457-11593) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547677 INFO (qtp1706888933-11583) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547678 INFO (qtp1073030354-11599) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 547678 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.13/jar_a.jar
[junit4] 2> 547678 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.13/jar_a.jar and metadata. sizes 6582 246
[junit4] 2> 547679 INFO (qtp1073030354-11589) [n:127.0.0.1:34933_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={getFrom=127.0.0.1:45949_solr} status=0 QTime=0
[junit4] 2> 547679 INFO (updateExecutor-3263-thread-1-processing-n:127.0.0.1:34933_solr) [n:127.0.0.1:34933_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.13/jar_a.jar from 127.0.0.1:45949_solr
[junit4] 2> 547679 INFO (qtp1697804457-11597) [n:127.0.0.1:33087_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={getFrom=127.0.0.1:45949_solr} status=0 QTime=0
[junit4] 2> 547680 INFO (updateExecutor-3256-thread-3-processing-n:127.0.0.1:33087_solr) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.13/jar_a.jar from 127.0.0.1:45949_solr
[junit4] 2> 547680 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/.jar_a.jar.json params={} status=0 QTime=0
[junit4] 2> 547680 INFO (qtp1706888933-11603) [n:127.0.0.1:38359_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={getFrom=127.0.0.1:45949_solr} status=0 QTime=0
[junit4] 2> 547680 INFO (qtp1140105293-11614) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/.jar_a.jar.json params={} status=0 QTime=0
[junit4] 2> 547680 INFO (updateExecutor-3277-thread-1-processing-n:127.0.0.1:38359_solr) [n:127.0.0.1:38359_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.13/jar_a.jar from 127.0.0.1:45949_solr
[junit4] 2> 547680 INFO (qtp1140105293-11613) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={} status=0 QTime=0
[junit4] 2> 547680 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={} status=0 QTime=0
[junit4] 2> 547681 INFO (qtp1140105293-11614) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/.jar_a.jar.json params={} status=0 QTime=0
[junit4] 2> 547681 INFO (qtp1140105293-11585) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={} status=0 QTime=0
[junit4] 2> 547682 INFO (updateExecutor-3256-thread-3-processing-n:127.0.0.1:33087_solr) [n:127.0.0.1:33087_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.13/jar_a.jar and metadata. sizes 6582 246
[junit4] 2> 547682 INFO (updateExecutor-3256-thread-3-processing-n:127.0.0.1:33087_solr) [n:127.0.0.1:33087_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.13/jar_a.jar
[junit4] 2> 547682 INFO (qtp1140105293-11605) [n:127.0.0.1:45949_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/mypkg/v.0.13/jar_a.jar params={sig=j%2BRflxi64tXdqosIhbusqi6GTwZq8znunC/dzwcWW0/dHlFGKDurOaE1Nz9FSPJuXbHkVLj638yZ0Lp1ssnoYA%3D%3D&wt=javabin&version=2} status=0 QT
[...truncated too long message...]
cConnected type:NodeDataChanged path:/collections/infected/state.json] for collection [infected] has occurred - updating... (live nodes size: [2])
[junit4] 2> 830927 INFO (zkCallback-3380-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: [2])
[junit4] 2> 830927 INFO (zkCallback-3380-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: [2])
[junit4] 2> 830927 INFO (zkCallback-3369-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: [2])
[junit4] 2> 830957 INFO (zkCallback-3369-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 830971 INFO (closeThreadPool-3411-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72102216538587144-127.0.0.1:37285_solr-n_0000000000) closing
[junit4] 2> 830971 INFO (OverseerStateUpdate-72102216538587144-127.0.0.1:37285_solr-n_0000000000) [n:127.0.0.1:37285_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:37285_solr
[junit4] 2> 830971 INFO (OverseerAutoScalingTriggerThread-72102216538587144-127.0.0.1:37285_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 830983 INFO (closeThreadPool-3411-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72102216538587144-127.0.0.1:37285_solr-n_0000000000) closing
[junit4] 2> 831012 INFO (jetty-closer-3400-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@222596fd{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:0}
[junit4] 2> 831012 INFO (jetty-closer-3400-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@58fa13c5{/solr,null,UNAVAILABLE}
[junit4] 2> 831012 INFO (jetty-closer-3400-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 831099 INFO (jetty-closer-3400-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72102216538587144-127.0.0.1:37285_solr-n_0000000000) closing
[junit4] 2> 831108 INFO (jetty-closer-3400-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1b548a6b{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:0}
[junit4] 2> 831108 INFO (jetty-closer-3400-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@32c01163{/solr,null,UNAVAILABLE}
[junit4] 2> 831108 INFO (jetty-closer-3400-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 831200 INFO (jetty-closer-3400-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@653908d1{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:0}
[junit4] 2> 831201 INFO (jetty-closer-3400-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3689b743{/solr,null,UNAVAILABLE}
[junit4] 2> 831201 INFO (jetty-closer-3400-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 831201 INFO (SUITE-TestQueryingOnDownCollection-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 831415 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> 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> 26 /solr/collections/infected/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2> 4 /solr/clusterprops.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> 4 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 831416 INFO (SUITE-TestQueryingOnDownCollection-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:38591
[junit4] 2> 831416 INFO (SUITE-TestQueryingOnDownCollection-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38591
[junit4] 2> 831416 INFO (SUITE-TestQueryingOnDownCollection-seed#[BDC1749D6362541E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 38591
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.TestQueryingOnDownCollection_BDC1749D6362541E-001
[junit4] 2> Feb 18, 2020 11:55:18 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(Lucene84): {_root_=PostingsFormat(name=LuceneFixedGap), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84))}, docValues:{_version_=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1947, maxMBSortInHeap=6.248793537406291, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@73186c64), locale=es-HN, timezone=Europe/Zaporozhye
[junit4] 2> NOTE: Linux 5.3.0-28-generic amd64/AdoptOpenJDK 13.0.2 (64-bit)/cpus=16,threads=1,free=304087040,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [SecurityConfHandlerTest, TestScoreJoinQPNoScore, TestBlobHandler, TestQueryTypes, SliceStateTest, RangeFacetCloudTest, SolrJmxReporterTest, AnalyticsMergeStrategyTest, CreateRoutedAliasTest, SystemCollectionCompatTest, HdfsSyncSliceTest, RegexBytesRefFilterTest, QueryResultKeyTest, TestUniqueKeyFieldResource, TestCustomStream, MaxSizeAutoCommitTest, DimensionalRoutedAliasUpdateProcessorTest, TestMultiWordSynonyms, TestFieldTypeResource, DistributedFacetPivotWhiteBoxTest, SystemInfoHandlerTest, LeaderFailureAfterFreshStartTest, TestConfigSetImmutable, SolrLogAuditLoggerPluginTest, CheckHdfsIndexTest, BasicZkTest, TestDistributedStatsComponentCardinality, SolrCoreTest, TestCrossCoreJoin, EchoParamsTest, TestSortByMinMaxFunction, CategoryRoutedAliasUpdateProcessorTest, ConfigureRecoveryStrategyTest, TestSolrCloudWithSecureImpersonation, DistributedExpandComponentTest, IndexSizeTriggerMixedBoundsTest, TestInPlaceUpdatesStandalone, DeleteStatusTest, TestRemoteStreaming, OverseerTest, TestCollectionsAPIViaSolrCloudCluster, TestExclusionRuleCollectionAccess, JavaBinAtomicUpdateMultivalueTest, TestFieldSortValues, JSONWriterTest, TestClusterProperties, ScheduledTriggerIntegrationTest, ScriptEngineTest, TestCloudManagedSchema, TestIndexSearcher, TestImpersonationWithHadoopAuth, TestSweetSpotSimilarityFactory, TestRealTimeGet, TestClusterStateMutator, TestComplexPhraseQParserPlugin, RemoteQueryErrorTest, SchemaVersionSpecificBehaviorTest, TestLMDirichletSimilarityFactory, TestSimNodeAddedTrigger, TestNumericRangeQuery32, SimpleMLTQParserTest, TestPhraseSuggestions, CollectionStateFormat2Test, MigrateRouteKeyTest, TestAtomicUpdateErrorCases, TestPostingsSolrHighlighter, SimplePostToolTest, HdfsChaosMonkeyNothingIsSafeTest, TestJsonFacetsStatsParsing, TestAnalyzedSuggestions, TestSolrCloudSnapshots, UpdateParamsTest, TlogReplayBufferedWhileIndexingTest, TestGroupingSearch, AssignBackwardCompatibilityTest, DocValuesNotIndexedTest, HttpPartitionTest, TestCloudSearcherWarming, TestQueryingOnDownCollection]
[junit4] Completed [533/904 (2!)] on J0 in 3.75s, 1 test, 1 failure <<< FAILURES!
[...truncated 53863 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25757/consoleText
[repro] Revision: ccb390d4a6fb1a00454660a50ec85287571ab4bf
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC"
[repro] Repro line: ant test -Dtestcase=TestPackages -Dtests.method=testPluginLoading -Dtests.seed=BDC1749D6362541E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=vun-TZ -Dtests.timezone=America/Argentina/Jujuy -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] Repro line: ant test -Dtestcase=TestQueryingOnDownCollection -Dtests.method=testQueryToDownCollectionShouldFailFast -Dtests.seed=BDC1749D6362541E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-HN -Dtests.timezone=Europe/Zaporozhye -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[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] TestQueryingOnDownCollection
[repro] TestPackages
[repro] ant compile-test
[...truncated 3146 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10 -Dtests.class="*.TestQueryingOnDownCollection|*.TestPackages" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC" -Dtests.seed=BDC1749D6362541E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=es-HN -Dtests.timezone=Europe/Zaporozhye -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...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...]