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/07/08 19:53:07 UTC
[JENKINS-Experimental-GC] Lucene-Solr-8.6-Windows
(64bit/jdk-15-ea+30) - Build # 347 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.6-Windows/347/
Java: 64bit/jdk-15-ea+30 -XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC
1 tests failed.
FAILED: org.apache.solr.handler.TestContainerPlugin.testApiFromPackage
Error Message:
Error from server at http://127.0.0.1:65527/solr: Error executing command
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteExecutionException: Error from server at http://127.0.0.1:65527/solr: Error executing command
at __randomizedtesting.SeedInfo.seed([41B7DB96E0998EBB:ACE923E7D2D35932]:0)
at org.apache.solr.client.solrj.impl.BaseHttpSolrClient$RemoteExecutionException.create(BaseHttpSolrClient.java:67)
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:647)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:370)
at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:298)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1157)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:918)
at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:850)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:231)
at org.apache.solr.handler.TestContainerPlugin.testApiFromPackage(TestContainerPlugin.java:266)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:64)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:832)
Build Log:
[...truncated 14349 lines...]
[junit4] Suite: org.apache.solr.handler.TestContainerPlugin
[junit4] 2> 521473 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of 'C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 521473 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 521474 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001\data-dir-41-001
[junit4] 2> 521474 WARN (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=60 numCloses=60
[junit4] 2> 521474 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 521478 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 521481 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testApiFromPackage
[junit4] 2> 521483 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001\tempDir-001
[junit4] 2> 521484 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 521484 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 521485 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 521586 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer start zk server on port: 65509
[junit4] 2> 521586 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:65509
[junit4] 2> 521586 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:65509
[junit4] 2> 521586 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 65509
[junit4] 2> 521593 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521601 INFO (zkConnectionManagerCallback-4084-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521601 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521605 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521608 INFO (zkConnectionManagerCallback-4086-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521609 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521610 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521614 INFO (zkConnectionManagerCallback-4088-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521614 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521724 WARN (jetty-launcher-4089-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 521724 WARN (jetty-launcher-4089-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 521724 WARN (jetty-launcher-4089-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+30-1476
[junit4] 2> 521724 WARN (jetty-launcher-4089-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+30-1476
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+30-1476
[junit4] 2> 521724 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 15-ea+30-1476
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2961f5e0{/solr,null,AVAILABLE}
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6e005fd4{/solr,null,AVAILABLE}
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5dc89ff9{/solr,null,AVAILABLE}
[junit4] 2> 521727 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@29ae445d{/solr,null,AVAILABLE}
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@74efdae6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:65533}
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@305516f6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:65527}
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.e.j.s.Server Started @521772ms
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.e.j.s.Server Started @521772ms
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65533}
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65527}
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@428f578b{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:65534}
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.e.j.s.Server Started @521772ms
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65534}
[junit4] 2> 521730 ERROR (jetty-launcher-4089-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 521730 ERROR (jetty-launcher-4089-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 521730 ERROR (jetty-launcher-4089-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-08T19:03:47.975544600Z
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-08T19:03:47.975544600Z
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 521730 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-08T19:03:47.975544600Z
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@39121673{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:65528}
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.e.j.s.Server Started @521778ms
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65528}
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521736 ERROR (jetty-launcher-4089-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-08T19:03:47.981179800Z
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521736 INFO (zkConnectionManagerCallback-4093-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521736 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 521741 INFO (zkConnectionManagerCallback-4097-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521741 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521741 INFO (zkConnectionManagerCallback-4095-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521741 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 521741 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521741 INFO (zkConnectionManagerCallback-4092-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521741 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 521741 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 521741 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 521917 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 521922 WARN (jetty-launcher-4089-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@e78dffe[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 521922 WARN (jetty-launcher-4089-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@e78dffe[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 521924 WARN (jetty-launcher-4089-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@477a2057[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 521924 WARN (jetty-launcher-4089-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@477a2057[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 521924 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65509/solr
[junit4] 2> 521924 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 521931 INFO (zkConnectionManagerCallback-4108-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 521931 INFO (jetty-launcher-4089-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522160 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 522160 WARN (jetty-launcher-4089-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7c3bf1ee[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522160 WARN (jetty-launcher-4089-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7c3bf1ee[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522160 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 522160 WARN (jetty-launcher-4089-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@306360fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522160 WARN (jetty-launcher-4089-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@306360fd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522160 WARN (jetty-launcher-4089-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5ea1cad[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522160 WARN (jetty-launcher-4089-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5ea1cad[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522168 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65509/solr
[junit4] 2> 522168 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522172 WARN (jetty-launcher-4089-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2813ee1b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522172 WARN (jetty-launcher-4089-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2813ee1b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522172 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65509/solr
[junit4] 2> 522177 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522177 INFO (zkConnectionManagerCallback-4129-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522177 INFO (jetty-launcher-4089-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522184 INFO (zkConnectionManagerCallback-4133-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522184 INFO (jetty-launcher-4089-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522255 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522255 INFO (zkConnectionManagerCallback-4135-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522255 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522310 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 522312 WARN (jetty-launcher-4089-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@738d14d2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522312 WARN (jetty-launcher-4089-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@738d14d2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522317 WARN (jetty-launcher-4089-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@44eafcdc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522317 WARN (jetty-launcher-4089-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@44eafcdc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 522318 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:65509/solr
[junit4] 2> 522319 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522319 INFO (zkConnectionManagerCallback-4145-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522319 INFO (jetty-launcher-4089-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522355 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522359 INFO (zkConnectionManagerCallback-4147-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522359 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522380 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:65528_solr
[junit4] 2> 522381 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.Overseer Overseer (id=72173981320609802-127.0.0.1:65528_solr-n_0000000000) starting
[junit4] 2> 522384 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:65527_solr
[junit4] 2> 522385 INFO (zkCallback-4134-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 522385 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 522387 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 522388 WARN (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_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> 522388 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:65528_solr as DOWN
[junit4] 2> 522388 INFO (OverseerStateUpdate-72173981320609802-127.0.0.1:65528_solr-n_0000000000) [n:127.0.0.1:65528_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:65528_solr
[junit4] 2> 522388 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 522388 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:65528_solr
[junit4] 2> 522391 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 522392 INFO (zkCallback-4134-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 522393 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 522394 WARN (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_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> 522427 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 522428 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 522454 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522461 INFO (zkConnectionManagerCallback-4165-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522461 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522468 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65527.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522469 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65528.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522476 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 522477 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65528.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522477 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65528.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522477 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65527.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522477 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65527.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522479 INFO (jetty-launcher-4089-thread-3) [n:127.0.0.1:65528_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001\tempDir-001\node3
[junit4] 2> 522479 INFO (jetty-launcher-4089-thread-2) [n:127.0.0.1:65527_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001\tempDir-001\node2
[junit4] 2> 522481 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:65534_solr as DOWN
[junit4] 2> 522482 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 522482 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:65534_solr
[junit4] 2> 522486 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 522486 INFO (zkCallback-4164-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 522486 INFO (zkCallback-4134-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 522487 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 522487 WARN (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_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> 522517 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 522537 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65534.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522541 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65534.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522542 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65534.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522543 INFO (jetty-launcher-4089-thread-4) [n:127.0.0.1:65534_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001\tempDir-001\node4
[junit4] 2> 522556 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522564 INFO (zkConnectionManagerCallback-4177-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522564 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522585 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 522607 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:65533_solr as DOWN
[junit4] 2> 522609 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 522609 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:65533_solr
[junit4] 2> 522610 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 522610 INFO (zkCallback-4164-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 522610 INFO (zkCallback-4176-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 522610 INFO (zkCallback-4134-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 522612 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 522612 WARN (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_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> 522642 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 522666 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65533.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522679 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65533.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522680 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_65533.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1cbe2365
[junit4] 2> 522686 INFO (jetty-launcher-4089-thread-1) [n:127.0.0.1:65533_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001\tempDir-001\node1
[junit4] 2> 522733 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 522734 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 522739 INFO (zkConnectionManagerCallback-4190-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 522739 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 522740 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 522741 INFO (TEST-TestContainerPlugin.testApiFromPackage-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:65509/solr ready
[junit4] 2> 522795 INFO (qtp1049816916-5776) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:65528_solr} status=0 QTime=1
[junit4] 2> 522795 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:65528_solr
[junit4] 2> 522800 INFO (qtp2049453011-5789) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:65528_solr} status=0 QTime=0
[junit4] 2> 522800 INFO (updateExecutor-4141-thread-1-processing-n:127.0.0.1:65533_solr) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:65528_solr
[junit4] 2> 522800 INFO (qtp936771321-5787) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=1
[junit4] 2> 522802 INFO (qtp936771321-5784) [n:127.0.0.1:65528_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> 522804 INFO (qtp1279832178-5790) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:65528_solr} status=0 QTime=0
[junit4] 2> 522804 INFO (updateExecutor-4121-thread-1-processing-n:127.0.0.1:65534_solr) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:65528_solr
[junit4] 2> 522805 INFO (qtp936771321-5779) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={sync=true} status=0 QTime=32
[junit4] 2> 522805 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 522805 INFO (qtp936771321-5775) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 1> sync resp: http://127.0.0.1:65528/api/node/files/_trusted_/keys/pub_key512.der?sync=true ,is: null
[junit4] 2> 522806 INFO (qtp936771321-5787) [n:127.0.0.1:65528_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> 522810 INFO (qtp936771321-5779) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=1
[junit4] 2> 522812 INFO (qtp1049816916-5781) [n:127.0.0.1:65527_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> 522820 INFO (updateExecutor-4141-thread-1-processing-n:127.0.0.1:65533_solr) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 522820 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 522820 INFO (updateExecutor-4141-thread-1-processing-n:127.0.0.1:65533_solr) [n:127.0.0.1:65533_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 522820 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 522827 INFO (updateExecutor-4121-thread-1-processing-n:127.0.0.1:65534_solr) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 522827 INFO (updateExecutor-4121-thread-1-processing-n:127.0.0.1:65534_solr) [n:127.0.0.1:65534_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 522924 INFO (qtp1049816916-5781) [n:127.0.0.1:65527_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=3
[junit4] 2> 522932 INFO (qtp936771321-5787) [n:127.0.0.1:65528_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=1
[junit4] 2> 522939 INFO (qtp1279832178-5794) [n:127.0.0.1:65534_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=1
[junit4] 2> 522944 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_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=1
[junit4] 2> 522959 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 522962 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /myplugin/v1.jar
[junit4] 2> 522963 INFO (qtp1049816916-5781) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 522966 INFO (qtp1279832178-5794) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 522967 INFO (qtp936771321-5779) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 522967 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore Unable to download file : /myplugin/v1.jar
[junit4] 2> 522974 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v1.jar and metadata. sizes 867 246
[junit4] 2> 522977 INFO (qtp936771321-5890) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={getFrom=127.0.0.1:65533_solr} status=0 QTime=0
[junit4] 2> 522977 INFO (qtp1279832178-5786) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={getFrom=127.0.0.1:65533_solr} status=0 QTime=0
[junit4] 2> 522977 INFO (updateExecutor-4104-thread-2-processing-n:127.0.0.1:65528_solr) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore fetching a file /myplugin/v1.jar from 127.0.0.1:65533_solr
[junit4] 2> 522977 INFO (updateExecutor-4121-thread-1-processing-n:127.0.0.1:65534_solr) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore fetching a file /myplugin/v1.jar from 127.0.0.1:65533_solr
[junit4] 2> 522978 INFO (qtp1049816916-5774) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={getFrom=127.0.0.1:65533_solr} status=0 QTime=0
[junit4] 2> 522978 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.DistribPackageStore fetching a file /myplugin/v1.jar from 127.0.0.1:65533_solr
[junit4] 2> 522978 INFO (qtp2049453011-5785) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/.v1.jar.json params={} status=0 QTime=0
[junit4] 2> 522978 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/myplugin/v1.jar params={sig=pmrmWCDafdNpYle2rueAGnU2J6NYlcAey9mkZYbqh%2B5RdYo2Ln%2BllLF9voyRj%2BDDivK9GV1XdtKvD9rgCxlD7Q%3D%3D&wt=javabin&version=2} status=0 QTime=23
[junit4] 2> 522979 INFO (qtp2049453011-5791) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/.v1.jar.json params={} status=0 QTime=0
[junit4] 2> 522980 INFO (qtp2049453011-5789) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/.v1.jar.json params={} status=0 QTime=0
[junit4] 2> 522980 INFO (qtp2049453011-5785) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={} status=0 QTime=0
[junit4] 2> 522981 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={} status=0 QTime=0
[junit4] 2> 522981 INFO (qtp2049453011-5791) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={} status=0 QTime=0
[junit4] 2> 522981 INFO (qtp1049816916-5776) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 522985 INFO (updateExecutor-4121-thread-1-processing-n:127.0.0.1:65534_solr) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v1.jar and metadata. sizes 867 246
[junit4] 2> 522985 INFO (updateExecutor-4121-thread-1-processing-n:127.0.0.1:65534_solr) [n:127.0.0.1:65534_solr ] o.a.s.f.PackageStoreAPI downloaded file: /myplugin/v1.jar
[junit4] 2> 522985 INFO (updateExecutor-4104-thread-2-processing-n:127.0.0.1:65528_solr) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v1.jar and metadata. sizes 867 246
[junit4] 2> 522985 INFO (updateExecutor-4104-thread-2-processing-n:127.0.0.1:65528_solr) [n:127.0.0.1:65528_solr ] o.a.s.f.PackageStoreAPI downloaded file: /myplugin/v1.jar
[junit4] 2> 522985 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v1.jar and metadata. sizes 867 246
[junit4] 2> 522985 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.PackageStoreAPI downloaded file: /myplugin/v1.jar
[junit4] 2> 523089 INFO (qtp1049816916-5776) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523095 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523101 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523107 INFO (qtp2049453011-5785) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523121 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523123 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /myplugin/v2.jar
[junit4] 2> 523126 INFO (qtp1049816916-5776) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523127 INFO (qtp2049453011-5789) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523127 INFO (qtp936771321-5890) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523127 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore Unable to download file : /myplugin/v2.jar
[junit4] 2> 523134 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v2.jar and metadata. sizes 867 246
[junit4] 2> 523138 INFO (qtp936771321-5787) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={getFrom=127.0.0.1:65534_solr} status=0 QTime=0
[junit4] 2> 523138 INFO (updateExecutor-4104-thread-2-processing-n:127.0.0.1:65528_solr) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore fetching a file /myplugin/v2.jar from 127.0.0.1:65534_solr
[junit4] 2> 523138 INFO (qtp2049453011-5785) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={getFrom=127.0.0.1:65534_solr} status=0 QTime=0
[junit4] 2> 523139 INFO (qtp1279832178-5794) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/.v2.jar.json params={} status=0 QTime=0
[junit4] 2> 523139 INFO (updateExecutor-4141-thread-2-processing-n:127.0.0.1:65533_solr) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore fetching a file /myplugin/v2.jar from 127.0.0.1:65534_solr
[junit4] 2> 523139 INFO (qtp1049816916-5774) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={getFrom=127.0.0.1:65534_solr} status=0 QTime=0
[junit4] 2> 523139 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.DistribPackageStore fetching a file /myplugin/v2.jar from 127.0.0.1:65534_solr
[junit4] 2> 523140 INFO (qtp1279832178-5790) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={} status=0 QTime=0
[junit4] 2> 523140 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/myplugin/v2.jar params={sig=StR3DmqaUSL7qjDOeVEiCqE%2BouiZAkW99fsL48F9oWG047o7NGgwwZ36iGgzDC3S2tPaFjRAd9Zg4UK7OZLQzg%3D%3D&wt=javabin&version=2} status=0 QTime=21
[junit4] 2> 523140 INFO (qtp1279832178-5786) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/.v2.jar.json params={} status=0 QTime=0
[junit4] 2> 523140 INFO (qtp1279832178-5786) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/.v2.jar.json params={} status=0 QTime=0
[junit4] 2> 523140 INFO (qtp1279832178-5794) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={} status=0 QTime=0
[junit4] 2> 523143 INFO (qtp1279832178-5792) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={} status=0 QTime=0
[junit4] 2> 523143 INFO (qtp1049816916-5780) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523146 INFO (updateExecutor-4104-thread-2-processing-n:127.0.0.1:65528_solr) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v2.jar and metadata. sizes 867 246
[junit4] 2> 523146 INFO (updateExecutor-4104-thread-2-processing-n:127.0.0.1:65528_solr) [n:127.0.0.1:65528_solr ] o.a.s.f.PackageStoreAPI downloaded file: /myplugin/v2.jar
[junit4] 2> 523148 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v2.jar and metadata. sizes 867 246
[junit4] 2> 523148 INFO (updateExecutor-4127-thread-1-processing-n:127.0.0.1:65527_solr) [n:127.0.0.1:65527_solr ] o.a.s.f.PackageStoreAPI downloaded file: /myplugin/v2.jar
[junit4] 2> 523148 INFO (updateExecutor-4141-thread-2-processing-n:127.0.0.1:65533_solr) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore persisted a file /myplugin/v2.jar and metadata. sizes 867 246
[junit4] 2> 523148 INFO (updateExecutor-4141-thread-2-processing-n:127.0.0.1:65533_solr) [n:127.0.0.1:65533_solr ] o.a.s.f.PackageStoreAPI downloaded file: /myplugin/v2.jar
[junit4] 2> 523251 INFO (qtp1049816916-5780) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523257 INFO (qtp936771321-5775) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523264 INFO (qtp1279832178-5786) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 523272 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/myplugin/v2.jar params={meta=true&wt=javabin} status=0 QTime=2
[junit4] 2> 523377 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523379 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523387 INFO (qtp1049816916-5781) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523387 INFO (qtp2049453011-5791) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523388 INFO (qtp1279832178-5790) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523388 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 523388 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 523390 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/myplugin/v1.jar]
[junit4] 2> 523400 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523402 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523405 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node3/filestore/myplugin]
[junit4] 2> 523406 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 523406 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=0 QTime=128
[junit4] 2> 523410 INFO (qtp1049816916-5774) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin} status=0 QTime=0
[junit4] 2> 523419 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 523419 INFO (zkCallback-4134-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 523419 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 523419 INFO (zkCallback-4176-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 523419 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 523419 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/myplugin/v1.jar]
[junit4] 2> 523419 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 523419 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/myplugin/v1.jar]
[junit4] 2> 523419 INFO (zkCallback-4176-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 523420 INFO (zkCallback-4176-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/myplugin/v1.jar]
[junit4] 2> 523421 INFO (zkCallback-4164-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523421 INFO (zkCallback-4176-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523421 INFO (zkCallback-4146-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523424 INFO (zkCallback-4164-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523424 INFO (zkCallback-4146-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523425 INFO (zkCallback-4176-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523426 INFO (zkCallback-4164-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node4/filestore/myplugin]
[junit4] 2> 523426 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node2/filestore/myplugin]
[junit4] 2> 523426 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 523427 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 523427 INFO (zkCallback-4176-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node1/filestore/myplugin]
[junit4] 2> 523427 INFO (zkCallback-4176-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 523515 INFO (qtp1049816916-5774) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin} status=0 QTime=0
[junit4] 2> 523519 INFO (qtp936771321-5779) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin} status=0 QTime=0
[junit4] 2> 523522 INFO (qtp1279832178-5794) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin} status=0 QTime=0
[junit4] 2> 523525 INFO (qtp2049453011-5789) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin} status=0 QTime=0
[junit4] 2> 523536 INFO (qtp1049816916-5774) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=8
[junit4] 2> 523543 INFO (qtp1279832178-5786) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=0 QTime=5
[junit4] 2> 523546 INFO (qtp936771321-5784) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/plugin/my/path params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 523565 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523568 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523572 INFO (qtp1279832178-5794) [n:127.0.0.1:65534_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523572 INFO (qtp1049816916-5776) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523572 INFO (qtp936771321-5775) [n:127.0.0.1:65528_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 523572 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 523572 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.p.PackageLoader Package mypkg is modified
[junit4] 2> 523572 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.p.PackageLoader A new version: 2.0 added for package: mypkg with artifacts [/myplugin/v2.jar]
[junit4] 2> 523576 INFO (zkCallback-4134-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 523576 INFO (zkCallback-4134-thread-1) [ ] o.a.s.p.PackageLoader Package mypkg is modified
[junit4] 2> 523576 INFO (zkCallback-4134-thread-1) [ ] o.a.s.p.PackageLoader A new version: 2.0 added for package: mypkg with artifacts [/myplugin/v2.jar]
[junit4] 2> 523577 INFO (zkCallback-4176-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 523577 INFO (zkCallback-4176-thread-1) [ ] o.a.s.p.PackageLoader Package mypkg is modified
[junit4] 2> 523577 INFO (zkCallback-4134-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523580 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523580 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 523580 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader Package mypkg is modified
[junit4] 2> 523580 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader A new version: 2.0 added for package: mypkg with artifacts [/myplugin/v2.jar]
[junit4] 2> 523580 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 1
[junit4] 2> 523580 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader Package mypkg is modified
[junit4] 2> 523580 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader A new version: 2.0 added for package: mypkg with artifacts [/myplugin/v2.jar]
[junit4] 2> 523584 INFO (zkCallback-4134-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523584 INFO (zkCallback-4134-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node3/filestore/myplugin]
[junit4] 2> 523584 INFO (zkCallback-4134-thread-1) [ ] o.a.s.p.PackageLoader version: 2.0 is the new latest in package: mypkg
[junit4] 2> 523584 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523588 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node1/filestore/myplugin]
[junit4] 2> 523588 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.p.PackageLoader version: 2.0 is the new latest in package: mypkg
[junit4] 2> 523588 INFO (qtp2049453011-5795) [n:127.0.0.1:65533_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=0 QTime=39
[junit4] 2> 523588 INFO (zkCallback-4146-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523592 ERROR (qtp1049816916-5781) [n:127.0.0.1:65527_solr ] o.a.s.a.AnnotatedApi Error executing command
[junit4] 2> => org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error executing command, errors: [{update=org.apache.solr.client.solrj.request.beans.PluginMeta@5f226d1d, errorMessages=[No such package version:mypkg:2.0 . available versions :[1.0]]}],
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.checkForErrorInPayload(AnnotatedApi.java:321)
[junit4] 2> org.apache.solr.api.ApiBag$ExceptionWithErrObject: Error executing command
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.checkForErrorInPayload(AnnotatedApi.java:321) ~[java/:?]
[junit4] 2> at org.apache.solr.api.AnnotatedApi$Cmd.invoke(AnnotatedApi.java:291) [java/:?]
[junit4] 2> at org.apache.solr.api.AnnotatedApi.call(AnnotatedApi.java:194) [java/:?]
[junit4] 2> at org.apache.solr.api.V2HttpCall.handleAdmin(V2HttpCall.java:340) [java/:?]
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:818) [java/:?]
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:566) [java/:?]
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:415) [java/:?]
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:345) [java/:?]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1604) [jetty-servlet-9.4.27.v20200227.jar:9.4.27.v20200227]
[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.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:545) [jetty-servlet-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1610) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:233) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1300) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:188) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:485) [jetty-servlet-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1580) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:186) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1215) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:322) [jetty-rewrite-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:717) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:127) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:500) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.lambda$handle$1(HttpChannel.java:383) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:547) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:375) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:273) [jetty-server-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311) [jetty-io-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103) [jetty-io-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117) [jetty-io-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806) [jetty-util-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938) [jetty-util-9.4.27.v20200227.jar:9.4.27.v20200227]
[junit4] 2> at java.lang.Thread.run(Thread.java:832) [?:?]
[junit4] 2> 523592 INFO (qtp1049816916-5781) [n:127.0.0.1:65527_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/plugin params={wt=javabin&version=2} status=400 QTime=4
[junit4] 2> 523596 INFO (zkCallback-4164-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523599 INFO (zkCallback-4146-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523601 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node2/filestore/myplugin]
[junit4] 2> 523601 INFO (zkCallback-4146-thread-1) [ ] o.a.s.p.PackageLoader version: 2.0 is the new latest in package: mypkg
[junit4] 2> 523604 INFO (zkCallback-4164-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 523606 INFO (zkCallback-4164-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 1 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001/tempDir-001/node4/filestore/myplugin]
[junit4] 2> 523606 INFO (zkCallback-4164-thread-1) [ ] o.a.s.p.PackageLoader version: 2.0 is the new latest in package: mypkg
[junit4] 2> 523719 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1648231344
[junit4] 2> 523719 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=653233188
[junit4] 2> 523719 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:65527_solr
[junit4] 2> 523719 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:65528_solr
[junit4] 2> 523719 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=71349791
[junit4] 2> 523719 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:65534_solr
[junit4] 2> 523720 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 523720 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:65527_solr as DOWN
[junit4] 2> 523720 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 523720 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:65534_solr as DOWN
[junit4] 2> 523720 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 523720 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:65528_solr as DOWN
[junit4] 2> 523722 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1682639644
[junit4] 2> 523722 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:65533_solr
[junit4] 2> 523722 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.c.ZkController Publish this node as DOWN...
[junit4] 2> 523722 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:65533_solr as DOWN
[junit4] 2> 523725 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 523725 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 523725 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 523725 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f57311e: rootName = solr_65528, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@70942734
[junit4] 2> 523725 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2f3ce5b5: rootName = solr_65527, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@223fd872
[junit4] 2> 523726 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 523726 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@51c73479: rootName = solr_65534, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@aa90902
[junit4] 2> 523728 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 523728 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@40fe94d7: rootName = solr_65533, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@2fb1a05d
[junit4] 2> 523776 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 523776 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1f75145a: rootName = solr_65534, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@7f20369
[junit4] 2> 523776 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 523776 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@64ac7863: rootName = solr_65533, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@7f20369
[junit4] 2> 523778 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 523778 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@138dab22: rootName = solr_65528, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@7f20369
[junit4] 2> 523778 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 523778 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@610e222: rootName = solr_65527, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@7f20369
[junit4] 2> 523817 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 523817 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5f82270a: rootName = solr_65534, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@1d83d23
[junit4] 2> 523817 INFO (jetty-closer-4191-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 523818 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 523818 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5de45308: rootName = solr_65533, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@1d83d23
[junit4] 2> 523818 INFO (jetty-closer-4191-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 523821 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 523821 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1e7e1ffa: rootName = solr_65528, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@1d83d23
[junit4] 2> 523821 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 523821 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@78f0bffb: rootName = solr_65527, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@1d83d23
[junit4] 2> 523821 INFO (jetty-closer-4191-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 523821 INFO (jetty-closer-4191-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 523821 INFO (zkCallback-4134-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
[junit4] 2> 523821 INFO (zkCallback-4146-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
[junit4] 2> 523822 INFO (closeThreadPool-4210-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72173981320609802-127.0.0.1:65528_solr-n_0000000000) closing
[junit4] 2> 523822 INFO (OverseerStateUpdate-72173981320609802-127.0.0.1:65528_solr-n_0000000000) [n:127.0.0.1:65528_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:65528_solr
[junit4] 2> 523822 INFO (OverseerAutoScalingTriggerThread-72173981320609802-127.0.0.1:65528_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 523825 INFO (closeThreadPool-4210-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72173981320609802-127.0.0.1:65528_solr-n_0000000000) closing
[junit4] 2> 524054 INFO (jetty-closer-4191-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@305516f6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 524061 INFO (jetty-closer-4191-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.Ser
[...truncated too long message...]
17 INFO (jetty-closer-239-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5c01a3e3: rootName = solr_61248, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@32ea308e
[junit4] 2> 39721 INFO (jetty-closer-239-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 39741 INFO (jetty-closer-239-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6902ff93{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 39741 INFO (jetty-closer-239-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1b352994{/solr,null,UNAVAILABLE}
[junit4] 2> 39741 INFO (jetty-closer-239-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 39764 INFO (closeThreadPool-258-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72174173612867595-127.0.0.1:61244_solr-n_0000000000) closing
[junit4] 2> 39765 INFO (OverseerAutoScalingTriggerThread-72174173612867595-127.0.0.1:61244_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 39765 INFO (OverseerStateUpdate-72174173612867595-127.0.0.1:61244_solr-n_0000000000) [n:127.0.0.1:61244_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:61244_solr
[junit4] 2> 39765 INFO (closeThreadPool-258-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72174173612867595-127.0.0.1:61244_solr-n_0000000000) closing
[junit4] 2> 39843 INFO (jetty-closer-239-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72174173612867595-127.0.0.1:61244_solr-n_0000000000) closing
[junit4] 2> 39847 INFO (jetty-closer-239-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3144fb3a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 39847 INFO (jetty-closer-239-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@129b2e8b{/solr,null,UNAVAILABLE}
[junit4] 2> 39848 INFO (jetty-closer-239-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 39951 INFO (jetty-closer-239-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7c2f9fcb{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 39951 INFO (jetty-closer-239-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a0f9741{/solr,null,UNAVAILABLE}
[junit4] 2> 39951 INFO (jetty-closer-239-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 40050 INFO (jetty-closer-239-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@575b580{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 40050 INFO (jetty-closer-239-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@626bcb07{/solr,null,UNAVAILABLE}
[junit4] 2> 40052 INFO (jetty-closer-239-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 40054 INFO (TEST-TestContainerPlugin.testApi-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 40279 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> 5 /solr/aliases.json
[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> 18 /solr/clusterprops.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 15 /solr/live_nodes
[junit4] 2> 7 /solr/overseer/queue
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> 40285 INFO (TEST-TestContainerPlugin.testApi-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:61219
[junit4] 2> 40285 INFO (TEST-TestContainerPlugin.testApi-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:61219
[junit4] 2> 40285 INFO (TEST-TestContainerPlugin.testApi-seed#[41B7DB96E0998EBB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 61219
[junit4] 2> 42406 INFO (TEST-TestContainerPlugin.testApi-seed#[41B7DB96E0998EBB]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testApi
[junit4] OK 6.30s J0 | TestContainerPlugin.testApi
[junit4] 2> 42406 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 42408 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:61219
[junit4] 2> 42408 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:61219
[junit4] 2> 42408 INFO (SUITE-TestContainerPlugin-seed#[41B7DB96E0998EBB]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 61219
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestContainerPlugin_41B7DB96E0998EBB-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene86): {}, docValues:{}, maxPointsInLeafNode=592, maxMBSortInHeap=7.7911442747619475, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=es-MX, timezone=PST8PDT
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 15-ea (64-bit)/cpus=6,threads=1,free=293601280,total=471859200
[junit4] 2> NOTE: All tests run in this JVM: [TestContainerPlugin]
[junit4] Completed [1/5 (1!)] on J0 in 43.18s, 2 tests, 1 error <<< FAILURES!
[...truncated 33 lines...]
BUILD FAILED
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\lucene\common-build.xml:1599: The following error occurred while executing this line:
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\lucene\common-build.xml:1126: There were test failures: 5 suites, 10 tests, 1 error [seed: 41B7DB96E0998EBB]
Total time: 48 seconds
[repro] Setting last failure code to 1
[repro] Failures w/original seeds:
[repro] 1/5 failed: org.apache.solr.handler.TestContainerPlugin
[repro] Exiting with code 1
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows>IF EXIST lucene\build move /y lucene\build lucene\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows>IF EXIST solr\build move /y solr\build solr\build.repro
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows>IF EXIST lucene\build.orig move /y lucene\build.orig lucene\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows>IF EXIST solr\build.orig move /y solr\build.orig solr\build
1 dir(s) moved.
C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows>exit 0
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Archiving artifacts
[Java] Sleeping for 5 seconds due to JENKINS-32191...
[Java] Parsing console log (workspace: 'C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows')
[Java] Successfully parsed console log
[Java] -> found 113 issues (skipped 104 duplicates)
[Java] Post processing issues on 'Windows VBOX' with source code encoding 'UTF-8'
[Java] Creating SCM blamer to obtain author and commit information for affected files
[Java] Creating SCM miner to obtain statistics for affected repository files
[Java] Resolving file names for all issues in source directory 'C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows'
[Java] -> resolved paths in source directory (54 found, 0 not found)
[Java] Resolving module names from module definitions (build.xml, pom.xml, or Manifest.mf files)
[Java] -> resolved module names for 113 issues
[Java] Resolving package names (or namespaces) by parsing the affected files
[Java] -> resolved package names of 54 affected files
[Java] No filter has been set, publishing all 113 issues
[Java] Creating fingerprints for all affected code blocks to track issues over different builds
[Java] -> created fingerprints for 113 issues (skipped 0 issues)
[Java] Copying affected files to Jenkins' build folder '/home/jenkins/jobs/Lucene-Solr-8.6-Windows/builds/347/files-with-issues'
[Java] -> 54 copied, 0 not in workspace, 0 not-found, 0 with I/O error
[Java] Using reference build 'Lucene-Solr-8.6-Windows #346' to compute new, fixed, and outstanding issues
[Java] Issues delta (vs. reference build): outstanding: 113, new: 0, fixed: 0
[Java] No quality gates have been set - skipping
[Java] Health report is disabled - skipping
[Java] Created analysis result for 113 issues (found 0 new issues, fixed 0 issues)
[Java] Attaching ResultAction with ID 'java' to run 'Lucene-Solr-8.6-Windows #347'.
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Recording test results
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
[JENKINS-Experimental-GC] Lucene-Solr-8.6-Windows
(64bit/jdk-14.0.1) - Build # 348 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.6-Windows/348/
Java: 64bit/jdk-14.0.1 -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$1824/0x000001b3a496c8b0@37522e00 . 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$1824/0x000001b3a496c8b0@37522e00 . 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([8208AC7D35FAA2D0:548E4C80D6E4654A]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:257)
at org.apache.solr.filestore.TestDistribPackageStore.assertResponseValues(TestDistribPackageStore.java:224)
at org.apache.solr.pkg.TestPackages.verifyCmponent(TestPackages.java:466)
at org.apache.solr.pkg.TestPackages.testPluginLoading(TestPackages.java:181)
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 16035 lines...]
[junit4] Suite: org.apache.solr.pkg.TestPackages
[junit4] 2> 2004018 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of 'C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\server\solr\configsets\_default\conf'
[junit4] 2> 2004018 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2004020 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\data-dir-168-001
[junit4] 2> 2004020 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2004023 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 2004025 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPluginLoading
[junit4] 2> 2004027 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001
[junit4] 2> 2004027 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2004029 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 2004029 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2004133 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer start zk server on port: 56577
[junit4] 2> 2004133 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:56577
[junit4] 2> 2004133 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:56577
[junit4] 2> 2004133 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 56577
[junit4] 2> 2004137 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004140 INFO (zkConnectionManagerCallback-15483-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004140 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004143 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004145 INFO (zkConnectionManagerCallback-15485-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004145 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004147 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004148 INFO (zkConnectionManagerCallback-15487-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004148 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004255 WARN (jetty-launcher-15488-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 2004255 WARN (jetty-launcher-15488-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 2004255 WARN (jetty-launcher-15488-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 2004255 WARN (jetty-launcher-15488-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 2004255 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git: a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14.0.1+7
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@122c4915{/solr,null,AVAILABLE}
[junit4] 2> 2004257 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3bbfd386{/solr,null,AVAILABLE}
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@50303d2b{/solr,null,AVAILABLE}
[junit4] 2> 2004259 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@741ca152{/solr,null,AVAILABLE}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@67ada99a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56591}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@460d278d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56590}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-3) [ ] o.e.j.s.Server Started @2004259ms
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@e3d20e6{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56596}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-4) [ ] o.e.j.s.Server Started @2004259ms
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-1) [ ] o.e.j.s.Server Started @2004259ms
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1d5e5966{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:56597}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56596}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56591}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-2) [ ] o.e.j.s.Server Started @2004259ms
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56590}
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56597}
[junit4] 2> 2004262 ERROR (jetty-launcher-15488-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2004262 ERROR (jetty-launcher-15488-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2004262 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2004262 ERROR (jetty-launcher-15488-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2004262 ERROR (jetty-launcher-15488-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.6.0
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-09T03:32:14.258149200Z
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-09T03:32:14.258149200Z
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-09T03:32:14.258149200Z
[junit4] 2> 2004263 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-07-09T03:32:14.258149200Z
[junit4] 2> 2004265 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004265 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004266 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004266 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004268 INFO (zkConnectionManagerCallback-15491-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004268 INFO (zkConnectionManagerCallback-15492-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004268 INFO (zkConnectionManagerCallback-15495-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004268 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004268 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004268 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004268 INFO (zkConnectionManagerCallback-15496-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004268 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004269 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2004269 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2004269 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2004269 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2004510 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2004518 WARN (jetty-launcher-15488-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@67d2c6b3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004518 WARN (jetty-launcher-15488-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@67d2c6b3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004522 WARN (jetty-launcher-15488-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4045ff15[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004522 WARN (jetty-launcher-15488-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4045ff15[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004523 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56577/solr
[junit4] 2> 2004524 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004526 INFO (zkConnectionManagerCallback-15510-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004526 INFO (jetty-launcher-15488-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004570 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2004571 WARN (jetty-launcher-15488-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@176d3875[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004571 WARN (jetty-launcher-15488-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@176d3875[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004575 WARN (jetty-launcher-15488-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6b8f737[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004575 WARN (jetty-launcher-15488-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6b8f737[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004575 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56577/solr
[junit4] 2> 2004578 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004580 INFO (zkConnectionManagerCallback-15518-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004580 INFO (jetty-launcher-15488-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004727 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2004731 WARN (jetty-launcher-15488-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@338c8c60[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004731 WARN (jetty-launcher-15488-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@338c8c60[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004749 WARN (jetty-launcher-15488-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@182f70b3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004749 WARN (jetty-launcher-15488-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@182f70b3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004754 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56577/solr
[junit4] 2> 2004755 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004759 INFO (zkConnectionManagerCallback-15532-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004759 INFO (jetty-launcher-15488-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004763 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2004763 WARN (jetty-launcher-15488-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@885871[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004763 WARN (jetty-launcher-15488-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@885871[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004767 WARN (jetty-launcher-15488-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@484c136e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004767 WARN (jetty-launcher-15488-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@484c136e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2004767 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56577/solr
[junit4] 2> 2004767 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004773 INFO (zkConnectionManagerCallback-15540-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004773 INFO (jetty-launcher-15488-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004788 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004788 INFO (zkConnectionManagerCallback-15542-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004788 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004888 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2004892 INFO (zkConnectionManagerCallback-15546-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2004893 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2004895 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56597_solr
[junit4] 2> 2004896 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.c.Overseer Overseer (id=72175980505333771-127.0.0.1:56597_solr-n_0000000000) starting
[junit4] 2> 2004903 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56596_solr
[junit4] 2> 2004903 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56597_solr
[junit4] 2> 2004903 INFO (OverseerStateUpdate-72175980505333771-127.0.0.1:56597_solr-n_0000000000) [n:127.0.0.1:56597_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:56597_solr
[junit4] 2> 2004904 INFO (OverseerStateUpdate-72175980505333771-127.0.0.1:56597_solr-n_0000000000) [n:127.0.0.1:56597_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2004905 INFO (zkCallback-15545-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2004906 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2004906 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2004907 WARN (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_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> 2004907 WARN (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_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> 2004951 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2004951 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2005001 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2005007 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56597.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005007 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56596.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005007 INFO (zkConnectionManagerCallback-15564-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2005008 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2005016 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56597.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005016 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56597.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005018 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56596.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005018 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56596.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005019 INFO (jetty-launcher-15488-thread-2) [n:127.0.0.1:56597_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node1
[junit4] 2> 2005020 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2005021 INFO (jetty-launcher-15488-thread-1) [n:127.0.0.1:56596_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node3
[junit4] 2> 2005040 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56590_solr as DOWN
[junit4] 2> 2005044 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2005044 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56590_solr
[junit4] 2> 2005046 INFO (zkCallback-15541-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2005046 INFO (zkCallback-15563-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2005050 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2005050 WARN (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_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> 2005052 INFO (zkCallback-15545-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2005101 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2005186 INFO (zkConnectionManagerCallback-15571-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2005186 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2005199 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 2005202 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:56591_solr as DOWN
[junit4] 2> 2005203 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2005203 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56591_solr
[junit4] 2> 2005205 INFO (zkCallback-15541-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2005205 INFO (zkCallback-15563-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2005205 INFO (zkCallback-15545-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2005205 INFO (zkCallback-15570-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2005207 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 2005207 WARN (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_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> 2005219 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2005243 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56590.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005244 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2005248 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56590.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005248 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56590.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005250 INFO (jetty-launcher-15488-thread-4) [n:127.0.0.1:56590_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node2
[junit4] 2> 2005265 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56591.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005272 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56591.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005272 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56591.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2005272 INFO (jetty-launcher-15488-thread-3) [n:127.0.0.1:56591_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node4
[junit4] 2> 2005295 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 2005300 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2005303 INFO (zkConnectionManagerCallback-15589-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2005303 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2005303 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2005303 INFO (TEST-TestPackages.testPluginLoading-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56577/solr ready
[junit4] 2> 2005328 INFO (qtp16440969-23955) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:56591_solr} status=0 QTime=0
[junit4] 2> 2005328 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:56591_solr
[junit4] 2> 2005328 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:56591_solr} status=0 QTime=0
[junit4] 2> 2005328 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_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> 2005328 INFO (updateExecutor-15514-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:56591_solr
[junit4] 2> 2005331 INFO (qtp1768573639-23936) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 2005331 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_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> 2005331 INFO (qtp1221251300-23940) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={getFrom=127.0.0.1:56591_solr} status=0 QTime=0
[junit4] 2> 2005331 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_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> 2005331 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:56591_solr
[junit4] 1> sync resp: http://127.0.0.1:56591/api/node/files/_trusted_/keys/pub_key512.der?sync=true ,is: null
[junit4] 2> 2005331 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 2005331 INFO (qtp1768573639-23936) [n:127.0.0.1:56591_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> 2005335 INFO (qtp328836453-23959) [n:127.0.0.1:56597_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> 2005335 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
[junit4] 2> 2005337 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 2005337 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 2005340 INFO (updateExecutor-15514-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 2005340 INFO (updateExecutor-15514-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 2005341 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 141
[junit4] 2> 2005341 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.PackageStoreAPI downloaded file: /_trusted_/keys/pub_key512.der
[junit4] 2> 2005439 INFO (qtp328836453-23959) [n:127.0.0.1:56597_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=1
[junit4] 2> 2005444 INFO (qtp16440969-23957) [n:127.0.0.1:56596_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=1
[junit4] 2> 2005491 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_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=1
[junit4] 2> 2005496 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_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=1
[junit4] 2> 2005504 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005506 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/runtimelibs.jar
[junit4] 2> 2005506 INFO (qtp16440969-23949) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005507 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005508 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005508 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/runtimelibs.jar
[junit4] 2> 2005522 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/runtimelibs.jar and metadata. sizes 6860 246
[junit4] 2> 2005523 INFO (qtp328836453-23959) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={getFrom=127.0.0.1:56591_solr} status=0 QTime=0
[junit4] 2> 2005524 INFO (updateExecutor-15514-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/runtimelibs.jar from 127.0.0.1:56591_solr
[junit4] 2> 2005524 INFO (qtp16440969-23957) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={getFrom=127.0.0.1:56591_solr} status=0 QTime=0
[junit4] 2> 2005524 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/runtimelibs.jar from 127.0.0.1:56591_solr
[junit4] 2> 2005524 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={getFrom=127.0.0.1:56591_solr} status=0 QTime=0
[junit4] 2> 2005524 INFO (qtp1768573639-23936) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.runtimelibs.jar.json params={} status=0 QTime=0
[junit4] 2> 2005524 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/runtimelibs.jar from 127.0.0.1:56591_solr
[junit4] 2> 2005526 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.runtimelibs.jar.json params={} status=0 QTime=0
[junit4] 2> 2005526 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.runtimelibs.jar.json params={} status=0 QTime=0
[junit4] 2> 2005526 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/mypkg/runtimelibs.jar params={sig=L3q/qIGs4NaF6JiO0ZkMUFa88j0OmYc%2BI6O7BOdNuMct/xoZ4h73aZHZGc0%2BnmI1f/U3bOlMPINlSOM6LK3JpQ%3D%3D&wt=javabin&version=2} status=0 QTime=25
[junit4] 2> 2005526 INFO (qtp1768573639-23936) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={} status=0 QTime=0
[junit4] 2> 2005526 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={} status=0 QTime=0
[junit4] 2> 2005526 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={} status=0 QTime=0
[junit4] 2> 2005529 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005531 INFO (updateExecutor-15514-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/runtimelibs.jar and metadata. sizes 6860 246
[junit4] 2> 2005531 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/runtimelibs.jar and metadata. sizes 6860 246
[junit4] 2> 2005531 INFO (updateExecutor-15514-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/runtimelibs.jar
[junit4] 2> 2005531 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/runtimelibs.jar
[junit4] 2> 2005531 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/runtimelibs.jar and metadata. sizes 6860 246
[junit4] 2> 2005531 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/runtimelibs.jar
[junit4] 2> 2005635 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005641 INFO (qtp16440969-23955) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005645 INFO (qtp1221251300-23941) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005651 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/runtimelibs.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005661 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005664 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/testurpv1.jar
[junit4] 2> 2005666 INFO (qtp1221251300-23941) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005667 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005668 INFO (qtp16440969-23955) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005668 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/testurpv1.jar
[junit4] 2> 2005675 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/testurpv1.jar and metadata. sizes 689 246
[junit4] 2> 2005680 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={getFrom=127.0.0.1:56597_solr} status=0 QTime=0
[junit4] 2> 2005680 INFO (updateExecutor-15528-thread-3-processing-n:127.0.0.1:56591_solr) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/testurpv1.jar from 127.0.0.1:56597_solr
[junit4] 2> 2005681 INFO (qtp16440969-23949) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={getFrom=127.0.0.1:56597_solr} status=0 QTime=0
[junit4] 2> 2005681 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.testurpv1.jar.json params={} status=0 QTime=0
[junit4] 2> 2005681 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/testurpv1.jar from 127.0.0.1:56597_solr
[junit4] 2> 2005682 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={getFrom=127.0.0.1:56597_solr} status=0 QTime=0
[junit4] 2> 2005682 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/testurpv1.jar from 127.0.0.1:56597_solr
[junit4] 2> 2005683 INFO (qtp328836453-23959) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={} status=0 QTime=0
[junit4] 2> 2005684 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.testurpv1.jar.json params={} status=0 QTime=0
[junit4] 2> 2005686 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.testurpv1.jar.json params={} status=0 QTime=0
[junit4] 2> 2005686 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={} status=0 QTime=0
[junit4] 2> 2005686 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/mypkg/testurpv1.jar params={sig=h6UmMzuPqu4hQFGLBMJh/6kDSEXpJlgLsQDXx0KuxXWkV5giilRP57K3towiJRh2J%2BrqihqIghNCi3YgzgUnWQ%3D%3D&wt=javabin&version=2} status=0 QTime=27
[junit4] 2> 2005688 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={} status=0 QTime=0
[junit4] 2> 2005692 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005694 INFO (updateExecutor-15528-thread-3-processing-n:127.0.0.1:56591_solr) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/testurpv1.jar and metadata. sizes 689 246
[junit4] 2> 2005695 INFO (updateExecutor-15528-thread-3-processing-n:127.0.0.1:56591_solr) [n:127.0.0.1:56591_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/testurpv1.jar
[junit4] 2> 2005697 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/testurpv1.jar and metadata. sizes 689 246
[junit4] 2> 2005697 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/testurpv1.jar
[junit4] 2> 2005701 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/testurpv1.jar and metadata. sizes 689 246
[junit4] 2> 2005701 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/testurpv1.jar
[junit4] 2> 2005703 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={meta=true&wt=javabin} status=0 QTime=2
[junit4] 2> 2005708 INFO (qtp1221251300-23940) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005713 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/testurpv1.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005723 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005727 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore Missing file in package store: /mypkg/expressible.jar
[junit4] 2> 2005727 INFO (qtp16440969-23957) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005727 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005727 INFO (qtp1768573639-23936) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005727 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore Unable to download file : /mypkg/expressible.jar
[junit4] 2> 2005735 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/expressible.jar and metadata. sizes 1977 246
[junit4] 2> 2005736 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={getFrom=127.0.0.1:56597_solr} status=0 QTime=0
[junit4] 2> 2005739 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/expressible.jar from 127.0.0.1:56597_solr
[junit4] 2> 2005739 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={getFrom=127.0.0.1:56597_solr} status=0 QTime=0
[junit4] 2> 2005739 INFO (updateExecutor-15528-thread-3-processing-n:127.0.0.1:56591_solr) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/expressible.jar from 127.0.0.1:56597_solr
[junit4] 2> 2005739 INFO (qtp1221251300-23940) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={getFrom=127.0.0.1:56597_solr} status=0 QTime=0
[junit4] 2> 2005739 INFO (qtp328836453-24066) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.expressible.jar.json params={} status=0 QTime=0
[junit4] 2> 2005739 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.expressible.jar.json params={} status=0 QTime=0
[junit4] 2> 2005739 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore fetching a file /mypkg/expressible.jar from 127.0.0.1:56597_solr
[junit4] 2> 2005739 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={} status=0 QTime=0
[junit4] 2> 2005742 INFO (qtp328836453-23959) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={} status=0 QTime=0
[junit4] 2> 2005742 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/.expressible.jar.json params={} status=0 QTime=0
[junit4] 2> 2005742 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/files/mypkg/expressible.jar params={sig=ZOT11arAiPmPZYOHzqodiNnxO9pRyRozWZEBX8XGjU1/HJptFnZK%2BDI7eXnUtbNaMcbXE2Ze8hh4M/eGyhY8BQ%3D%3D&wt=javabin&version=2} status=0 QTime=19
[junit4] 2> 2005742 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={} status=0 QTime=0
[junit4] 2> 2005750 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005750 INFO (updateExecutor-15528-thread-3-processing-n:127.0.0.1:56591_solr) [n:127.0.0.1:56591_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/expressible.jar and metadata. sizes 1977 246
[junit4] 2> 2005750 INFO (updateExecutor-15528-thread-3-processing-n:127.0.0.1:56591_solr) [n:127.0.0.1:56591_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/expressible.jar
[junit4] 2> 2005750 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/expressible.jar and metadata. sizes 1977 246
[junit4] 2> 2005750 INFO (updateExecutor-15536-thread-1-processing-n:127.0.0.1:56590_solr) [n:127.0.0.1:56590_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/expressible.jar
[junit4] 2> 2005750 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.DistribPackageStore persisted a file /mypkg/expressible.jar and metadata. sizes 1977 246
[junit4] 2> 2005750 INFO (updateExecutor-15506-thread-1-processing-n:127.0.0.1:56596_solr) [n:127.0.0.1:56596_solr ] o.a.s.f.PackageStoreAPI downloaded file: /mypkg/expressible.jar
[junit4] 2> 2005755 INFO (qtp16440969-23949) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005759 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005763 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/node/files/mypkg/expressible.jar params={meta=true&wt=javabin} status=0 QTime=1
[junit4] 2> 2005772 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005772 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005777 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005779 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005779 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005784 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005787 DEBUG (zkCallback-15563-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 2005787 DEBUG (zkCallback-15541-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 2005787 DEBUG (zkCallback-15545-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 2005787 DEBUG (zkCallback-15570-thread-1) [ ] o.a.s.p.PackageAPI Updating [/packages.json] ...
[junit4] 2> 2005787 INFO (qtp328836453-23958) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005787 INFO (qtp1768573639-23943) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005787 INFO (zkCallback-15563-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 2005791 INFO (zkCallback-15563-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 2005791 INFO (zkCallback-15563-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/mypkg/runtimelibs.jar, /mypkg/testurpv1.jar, /mypkg/expressible.jar]
[junit4] 2> 2005791 INFO (zkCallback-15541-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 2005791 INFO (zkCallback-15541-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 2005791 INFO (zkCallback-15570-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 2005791 INFO (zkCallback-15541-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/mypkg/runtimelibs.jar, /mypkg/testurpv1.jar, /mypkg/expressible.jar]
[junit4] 2> 2005791 INFO (zkCallback-15570-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 2005791 INFO (zkCallback-15570-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/mypkg/runtimelibs.jar, /mypkg/testurpv1.jar, /mypkg/expressible.jar]
[junit4] 2> 2005791 INFO (qtp16440969-23949) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
[junit4] 2> 2005791 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 2005791 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 2005791 INFO (zkCallback-15545-thread-1) [ ] o.a.s.p.PackageLoader /packages.json updated to version 0
[junit4] 2> 2005791 INFO (zkCallback-15545-thread-1) [ ] o.a.s.p.PackageLoader A new package: mypkg introduced
[junit4] 2> 2005791 INFO (zkCallback-15545-thread-1) [ ] o.a.s.p.PackageLoader A new version: 1.0 added for package: mypkg with artifacts [/mypkg/runtimelibs.jar, /mypkg/testurpv1.jar, /mypkg/expressible.jar]
[junit4] 2> 2005791 INFO (zkCallback-15563-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005791 INFO (zkCallback-15570-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005791 INFO (zkCallback-15541-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005795 INFO (zkCallback-15545-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005795 INFO (zkCallback-15570-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005795 INFO (zkCallback-15563-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005795 INFO (zkCallback-15541-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005795 INFO (zkCallback-15545-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15570-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15545-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15563-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15541-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15570-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15545-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15563-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005799 INFO (zkCallback-15541-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005803 INFO (zkCallback-15545-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005805 INFO (zkCallback-15570-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005805 INFO (zkCallback-15563-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005805 INFO (zkCallback-15541-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005806 INFO (zkCallback-15563-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005806 INFO (zkCallback-15545-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005806 INFO (zkCallback-15570-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005807 INFO (zkCallback-15541-thread-1) [ ] o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, downloading..
[junit4] 2> 2005807 INFO (zkCallback-15563-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 3 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.pkg.TestPackages_8208AC7D35FAA2D0-001/tempDir-001/node2/filestore/mypkg]
[junit4] 2> 2005807 INFO (zkCallback-15563-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 2005807 INFO (qtp1221251300-23942) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package params={wt=javabin&version=2} status=0 QTime=39
[junit4] 2> 2005809 INFO (zkCallback-15541-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 3 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.pkg.TestPackages_8208AC7D35FAA2D0-001/tempDir-001/node1/filestore/mypkg]
[junit4] 2> 2005809 INFO (zkCallback-15541-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 2005809 INFO (zkCallback-15545-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 3 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.pkg.TestPackages_8208AC7D35FAA2D0-001/tempDir-001/node3/filestore/mypkg]
[junit4] 2> 2005809 INFO (zkCallback-15545-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 2005809 INFO (zkCallback-15570-thread-1) [ ] o.a.s.c.SolrResourceLoader Added 3 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-8.6-Windows/solr/build/solr-core/test/J4/temp/solr.pkg.TestPackages_8208AC7D35FAA2D0-001/tempDir-001/node4/filestore/mypkg]
[junit4] 2> 2005809 INFO (qtp1768573639-23947) [n:127.0.0.1:56591_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&maxShardsPerNode=100&name=testPluginLoadingColl&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2005809 INFO (zkCallback-15570-thread-1) [ ] o.a.s.p.PackageLoader version: 1.0 is the new latest in package: mypkg
[junit4] 2> 2005811 INFO (OverseerThreadFactory-15553-thread-1-processing-n:127.0.0.1:56597_solr) [n:127.0.0.1:56597_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testPluginLoadingColl
[junit4] 2> 2005924 INFO (qtp1768573639-23936) [n:127.0.0.1:56591_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node} status=0 QTime=4
[junit4] 2> 2005929 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2005933 INFO (qtp328836453-23953) [n:127.0.0.1:56597_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node} status=0 QTime=4
[junit4] 2> 2005939 INFO (qtp1221251300-23940) [n:127.0.0.1:56590_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node} status=0 QTime=4
[junit4] 2> 2005939 INFO (qtp16440969-23957) [n:127.0.0.1:56596_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2005944 INFO (qtp16440969-23957) [n:127.0.0.1:56596_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CONTAINER.cores&wt=javabin&version=2&group=solr.node} status=0 QTime=4
[junit4] 2> 2005952 INFO (OverseerStateUpdate-72175980505333771-127.0.0.1:56597_solr-n_0000000000) [n:127.0.0.1:56597_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testPluginLoadingColl",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testPluginLoadingColl_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56596/solr",
[junit4] 2> "node_name":"127.0.0.1:56596_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2005956 INFO (OverseerStateUpdate-72175980505333771-127.0.0.1:56597_solr-n_0000000000) [n:127.0.0.1:56597_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testPluginLoadingColl",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testPluginLoadingColl_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56590/solr",
[junit4] 2> "node_name":"127.0.0.1:56590_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2005960 INFO (OverseerStateUpdate-72175980505333771-127.0.0.1:56597_solr-n_0000000000) [n:127.0.0.1:56597_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testPluginLoadingColl",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testPluginLoadingColl_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56597/solr",
[junit4] 2> "node_name":"127.0.0.1:56597_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2005963 INFO (OverseerStateUpdate-72175980505333771-127.0.0.1:56597_solr-n_0000000000) [n:127.0.0.1:56597_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testPluginLoadingColl",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testPluginLoadingColl_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:56591/solr",
[junit4] 2> "node_name":"127.0.0.1:56591_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2006167 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=testPluginLoadingColl_shard1_replica_n1&action=CREATE&numShards=2&collection=testPluginLoadingColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2006167 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=testPluginLoadingColl_shard2_replica_n4&action=CREATE&numShards=2&collection=testPluginLoadingColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2006167 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=testPluginLoadingColl_shard2_replica_n6&action=CREATE&numShards=2&collection=testPluginLoadingColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2006167 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=testPluginLoadingColl_shard1_replica_n2&action=CREATE&numShards=2&collection=testPluginLoadingColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2006197 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr c:testPluginLoadingColl s:shard1 r:core_node5 x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 2006197 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr c:testPluginLoadingColl s:shard2 r:core_node7 x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 2006199 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr c:testPluginLoadingColl s:shard1 r:core_node3 x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 2006213 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr c:testPluginLoadingColl s:shard2 r:core_node8 x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.6.0
[junit4] 2> 2006215 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr c:testPluginLoadingColl s:shard1 r:core_node3 x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2006215 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr c:testPluginLoadingColl s:shard2 r:core_node7 x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2006215 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr c:testPluginLoadingColl s:shard1 r:core_node5 x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2006220 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr c:testPluginLoadingColl s:shard1 r:core_node5 x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2006220 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr c:testPluginLoadingColl s:shard1 r:core_node3 x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2006221 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr c:testPluginLoadingColl s:shard1 r:core_node5 x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'testPluginLoadingColl_shard1_replica_n2' using configuration from configset conf, trusted=true
[junit4] 2> 2006221 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr c:testPluginLoadingColl s:shard1 r:core_node3 x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'testPluginLoadingColl_shard1_replica_n1' using configuration from configset conf, trusted=true
[junit4] 2> 2006220 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr c:testPluginLoadingColl s:shard2 r:core_node7 x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2006221 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr c:testPluginLoadingColl s:shard1 r:core_node5 x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56590.solr.core.testPluginLoadingColl.shard1.replica_n2' (registry 'solr.core.testPluginLoadingColl.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2006221 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr c:testPluginLoadingColl s:shard2 r:core_node7 x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'testPluginLoadingColl_shard2_replica_n4' using configuration from configset conf, trusted=true
[junit4] 2> 2006221 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr c:testPluginLoadingColl s:shard1 r:core_node3 x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56596.solr.core.testPluginLoadingColl.shard1.replica_n1' (registry 'solr.core.testPluginLoadingColl.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2006222 INFO (qtp16440969-23945) [n:127.0.0.1:56596_solr c:testPluginLoadingColl s:shard1 r:core_node3 x:testPluginLoadingColl_shard1_replica_n1 ] o.a.s.c.SolrCore [[testPluginLoadingColl_shard1_replica_n1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node3\testPluginLoadingColl_shard1_replica_n1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node3\testPluginLoadingColl_shard1_replica_n1\data\]
[junit4] 2> 2006222 INFO (qtp1221251300-23946) [n:127.0.0.1:56590_solr c:testPluginLoadingColl s:shard1 r:core_node5 x:testPluginLoadingColl_shard1_replica_n2 ] o.a.s.c.SolrCore [[testPluginLoadingColl_shard1_replica_n2] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node2\testPluginLoadingColl_shard1_replica_n2], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node2\testPluginLoadingColl_shard1_replica_n2\data\]
[junit4] 2> 2006222 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr c:testPluginLoadingColl s:shard2 r:core_node7 x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56597.solr.core.testPluginLoadingColl.shard2.replica_n4' (registry 'solr.core.testPluginLoadingColl.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2006222 INFO (qtp328836453-23948) [n:127.0.0.1:56597_solr c:testPluginLoadingColl s:shard2 r:core_node7 x:testPluginLoadingColl_shard2_replica_n4 ] o.a.s.c.SolrCore [[testPluginLoadingColl_shard2_replica_n4] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node1\testPluginLoadingColl_shard2_replica_n4], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001\tempDir-001\node1\testPluginLoadingColl_shard2_replica_n4\data\]
[junit4] 2> 2006226 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr c:testPluginLoadingColl s:shard2 r:core_node8 x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.s.IndexSchema Schema name=minimal
[junit4] 2> 2006227 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr c:testPluginLoadingColl s:shard2 r:core_node8 x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2006227 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr c:testPluginLoadingColl s:shard2 r:core_node8 x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.c.CoreContainer Creating SolrCore 'testPluginLoadingColl_shard2_replica_n6' using configuration from configset conf, trusted=true
[junit4] 2> 2006227 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr c:testPluginLoadingColl s:shard2 r:core_node8 x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56591.solr.core.testPluginLoadingColl.shard2.replica_n6' (registry 'solr.core.testPluginLoadingColl.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@191be9ba
[junit4] 2> 2006227 INFO (qtp1768573639-23950) [n:127.0.0.1:56591_solr c:testPluginLoadingColl s:shard2 r:core_node8 x:testPluginLoadingColl_shard2_replica_n6 ] o.a.s.c.SolrCore [[testPluginLoadingColl_shard2_replica_n6] ] Opening new SolrCore at [C:\Users\jenkins\
[...truncated too long message...]
] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@16f4e17d: rootName = solr_56927, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@5d216ea4
[junit4] 2> 2019994 INFO (jetty-closer-15786-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 2020071 INFO (jetty-closer-15786-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72175981421527051-127.0.0.1:56933_solr-n_0000000000) closing
[junit4] 2> 2020173 INFO (jetty-closer-15786-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@185c425d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2020173 INFO (jetty-closer-15786-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7f3b627e{/solr,null,UNAVAILABLE}
[junit4] 2> 2020173 INFO (jetty-closer-15786-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2029280 INFO (jetty-closer-15786-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1f0da585{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2029282 INFO (jetty-closer-15786-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7e098865{/solr,null,UNAVAILABLE}
[junit4] 2> 2029282 INFO (jetty-closer-15786-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2029626 INFO (jetty-closer-15786-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@53c0fcc1{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2029626 INFO (jetty-closer-15786-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1648b978{/solr,null,UNAVAILABLE}
[junit4] 2> 2029626 INFO (jetty-closer-15786-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2029688 INFO (jetty-closer-15786-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2f53f809{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:0}
[junit4] 2> 2029688 INFO (jetty-closer-15786-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5271aafe{/solr,null,UNAVAILABLE}
[junit4] 2> 2029688 INFO (jetty-closer-15786-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2029691 INFO (TEST-TestPackages.testAPI-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 2029915 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> 5 /solr/aliases.json
[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> 12 /solr/packages.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/live_nodes
[junit4] 2> 7 /solr/overseer/queue
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> 2029927 INFO (TEST-TestPackages.testAPI-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:56903
[junit4] 2> 2029927 INFO (TEST-TestPackages.testAPI-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:56903
[junit4] 2> 2029927 INFO (TEST-TestPackages.testAPI-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 56903
[junit4] 2> 2031970 INFO (TEST-TestPackages.testAPI-seed#[8208AC7D35FAA2D0]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testAPI
[junit4] 2> 2031970 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 2031970 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:56903
[junit4] 2> 2031970 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:56903
[junit4] 2> 2031970 INFO (SUITE-TestPackages-seed#[8208AC7D35FAA2D0]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 56903
[junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-8.6-Windows\solr\build\solr-core\test\J4\temp\solr.pkg.TestPackages_8208AC7D35FAA2D0-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=en-MT, timezone=GB
[junit4] 2> NOTE: Windows 10 10.0 amd64/AdoptOpenJDK 14.0.1 (64-bit)/cpus=6,threads=1,free=371195904,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [HdfsRecoverLeaseTest, OrderedExecutorTest, LukeRequestHandlerTest, AnalyticsMergeStrategyTest, ForceLeaderTest, ScheduledMaintenanceTriggerTest, HighlighterTest, ZkNodePropsTest, OutOfBoxZkACLAndCredentialsProvidersTest, TimeRoutedAliasUpdateProcessorTest, SuggesterTSTTest, CleanupOldIndexTest, DimensionalRoutedAliasUpdateProcessorTest, HttpPartitionWithTlogReplicasTest, TestPayloadCheckQParserPlugin, TestTlogReplayVsRecovery, TestChildDocTransformerHierarchy, MoveReplicaTest, HdfsLockFactoryTest, IndexSizeTriggerSizeEstimationTest, ExitableDirectoryReaderTest, HdfsBasicDistributedZk2Test, RegexBoostProcessorTest, MetricsHistoryWithAuthIntegrationTest, TestWordDelimiterFilterFactory, ConnectionManagerTest, DistributedFacetExistsSmallTest, JavabinLoaderTest, StatelessScriptUpdateProcessorFactoryTest, TestInPlaceUpdatesDistrib, TestConfigSetsAPI, TestStressUserVersions, TestHighlightDedupGrouping, V2StandaloneTest, CurrencyFieldTypeTest, TestOnReconnectListenerSupport, TestExactSharedStatsCache, TestRTGBase, TestSort, UnloadDistributedZkTest, RollingRestartTest, DaemonStreamApiTest, TestRawResponseWriter, TestStreamBody, SortByFunctionTest, TestLazyCores, TestOmitPositions, TestWaitForStateWithJettyShutdowns, DistributedFacetPivotWhiteBoxTest, SpellPossibilityIteratorTest, SplitByPrefixTest, TestDynamicURP, RootFieldTest, TestRandomFlRTGCloud, TestBM25SimilarityFactory, TestHashPartitioner, TestSafeXMLParsing, TestSortableTextField, TestAuthorizationFramework, TestReplicationHandlerDiskOverFlow, SolrIndexSplitterTest, DocumentAnalysisRequestHandlerTest, TestNumericTerms32, TestSegmentSorting, DistanceFunctionTest, ZkCollectionPropsCachingTest, SearchHandlerTest, TestRecovery, TestExpandComponent, TestImpersonationWithHadoopAuth, SuggestComponentTest, BadCopyFieldTest, HttpSolrCallGetCoreTest, TestFieldCacheSort, TestGeoJSONResponseWriter, SubstringBytesRefFilterTest, CollectionReloadTest, TestReplicaProperties, TestEmbeddedSolrServerSchemaAPI, RankQParserPluginTest, TestCollationFieldDocValues, TestLegacyField, TestBackupRepositoryFactory, DocValuesTest, TestDistribDocBasedVersion, TestSolrConfigHandlerCloud, TestReloadAndDeleteDocs, ByteBuffersDirectoryFactoryTest, TestDistributedSearch, BasicZkTest, ChaosMonkeyNothingIsSafeTest, DistribDocExpirationUpdateProcessorTest, MetricsHistoryIntegrationTest, MissingSegmentRecoveryTest, MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest, OverriddenZkACLAndCredentialsProvidersTest, RecoveryZkTest, RoutingToNodesWithPropertiesTest, SolrXmlInZkTest, TestCloudDeleteByQuery, TestCloudInspectUtil, TestCloudPhrasesIdentificationComponent, TestCloudPseudoReturnFields, TestShortCircuitedRequests, TestSkipOverseerOperations, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest, ZkCLITest, TestHdfsCloudBackupRestore, TestLocalFSCloudBackupRestore, NodeAddedTriggerTest, TriggerSetPropertiesIntegrationTest, TestSimExecutePlanAction, TestSimExtremeIndexing, TestSimGenericDistributedQueue, TestSimPolicyCloud, TestSimTriggerIntegration, CdcrReplicationHandlerTest, HdfsRecoveryZkTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsThreadLeakTest, HdfsTlogReplayBufferedWhileIndexingTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMutator, RulesTest, TestCoreContainer, TestImplicitCoreProperties, TestInfoStreamLogging, TestInitParams, TestJmxIntegration, TestSolrDeletionPolicy2, TestSolrIndexConfig, TestSolrXml, TestXIncludeConfig, TestSolrCloudSnapshots, PingRequestHandlerTest, TestContainerPlugin, TestRestoreCore, TestStressThreadBackup, TestSystemCollAutoCreate, InfoHandlerTest, MBeansHandlerTest, MoreLikeThisComponentTest, QueryElevationComponentTest, TestDistributedStatsComponentCardinality, JvmMetricsTest, SolrJmxReporterTest, SolrRrdBackendFactoryTest, TestPackages]
[junit4] Completed [746/914 (1!)] on J4 in 30.06s, 2 tests, 1 failure <<< FAILURES!
[...truncated 45397 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.6-Windows/348/consoleText
[repro] Revision: afeaa52f625707d3f653f9def76d32c027eb19a1
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseZGC"
[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 3472 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=8208AC7D35FAA2D0 -Dtests.slow=true -Dtests.locale=en-MT -Dtests.timezone=GB -Dtests.asserts=true -Dtests.file.encoding=Cp1252
[...truncated 87 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.pkg.TestPackages
[repro] Exiting with code 0
[...truncated 96 lines...]