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/01/29 18:57:24 UTC
[JENKINS-Experimental-GC] Lucene-Solr-8.x-Linux
(64bit/jdk-14-ea+32) - Build # 1948 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/1948/
Java: 64bit/jdk-14-ea+32 -XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC
1 tests failed.
FAILED: org.apache.solr.pkg.TestPackages.testPluginLoading
Error Message:
req: org.apache.solr.filestore.TestDistribPackageStore$$Lambda$905/0x00007ff586e908b0@2ee32d6c . 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$905/0x00007ff586e908b0@2ee32d6c . 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([42E44689CA2DED2E:9462A67429332AB4]: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:415)
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:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:832)
Build Log:
[...truncated 14976 lines...]
[junit4] Suite: org.apache.solr.pkg.TestPackages
[junit4] 2> 542249 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/data-dir-50-001
[junit4] 2> 542249 WARN (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=17 numCloses=17
[junit4] 2> 542249 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 542250 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-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> 542250 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 542252 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAPI
[junit4] 2> 542253 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001
[junit4] 2> 542253 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 542254 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 542254 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 542354 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer start zk server on port:43013
[junit4] 2> 542354 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:43013
[junit4] 2> 542354 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43013
[junit4] 2> 542354 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 43013
[junit4] 2> 542358 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542359 INFO (zkConnectionManagerCallback-2731-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542359 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542367 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542371 INFO (zkConnectionManagerCallback-2733-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542371 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542373 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542380 INFO (zkConnectionManagerCallback-2735-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542380 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542496 WARN (jetty-launcher-2736-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 542496 WARN (jetty-launcher-2736-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 542496 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 542496 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 542496 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 14-ea+32-1423
[junit4] 2> 542497 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 542497 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 542497 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 14-ea+32-1423
[junit4] 2> 542497 WARN (jetty-launcher-2736-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 542497 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 542497 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 542497 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 14-ea+32-1423
[junit4] 2> 542504 WARN (jetty-launcher-2736-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 542504 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 542504 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 542504 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 14-ea+32-1423
[junit4] 2> 542524 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 542524 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 542524 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 542532 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1965bc38{/solr,null,AVAILABLE}
[junit4] 2> 542537 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 542537 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 542537 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 542539 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5317a3fc{/solr,null,AVAILABLE}
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@63598e15{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36795}
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.e.j.s.Server Started @542879ms
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36795}
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4a68ffbd{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:41897}
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.e.j.s.Server Started @542879ms
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41897}
[junit4] 2> 542562 ERROR (jetty-launcher-2736-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 542562 ERROR (jetty-launcher-2736-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 542562 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 542563 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-29T18:33:23.018994Z
[junit4] 2> 542563 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-29T18:33:23.018994Z
[junit4] 2> 542566 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 542566 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 542566 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 542569 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542570 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542570 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 542570 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 542570 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 542570 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@575fca74{/solr,null,AVAILABLE}
[junit4] 2> 542570 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5a01c233{/solr,null,AVAILABLE}
[junit4] 2> 542571 INFO (zkConnectionManagerCallback-2739-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7c74b78c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:42043}
[junit4] 2> 542571 INFO (zkConnectionManagerCallback-2740-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6cf8c091{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:39217}
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.e.j.s.Server Started @542888ms
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.e.j.s.Server Started @542888ms
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39217}
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=42043}
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542571 ERROR (jetty-launcher-2736-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 542571 ERROR (jetty-launcher-2736-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-29T18:33:23.027794Z
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-29T18:33:23.027793Z
[junit4] 2> 542571 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 542572 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 542573 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542573 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542574 INFO (zkConnectionManagerCallback-2743-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542574 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542574 INFO (zkConnectionManagerCallback-2744-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542574 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542575 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 542575 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 542764 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 542765 WARN (jetty-launcher-2736-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@687c06ab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542765 WARN (jetty-launcher-2736-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@687c06ab[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542768 WARN (jetty-launcher-2736-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@28b2bf25[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542768 WARN (jetty-launcher-2736-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@28b2bf25[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542771 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43013/solr
[junit4] 2> 542774 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542776 INFO (zkConnectionManagerCallback-2751-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542777 INFO (jetty-launcher-2736-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 542827 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 542830 WARN (jetty-launcher-2736-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@27d58444[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542830 WARN (jetty-launcher-2736-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@27d58444[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542837 WARN (jetty-launcher-2736-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4790b525[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542837 WARN (jetty-launcher-2736-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4790b525[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 542838 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43013/solr
[junit4] 2> 542838 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 542842 INFO (zkConnectionManagerCallback-2758-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 542842 INFO (jetty-launcher-2736-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543004 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 543005 WARN (jetty-launcher-2736-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4f08fb9e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543005 WARN (jetty-launcher-2736-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4f08fb9e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543011 WARN (jetty-launcher-2736-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4576d79e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543011 WARN (jetty-launcher-2736-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4576d79e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543012 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43013/solr
[junit4] 2> 543013 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543021 INFO (zkConnectionManagerCallback-2766-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543021 INFO (jetty-launcher-2736-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543022 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 543023 WARN (jetty-launcher-2736-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5d958263[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543023 WARN (jetty-launcher-2736-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5d958263[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543046 WARN (jetty-launcher-2736-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@644cac1b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543046 WARN (jetty-launcher-2736-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@644cac1b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 543048 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43013/solr
[junit4] 2> 543048 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543050 INFO (zkConnectionManagerCallback-2772-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543050 INFO (jetty-launcher-2736-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543081 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543082 INFO (zkConnectionManagerCallback-2774-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543082 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543116 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42043_solr
[junit4] 2> 543117 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.c.Overseer Overseer (id=72096005686886411-127.0.0.1:42043_solr-n_0000000000) starting
[junit4] 2> 543122 INFO (OverseerStateUpdate-72096005686886411-127.0.0.1:42043_solr-n_0000000000) [n:127.0.0.1:42043_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:42043_solr
[junit4] 2> 543123 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42043_solr
[junit4] 2> 543127 INFO (zkCallback-2773-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 543127 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 543128 WARN (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_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> 543137 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 543153 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42043.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543157 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42043.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543157 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42043.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543158 INFO (jetty-launcher-2736-thread-3) [n:127.0.0.1:42043_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node3/.
[junit4] 2> 543190 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543190 INFO (zkConnectionManagerCallback-2780-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543190 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543195 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 543196 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:36795_solr as DOWN
[junit4] 2> 543196 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 543196 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36795_solr
[junit4] 2> 543197 INFO (zkCallback-2773-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 543197 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 543197 WARN (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_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> 543201 INFO (zkCallback-2779-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 543209 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 543224 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36795.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543230 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36795.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543230 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36795.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543231 INFO (jetty-launcher-2736-thread-4) [n:127.0.0.1:36795_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node4/.
[junit4] 2> 543280 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543281 INFO (zkConnectionManagerCallback-2786-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543281 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543284 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 543285 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:41897_solr as DOWN
[junit4] 2> 543286 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 543286 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41897_solr
[junit4] 2> 543286 INFO (zkCallback-2773-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 543286 INFO (zkCallback-2779-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 543287 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 543287 WARN (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_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> 543290 INFO (zkCallback-2785-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 543298 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 543309 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41897.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543316 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41897.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543317 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_41897.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543318 INFO (jetty-launcher-2736-thread-1) [n:127.0.0.1:41897_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node1/.
[junit4] 2> 543381 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543381 INFO (zkConnectionManagerCallback-2792-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543381 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543383 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 543385 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:39217_solr as DOWN
[junit4] 2> 543385 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 543385 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39217_solr
[junit4] 2> 543386 INFO (zkCallback-2773-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 543386 INFO (zkCallback-2779-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 543386 INFO (zkCallback-2785-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 543386 INFO (zkCallback-2791-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 543387 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 543387 WARN (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_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> 543398 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 543416 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39217.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543422 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39217.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543422 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39217.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43c79d8a
[junit4] 2> 543423 INFO (jetty-launcher-2736-thread-2) [n:127.0.0.1:39217_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node2/.
[junit4] 2> 543455 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 543456 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 543457 INFO (zkConnectionManagerCallback-2801-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 543457 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 543457 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 543458 INFO (TEST-TestPackages.testAPI-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43013/solr ready
[junit4] 2> 543465 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543471 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543472 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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> 543474 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543474 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543475 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543475 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543475 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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> 543476 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543476 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543476 ERROR (qtp1648304806-9250) [n:127.0.0.1:39217_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:341) ~[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:832) [?:?]
[junit4] 2> 543476 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=400 QTime=14
[junit4] 2> 543480 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543480 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543481 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543481 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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> 543481 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543482 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 543483 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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:39217_solr} status=0 QTime=0
[junit4] 2> 543484 INFO (updateExecutor-2747-thread-1-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_a.jar from 127.0.0.1:39217_solr
[junit4] 2> 543484 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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:39217_solr} status=0 QTime=0
[junit4] 2> 543484 INFO (updateExecutor-2768-thread-1-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_a.jar from 127.0.0.1:39217_solr
[junit4] 2> 543485 INFO (qtp1648304806-9260) [n:127.0.0.1:39217_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> 543485 INFO (qtp1648304806-9260) [n:127.0.0.1:39217_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> 543486 INFO (qtp1648304806-9260) [n:127.0.0.1:39217_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> 543486 INFO (updateExecutor-2747-thread-1-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 543486 INFO (updateExecutor-2747-thread-1-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543487 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_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> 543488 INFO (updateExecutor-2768-thread-1-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 543488 INFO (updateExecutor-2768-thread-1-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543493 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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:39217_solr} status=0 QTime=8
[junit4] 2> 543493 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_a.jar from 127.0.0.1:39217_solr
[junit4] 2> 543493 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_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=15
[junit4] 2> 543494 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_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> 543494 INFO (qtp1648304806-9260) [n:127.0.0.1:39217_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> 543495 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_a.jar and metadata. sizes 6860 144
[junit4] 2> 543495 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_a.jar
[junit4] 2> 543499 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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> 543508 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543511 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543519 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_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> 543523 ERROR (qtp1152321880-9269) [n:127.0.0.1:41897_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:341) ~[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:832) [?:?]
[junit4] 2> 543523 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=400 QTime=2
[junit4] 2> 543529 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:36795_solr} status=0 QTime=0
[junit4] 2> 543529 INFO (updateExecutor-2768-thread-1-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:36795_solr
[junit4] 2> 543530 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543530 INFO (qtp1924351914-9265) [n:127.0.0.1:42043_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:36795_solr} status=0 QTime=0
[junit4] 2> 543530 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:36795_solr
[junit4] 2> 543530 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 543531 INFO (updateExecutor-2768-thread-1-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 543531 INFO (updateExecutor-2768-thread-1-processing-n:127.0.0.1:41897_solr) [n:127.0.0.1:41897_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 543534 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543534 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:36795_solr} status=0 QTime=4
[junit4] 2> 543535 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={sync=true} status=0 QTime=8
[junit4] 2> 543535 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:36795_solr
[junit4] 1> sync resp: http://127.0.0.1:36795/api/node/files/_trusted_/keys/pub_key512.der?sync=true ,is: null
[junit4] 2> 543535 INFO (qtp1839099350-9272) [n:127.0.0.1:36795_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 543535 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543536 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 543536 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 543536 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 543537 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 543537 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 543538 INFO (qtp1924351914-9265) [n:127.0.0.1:42043_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> 543549 INFO (qtp1839099350-9272) [n:127.0.0.1:36795_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> 543555 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_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> 543563 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_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> 543578 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543580 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543581 INFO (qtp1839099350-9272) [n:127.0.0.1:36795_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> 543586 INFO (qtp1924351914-9265) [n:127.0.0.1:42043_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> 543587 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_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> 543587 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543588 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 543598 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_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:41897_solr} status=0 QTime=2
[junit4] 2> 543598 INFO (updateExecutor-2747-thread-2-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_b.jar from 127.0.0.1:41897_solr
[junit4] 2> 543598 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543598 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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:41897_solr} status=0 QTime=0
[junit4] 2> 543598 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_b.jar from 127.0.0.1:41897_solr
[junit4] 2> 543599 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_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:41897_solr} status=0 QTime=0
[junit4] 2> 543599 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.12/jar_b.jar from 127.0.0.1:41897_solr
[junit4] 2> 543599 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543599 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543600 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 543600 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543602 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_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=37
[junit4] 2> 543603 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543604 INFO (updateExecutor-2747-thread-2-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 543604 INFO (updateExecutor-2747-thread-2-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543607 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_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> 543607 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543609 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.12/jar_b.jar and metadata. sizes 6860 246
[junit4] 2> 543609 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.12/jar_b.jar
[junit4] 2> 543612 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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> 543615 INFO (qtp1839099350-9272) [n:127.0.0.1:36795_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> 543619 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_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> 543621 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_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> 543629 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543630 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543633 DEBUG (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543633 DEBUG (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543633 DEBUG (zkCallback-2779-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543633 DEBUG (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543633 INFO (qtp1648304806-9250) [n:127.0.0.1:39217_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543634 INFO (qtp1924351914-9265) [n:127.0.0.1:42043_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543634 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543634 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 543634 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 543635 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_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> 543637 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543637 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543639 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node4/filestore/mypkg/v.0.12]
[junit4] 2> 543639 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 543639 INFO (qtp1839099350-9256) [n:127.0.0.1:36795_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=0 QTime=12
[junit4] 2> 543642 INFO (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 543642 INFO (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 543642 INFO (zkCallback-2791-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> 543643 INFO (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 543643 INFO (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 543643 INFO (zkCallback-2785-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> 543643 INFO (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 543643 INFO (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageLoader A new package: test_pkg introduced
[junit4] 2> 543643 INFO (zkCallback-2773-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> 543643 INFO (zkCallback-2791-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543643 INFO (zkCallback-2779-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 543646 INFO (zkCallback-2791-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543646 INFO (qtp1152321880-9279) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543647 INFO (qtp1152321880-9279) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/v.0.13/jar_a.jar
[junit4] 2> 543647 INFO (zkCallback-2791-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node2/filestore/mypkg/v.0.12]
[junit4] 2> 543647 INFO (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 543648 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_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> 543648 INFO (zkCallback-2773-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543648 INFO (zkCallback-2785-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543648 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_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> 543649 INFO (zkCallback-2785-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543649 INFO (zkCallback-2773-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543650 INFO (zkCallback-2773-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node3/filestore/mypkg/v.0.12]
[junit4] 2> 543650 INFO (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 543650 INFO (zkCallback-2785-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node1/filestore/mypkg/v.0.12]
[junit4] 2> 543650 INFO (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageLoader version: 0.12 is the new latest in package: test_pkg
[junit4] 2> 543650 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_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> 543650 INFO (qtp1152321880-9279) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/v.0.13/jar_a.jar
[junit4] 2> 543651 INFO (qtp1152321880-9279) [n:127.0.0.1:41897_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.13/jar_a.jar and metadata. sizes 6582 246
[junit4] 2> 543653 INFO (qtp1839099350-9272) [n:127.0.0.1:36795_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:41897_solr} status=0 QTime=0
[junit4] 2> 543653 INFO (updateExecutor-2747-thread-2-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.13/jar_a.jar from 127.0.0.1:41897_solr
[junit4] 2> 543653 INFO (qtp1648304806-9260) [n:127.0.0.1:39217_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:41897_solr} status=0 QTime=0
[junit4] 2> 543653 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.13/jar_a.jar from 127.0.0.1:41897_solr
[junit4] 2> 543653 INFO (qtp1924351914-9265) [n:127.0.0.1:42043_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:41897_solr} status=0 QTime=0
[junit4] 2> 543653 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/v.0.13/jar_a.jar from 127.0.0.1:41897_solr
[junit4] 2> 543653 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543653 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_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> 543653 INFO (qtp1152321880-9279) [n:127.0.0.1:41897_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 QTime=12
[junit4] 2> 543654 INFO (qtp1152321880-9285) [n:127.0.0.1:41897_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> 543654 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_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> 543654 INFO (qtp1152321880-9269) [n:127.0.0.1:41897_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> 543654 INFO (qtp1152321880-9279) [n:127.0.0.1:41897_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> 543655 INFO (updateExecutor-2747-thread-2-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.13/jar_a.jar and metadata. sizes 6582 246
[junit4] 2> 543655 INFO (updateExecutor-2747-thread-2-processing-n:127.0.0.1:36795_solr) [n:127.0.0.1:36795_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.13/jar_a.jar
[junit4] 2> 543655 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.13/jar_a.jar and metadata. sizes 6582 246
[junit4] 2> 543655 INFO (updateExecutor-2762-thread-2-processing-n:127.0.0.1:39217_solr) [n:127.0.0.1:39217_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.13/jar_a.jar
[junit4] 2> 543655 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/v.0.13/jar_a.jar and metadata. sizes 6582 246
[junit4] 2> 543655 INFO (updateExecutor-2754-thread-1-processing-n:127.0.0.1:42043_solr) [n:127.0.0.1:42043_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/v.0.13/jar_a.jar
[junit4] 2> 543659 INFO (qtp1924351914-9265) [n:127.0.0.1:42043_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543661 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543663 INFO (qtp1152321880-9252) [n:127.0.0.1:41897_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543671 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/v.0.13/jar_a.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543673 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543674 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543675 DEBUG (zkCallback-2779-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543675 DEBUG (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543675 INFO (qtp1152321880-9285) [n:127.0.0.1:41897_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543675 DEBUG (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543676 INFO (qtp1924351914-9254) [n:127.0.0.1:42043_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543676 INFO (qtp1648304806-9261) [n:127.0.0.1:39217_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 543676 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 543676 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader Package test_pkg is modified
[junit4] 2> 543676 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.p.PackageLoader A new version: 0.13 added for package: test_pkg with artifacts [/mypkg/v.0.13/jar_a.jar]
[junit4] 2> 543682 DEBUG (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 543682 INFO (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 543682 INFO (zkCallback-2779-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 543682 INFO (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 543682 INFO (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageLoader Package test_pkg is modified
[junit4] 2> 543682 INFO (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageLoader Package test_pkg is modified
[junit4] 2> 543682 INFO (zkCallback-2785-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.13 added for package: test_pkg with artifacts [/mypkg/v.0.13/jar_a.jar]
[junit4] 2> 543682 INFO (zkCallback-2773-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.13 added for package: test_pkg with artifacts [/mypkg/v.0.13/jar_a.jar]
[junit4] 2> 543683 INFO (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 543683 INFO (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageLoader Package test_pkg is modified
[junit4] 2> 543683 INFO (zkCallback-2791-thread-1) [ ] o.a.s.p.PackageLoader A new version: 0.13 added for package: test_pkg with artifacts [/mypkg/v.0.13/jar_a.jar]
[junit4] 2> 543683 INFO (zkCallback-2779-thread-1) [ ] o.a.s.p.PackageLoader Package test_pkg is modified
[junit4] 2> 543683 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543683 INFO (zkCallback-2773-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543683 INFO (zkCallback-2785-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543684 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543684 INFO (zkCallback-2791-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543684 INFO (zkCallback-2773-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543684 INFO (zkCallback-2785-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543685 INFO (zkCallback-2791-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 543685 INFO (qtp1839099350-9267) [n:127.0.0.1:36795_solr ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001/tempDir-001/node4/filestore/mypkg/v.0.13]
[junit4]
[...truncated too long message...]
ry solr.jetty / com.codahale.metrics.MetricRegistry@4a40a855
[junit4] 2> 559156 INFO (jetty-closer-2907-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 559164 INFO (closeThreadPool-2922-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72096006447497227-127.0.0.1:40373_solr-n_0000000000) closing
[junit4] 2> 559255 INFO (jetty-closer-2907-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4cacdebf{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 559255 INFO (jetty-closer-2907-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1c219323{/solr,null,UNAVAILABLE}
[junit4] 2> 559255 INFO (jetty-closer-2907-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 559457 INFO (jetty-closer-2907-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72096006447497227-127.0.0.1:40373_solr-n_0000000000) closing
[junit4] 2> 565017 INFO (jetty-closer-2907-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@45dd3864{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 565017 INFO (jetty-closer-2907-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@49925a28{/solr,null,UNAVAILABLE}
[junit4] 2> 565017 INFO (jetty-closer-2907-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 565047 INFO (jetty-closer-2907-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3e8b1402{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 565047 INFO (jetty-closer-2907-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6c4a0d16{/solr,null,UNAVAILABLE}
[junit4] 2> 565047 INFO (jetty-closer-2907-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 565079 INFO (jetty-closer-2907-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@23747855{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 565079 INFO (jetty-closer-2907-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1365b978{/solr,null,UNAVAILABLE}
[junit4] 2> 565079 INFO (jetty-closer-2907-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 565080 INFO (TEST-TestPackages.testPluginLoading-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 565282 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> 8 /solr/configs/conf
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/collections/testPluginLoadingColl/terms/shard2
[junit4] 2> 5 /solr/collections/testPluginLoadingColl/terms/shard1
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4 /solr/packages.json
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 31 /solr/collections/testPluginLoadingColl/state.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 4 /solr/packages.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 25 /solr/overseer/queue
[junit4] 2> 20 /solr/live_nodes
[junit4] 2> 10 /solr/collections
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> 565283 INFO (TEST-TestPackages.testPluginLoading-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46093
[junit4] 2> 565283 INFO (TEST-TestPackages.testPluginLoading-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46093
[junit4] 2> 565283 INFO (TEST-TestPackages.testPluginLoading-seed#[42E44689CA2DED2E]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46093
[junit4] 2> 565284 INFO (TEST-TestPackages.testPluginLoading-seed#[42E44689CA2DED2E]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPluginLoading
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestPackages -Dtests.method=testPluginLoading -Dtests.seed=42E44689CA2DED2E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=be -Dtests.timezone=Africa/Bujumbura -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 11.4s J1 | TestPackages.testPluginLoading <<<
[junit4] > Throwable #1: java.lang.AssertionError: req: org.apache.solr.filestore.TestDistribPackageStore$$Lambda$905/0x00007ff586e908b0@2ee32d6c . attempt: 9 Mismatch for value : '[config, queryResponseWriter, json1, _packageinfo_, package]' in response , {
[junit4] > "responseHeader":{
[junit4] > "status":0,
[junit4] > "QTime":0},
[junit4] > "config":{"queryResponseWriter":{"json1":{
[junit4] > "name":"json1",
[junit4] > "class":"mypkg:org.apache.solr.core.RuntimeLibResponseWriter"}}}}
[junit4] > at __randomizedtesting.SeedInfo.seed([42E44689CA2DED2E:9462A67429332AB4]:0)
[junit4] > at org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:242)
[junit4] > at org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:213)
[junit4] > at org.apache.solr.pkg.TestPackages.verifyCmponent(TestPackages.java:415)
[junit4] > at org.apache.solr.pkg.TestPackages.testPluginLoading(TestPackages.java:153)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:832)
[junit4] 2> 565286 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 565286 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:46093
[junit4] 2> 565286 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:46093
[junit4] 2> 565286 INFO (SUITE-TestPackages-seed#[42E44689CA2DED2E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 46093
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.pkg.TestPackages_42E44689CA2DED2E-001
[junit4] 2> Jan 29, 2020 6:33:45 PM 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): {}, docValues:{}, maxPointsInLeafNode=1178, maxMBSortInHeap=7.860754584816182, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5ab0c7cc), locale=be, timezone=Africa/Bujumbura
[junit4] 2> NOTE: Linux 5.3.0-26-generic amd64/Oracle Corporation 14-ea (64-bit)/cpus=16,threads=1,free=272629760,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [LeaderVoteWaitTimeoutTest, TestXmlQParserPlugin, TestStressCloudBlindAtomicUpdates, TestManagedSchemaAPI, TestDistribPackageStore, TestDynamicLoading, TestUtils, TestReqParamsAPI, CloudExitableDirectoryReaderTest, OverseerSolrResponseTest, HdfsNNFailoverTest, TestDocTermOrdsUninvertLimit, InfixSuggestersTest, TriggerIntegrationTest, AdminHandlersProxyTest, TestIndexingPerformance, DirectoryFactoryTest, TestJmxIntegration, TestRTimerTree, TermVectorComponentDistributedTest, TestSimExecutePlanAction, NestedAtomicUpdateTest, MBeansHandlerTest, TestCloudRecovery, TestSubQueryTransformer, DistributedUpdateProcessorTest, JWTAuthPluginTest, TestEmbeddedSolrServerAdminHandler, MoreLikeThisHandlerTest, TestScoreJoinQPScore, IndexSizeTriggerTest, IndexSchemaRuntimeFieldTest, TestReloadDeadlock, TestComponentsName, TestRandomFlRTGCloud, PolyFieldTest, TestStressVersions, TestBM25SimilarityFactory, TestBadConfig, TestConfigSetsAPIZkFailure, MoveReplicaHDFSFailoverTest, AuditLoggerIntegrationTest, TestTolerantUpdateProcessorRandomCloud, TestJsonFacetRefinement, TestConfigReload, TestPackages]
[junit4] Completed [414/897 (1!)] on J1 in 24.02s, 2 tests, 1 failure <<< FAILURES!
[...truncated 46392 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/1948/consoleText
[repro] Revision: 47c01af39472b37e6a90b08d3eee7cc0b180428d
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC"
[repro] Repro line: ant test -Dtestcase=TestPackages -Dtests.method=testPluginLoading -Dtests.seed=42E44689CA2DED2E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=be -Dtests.timezone=Africa/Bujumbura -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] TestPackages
[repro] ant compile-test
[...truncated 3610 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestPackages" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC" -Dtests.seed=42E44689CA2DED2E -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=be -Dtests.timezone=Africa/Bujumbura -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 86 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.pkg.TestPackages
[repro] Exiting with code 0
[...truncated 43 lines...]