Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/25021/
Java: 64bit/jdk-13 -XX:+UseCompressedOops -XX:+UseSerialGC

1 tests failed.
FAILED:  org.apache.solr.cloud.PackageManagerCLITest.testPackageManager

Error Message:
Could not get expected value  '1.1.0' for path 
'config/requestHandler/\/mypath2/_packageinfo_/version' full output: {   
"responseHeader":{     "status":0,     "QTime":0},   
"config":{"requestHandler":{"/mypath2":{         "name":"/mypath2",         
"class":"question-answer:fullstory.QARequestHandler",         "_packageinfo_":{ 
          "package":"question-answer",           "version":"1.0.0",           
"files":["/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar"],
           "manifest":"/package/question-answer/1.0.0/manifest.json",           
"manifestSHA512":"a91ab5a2c5abd53f0f72c256592c2be8b667cecb8226ac054aeed4d28aac9d743311442f2d58539bb83663a19bd1efb310aaadfd77bea458f3d475161721a114"}}}}},
  from server:  https://127.0.0.1:45931/solr/abc

Stack Trace:
java.lang.AssertionError: Could not get expected value  '1.1.0' for path 
'config/requestHandler/\/mypath2/_packageinfo_/version' full output: {
  "responseHeader":{
    "status":0,
    "QTime":0},
  "config":{"requestHandler":{"/mypath2":{
        "name":"/mypath2",
        "class":"question-answer:fullstory.QARequestHandler",
        "_packageinfo_":{
          "package":"question-answer",
          "version":"1.0.0",
          
"files":["/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar"],
          "manifest":"/package/question-answer/1.0.0/manifest.json",
          
"manifestSHA512":"a91ab5a2c5abd53f0f72c256592c2be8b667cecb8226ac054aeed4d28aac9d743311442f2d58539bb83663a19bd1efb310aaadfd77bea458f3d475161721a114"}}}}},
  from server:  https://127.0.0.1:45931/solr/abc
        at 
__randomizedtesting.SeedInfo.seed([7FB7A8609119800:45131E80BFF47AB]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.assertTrue(Assert.java:41)
        at 
org.apache.solr.core.TestSolrConfigHandler.testForResponseElement(TestSolrConfigHandler.java:590)
        at 
org.apache.solr.cloud.PackageManagerCLITest.assertPackageVersion(PackageManagerCLITest.java:149)
        at 
org.apache.solr.cloud.PackageManagerCLITest.testPackageManager(PackageManagerCLITest.java:129)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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:830)




Build Log:
[...truncated 14595 lines...]
   [junit4] Suite: org.apache.solr.cloud.PackageManagerCLITest
   [junit4]   2> 1402026 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 1402027 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/data-dir-163-001
   [junit4]   2> 1402027 WARN  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=8 numCloses=8
   [junit4]   2> 1402027 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1402028 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1402028 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001
   [junit4]   2> 1402029 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1402029 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1402029 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 1402129 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port:38923
   [junit4]   2> 1402129 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:38923
   [junit4]   2> 1402129 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38923
   [junit4]   2> 1402129 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 38923
   [junit4]   2> 1402130 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402132 INFO  (zkConnectionManagerCallback-8749-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402132 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402133 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402134 INFO  (zkConnectionManagerCallback-8751-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402134 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402134 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402135 INFO  (zkConnectionManagerCallback-8753-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402135 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402239 WARN  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 1402239 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 1402239 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 1402239 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 13+33
   [junit4]   2> 1402240 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1402240 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1402240 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1402240 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@65f81da8{/solr,null,AVAILABLE}
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@2e70eb5f{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:?????}
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.s.Server Started @???????ms
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45931}
   [junit4]   2> 1402241 ERROR (jetty-launcher-8754-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
9.0.0
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1402241 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-14T16:39:59.666893Z
   [junit4]   2> 1402242 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402243 INFO  (zkConnectionManagerCallback-8756-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402243 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402243 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1402422 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 1402423 WARN  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@28e2418f[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1402423 WARN  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@28e2418f[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1402425 WARN  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@290b03c1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1402425 WARN  (jetty-launcher-8754-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@290b03c1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 1402426 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38923/solr
   [junit4]   2> 1402426 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402427 INFO  (zkConnectionManagerCallback-8763-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402427 INFO  (jetty-launcher-8754-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402529 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1402530 INFO  (zkConnectionManagerCallback-8765-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402530 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 1402566 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:45931_solr
   [junit4]   2> 1402567 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.Overseer Overseer 
(id=72057849380012037-127.0.0.1:45931_solr-n_0000000000) starting
   [junit4]   2> 1402569 INFO  
(OverseerStateUpdate-72057849380012037-127.0.0.1:45931_solr-n_0000000000) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:45931_solr
   [junit4]   2> 1402569 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45931_solr
   [junit4]   2> 1402569 INFO  
(OverseerStateUpdate-72057849380012037-127.0.0.1:45931_solr-n_0000000000) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1402578 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1402589 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45931.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@66a68fe7
   [junit4]   2> 1402595 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45931.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@66a68fe7
   [junit4]   2> 1402595 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45931.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@66a68fe7
   [junit4]   2> 1402596 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 1402596 INFO  (jetty-launcher-8754-thread-1) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/.
   [junit4]   2> 1402605 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
   [junit4]   2> 1402605 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402606 INFO  (zkConnectionManagerCallback-8774-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402606 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402607 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1402608 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:38923/solr ready
   [junit4]   2> 1402614 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 13+33
   [junit4]   2> 1402617 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1c3ac1b8{HTTP/1.1,[http/1.1]}{0.0.0.0:?????}
   [junit4]   2> 1402617 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.e.j.s.Server Started @???????ms
   [junit4]   2> 1402624 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testPackageManager
   [junit4]   2> 1402626 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1402660 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=6
   [junit4]   2> 1402663 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1402664 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
   [junit4]   2> 1402665 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1402669 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402669 INFO  (zkConnectionManagerCallback-8776-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402669 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402670 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   1> Installed packages:
   [junit4]   1> -----
   [junit4]   2> 1402673 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1402674 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: []
   [junit4]   2> 1402774 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: list-installed
   [junit4]   2> 1402775 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1402788 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=5
   [junit4]   2> 1402789 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1402790 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
   [junit4]   2> 1402790 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1402791 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402795 INFO  (zkConnectionManagerCallback-8778-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402795 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1402795 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   2> 1402796 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.RepositoryManager []
   [junit4]   1> Added repository: fullstory
   [junit4]   2> 1402932 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: add-repo
   [junit4]   2> 1402932 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1402946 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=7
   [junit4]   2> 1402948 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1402948 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
   [junit4]   2> 1402949 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1402951 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1402956 INFO  (zkConnectionManagerCallback-8780-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1402956 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   1> Available packages:
   [junit4]   1> -----
   [junit4]   2> 1402956 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   1> question-answer           A natural language question 
answering plugin
   [junit4]   1>   Version: 1.0.0
   [junit4]   1>   Version: 1.1.0
   [junit4]   2> 1403065 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: list-available
   [junit4]   2> 1403065 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1403078 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=5
   [junit4]   2> 1403080 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1403080 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
   [junit4]   2> 1403080 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1403081 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1403082 INFO  (zkConnectionManagerCallback-8782-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1403082 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1403082 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   2> 1403099 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1403099 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: []
   [junit4]   1> Posting manifest...
   [junit4]   2> 1403143 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Missing file in package store: 
/package/question-answer/1.0.0/manifest.json
   [junit4]   2> 1403143 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Unable to download file : 
/package/question-answer/1.0.0/manifest.json
   [junit4]   2> 1403174 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore persisted a file 
/package/question-answer/1.0.0/manifest.json and metadata. sizes 809 144
   [junit4]   2> 1403178 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/cluster/files/package/question-answer/1.0.0/manifest.json 
params={wt=javabin&version=2} status=0 QTime=35
   [junit4]   1> Posting artifacts...
   [junit4]   2> 1403181 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Missing file in package store: 
/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar
   [junit4]   2> 1403181 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Unable to download file : 
/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar
   [junit4]   2> 1403184 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore persisted a file 
/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar and 
metadata. sizes 5652 246
   [junit4]   2> 1403187 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/cluster/files/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar
 
params={sig=C9UWKkucmY3UNzqn0VLneVMe9kCbJjw7Urc76vGenoRwp32xvNn5ZIGZ7G34xZP7cVjqn/ltDlLWBZ/C3eAtuw%3D%3D&wt=javabin&version=2}
 status=0 QTime=7
   [junit4]   1> Executing Package API to register this package...
   [junit4]   2> 1403194 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader /packages.json updated to version 0
   [junit4]   2> 1403194 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader A new package: question-answer introduced
   [junit4]   2> 1403194 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader A new version: 1.0.0 added for package: 
question-answer with artifacts 
[/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar]
   [junit4]   2> 1403196 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/filestore/package/question-answer/1.0.0]
   [junit4]   2> 1403196 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader version: 1.0.0 is the new latest in package: 
question-answer
   [junit4]   2> 1403196 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package 
params={wt=javabin&version=2} status=0 QTime=8
   [junit4]   1> Response: {"responseHeader":{
   [junit4]   1>     "status":0,
   [junit4]   1>     "QTime":8}}
   [junit4]   2> 1403196 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1403207 INFO  (zkCallback-8764-thread-1) [     ] 
o.a.s.p.PackageLoader /packages.json updated to version 0
   [junit4]   2> 1403208 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.0.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1403212 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: [{
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.0.0"}]
   [junit4]   1> {
   [junit4]   1>   
"path":"/api/collections/${collection}/config/requestHandler?componentName=${RH-HANDLER-PATH}&meta=true",
   [junit4]   1>   "method":"GET",
   [junit4]   1>   
"condition":"$['config'].['requestHandler'].['${RH-HANDLER-PATH}'].['_packageinfo_'].['version']",
   [junit4]   1>   "expected":"${package-version}"}
   [junit4]   1> Verifying version 1.0.0 on [], result: true
   [junit4]   1> org.apache.solr.packagemanager.RepositoryManager@14b7ea83 
installed.
   [junit4]   2> 1403313 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: install
   [junit4]   2> 1403313 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1403325 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=4
   [junit4]   2> 1403326 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1403327 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
   [junit4]   2> 1403327 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1403328 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1403329 INFO  (zkConnectionManagerCallback-8784-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1403329 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1403329 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   1> Installed packages:
   [junit4]   1> -----
   [junit4]   2> 1403329 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1403336 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.0.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1403339 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: [{
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.0.0"}]
   [junit4]   1> {
   [junit4]   1>   "name":"question-answer",
   [junit4]   1>   "version":"1.0.0"}
   [junit4]   2> 1403439 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: list-installed
   [junit4]   2> 1403446 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf1&name=abc&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1403449 INFO  
(OverseerThreadFactory-8643-thread-1-processing-n:127.0.0.1:45931_solr) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
abc
   [junit4]   2> 1403553 INFO  
(OverseerStateUpdate-72057849380012037-127.0.0.1:45931_solr-n_0000000000) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"abc",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"abc_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:45931/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1403758 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
x:abc_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=abc_shard1_replica_n1&action=CREATE&numShards=1&collection=abc&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1403758 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
x:abc_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1404766 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.0.0
   [junit4]   2> 1404770 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.s.IndexSchema 
[abc_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1404771 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1404771 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.CoreContainer 
Creating SolrCore 'abc_shard1_replica_n1' using configuration from collection 
abc, trusted=true
   [junit4]   2> 1404772 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 'solr_45931.solr.core.abc.shard1.replica_n1' (registry 
'solr.core.abc.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@66a68fe7
   [junit4]   2> 1404772 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[abc_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/abc_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/./abc_shard1_replica_n1/data/]
   [junit4]   2> 1404801 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1404801 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1404802 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1404802 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1404803 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@1115df62[abc_shard1_replica_n1] main]
   [junit4]   2> 1404804 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1404804 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1404804 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1404804 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1650196062906875904
   [junit4]   2> 1404806 INFO  
(searcherExecutor-8648-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrCore 
[abc_shard1_replica_n1] Registered new searcher 
Searcher@1115df62[abc_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1404807 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/abc/terms/shard1 to 
Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1404807 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/abc/leaders/shard1
   [junit4]   2> 1404809 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1404809 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1404809 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
replicas to https://127.0.0.1:45931/solr/abc_shard1_replica_n1/
   [junit4]   2> 1404809 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
Success - now sync replicas to me
   [junit4]   2> 1404809 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
https://127.0.0.1:45931/solr/abc_shard1_replica_n1/ has no replicas
   [junit4]   2> 1404809 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/abc/leaders/shard1/leader after winning as 
/collections/abc/leader_elect/shard1/election/72057849380012037-core_node2-n_0000000000
   [junit4]   2> 1404810 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:45931/solr/abc_shard1_replica_n1/ shard1
   [junit4]   2> 1404911 INFO  (zkCallback-8764-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for 
collection [abc] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1404911 INFO  (zkCallback-8764-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for 
collection [abc] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1404912 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 1404914 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf1&newCollection=true&name=abc_shard1_replica_n1&action=CREATE&numShards=1&collection=abc&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1155
   [junit4]   2> 1404916 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 1405013 INFO  (zkCallback-8764-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for 
collection [abc] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1405013 INFO  (zkCallback-8764-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for 
collection [abc] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1405013 INFO  (zkCallback-8764-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/abc/state.json] for 
collection [abc] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1405013 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf1&name=abc&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=1567
   [junit4]   2> 1405014 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf2&name=def&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1405015 INFO  
(OverseerThreadFactory-8643-thread-2-processing-n:127.0.0.1:45931_solr) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
def
   [junit4]   2> 1405015 INFO  
(OverseerCollectionConfigSetProcessor-72057849380012037-127.0.0.1:45931_solr-n_0000000000)
 [n:127.0.0.1:45931_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1405225 INFO  
(OverseerStateUpdate-72057849380012037-127.0.0.1:45931_solr-n_0000000000) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"def",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"def_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:45931/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1405426 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
x:def_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf2&newCollection=true&name=def_shard1_replica_n1&action=CREATE&numShards=1&collection=def&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1406433 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.0.0
   [junit4]   2> 1406455 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.s.IndexSchema 
[def_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1406456 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1406456 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.CoreContainer 
Creating SolrCore 'def_shard1_replica_n1' using configuration from collection 
def, trusted=true
   [junit4]   2> 1406456 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 'solr_45931.solr.core.def.shard1.replica_n1' (registry 
'solr.core.def.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@66a68fe7
   [junit4]   2> 1406456 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[def_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/def_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/./def_shard1_replica_n1/data/]
   [junit4]   2> 1406486 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1406486 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1406487 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1406487 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1406487 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@38fe8097[def_shard1_replica_n1] main]
   [junit4]   2> 1406489 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf2
   [junit4]   2> 1406489 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf2
   [junit4]   2> 1406489 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1406489 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1650196064673726464
   [junit4]   2> 1406491 INFO  
(searcherExecutor-8653-thread-1-processing-n:127.0.0.1:45931_solr 
x:def_shard1_replica_n1 c:def s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.SolrCore 
[def_shard1_replica_n1] Registered new searcher 
Searcher@38fe8097[def_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1406493 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/def/terms/shard1 to 
Terms{values={core_node2=0}, version=0}
   [junit4]   2> 1406493 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/def/leaders/shard1
   [junit4]   2> 1406494 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1406494 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1406494 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
replicas to https://127.0.0.1:45931/solr/def_shard1_replica_n1/
   [junit4]   2> 1406495 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync 
Success - now sync replicas to me
   [junit4]   2> 1406495 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
https://127.0.0.1:45931/solr/def_shard1_replica_n1/ has no replicas
   [junit4]   2> 1406495 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/def/leaders/shard1/leader after winning as 
/collections/def/leader_elect/shard1/election/72057849380012037-core_node2-n_0000000000
   [junit4]   2> 1406495 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:45931/solr/def_shard1_replica_n1/ shard1
   [junit4]   2> 1406597 INFO  (zkCallback-8764-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for 
collection [def] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1406597 INFO  (zkCallback-8764-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for 
collection [def] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1406598 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 1406599 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf2&newCollection=true&name=def_shard1_replica_n1&action=CREATE&numShards=1&collection=def&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1172
   [junit4]   2> 1406599 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 1406699 INFO  (zkCallback-8764-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for 
collection [def] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1406699 INFO  (zkCallback-8764-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for 
collection [def] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1406699 INFO  (zkCallback-8764-thread-4) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/collections/def/state.json] for 
collection [def] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1406699 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf2&name=def&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=1685
   [junit4]   2> 1406700 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1406708 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=5
   [junit4]   2> 1406710 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1406711 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=1
   [junit4]   2> 1406712 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1406713 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1406714 INFO  (zkConnectionManagerCallback-8788-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1406714 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1406714 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   1> Collections on which package question-answer was 
deployed:
   [junit4]   2> 1406846 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: list-deployed
   [junit4]   2> 1406846 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1406859 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=5
   [junit4]   2> 1406861 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1406863 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=1
   [junit4]   2> 1406863 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1406865 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1406865 INFO  (zkConnectionManagerCallback-8790-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1406865 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1406866 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   2> 1406866 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1406876 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.0.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1406879 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: [{
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.0.0"}]
   [junit4]   2> 1406899 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Waiting up to 30 secs for 1 replicas to set the property params to be of 
version 0 for collection abc
   [junit4]   2> 1406903 INFO  (Thread-13995) [     ] o.a.s.c.SolrCore config 
update listener called for core abc_shard1_replica_n1
   [junit4]   2> 1406904 INFO  (Thread-13995) [     ] o.a.s.c.RequestParams 
conf resource params.json loaded . version : 0 
   [junit4]   2> 1406904 INFO  (Thread-13995) [     ] o.a.s.c.RequestParams 
request params refreshed to version 0
   [junit4]   2> 1406907 INFO  
(solrHandlerExecutor-8658-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1407011 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
I already have the expected version 0 of params
   [junit4]   2> 1407011 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
isStale false , resourceloader org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1407011 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={params=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1407012 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Took 112.0ms to set the property params to be of version 0 for collection abc
   [junit4]   2> 1407013 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.ZkController 
Persisted config data to node /configs/conf1/params.json 
   [junit4]   2> 1407013 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Waiting up to 30 secs for 1 replicas to set the property params to be of 
version 1 for collection abc
   [junit4]   2> 1407013 INFO  (Thread-13996) [     ] o.a.s.c.SolrCore config 
update listener called for core abc_shard1_replica_n1
   [junit4]   2> 1407013 INFO  (Thread-13996) [     ] o.a.s.c.RequestParams 
conf resource params.json loaded . version : 1 
   [junit4]   2> 1407013 INFO  (Thread-13996) [     ] o.a.s.c.RequestParams 
request params refreshed to version 1
   [junit4]   2> 1407014 INFO  
(solrHandlerExecutor-8659-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1407016 INFO  
(OverseerCollectionConfigSetProcessor-72057849380012037-127.0.0.1:45931_solr-n_0000000000)
 [n:127.0.0.1:45931_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1407120 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
I already have the expected version 1 of params
   [junit4]   2> 1407120 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
isStale false , resourceloader org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1407120 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={params=1&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1407121 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Took 107.0ms to set the property params to be of version 1 for collection abc
   [junit4]   1> Executing 
{"add-requesthandler":{"name":"/mypath2","class":"question-answer:fullstory.QARequestHandler"}}
 for path:/api/collections/abc/config
   [junit4]   1> Putting patterns into the list from the init()
   [junit4]   2> 1407129 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Waiting up to 30 secs for 1 replicas to set the property overlay to be of 
version 0 for collection abc
   [junit4]   2> 1407130 INFO  (Thread-13997) [     ] o.a.s.c.SolrCore config 
update listener called for core abc_shard1_replica_n1
   [junit4]   2> 1407130 INFO  (Thread-13997) [     ] o.a.s.c.SolrCore core 
reload abc_shard1_replica_n1
   [junit4]   2> 1407130 INFO  
(solrHandlerExecutor-8660-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1407133 INFO  (Thread-13997) [     ] o.a.s.c.RequestParams 
conf resource params.json loaded . version : 1 
   [junit4]   2> 1407133 INFO  (Thread-13997) [     ] o.a.s.c.RequestParams 
request params refreshed to version 1
   [junit4]   2> 1407133 INFO  (Thread-13997) [     ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.0.0
   [junit4]   2> 1407137 INFO  (Thread-13997) [     ] o.a.s.s.IndexSchema 
[abc_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1407138 INFO  (Thread-13997) [     ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1407138 INFO  (Thread-13997) [     ] o.a.s.c.CoreContainer 
Reloading SolrCore 'abc_shard1_replica_n1' using configuration from collection 
abc
   [junit4]   2> 1407155 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr_45931.solr.core.abc.shard1.replica_n1' (registry 
'solr.core.abc.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@66a68fe7
   [junit4]   2> 1407155 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[abc_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/abc_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/./abc_shard1_replica_n1/data/]
   [junit4]   2> 1407200 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.p.PackagePluginHolder 
loading plugin: requestHandler -> /mypath2 using  package question-answer:1.0.0
   [junit4]   1> Putting patterns into the list from the init()
   [junit4]   2> 1407202 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 1407202 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 1407203 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@4573579[abc_shard1_replica_n1] main]
   [junit4]   2> 1407204 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1407204 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1407204 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 1407204 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1650196065423458304
   [junit4]   2> 1407206 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.u.DefaultSolrCoreState 
New IndexWriter is ready to be used.
   [junit4]   2> 1407207 INFO  
(searcherExecutor-8661-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrCore 
[abc_shard1_replica_n1] Registered new searcher 
Searcher@4573579[abc_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1407207 INFO  (Thread-13997) [n:127.0.0.1:45931_solr c:abc 
s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@685a6398[abc_shard1_replica_n1] main]
   [junit4]   2> 1407209 INFO  
(searcherExecutor-8661-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrCore 
[abc_shard1_replica_n1] Registered new searcher 
Searcher@685a6398[abc_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1407238 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
I already have the expected version 0 of config
   [junit4]   2> 1407238 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
isStale false , resourceloader org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1407238 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={overlay=0&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1407238 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Took 109.0ms to set the property overlay to be of version 0 for collection abc
   [junit4]   2> 1407238 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.SolrCore 
[abc_shard1_replica_n1]  CLOSING SolrCore org.apache.solr.core.SolrCore@7ea0f8c7
   [junit4]   2> 1407238 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for registry=solr.core.abc.shard1.replica_n1, 
tag=SolrCore@7ea0f8c7
   [junit4]   2> 1407238 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter 
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@31b8c20b: 
rootName = solr_45931, domain = solr.core.abc.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.abc.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@5770b66c
   [junit4]   2> 1407245 INFO  (qtp1636434725-35959) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.m.SolrMetricManager 
Closing metric reporters for registry=solr.collection.abc.shard1.leader, 
tag=SolrCore@7ea0f8c7
   [junit4]   2> 1407247 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.ZkController 
Persisted config data to node /configs/conf1/params.json 
   [junit4]   2> 1407247 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Waiting up to 30 secs for 1 replicas to set the property params to be of 
version 2 for collection abc
   [junit4]   2> 1407247 INFO  (Thread-13998) [     ] o.a.s.c.SolrCore config 
update listener called for core abc_shard1_replica_n1
   [junit4]   2> 1407248 INFO  (Thread-13998) [     ] o.a.s.c.RequestParams 
conf resource params.json loaded . version : 2 
   [junit4]   2> 1407248 INFO  (Thread-13998) [     ] o.a.s.c.RequestParams 
request params refreshed to version 2
   [junit4]   2> 1407248 INFO  
(solrHandlerExecutor-8665-thread-1-processing-n:127.0.0.1:45931_solr 
x:abc_shard1_replica_n1 c:abc s:shard1 r:core_node2) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Time elapsed : 0 secs, maxWait 30
   [junit4]   2> 1407354 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
I already have the expected version 2 of params
   [junit4]   2> 1407354 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
isStale false , resourceloader org.apache.solr.cloud.ZkSolrResourceLoader
   [junit4]   2> 1407354 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/znodeVersion 
params={params=2&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1407355 INFO  (qtp1636434725-35961) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.h.SolrConfigHandler 
Took 107.0ms to set the property params to be of version 2 for collection abc
   [junit4]   1> {
   [junit4]   1>   
"path":"/api/collections/${collection}/config/requestHandler?componentName=${RH-HANDLER-PATH}&meta=true",
   [junit4]   1>   "method":"GET",
   [junit4]   1>   
"condition":"$['config'].['requestHandler'].['${RH-HANDLER-PATH}'].['_packageinfo_'].['version']",
   [junit4]   1>   "expected":"${package-version}"}
   [junit4]   1> Executing 
https://127.0.0.1:45931/api/collections/abc/config/requestHandler?componentName=/mypath2&meta=true
 for collection:abc
   [junit4]   1> {
   [junit4]   1>   "responseHeader":{
   [junit4]   1>     "status":0,
   [junit4]   1>     "QTime":0},
   [junit4]   1>   "config":{"requestHandler":{"/mypath2":{
   [junit4]   1>         "name":"/mypath2",
   [junit4]   1>         "class":"question-answer:fullstory.QARequestHandler",
   [junit4]   1>         "_packageinfo_":{
   [junit4]   1>           "package":"question-answer",
   [junit4]   1>           "version":"1.0.0",
   [junit4]   1>           
"files":["/package/question-answer/1.0.0/question-answer-request-handler-1.0.jar"],
   [junit4]   1>           
"manifest":"/package/question-answer/1.0.0/manifest.json",
   [junit4]   1>           
"manifestSHA512":"a91ab5a2c5abd53f0f72c256592c2be8b667cecb8226ac054aeed4d28aac9d743311442f2d58539bb83663a19bd1efb310aaadfd77bea458f3d475161721a114"}}}}}
   [junit4]   1> 
   [junit4]   1> Actual: 1.0.0, expected: 1.0.0
   [junit4]   1> Deployed and verified package: question-answer, version: 
1.0.0
   [junit4]   1> Deployment successful
   [junit4]   2> 1407469 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: deploy
   [junit4]   2> 1407476 INFO  (qtp1636434725-36074) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/params params={meta=true} 
status=0 QTime=0
   [junit4]   2> 1407480 INFO  (qtp1636434725-36078) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/requestHandler 
params={meta=true&componentName=/mypath2} status=0 QTime=0
   [junit4]   2> 1407481 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1407489 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=4
   [junit4]   2> 1407490 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1407492 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=1
   [junit4]   2> 1407492 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1407493 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1407494 INFO  (zkConnectionManagerCallback-8797-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1407494 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1407494 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   1> Collections on which package question-answer was 
deployed:
   [junit4]   1>   abc(question-answer:1.0.0)
   [junit4]   2> 1407605 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: list-deployed
   [junit4]   2> 1407605 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1407615 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=4
   [junit4]   2> 1407617 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1407619 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=2
   [junit4]   2> 1407619 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1407620 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1407621 INFO  (zkConnectionManagerCallback-8799-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1407621 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1407621 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   2> 1407628 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1407632 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.0.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1407634 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: [{
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.0.0"}]
   [junit4]   1> Packages deployed on abc:
   [junit4]   1>   {
   [junit4]   1>   "name":"question-answer",
   [junit4]   1>   "version":"1.0.0"}
   [junit4]   2> 1407736 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: list-deployed
   [junit4]   2> 1407736 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.PackageManagerCLITest Testing explicit deployment to a different/newer 
version
   [junit4]   2> 1407736 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1407746 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=4
   [junit4]   2> 1407748 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1407750 INFO  (qtp1636434725-35960) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=2
   [junit4]   2> 1407751 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1407752 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1407753 INFO  (zkConnectionManagerCallback-8801-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1407753 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1407753 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Done initializing a zkClient instance...
   [junit4]   2> 1407770 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1407774 INFO  (qtp1636434725-36077) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.0.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1407776 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: [{
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.0.0"}]
   [junit4]   1> Posting manifest...
   [junit4]   2> 1407808 INFO  (qtp1636434725-36079) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Missing file in package store: 
/package/question-answer/1.1.0/manifest.json
   [junit4]   2> 1407808 INFO  (qtp1636434725-36079) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Unable to download file : 
/package/question-answer/1.1.0/manifest.json
   [junit4]   2> 1407816 INFO  (qtp1636434725-36079) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore persisted a file 
/package/question-answer/1.1.0/manifest.json and metadata. sizes 864 144
   [junit4]   2> 1407823 INFO  (qtp1636434725-36079) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/cluster/files/package/question-answer/1.1.0/manifest.json 
params={wt=javabin&version=2} status=0 QTime=15
   [junit4]   1> Posting artifacts...
   [junit4]   2> 1407826 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Missing file in package store: 
/package/question-answer/1.1.0/question-answer-request-handler-1.1.jar
   [junit4]   2> 1407826 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore Unable to download file : 
/package/question-answer/1.1.0/question-answer-request-handler-1.1.jar
   [junit4]   2> 1407829 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.f.DistribPackageStore persisted a file 
/package/question-answer/1.1.0/question-answer-request-handler-1.1.jar and 
metadata. sizes 6324 246
   [junit4]   2> 1407832 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/cluster/files/package/question-answer/1.1.0/question-answer-request-handler-1.1.jar
 
params={sig=qdNsVe5G8clkBDQwcX2MViA1XU6bhqEwFCPiqPxot7YQw5oj/pFvDPkzWaVa6rNbUzK3WUBbhV5TedhF7hZMOQ%3D%3D&wt=javabin&version=2}
 status=0 QTime=8
   [junit4]   1> Executing Package API to register this package...
   [junit4]   2> 1407835 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader /packages.json updated to version 0
   [junit4]   2> 1407835 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader Package question-answer is modified 
   [junit4]   2> 1407835 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader A new version: 1.1.0 added for package: 
question-answer with artifacts 
[/package/question-answer/1.1.0/question-answer-request-handler-1.1.jar]
   [junit4]   2> 1407835 INFO  (zkCallback-8764-thread-3) [     ] 
o.a.s.p.PackageLoader /packages.json updated to version 1
   [junit4]   2> 1407835 INFO  (zkCallback-8764-thread-3) [     ] 
o.a.s.p.PackageLoader Package question-answer is modified 
   [junit4]   2> 1407836 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr    
 ] o.a.s.c.SolrResourceLoader [null] Added 1 libs to classloader, from paths: 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001/tempDir-001/node1/filestore/package/question-answer/1.1.0]
   [junit4]   2> 1407836 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr    
 ] o.a.s.p.PackageLoader version: 1.1.0 is the new latest in package: 
question-answer
   [junit4]   2> 1407836 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.p.PackagePluginHolder Using version :1.0.0. latest is 1.1.0,  params.json 
has config question-answer : 1.0.0
   [junit4]   2> 1407836 INFO  (zkCallback-8764-thread-3) 
[n:127.0.0.1:45931_solr c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] 
o.a.s.p.PackagePluginHolder Using version :1.0.0. latest is 1.1.0,  params.json 
has config question-answer : 1.0.0
   [junit4]   2> 1407836 INFO  (qtp1636434725-36076) [n:127.0.0.1:45931_solr 
c:def s:shard1 r:core_node2 x:def_shard1_replica_n1 ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/cluster/package params={wt=javabin&version=2} 
status=0 QTime=3
   [junit4]   1> Response: {"responseHeader":{
   [junit4]   1>     "status":0,
   [junit4]   1>     "QTime":3}}
   [junit4]   2> 1407837 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Getting packages from packages.json...
   [junit4]   2> 1407842 INFO  (qtp1636434725-36078) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.0.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1407846 INFO  (qtp1636434725-36074) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/package/question-answer/1.1.0/manifest.json params={} status=0 
QTime=0
   [junit4]   2> 1407847 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.p.PackageManager Got packages: [{
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.0.0"}, {
   [junit4]   2>   "name":"question-answer",
   [junit4]   2>   "version":"1.1.0"}]
   [junit4]   1> {
   [junit4]   1>   
"path":"/api/collections/${collection}/config/requestHandler?componentName=${RH-HANDLER-PATH}&meta=true",
   [junit4]   1>   "method":"GET",
   [junit4]   1>   
"condition":"$['config'].['requestHandler'].['${RH-HANDLER-PATH}'].['_packageinfo_'].['version']",
   [junit4]   1>   "expected":"${package-version}"}
   [junit4]   1> Verifying version 1.1.0 on [], result: true
   [junit4]   1> org.apache.solr.packagemanager.RepositoryManager@7cd4db42 
installed.
   [junit4]   2> 1407949 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Finished: install
   [junit4]   2> 1407956 INFO  (qtp1636434725-36075) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/params params={meta=true} 
status=0 QTime=0
   [junit4]   2> 1407959 INFO  (qtp1636434725-36074) [n:127.0.0.1:45931_solr 
c:abc s:shard1 r:core_node2 x:abc_shard1_replica_n1 ] o.a.s.c.S.Request 
[abc_shard1_replica_n1]  webapp=/solr path=/config/requestHandler 
params={meta=true&componentName=/mypath2} status=0 QTime=0
   [junit4]   2> 1407960 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool Solr url: https://127.0.0.1:45931/solr, solr base url: 
https://127.0.0.1:45931
   [junit4]   2> 1407968 INFO  (qtp1636434725-36072) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system 
params={wt=json} status=0 QTime=4
   [junit4]   2> 1407969 INFO  (qtp1636434725-36077) [n:127.0.0.1:45931_solr    
 ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with 
params action=CLUSTERSTATUS&wt=json and sendToOCPQueue=true
   [junit4]   2> 1407971 INFO  (qtp1636434725-36077) [n:127.0.0.1:45931_solr    
 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=CLUSTERSTATUS&wt=json} status=0 QTime=1
   [junit4]   2> 1407971 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.u.PackageTool ZK: 127.0.0.1:38923/solr
   [junit4]   2> 1407972 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1407973 INFO  (zkConnectionManagerCallback-8803-thread-1) [    
 ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1407973 INFO  
(TEST-PackageManagerCLITest.testPackageManager-seed#[7FB7A8609119800]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected

[...truncated too long message...]

 [org.apache.solr.metrics.reporters.SolrJmxReporter@738dfe7b: rootName = 
solr_45931, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@73d22196
   [junit4]   2> 1409635 INFO  (jetty-closer-8807-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1409635 INFO  (jetty-closer-8807-thread-1) [     ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@120bcbe1: rootName = 
solr_45931, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@5016f83
   [junit4]   2> 1409635 INFO  (jetty-closer-8807-thread-1) [     ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 1409635 INFO  (closeThreadPool-8811-thread-2) [     ] 
o.a.s.c.Overseer Overseer 
(id=72057849380012037-127.0.0.1:45931_solr-n_0000000000) closing
   [junit4]   2> 1409635 INFO  
(OverseerStateUpdate-72057849380012037-127.0.0.1:45931_solr-n_0000000000) 
[n:127.0.0.1:45931_solr     ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:45931_solr
   [junit4]   2> 1409635 INFO  
(OverseerAutoScalingTriggerThread-72057849380012037-127.0.0.1:45931_solr-n_0000000000)
 [     ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1409636 INFO  (closeThreadPool-8811-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72057849380012037-127.0.0.1:45931_solr-n_0000000000) closing
   [junit4]   2> 1409736 INFO  (jetty-closer-8807-thread-1) [     ] 
o.a.s.c.Overseer Overseer 
(id=72057849380012037-127.0.0.1:45931_solr-n_0000000000) closing
   [junit4]   2> 1417833 INFO  (jetty-closer-8807-thread-1) [     ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@2e70eb5f{ssl,[ssl, alpn, 
http/1.1, h2]}{127.0.0.1:?}
   [junit4]   2> 1417834 INFO  (jetty-closer-8807-thread-1) [     ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@65f81da8{/solr,null,UNAVAILABLE}
   [junit4]   2> 1417834 INFO  (jetty-closer-8807-thread-1) [     ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1417834 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 1418036 WARN  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        8       /solr/configs/conf1
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2>        2       /solr/collections/def/terms/shard1
   [junit4]   2>        2       /solr/collections/abc/terms/shard1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        12      /solr/collections/abc/state.json
   [junit4]   2>        12      /solr/collections/def/state.json
   [junit4]   2>        2       /solr/packages.json
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        23      /solr/overseer/queue
   [junit4]   2>        9       /solr/overseer/collection-queue-work
   [junit4]   2>        6       /solr/collections
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2> 
   [junit4]   2> 1418037 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:38923
   [junit4]   2> 1418037 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:38923
   [junit4]   2> 1418038 INFO  
(SUITE-PackageManagerCLITest-seed#[7FB7A8609119800]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 38923
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.PackageManagerCLITest_7FB7A8609119800-001
   [junit4]   2> Nov 14, 2019 4:40:15 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7a5148c3),
 locale=ar, timezone=Europe/Gibraltar
   [junit4]   2> NOTE: Linux 5.0.0-36-generic amd64/Oracle Corporation 13 
(64-bit)/cpus=8,threads=1,free=246689080,total=518979584
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestManagedSynonymFilterFactory, TestReqParamsAPI, 
TestSimClusterStateProvider, CoreMergeIndexesAdminHandlerTest, 
DocumentAnalysisRequestHandlerTest, TestPartialUpdateDeduplication, 
DistributedQueryComponentOptimizationTest, 
TestDistributedStatsComponentCardinality, TestExceedMaxTermLength, 
TestSimDistributedQueue, DistanceUnitsTest, CachingDirectoryFactoryTest, 
OverseerModifyCollectionTest, SolrCloudExampleTest, MoveReplicaHDFSTest, 
SearchHandlerTest, HdfsRestartWhileUpdatingTest, TestRecoveryHdfs, 
LeaderFailureAfterFreshStartTest, BlobRepositoryCloudTest, 
TestTolerantUpdateProcessorRandomCloud, TriggerEventQueueTest, SparseHLLTest, 
TestStandardQParsers, TestSystemIdResolver, ComputePlanActionTest, 
JWTAuthPluginTest, SpellCheckCollatorTest, TestSolrJ, MigrateRouteKeyTest, 
TestDistributedGrouping, SharedFSAutoReplicaFailoverTest, 
TestSurroundQueryParser, BasicAuthOnSingleNodeTest, 
SubstringBytesRefFilterTest, TestSearchPerf, TestSimNodeLostTrigger, 
SchemaApiFailureTest, TestDownShardTolerantSearch, TestIntervalFaceting, 
TestFieldCacheWithThreads, TestFunctionQuery, SaslZkACLProviderTest, 
JavabinLoaderTest, XmlInterpolationTest, MultiDestinationAuditLoggerTest, 
TestLuceneMatchVersion, StatsComponentTest, HttpTriggerListenerTest, 
CdcrWithNodesRestartsTest, TestMultiValuedNumericRangeQuery, 
TriLevelCompositeIdRoutingTest, TestPrepRecovery, ClusterStateTest, 
TestSimGenericDistributedQueue, TimeZoneUtilsTest, 
FullSolrCloudDistribCmdsTest, TestIndexingPerformance, 
TestSolrCloudWithSecureImpersonation, TestDocTermOrdsUninvertLimit, 
SpatialRPTFieldTypeTest, RuleEngineTest, TestDeleteCollectionOnDownNodes, 
TestSolrCloudWithHadoopAuthPlugin, TestSafeXMLParsing, TestBulkSchemaAPI, 
TestJoin, TestCloudInspectUtil, TestConfigOverlay, ScheduledTriggerTest, 
TestSimpleTrackingShardHandler, TestCloudPseudoReturnFields, 
AnalyticsQueryTest, SolrTestCaseJ4Test, DistributedUpdateProcessorTest, 
TestBM25SimilarityFactory, TestSolrIndexConfig, TestNRTOpen, 
DirectSolrConnectionTest, TestJsonFacetsStatsParsing, TestBulkSchemaConcurrent, 
SpellingQueryConverterTest, TestFilteredDocIdSet, CopyFieldTest, 
CoreAdminHandlerTest, SignificantTermsQParserPluginTest, AssignTest, 
AliasIntegrationTest, NodeLostTriggerIntegrationTest, ConvertedLegacyTest, 
TestDistribPackageStore, ConfigSetsAPITest, TestJmxIntegration, 
DirectoryFactoryTest, TestDynamicFieldResource, BlockJoinFacetDistribTest, 
TestOverriddenPrefixQueryForCustomFieldType, NotRequiredUniqueKeyTest, 
TestSolrCachePerf, ReindexCollectionTest, TestAddFieldRealTimeGet, 
TestSQLHandlerNonCloud, CloneFieldUpdateProcessorFactoryTest, 
WrapperMergePolicyFactoryTest, LargeFieldTest, SolrCoreCheckLockOnStartupTest, 
ZkCLITest, DirectSolrSpellCheckerTest, TemplateUpdateProcessorTest, 
ClassificationUpdateProcessorFactoryTest, TestBadConfig, TransactionLogTest, 
RegexBoostProcessorTest, TestAuthorizationFramework, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestCustomSort, 
AuditLoggerIntegrationTest, PeerSyncWithLeaderAndIndexFingerprintCachingTest, 
TestHttpServletCarrier, TestPseudoReturnFields, QueryElevationComponentTest, 
ConnectionReuseTest, TestUseDocValuesAsStored2, 
TestLMJelinekMercerSimilarityFactory, DeleteNodeTest, TestChildDocTransformer, 
TestJsonRequest, TestWithCollection, HdfsTlogReplayBufferedWhileIndexingTest, 
TestSimTriggerIntegration, TestConfigSets, ZkNodePropsTest, 
TestPHPSerializedResponseWriter, TestSkipOverseerOperations, 
DocValuesNotIndexedTest, TestCollectionAPIs, ShardSplitTest, 
TestFuzzyAnalyzedSuggestions, TestRawTransformer, TestRTGBase, 
TestStressThreadBackup, SolrMetricReporterTest, TestSchemalessBufferedUpdates, 
OutputWriterTest, PeerSyncTest, CollectionPropsTest, 
CreateCollectionCleanupTest, DeleteReplicaTest, HttpPartitionTest, 
LeaderTragicEventTest, LeaderVoteWaitTimeoutTest, MultiSolrCloudTestCaseTest, 
PackageManagerCLITest]
   [junit4] Completed [502/891 (1!)] on J2 in 17.02s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 46231 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:634: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:507: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:494: Source checkout 
is dirty (unversioned/missing files) after running tests!!! Offending files:
* solr/licenses/question-answer-request-handler-1.0.jar.sha1
* solr/licenses/question-answer-request-handler-1.1.jar.sha1

Total time: 90 minutes 40 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to