Build: https://ci-builds.apache.org/job/Solr/job/Solr-Check-9.x/5413/

2 tests failed.
FAILED:  org.apache.solr.pkg.TestPackages.testCoreReloadingPlugin

Error Message:
java.lang.Exception: Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([CF63900ABB0C336E]:0)


FAILED:  org.apache.solr.pkg.TestPackages.classMethod

Error Message:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([CF63900ABB0C336E]:0)




Build Log:
[...truncated 1287 lines...]
# ERROR: Solr is still running at http://localhost:7574/solr after 5 seconds
#
# Please find the SOLR_HOME snapshot for failed test #2 at: 
/tmp/src/solr/solr/packaging/build/test-output/failure-snapshots/62-2
# Last output:
#
# Found 2 Solr nodes running! Must either specify a port using -p or -all to 
stop all Solr nodes on this host.
ok 63 status detects locally running solr in 14337ms
ok 64 status does not expose cli parameters to end user in 209ms
ok 65 listing out files in 2163ms
ok 66 copying files around in 6550ms
ok 67 upconfig in 2621ms
ok 68 zkcli.sh gets 'solrhome' from 'solr.home' system property in 1212ms
ok 69 zkcli.sh gets 'solrhome' from 'solrhome' command line option in 1206ms

> Task :solr:packaging:integrationTests FAILED

> Task :solr:core:test

org.apache.solr.pkg.TestPackages > testCoreReloadingPlugin FAILED
    java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([CF63900ABB0C336E]:0)

org.apache.solr.pkg.TestPackages > classMethod FAILED
    java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([CF63900ABB0C336E]:0)

org.apache.solr.pkg.TestPackages > test suite's output saved to 
/tmp/src/solr/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.pkg.TestPackages.txt,
 copied below:
  2> 77846 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/tmp/src/solr/solr/server/solr/configsets/_default/conf'
  2> 77846 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
  2> 77848 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.u.ErrorLogMuter Closing ErrorLogMuter-regex-12 after mutting 0 log 
messages
  2> 77848 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.u.ErrorLogMuter Creating ErrorLogMuter-regex-13 for ERROR logs matching 
regex: ignore_exception
  2> 77849 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/data-dir-6-001
  2> 77849 WARN  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=22 numCloses=22
  2> 77849 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
  2> 77850 INFO  (SUITE-TestPackages-seed#[CF63900ABB0C336E]-worker) [] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0)
  2> 77856 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.SolrTestCaseJ4 ###Starting testSchemaPlugins
  2> 77857 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.u.t.SimplePropagator Always-on trace id generation enabled.
  2> 77857 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001
  2> 77858 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
  2> 77858 INFO  (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer client port: 
0.0.0.0/0.0.0.0:0
  2> 77858 INFO  (ZkTestServer Run Thread) [] o.a.s.c.ZkTestServer Starting 
server
  2> 77860 WARN  (ZkTestServer Run Thread) [] o.a.z.s.ServerCnxnFactory 
maxCnxns is not configured, using default value 0.
  2> 77958 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.ZkTestServer start zk server on port: 36017
  2> 77960 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. 
ZkCredentialsInjector is not secure, it creates an empty list of credentials 
which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 77961 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to 
ZooKeeper
  2> 77965 INFO  (zkConnectionManagerCallback-683-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 77965 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 77965 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is 
not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 77968 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. 
ZkCredentialsInjector is not secure, it creates an empty list of credentials 
which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 77969 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Waiting up to 30000ms for client to connect to 
ZooKeeper
  2> 77972 INFO  (zkConnectionManagerCallback-685-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 77972 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 77972 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is 
not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 77972 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. 
ZkCredentialsInjector is not secure, it creates an empty list of credentials 
which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 77973 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to 
ZooKeeper
  2> 77978 INFO  (zkConnectionManagerCallback-687-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 77978 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 77978 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is 
not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78091 INFO  (jetty-launcher-688-thread-3) [] o.a.s.e.JettySolrRunner Start 
Jetty (configured port=0, binding port=0)
  2> 78091 INFO  (jetty-launcher-688-thread-3) [] o.a.s.e.JettySolrRunner 
Trying to start Jetty on port 0 try number 2 ...
  2> 78092 INFO  (jetty-launcher-688-thread-3) [] o.e.j.s.Server jetty-10.0.16; 
built: 2023-08-25T19:11:25.422Z; git: a2735a9ae9d1afc124974253f1e223e5678be1f4; 
jvm 11.0.16+8
  2> 78092 INFO  (jetty-launcher-688-thread-2) [] o.a.s.e.JettySolrRunner Start 
Jetty (configured port=0, binding port=0)
  2> 78092 INFO  (jetty-launcher-688-thread-2) [] o.a.s.e.JettySolrRunner 
Trying to start Jetty on port 0 try number 2 ...
  2> 78092 INFO  (jetty-launcher-688-thread-2) [] o.e.j.s.Server jetty-10.0.16; 
built: 2023-08-25T19:11:25.422Z; git: a2735a9ae9d1afc124974253f1e223e5678be1f4; 
jvm 11.0.16+8
  2> 78092 INFO  (jetty-launcher-688-thread-4) [] o.a.s.e.JettySolrRunner Start 
Jetty (configured port=0, binding port=0)
  2> 78092 INFO  (jetty-launcher-688-thread-4) [] o.a.s.e.JettySolrRunner 
Trying to start Jetty on port 0 try number 2 ...
  2> 78092 INFO  (jetty-launcher-688-thread-1) [] o.a.s.e.JettySolrRunner Start 
Jetty (configured port=0, binding port=0)
  2> 78092 INFO  (jetty-launcher-688-thread-1) [] o.a.s.e.JettySolrRunner 
Trying to start Jetty on port 0 try number 2 ...
  2> 78093 INFO  (jetty-launcher-688-thread-4) [] o.e.j.s.Server jetty-10.0.16; 
built: 2023-08-25T19:11:25.422Z; git: a2735a9ae9d1afc124974253f1e223e5678be1f4; 
jvm 11.0.16+8
  2> 78093 INFO  (jetty-launcher-688-thread-1) [] o.e.j.s.Server jetty-10.0.16; 
built: 2023-08-25T19:11:25.422Z; git: a2735a9ae9d1afc124974253f1e223e5678be1f4; 
jvm 11.0.16+8
  2> 78098 INFO  (jetty-launcher-688-thread-3) [] 
o.e.j.s.s.DefaultSessionIdManager Session workerName=node0
  2> 78098 INFO  (jetty-launcher-688-thread-4) [] 
o.e.j.s.s.DefaultSessionIdManager Session workerName=node0
  2> 78099 INFO  (jetty-launcher-688-thread-3) [] o.e.j.s.h.ContextHandler 
Started 
o.e.j.s.ServletContextHandler@2108d9b2{/solr,file:///tmp/src/solr/solr/core/build/tmp/tests-cwd/,AVAILABLE}
  2> 78099 INFO  (jetty-launcher-688-thread-1) [] 
o.e.j.s.s.DefaultSessionIdManager Session workerName=node0
  2> 78099 INFO  (jetty-launcher-688-thread-2) [] 
o.e.j.s.s.DefaultSessionIdManager Session workerName=node0
  2> 78099 INFO  (jetty-launcher-688-thread-4) [] o.e.j.s.h.ContextHandler 
Started 
o.e.j.s.ServletContextHandler@54c9dcf{/solr,file:///tmp/src/solr/solr/core/build/tmp/tests-cwd/,AVAILABLE}
  2> 78100 INFO  (jetty-launcher-688-thread-1) [] o.e.j.s.h.ContextHandler 
Started 
o.e.j.s.ServletContextHandler@298a6e8b{/solr,file:///tmp/src/solr/solr/core/build/tmp/tests-cwd/,AVAILABLE}
  2> 78100 INFO  (jetty-launcher-688-thread-2) [] o.e.j.s.h.ContextHandler 
Started 
o.e.j.s.ServletContextHandler@75c913d9{/solr,file:///tmp/src/solr/solr/core/build/tmp/tests-cwd/,AVAILABLE}
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.e.j.s.AbstractConnector 
Started ServerConnector@5e284c0{ssl, (ssl, alpn, http/1.1, h2)}{127.0.0.1:38809}
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.e.j.s.Server Started 
Server@1e4c0da3{STARTING}[10.0.16,sto=0] @78119ms
  2> 78101 ERROR (jetty-launcher-688-thread-3) [] o.a.s.u.StartupLoggingUtils 
Missing Java Option solr.log.dir. Logging may be missing or incomplete.
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.a.s.s.CoreContainerProvider 
Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.a.s.s.CoreContainerProvider 
 ___      _       Welcome to Apache Solr™ version 9.4.0
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.a.s.s.CoreContainerProvider 
/ __| ___| |_ _   Starting in cloud mode on port null
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.a.s.s.CoreContainerProvider 
\__ \/ _ \ | '_|  Install dir: /tmp/src/solr/solr
  2> 78101 INFO  (jetty-launcher-688-thread-3) [] o.a.s.s.CoreContainerProvider 
|___/\___/_|_|    Start time: 2023-09-11T01:16:47.311889Z
  2> 78102 INFO  (jetty-launcher-688-thread-1) [] o.e.j.s.AbstractConnector 
Started ServerConnector@645c56a2{ssl, (ssl, alpn, http/1.1, 
h2)}{127.0.0.1:33603}
  2> 78102 INFO  (jetty-launcher-688-thread-3) [] o.a.s.s.CoreContainerProvider 
Solr Home: 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node3
 (source: servlet config: solr.solr.home)
  2> 78102 WARN  (jetty-launcher-688-thread-3) [] o.a.s.c.c.SolrZkClient Using 
default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates 
an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper 
nodes
  2> 78102 INFO  (jetty-launcher-688-thread-4) [] o.e.j.s.AbstractConnector 
Started ServerConnector@33b27232{ssl, (ssl, alpn, http/1.1, 
h2)}{127.0.0.1:46371}
  2> 78102 INFO  (jetty-launcher-688-thread-1) [] o.e.j.s.Server Started 
Server@51ad39ba{STARTING}[10.0.16,sto=0] @78121ms
  2> 78102 INFO  (jetty-launcher-688-thread-2) [] o.e.j.s.AbstractConnector 
Started ServerConnector@29eb5e6a{ssl, (ssl, alpn, http/1.1, 
h2)}{127.0.0.1:37385}
  2> 78102 ERROR (jetty-launcher-688-thread-1) [] o.a.s.u.StartupLoggingUtils 
Missing Java Option solr.log.dir. Logging may be missing or incomplete.
  2> 78103 INFO  (jetty-launcher-688-thread-1) [] o.a.s.s.CoreContainerProvider 
Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.e.j.s.Server Started 
Server@54065e08{STARTING}[10.0.16,sto=0] @78121ms
  2> 78103 INFO  (jetty-launcher-688-thread-1) [] o.a.s.s.CoreContainerProvider 
 ___      _       Welcome to Apache Solr™ version 9.4.0
  2> 78103 INFO  (jetty-launcher-688-thread-1) [] o.a.s.s.CoreContainerProvider 
/ __| ___| |_ _   Starting in cloud mode on port null
  2> 78103 INFO  (jetty-launcher-688-thread-1) [] o.a.s.s.CoreContainerProvider 
\__ \/ _ \ | '_|  Install dir: /tmp/src/solr/solr
  2> 78103 INFO  (jetty-launcher-688-thread-1) [] o.a.s.s.CoreContainerProvider 
|___/\___/_|_|    Start time: 2023-09-11T01:16:47.313212Z
  2> 78103 ERROR (jetty-launcher-688-thread-2) [] o.a.s.u.StartupLoggingUtils 
Missing Java Option solr.log.dir. Logging may be missing or incomplete.
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.a.s.s.CoreContainerProvider 
Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.a.s.s.CoreContainerProvider 
 ___      _       Welcome to Apache Solr™ version 9.4.0
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.a.s.s.CoreContainerProvider 
/ __| ___| |_ _   Starting in cloud mode on port null
  2> 78103 INFO  (jetty-launcher-688-thread-1) [] o.a.s.s.CoreContainerProvider 
Solr Home: 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node1
 (source: servlet config: solr.solr.home)
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.a.s.s.CoreContainerProvider 
\__ \/ _ \ | '_|  Install dir: /tmp/src/solr/solr
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.a.s.s.CoreContainerProvider 
|___/\___/_|_|    Start time: 2023-09-11T01:16:47.313595Z
  2> 78103 WARN  (jetty-launcher-688-thread-1) [] o.a.s.c.c.SolrZkClient Using 
default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates 
an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper 
nodes
  2> 78103 INFO  (jetty-launcher-688-thread-2) [] o.a.s.s.CoreContainerProvider 
Solr Home: 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node2
 (source: servlet config: solr.solr.home)
  2> 78103 INFO  (jetty-launcher-688-thread-3) [] o.a.s.c.c.ConnectionManager 
Waiting up to 30000ms for client to connect to ZooKeeper
  2> 78104 WARN  (jetty-launcher-688-thread-2) [] o.a.s.c.c.SolrZkClient Using 
default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates 
an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper 
nodes
  2> 78105 INFO  (jetty-launcher-688-thread-4) [] o.e.j.s.Server Started 
Server@2e89eed7{STARTING}[10.0.16,sto=0] @78123ms
  2> 78105 ERROR (jetty-launcher-688-thread-4) [] o.a.s.u.StartupLoggingUtils 
Missing Java Option solr.log.dir. Logging may be missing or incomplete.
  2> 78105 INFO  (jetty-launcher-688-thread-4) [] o.a.s.s.CoreContainerProvider 
Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
  2> 78105 INFO  (jetty-launcher-688-thread-4) [] o.a.s.s.CoreContainerProvider 
 ___      _       Welcome to Apache Solr™ version 9.4.0
  2> 78105 INFO  (jetty-launcher-688-thread-4) [] o.a.s.s.CoreContainerProvider 
/ __| ___| |_ _   Starting in cloud mode on port null
  2> 78105 INFO  (jetty-launcher-688-thread-4) [] o.a.s.s.CoreContainerProvider 
\__ \/ _ \ | '_|  Install dir: /tmp/src/solr/solr
  2> 78105 INFO  (jetty-launcher-688-thread-4) [] o.a.s.s.CoreContainerProvider 
|___/\___/_|_|    Start time: 2023-09-11T01:16:47.315847Z
  2> 78105 INFO  (jetty-launcher-688-thread-1) [] o.a.s.c.c.ConnectionManager 
Waiting up to 30000ms for client to connect to ZooKeeper
  2> 78106 INFO  (jetty-launcher-688-thread-4) [] o.a.s.s.CoreContainerProvider 
Solr Home: 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node4
 (source: servlet config: solr.solr.home)
  2> 78107 WARN  (jetty-launcher-688-thread-4) [] o.a.s.c.c.SolrZkClient Using 
default ZkCredentialsInjector. ZkCredentialsInjector is not secure, it creates 
an empty list of credentials which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper 
nodes
  2> 78107 INFO  (jetty-launcher-688-thread-2) [] o.a.s.c.c.ConnectionManager 
Waiting up to 30000ms for client to connect to ZooKeeper
  2> 78108 INFO  (zkConnectionManagerCallback-690-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78108 INFO  (jetty-launcher-688-thread-3) [] o.a.s.c.c.ConnectionManager 
Client is connected to ZooKeeper
  2> 78108 WARN  (jetty-launcher-688-thread-3) [] o.a.s.c.c.SolrZkClient Using 
default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 
'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78109 INFO  (jetty-launcher-688-thread-4) [] o.a.s.c.c.ConnectionManager 
Waiting up to 30000ms for client to connect to ZooKeeper
  2> 78109 INFO  (jetty-launcher-688-thread-3) [] o.a.s.c.NodeConfig solr.xml 
found in ZooKeeper. Loading...
  2> 78109 INFO  (zkConnectionManagerCallback-694-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78110 INFO  (jetty-launcher-688-thread-2) [] o.a.s.c.c.ConnectionManager 
Client is connected to ZooKeeper
  2> 78110 INFO  (zkConnectionManagerCallback-692-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78110 WARN  (jetty-launcher-688-thread-2) [] o.a.s.c.c.SolrZkClient Using 
default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 
'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78110 INFO  (jetty-launcher-688-thread-1) [] o.a.s.c.c.ConnectionManager 
Client is connected to ZooKeeper
  2> 78111 WARN  (jetty-launcher-688-thread-1) [] o.a.s.c.c.SolrZkClient Using 
default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 
'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78111 INFO  (jetty-launcher-688-thread-2) [] o.a.s.c.NodeConfig solr.xml 
found in ZooKeeper. Loading...
  2> 78112 INFO  (jetty-launcher-688-thread-1) [] o.a.s.c.NodeConfig solr.xml 
found in ZooKeeper. Loading...
  2> 78112 INFO  (zkConnectionManagerCallback-696-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78113 INFO  (jetty-launcher-688-thread-4) [] o.a.s.c.c.ConnectionManager 
Client is connected to ZooKeeper
  2> 78113 WARN  (jetty-launcher-688-thread-4) [] o.a.s.c.c.SolrZkClient Using 
default ZkACLProvider. DefaultZkACLProvider is not secure, it creates 
'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78114 INFO  (jetty-launcher-688-thread-4) [] o.a.s.c.NodeConfig solr.xml 
found in ZooKeeper. Loading...
  2> 78114 INFO  (jetty-launcher-688-thread-3) [] o.a.s.c.SolrXmlConfig Metrics 
collection is disabled.
  2> 78115 INFO  (jetty-launcher-688-thread-2) [] o.a.s.c.SolrXmlConfig Metrics 
collection is disabled.
  2> 78116 INFO  (jetty-launcher-688-thread-4) [] o.a.s.c.SolrXmlConfig Metrics 
collection is disabled.
  2> 78116 INFO  (jetty-launcher-688-thread-1) [] o.a.s.c.SolrXmlConfig Metrics 
collection is disabled.
  2> 78223 WARN  (jetty-launcher-688-thread-2) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@48152f31[provider=null,keyStore=null,trustStore=null]
  2> 78224 WARN  (jetty-launcher-688-thread-4) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@3ba73899[provider=null,keyStore=null,trustStore=null]
  2> 78224 WARN  (jetty-launcher-688-thread-2) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@48152f31[provider=null,keyStore=null,trustStore=null]
  2> 78224 WARN  (jetty-launcher-688-thread-4) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@3ba73899[provider=null,keyStore=null,trustStore=null]
  2> 78224 WARN  (jetty-launcher-688-thread-3) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@3d678ae7[provider=null,keyStore=null,trustStore=null]
  2> 78225 WARN  (jetty-launcher-688-thread-3) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@3d678ae7[provider=null,keyStore=null,trustStore=null]
  2> 78225 WARN  (jetty-launcher-688-thread-1) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@20f1ea4b[provider=null,keyStore=null,trustStore=null]
  2> 78225 WARN  (jetty-launcher-688-thread-1) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@20f1ea4b[provider=null,keyStore=null,trustStore=null]
  2> 78229 WARN  (jetty-launcher-688-thread-2) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@cdb4e8a[provider=null,keyStore=null,trustStore=null]
  2> 78229 WARN  (jetty-launcher-688-thread-2) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@cdb4e8a[provider=null,keyStore=null,trustStore=null]
  2> 78230 WARN  (jetty-launcher-688-thread-4) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@45af559[provider=null,keyStore=null,trustStore=null]
  2> 78230 WARN  (jetty-launcher-688-thread-4) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@45af559[provider=null,keyStore=null,trustStore=null]
  2> 78231 WARN  (jetty-launcher-688-thread-3) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@5f581972[provider=null,keyStore=null,trustStore=null]
  2> 78231 WARN  (jetty-launcher-688-thread-3) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@5f581972[provider=null,keyStore=null,trustStore=null]
  2> 78231 WARN  (jetty-launcher-688-thread-1) [] o.e.j.u.s.S.config Trusting 
all certificates configured for 
Client@583a4e4c[provider=null,keyStore=null,trustStore=null]
  2> 78231 INFO  (jetty-launcher-688-thread-2) [] o.a.s.c.ZkContainer Zookeeper 
client=127.0.0.1:36017/solr
  2> 78231 WARN  (jetty-launcher-688-thread-1) [] o.e.j.u.s.S.config No Client 
EndPointIdentificationAlgorithm configured for 
Client@583a4e4c[provider=null,keyStore=null,trustStore=null]
  2> 78231 INFO  (jetty-launcher-688-thread-2) [] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78231 INFO  (jetty-launcher-688-thread-4) [] o.a.s.c.ZkContainer Zookeeper 
client=127.0.0.1:36017/solr
  2> 78232 INFO  (jetty-launcher-688-thread-4) [] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78232 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to 
ZooKeeper
  2> 78235 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to 
ZooKeeper
  2> 78237 INFO  (jetty-launcher-688-thread-3) [] o.a.s.c.ZkContainer Zookeeper 
client=127.0.0.1:36017/solr
  2> 78237 INFO  (jetty-launcher-688-thread-3) [] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78238 INFO  (jetty-launcher-688-thread-1) [] o.a.s.c.ZkContainer Zookeeper 
client=127.0.0.1:36017/solr
  2> 78238 INFO  (jetty-launcher-688-thread-1) [] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78239 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to 
ZooKeeper
  2> 78239 INFO  (zkConnectionManagerCallback-730-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78239 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78240 INFO  (zkConnectionManagerCallback-727-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78240 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78242 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to 
ZooKeeper
  2> 78244 INFO  (zkConnectionManagerCallback-734-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78244 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78244 INFO  (zkConnectionManagerCallback-736-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78244 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78283 WARN  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; 
consider setting up ACLs as described in 
https://solr.apache.org/guide/solr/latest/deployment-guide/zookeeper-access-control.html
  2> 78283 WARN  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; 
consider setting up ACLs as described in 
https://solr.apache.org/guide/solr/latest/deployment-guide/zookeeper-access-control.html
  2> 78283 WARN  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; 
consider setting up ACLs as described in 
https://solr.apache.org/guide/solr/latest/deployment-guide/zookeeper-access-control.html
  2> 78284 WARN  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; 
consider setting up ACLs as described in 
https://solr.apache.org/guide/solr/latest/deployment-guide/zookeeper-access-control.html
  2> 78289 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78289 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78289 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78289 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78296 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38809_solr
  2> 78297 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46371_solr
  2> 78297 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37385_solr
  2> 78297 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.Overseer Overseer 
(id=72057619334496265-127.0.0.1:38809_solr-n_0000000000) starting
  2> 78297 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33603_solr
  2> 78302 INFO  (zkCallback-726-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (0) -> (3)
  2> 78302 INFO  (zkCallback-729-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (0) -> (3)
  2> 78302 INFO  (zkCallback-735-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (0) -> (3)
  2> 78302 INFO  (zkCallback-733-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (0) -> (3)
  2> 78306 WARN  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
  2> 78306 WARN  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
  2> 78306 WARN  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
  2> 78311 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.ZkController Publish node=127.0.0.1:38809_solr as DOWN
  2> 78311 INFO  
(OverseerStateUpdate-72057619334496265-127.0.0.1:38809_solr-n_0000000000) 
[n:127.0.0.1:38809_solr] o.a.s.c.Overseer Starting to work on the main queue : 
127.0.0.1:38809_solr
  2> 78312 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38809_solr
  2> 78313 INFO  
(OverseerStateUpdate-72057619334496265-127.0.0.1:38809_solr-n_0000000000) 
[n:127.0.0.1:38809_solr] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
  2> 78315 INFO  (zkCallback-735-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (3) -> (4)
  2> 78315 INFO  (zkCallback-726-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (3) -> (4)
  2> 78315 INFO  (zkCallback-729-thread-1) [] o.a.s.c.c.ZkStateReader Updated 
live nodes from ZooKeeper... (3) -> (4)
  2> 78319 WARN  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.CoreContainer Not all security plugins configured!  
authentication=disabled authorization=disabled.  Solr is only as secure as you 
make it. Consider configuring authentication/authorization before exposing Solr 
to users internal or external.  See https://s.apache.org/solrsecurity for more 
info
  2> 78361 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Creating 
DistributedCollectionConfigSetCommandRunner. Collection and ConfigSet APIs are 
running distributed (not Overseer based)
  2> 78361 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78410 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Creating 
DistributedCollectionConfigSetCommandRunner. Collection and ConfigSet APIs are 
running distributed (not Overseer based)
  2> 78410 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78439 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Creating 
DistributedCollectionConfigSetCommandRunner. Collection and ConfigSet APIs are 
running distributed (not Overseer based)
  2> 78442 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78443 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node1
  2> 78448 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Creating 
DistributedCollectionConfigSetCommandRunner. Collection and ConfigSet APIs are 
running distributed (not Overseer based)
  2> 78448 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.DistributedClusterStateUpdater Creating DistributedClusterStateUpdater 
with useDistributedStateUpdate=true. Solr will be using distributed cluster 
state updates.
  2> 78468 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node4
  2> 78472 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node2
  2> 78486 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node3
  2> 78490 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 78511 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 78516 INFO  (jetty-launcher-688-thread-1) [n:127.0.0.1:33603_solr] 
o.a.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=33603, 
zkHost=127.0.0.1:36017/solr}
  2> 78523 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 78537 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 78538 INFO  (jetty-launcher-688-thread-4) [n:127.0.0.1:46371_solr] 
o.a.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46371, 
zkHost=127.0.0.1:36017/solr}
  2> 78553 INFO  (jetty-launcher-688-thread-2) [n:127.0.0.1:37385_solr] 
o.a.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=37385, 
zkHost=127.0.0.1:36017/solr}
  2> 78565 INFO  (jetty-launcher-688-thread-3) [n:127.0.0.1:38809_solr] 
o.a.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38809, 
zkHost=127.0.0.1:36017/solr}
  2> 78569 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
  2> 78569 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.MiniSolrCloudCluster waitForNode: 127.0.0.1:33603_solr
  2> 78570 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. 
ZkCredentialsInjector is not secure, it creates an empty list of credentials 
which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78572 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Waiting up to 15000ms for client to connect to 
ZooKeeper
  2> 78575 INFO  (zkConnectionManagerCallback-775-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78575 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78575 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is 
not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78577 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
  2> 78579 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36017/solr 
ready
  2> 78579 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.MiniSolrCloudCluster waitForNode: 127.0.0.1:46371_solr
  2> 78579 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.MiniSolrCloudCluster waitForNode: 127.0.0.1:37385_solr
  2> 78579 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.MiniSolrCloudCluster waitForNode: 127.0.0.1:38809_solr
  2> 78579 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. 
ZkCredentialsInjector is not secure, it creates an empty list of credentials 
which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78582 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Waiting up to 45000ms for client to connect to 
ZooKeeper
  2> 78585 INFO  (zkConnectionManagerCallback-777-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78585 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78585 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is 
not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78691 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkCredentialsInjector. 
ZkCredentialsInjector is not secure, it creates an empty list of credentials 
which leads to 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78693 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Waiting up to 45000ms for client to connect to 
ZooKeeper
  2> 78696 INFO  (zkConnectionManagerCallback-779-thread-1) [] 
o.a.s.c.c.ConnectionManager zkClient has connected
  2> 78696 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
  2> 78696 WARN  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.c.c.SolrZkClient Using default ZkACLProvider. DefaultZkACLProvider is 
not secure, it creates 'OPEN_ACL_UNSAFE' ACLs to Zookeeper nodes
  2> 78813 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.f.DistribPackageStore Created filestore folder 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node2/filestore
  2> 78934 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr t:null-1095] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 78935 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1095) [n:127.0.0.1:38809_solr t:null-1095] o.a.s.f.DistribPackageStore 
Created filestore folder 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node3/filestore
  2> 78935 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1095) [n:127.0.0.1:38809_solr t:null-1095] o.a.s.f.DistribPackageStore 
fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:37385_solr 
  2> 78955 INFO  (qtp1084016355-1078) [n:127.0.0.1:37385_solr t:null-1096] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=0
  2> 78959 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1097] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
  2> 78967 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1095) [n:127.0.0.1:38809_solr t:null-1095] o.a.s.f.DistribPackageStore 
persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 144
  2> 78967 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1095) [n:127.0.0.1:38809_solr t:null-1095] o.a.s.f.PackageStoreAPI 
downloaded file: /_trusted_/keys/pub_key512.der
  2> 78975 INFO  (qtp2066054861-1093) [n:127.0.0.1:33603_solr t:null-1098] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 78976 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1098) [n:127.0.0.1:33603_solr t:null-1098] o.a.s.f.DistribPackageStore 
Created filestore folder 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node1/filestore
  2> 78976 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1098) [n:127.0.0.1:33603_solr t:null-1098] o.a.s.f.DistribPackageStore 
fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:37385_solr 
  2> 78997 INFO  (qtp1084016355-1082) [n:127.0.0.1:37385_solr t:null-1099] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=0
  2> 78999 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1100] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
  2> 79007 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1098) [n:127.0.0.1:33603_solr t:null-1098] o.a.s.f.DistribPackageStore 
persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 144
  2> 79007 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1098) [n:127.0.0.1:33603_solr t:null-1098] o.a.s.f.PackageStoreAPI 
downloaded file: /_trusted_/keys/pub_key512.der
  2> 79021 INFO  (qtp71276034-1090) [n:127.0.0.1:46371_solr t:null-1101] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79021 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1101) [n:127.0.0.1:46371_solr t:null-1101] o.a.s.f.DistribPackageStore 
Created filestore folder 
/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node4/filestore
  2> 79021 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1101) [n:127.0.0.1:46371_solr t:null-1101] o.a.s.f.DistribPackageStore 
fetching a file /_trusted_/keys/pub_key512.der from 127.0.0.1:37385_solr 
  2> 79022 INFO  (qtp1084016355-1094) [n:127.0.0.1:37385_solr t:null-1094] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={sync=true} status=0 
QTime=140
  2> 79023 INFO  (TEST-TestPackages.testSchemaPlugins-seed#[CF63900ABB0C336E]) 
[] o.a.s.f.TestDistribPackageStore sync resp: 
https://127.0.0.1:37385/api/node/files/_trusted_/keys/pub_key512.der?sync=true 
was null
  2> 79047 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1102] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/.pub_key512.der.json params={} status=0 QTime=1
  2> 79050 INFO  (qtp2066054861-1087) [n:127.0.0.1:33603_solr t:null-1103] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} 
status=0 QTime=2
  2> 79050 INFO  (qtp1084016355-1094) [n:127.0.0.1:37385_solr t:null-1104] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={} status=0 QTime=0
  2> 79061 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1101) [n:127.0.0.1:46371_solr t:null-1101] o.a.s.f.DistribPackageStore 
persisted a file /_trusted_/keys/pub_key512.der and metadata. sizes 94 144
  2> 79061 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1101) [n:127.0.0.1:46371_solr t:null-1101] o.a.s.f.PackageStoreAPI 
downloaded file: /_trusted_/keys/pub_key512.der
  2> 79071 INFO  (qtp71276034-1084) [n:127.0.0.1:46371_solr t:null-1105] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79092 INFO  (qtp1084016355-1082) [n:127.0.0.1:37385_solr t:null-1106] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} 
status=0 QTime=0
  2> 79111 INFO  (qtp1927894020-1072) [n:127.0.0.1:38809_solr t:null-1107] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/_trusted_/keys/pub_key512.der params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79140 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1108] 
o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, 
downloading.. 
  2> 79144 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1108] 
o.a.s.f.DistribPackageStore Missing file in package store: 
/schemapkg/schema-plugins.jar
  2> 79149 INFO  (qtp71276034-1096) [n:127.0.0.1:46371_solr t:null-1109] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar 
params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
  2> 79152 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1110] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar 
params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
  2> 79156 INFO  (qtp2066054861-1098) [n:127.0.0.1:33603_solr t:null-1111] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar 
params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
  2> 79156 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1108] 
o.a.s.f.DistribPackageStore Unable to download file : 
/schemapkg/schema-plugins.jar
  2> 79165 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1108] 
o.a.s.f.DistribPackageStore persisted a file /schemapkg/schema-plugins.jar and 
metadata. sizes 1461 246
  2> 79171 INFO  (qtp1927894020-1070) [n:127.0.0.1:38809_solr t:null-1112] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79171 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1112) [n:127.0.0.1:38809_solr t:null-1112] o.a.s.f.DistribPackageStore 
fetching a file /schemapkg/schema-plugins.jar from 127.0.0.1:37385_solr 
  2> 79173 INFO  (qtp1084016355-1094) [n:127.0.0.1:37385_solr t:null-1113] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/.schema-plugins.jar.json params={} status=0 QTime=0
  2> 79173 INFO  (qtp71276034-1079) [n:127.0.0.1:46371_solr t:null-1114] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79173 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1114) [n:127.0.0.1:46371_solr t:null-1114] o.a.s.f.DistribPackageStore 
fetching a file /schemapkg/schema-plugins.jar from 127.0.0.1:37385_solr 
  2> 79175 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1115] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/.schema-plugins.jar.json params={} status=0 QTime=0
  2> 79175 INFO  (qtp2066054861-1083) [n:127.0.0.1:33603_solr t:null-1116] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79175 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr t:null-1117] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={} status=0 QTime=0
  2> 79176 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1116) [n:127.0.0.1:33603_solr t:null-1116] o.a.s.f.DistribPackageStore 
fetching a file /schemapkg/schema-plugins.jar from 127.0.0.1:37385_solr 
  2> 79177 INFO  (qtp1084016355-1078) [n:127.0.0.1:37385_solr t:null-1118] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/.schema-plugins.jar.json params={} status=0 QTime=0
  2> 79177 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1108] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/cluster/files/schemapkg/schema-plugins.jar 
params={sig=U%2BAdO/jgY3DtMpeFRGoTQk72iA5g/qjPvdQYPGBaXB5%2BggcTZk4FoIWiueB0bwGJ8Mg3V/elxOqEbD2JR8R0tA%3D%3D&wt=javabin&version=2}
 status=0 QTime=40
  2> 79177 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr t:null-1119] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={} status=0 QTime=0
  2> 79179 INFO  (qtp1084016355-1094) [n:127.0.0.1:37385_solr t:null-1120] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={} status=0 QTime=0
  2> 79185 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1112) [n:127.0.0.1:38809_solr t:null-1112] o.a.s.f.DistribPackageStore 
persisted a file /schemapkg/schema-plugins.jar and metadata. sizes 1461 246
  2> 79185 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1112) [n:127.0.0.1:38809_solr t:null-1112] o.a.s.f.PackageStoreAPI 
downloaded file: /schemapkg/schema-plugins.jar
  2> 79187 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1114) [n:127.0.0.1:46371_solr t:null-1114] o.a.s.f.DistribPackageStore 
persisted a file /schemapkg/schema-plugins.jar and metadata. sizes 1461 246
  2> 79187 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1114) [n:127.0.0.1:46371_solr t:null-1114] o.a.s.f.PackageStoreAPI 
downloaded file: /schemapkg/schema-plugins.jar
  2> 79189 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1116) [n:127.0.0.1:33603_solr t:null-1116] o.a.s.f.DistribPackageStore 
persisted a file /schemapkg/schema-plugins.jar and metadata. sizes 1461 246
  2> 79189 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1116) [n:127.0.0.1:33603_solr t:null-1116] o.a.s.f.PackageStoreAPI 
downloaded file: /schemapkg/schema-plugins.jar
  2> 79199 INFO  (qtp2066054861-1095) [n:127.0.0.1:33603_solr t:null-1121] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79221 INFO  (qtp71276034-1090) [n:127.0.0.1:46371_solr t:null-1122] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79310 INFO  (qtp1084016355-1078) [n:127.0.0.1:37385_solr t:null-1123] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79331 INFO  (qtp1927894020-1085) [n:127.0.0.1:38809_solr t:null-1124] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/schema-plugins.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79339 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1125] 
o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, 
downloading.. 
  2> 79342 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1125] 
o.a.s.f.DistribPackageStore Missing file in package store: 
/schemapkg/payload-component.jar
  2> 79344 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr t:null-1126] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar 
params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
  2> 79347 INFO  (qtp71276034-1086) [n:127.0.0.1:46371_solr t:null-1127] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar 
params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
  2> 79350 INFO  (qtp1927894020-1075) [n:127.0.0.1:38809_solr t:null-1128] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar 
params={omitHeader=true&meta=true&wt=javabin} status=0 QTime=0
  2> 79350 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1125] 
o.a.s.f.DistribPackageStore Unable to download file : 
/schemapkg/payload-component.jar
  2> 79360 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1125] 
o.a.s.f.DistribPackageStore persisted a file /schemapkg/payload-component.jar 
and metadata. sizes 17815 246
  2> 79366 INFO  (qtp71276034-1084) [n:127.0.0.1:46371_solr t:null-1129] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79366 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1129) [n:127.0.0.1:46371_solr t:null-1129] o.a.s.f.DistribPackageStore 
fetching a file /schemapkg/payload-component.jar from 127.0.0.1:37385_solr 
  2> 79367 INFO  (qtp1927894020-1072) [n:127.0.0.1:38809_solr t:null-1130] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79367 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1130) [n:127.0.0.1:38809_solr t:null-1130] o.a.s.f.DistribPackageStore 
fetching a file /schemapkg/payload-component.jar from 127.0.0.1:37385_solr 
  2> 79367 INFO  (qtp1084016355-1082) [n:127.0.0.1:37385_solr t:null-1131] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/.payload-component.jar.json params={} status=0 
QTime=0
  2> 79368 INFO  (qtp2066054861-1087) [n:127.0.0.1:33603_solr t:null-1132] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar 
params={getFrom=127.0.0.1:37385_solr} status=0 QTime=0
  2> 79369 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1132) [n:127.0.0.1:33603_solr t:null-1132] o.a.s.f.DistribPackageStore 
fetching a file /schemapkg/payload-component.jar from 127.0.0.1:37385_solr 
  2> 79369 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1133] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/.payload-component.jar.json params={} status=0 
QTime=0
  2> 79369 INFO  (qtp1084016355-1078) [n:127.0.0.1:37385_solr t:null-1134] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={} status=0 QTime=0
  2> 79370 INFO  (qtp1084016355-1094) [n:127.0.0.1:37385_solr t:null-1135] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/.payload-component.jar.json params={} status=0 
QTime=0
  2> 79370 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1125] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/cluster/files/schemapkg/payload-component.jar 
params={sig=gI6vYUDmSXSXmpNEeK1cwqrp4qTeVQgizGQkd8A4Prx2K8k7c5QlXbcs4lxFAAbbdXz9F4esBqTCiLMjVDHJ5Q%3D%3D&wt=javabin&version=2}
 status=0 QTime=35
  2> 79371 INFO  (qtp1084016355-1088) [n:127.0.0.1:37385_solr t:null-1136] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={} status=0 QTime=0
  2> 79372 INFO  (qtp1084016355-1082) [n:127.0.0.1:37385_solr t:null-1137] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={} status=0 QTime=0
  2> 79385 INFO  (qtp2066054861-1083) [n:127.0.0.1:33603_solr t:null-1138] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79386 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1132) [n:127.0.0.1:33603_solr t:null-1132] o.a.s.f.DistribPackageStore 
persisted a file /schemapkg/payload-component.jar and metadata. sizes 17815 246
  2> 79386 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1129) [n:127.0.0.1:46371_solr t:null-1129] o.a.s.f.DistribPackageStore 
persisted a file /schemapkg/payload-component.jar and metadata. sizes 17815 246
  2> 79386 INFO  (updateExecutor-720-thread-1-processing-127.0.0.1:33603_solr 
null-1132) [n:127.0.0.1:33603_solr t:null-1132] o.a.s.f.PackageStoreAPI 
downloaded file: /schemapkg/payload-component.jar
  2> 79386 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1130) [n:127.0.0.1:38809_solr t:null-1130] o.a.s.f.DistribPackageStore 
persisted a file /schemapkg/payload-component.jar and metadata. sizes 17815 246
  2> 79386 INFO  (updateExecutor-718-thread-1-processing-127.0.0.1:46371_solr 
null-1129) [n:127.0.0.1:46371_solr t:null-1129] o.a.s.f.PackageStoreAPI 
downloaded file: /schemapkg/payload-component.jar
  2> 79386 INFO  (updateExecutor-719-thread-1-processing-127.0.0.1:38809_solr 
null-1130) [n:127.0.0.1:38809_solr t:null-1130] o.a.s.f.PackageStoreAPI 
downloaded file: /schemapkg/payload-component.jar
  2> 79402 INFO  (qtp71276034-1096) [n:127.0.0.1:46371_solr t:null-1139] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79417 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr t:null-1140] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={meta=true&wt=javabin} 
status=0 QTime=0
  2> 79434 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1141] 
o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/node/files/schemapkg/payload-component.jar params={meta=true&wt=javabin} 
status=0 QTime=1
  2> 79466 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1142] 
o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, 
downloading.. 
  2> 79468 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1142] 
o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, 
downloading.. 
  2> 79473 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1142] 
o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, 
downloading.. 
  2> 79475 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1142] 
o.a.s.f.DistribPackageStore pub_key512.der does not exist locally, 
downloading.. 
  2> 79481 DEBUG (zkCallback-735-thread-1) [] o.a.s.p.PackageAPI Updating 
[/packages.json] ... 
  2> 79481 DEBUG (zkCallback-726-thread-1) [] o.a.s.p.PackageAPI Updating 
[/packages.json] ... 
  2> 79481 DEBUG (zkCallback-733-thread-1) [] o.a.s.p.PackageAPI Updating 
[/packages.json] ... 
  2> 79481 DEBUG (zkCallback-729-thread-1) [] o.a.s.p.PackageAPI Updating 
[/packages.json] ... 
  2> 79499 INFO  (zkCallback-733-thread-1) [] o.a.s.p.SolrPackageLoader A new 
package: schemapkg introduced
  2> 79499 INFO  (zkCallback-735-thread-1) [] o.a.s.p.SolrPackageLoader A new 
package: schemapkg introduced
  2> 79499 INFO  (zkCallback-729-thread-1) [] o.a.s.p.SolrPackageLoader A new 
package: schemapkg introduced
  2> 79499 INFO  (zkCallback-726-thread-1) [] o.a.s.p.SolrPackageLoader A new 
package: schemapkg introduced
  2> 79499 INFO  (zkCallback-733-thread-1) [] o.a.s.p.SolrPackageLoader A new 
version: 1.0 added for package: schemapkg with artifacts 
[/schemapkg/schema-plugins.jar, /schemapkg/payload-component.jar]
  2> 79499 INFO  (zkCallback-726-thread-1) [] o.a.s.p.SolrPackageLoader A new 
version: 1.0 added for package: schemapkg with artifacts 
[/schemapkg/schema-plugins.jar, /schemapkg/payload-component.jar]
  2> 79499 INFO  (zkCallback-729-thread-1) [] o.a.s.p.SolrPackageLoader A new 
version: 1.0 added for package: schemapkg with artifacts 
[/schemapkg/schema-plugins.jar, /schemapkg/payload-component.jar]
  2> 79499 INFO  (zkCallback-735-thread-1) [] o.a.s.p.SolrPackageLoader A new 
version: 1.0 added for package: schemapkg with artifacts 
[/schemapkg/schema-plugins.jar, /schemapkg/payload-component.jar]
  2> 79507 INFO  (qtp71276034-1079) [n:127.0.0.1:46371_solr t:null-1143] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package 
params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
  2> 79510 INFO  (qtp1084016355-1100) [n:127.0.0.1:37385_solr t:null-1144] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package 
params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
  2> 79512 INFO  (zkCallback-729-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79513 INFO  (zkCallback-735-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79514 INFO  (zkCallback-726-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79515 INFO  (zkCallback-733-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79517 INFO  (zkCallback-729-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79517 INFO  (zkCallback-735-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79519 INFO  (zkCallback-733-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79520 INFO  (zkCallback-726-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79525 INFO  (zkCallback-729-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79526 INFO  (zkCallback-733-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79527 INFO  (qtp2066054861-1098) [n:127.0.0.1:33603_solr t:null-1145] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package 
params={expectedVersion1=&omitHeader=true&wt=javabin} status=0 QTime=0
  2> 79527 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1142] 
o.a.s.p.SolrPackageLoader A new package: schemapkg introduced
  2> 79528 INFO  (zkCallback-735-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79529 INFO  (zkCallback-726-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79530 INFO  (zkCallback-729-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79531 INFO  (zkCallback-733-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79533 INFO  (zkCallback-726-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79534 INFO  (zkCallback-735-thread-1) [] o.a.s.f.DistribPackageStore 
pub_key512.der does not exist locally, downloading.. 
  2> 79536 INFO  (zkCallback-733-thread-1) [] o.a.s.c.SolrResourceLoader Added 
2 libs to classloader, from paths: 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node3/filestore/schemapkg]
  2> 79536 INFO  (zkCallback-729-thread-1) [] o.a.s.c.SolrResourceLoader Added 
2 libs to classloader, from paths: 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node4/filestore/schemapkg]
  2> 79536 INFO  (zkCallback-733-thread-1) [] o.a.s.p.SolrPackageLoader 
version: 1.0 is the new latest in package: schemapkg
  2> 79536 INFO  (zkCallback-729-thread-1) [] o.a.s.p.SolrPackageLoader 
version: 1.0 is the new latest in package: schemapkg
  2> 79537 INFO  (qtp1927894020-1091) [n:127.0.0.1:38809_solr t:null-1142] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package 
params={wt=javabin&version=2} status=0 QTime=84
  2> 79537 INFO  (zkCallback-726-thread-1) [] o.a.s.c.SolrResourceLoader Added 
2 libs to classloader, from paths: 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node2/filestore/schemapkg]
  2> 79537 INFO  (zkCallback-726-thread-1) [] o.a.s.p.SolrPackageLoader 
version: 1.0 is the new latest in package: schemapkg
  2> 79537 INFO  (zkCallback-735-thread-1) [] o.a.s.c.SolrResourceLoader Added 
2 libs to classloader, from paths: 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node1/filestore/schemapkg]
  2> 79537 INFO  (zkCallback-735-thread-1) [] o.a.s.p.SolrPackageLoader 
version: 1.0 is the new latest in package: schemapkg
  2> 79551 INFO  (qtp2066054861-1093) [n:127.0.0.1:33603_solr t:null-1146] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/cluster/package 
params={wt=javabin&version=2} status=0 QTime=0
  2> 79555 INFO  (qtp2066054861-1083) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl t:null-1147] 
o.a.s.c.a.c.DistributedCollectionConfigSetCommandRunner Running Collection API 
locally for CREATE asyncId=null
  2> 79563 INFO  
(DistributedCollectionApiCommandExecutor-749-thread-1-processing-127.0.0.1:33603_solr
 null-1147 testSchemaLoadingColl) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl t:null-1147] o.a.s.c.a.c.CreateCollectionCmd Create 
collection testSchemaLoadingColl
  2> 79684 INFO  
(DistributedCollectionApiCommandExecutor-749-thread-1-processing-127.0.0.1:33603_solr
 null-1147 testSchemaLoadingColl) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl t:null-1147] o.a.s.c.o.SliceMutator createReplica() {
  2>   "core":"testSchemaLoadingColl_shard2_replica_n1",
  2>   "node_name":"127.0.0.1:38809_solr",
  2>   "base_url":"https://127.0.0.1:38809/solr";,
  2>   "collection":"testSchemaLoadingColl",
  2>   "shard":"shard2",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 79687 INFO  
(DistributedCollectionApiCommandExecutor-749-thread-1-processing-127.0.0.1:33603_solr
 null-1147 testSchemaLoadingColl) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl t:null-1147] o.a.s.c.o.SliceMutator createReplica() {
  2>   "core":"testSchemaLoadingColl_shard2_replica_n2",
  2>   "node_name":"127.0.0.1:46371_solr",
  2>   "base_url":"https://127.0.0.1:46371/solr";,
  2>   "collection":"testSchemaLoadingColl",
  2>   "shard":"shard2",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 79690 INFO  
(DistributedCollectionApiCommandExecutor-749-thread-1-processing-127.0.0.1:33603_solr
 null-1147 testSchemaLoadingColl) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl t:null-1147] o.a.s.c.o.SliceMutator createReplica() {
  2>   "core":"testSchemaLoadingColl_shard1_replica_n3",
  2>   "node_name":"127.0.0.1:37385_solr",
  2>   "base_url":"https://127.0.0.1:37385/solr";,
  2>   "collection":"testSchemaLoadingColl",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 79692 INFO  
(DistributedCollectionApiCommandExecutor-749-thread-1-processing-127.0.0.1:33603_solr
 null-1147 testSchemaLoadingColl) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl t:null-1147] o.a.s.c.o.SliceMutator createReplica() {
  2>   "core":"testSchemaLoadingColl_shard1_replica_n4",
  2>   "node_name":"127.0.0.1:33603_solr",
  2>   "base_url":"https://127.0.0.1:33603/solr";,
  2>   "collection":"testSchemaLoadingColl",
  2>   "shard":"shard1",
  2>   "state":"down",
  2>   "type":"NRT",
  2>   "operation":"ADDREPLICA",
  2>   "waitForFinalState":"false"} 
  2> 79744 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=testSchemaLoadingColl&version=2&replicaType=NRT&coreNodeName=core_node6&name=testSchemaLoadingColl_shard2_replica_n2&action=CREATE&numShards=2&shard=shard2&wt=javabin
  2> 79744 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=testSchemaLoadingColl&version=2&replicaType=NRT&coreNodeName=core_node8&name=testSchemaLoadingColl_shard1_replica_n4&action=CREATE&numShards=2&shard=shard1&wt=javabin
  2> 79747 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=testSchemaLoadingColl&version=2&replicaType=NRT&coreNodeName=core_node5&name=testSchemaLoadingColl_shard2_replica_n1&action=CREATE&numShards=2&shard=shard2&wt=javabin
  2> 79766 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=testSchemaLoadingColl&version=2&replicaType=NRT&coreNodeName=core_node7&name=testSchemaLoadingColl_shard1_replica_n3&action=CREATE&numShards=2&shard=shard1&wt=javabin
  2> 79769 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.7.0
  2> 79769 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.7.0
  2> 79771 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.7.0
  2> 79773 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.s.IndexSchema 
Schema name=minimal
  2> 79774 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.s.IndexSchema 
Schema name=minimal
  2> 79774 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.s.IndexSchema 
Schema name=minimal
  2> 79778 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
  2> 79778 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
  2> 79778 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
  2> 79779 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.c.CoreContainer 
Creating SolrCore 'testSchemaLoadingColl_shard1_replica_n4' using configuration 
from configset conf1, trusted=true
  2> 79780 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.c.SolrCore Opening 
new SolrCore at 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node1/testSchemaLoadingColl_shard1_replica_n4],
 
dataDir=[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node1/testSchemaLoadingColl_shard1_replica_n4/data/]
  2> 79780 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.c.CoreContainer 
Creating SolrCore 'testSchemaLoadingColl_shard2_replica_n1' using configuration 
from configset conf1, trusted=true
  2> 79780 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.c.CoreContainer 
Creating SolrCore 'testSchemaLoadingColl_shard2_replica_n2' using configuration 
from configset conf1, trusted=true
  2> 79780 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.c.SolrCore Opening 
new SolrCore at 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node3/testSchemaLoadingColl_shard2_replica_n1],
 
dataDir=[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node3/testSchemaLoadingColl_shard2_replica_n1/data/]
  2> 79780 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.c.SolrCore Opening 
new SolrCore at 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node4/testSchemaLoadingColl_shard2_replica_n2],
 
dataDir=[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node4/testSchemaLoadingColl_shard2_replica_n2/data/]
  2> 79789 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 9.7.0
  2> 79792 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.s.IndexSchema 
Schema name=minimal
  2> 79795 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
  2> 79797 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.c.CoreContainer 
Creating SolrCore 'testSchemaLoadingColl_shard1_replica_n3' using configuration 
from configset conf1, trusted=true
  2> 79797 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.c.SolrCore Opening 
new SolrCore at 
[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node2/testSchemaLoadingColl_shard1_replica_n3],
 
dataDir=[/tmp/src/solr/solr/core/build/tmp/tests-tmp/solr.pkg.TestPackages_CF63900ABB0C336E-001/tempDir-001/node2/testSchemaLoadingColl_shard1_replica_n3/data/]
  2> 79822 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 79824 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 79830 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
  2> 79830 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
  2> 79831 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
  2> 79832 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
  2> 79832 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
  2> 79832 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
  2> 79833 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
  2> 79833 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
  2> 79836 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
  2> 79836 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
  2> 79837 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 79837 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
  2> 79837 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1776701941006467072
  2> 79838 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
  2> 79838 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 79838 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 79838 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1776701941007515648
  2> 79842 INFO  
(searcherExecutor-781-thread-1-processing-testSchemaLoadingColl_shard1_replica_n4
 null-1147 core_node8 127.0.0.1:33603_solr testSchemaLoadingColl shard1) 
[n:127.0.0.1:33603_solr c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.c.SolrCore 
Registered new searcher autowarm time: 0 ms
  2> 79843 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] 
o.a.s.j.SolrRequestAuthorizer Creating a new SolrRequestAuthorizer
  2> 79844 INFO  
(searcherExecutor-783-thread-1-processing-testSchemaLoadingColl_shard2_replica_n1
 null-1147 core_node5 127.0.0.1:38809_solr testSchemaLoadingColl shard2) 
[n:127.0.0.1:38809_solr c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.c.SolrCore 
Registered new searcher autowarm time: 0 ms
  2> 79852 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
  2> 79852 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
  2> 79852 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/testSchemaLoadingColl/terms/shard1 
to Terms{values={core_node8=0}, version=0} for registerTerm
  2> 79852 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
  2> 79852 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
  2> 79852 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testSchemaLoadingColl/leaders/shard1
  2> 79853 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/testSchemaLoadingColl/terms/shard2 
to Terms{values={core_node5=0}, version=0} for registerTerm
  2> 79853 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testSchemaLoadingColl/leaders/shard2
  2> 79854 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
  2> 79854 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
  2> 79854 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
  2> 79854 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
  2> 79856 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
  2> 79857 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
  2> 79858 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 79858 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1776701941028487168
  2> 79858 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
  2> 79859 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
  2> 79859 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
  2> 79859 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1776701941029535744
  2> 79861 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoute in=9998ms
  2> 79863 INFO  
(searcherExecutor-790-thread-1-processing-testSchemaLoadingColl_shard1_replica_n3
 null-1147 core_node7 127.0.0.1:37385_solr testSchemaLoadingColl shard1) 
[n:127.0.0.1:37385_solr c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.c.SolrCore 
Registered new searcher autowarm time: 0 ms
  2> 79865 INFO  (qtp1927894020-1081) [n:127.0.0.1:38809_solr 
c:testSchemaLoadingColl s:shard2 r:core_node5 
x:testSchemaLoadingColl_shard2_replica_n1 t:null-1147] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoute in=9997ms
  2> 79865 INFO  
(searcherExecutor-785-thread-1-processing-testSchemaLoadingColl_shard2_replica_n2
 null-1147 core_node6 127.0.0.1:46371_solr testSchemaLoadingColl shard2) 
[n:127.0.0.1:46371_solr c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.c.SolrCore 
Registered new searcher autowarm time: 0 ms
  2> 79871 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/testSchemaLoadingColl/terms/shard1 
to Terms{values={core_node7=0, core_node8=0}, version=1} for registerTerm
  2> 79872 INFO  (qtp1084016355-1073) [n:127.0.0.1:37385_solr 
c:testSchemaLoadingColl s:shard1 r:core_node7 
x:testSchemaLoadingColl_shard1_replica_n3 t:null-1147] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testSchemaLoadingColl/leaders/shard1
  2> 79873 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] o.a.s.c.ZkShardTerms 
Successful update of terms at /collections/testSchemaLoadingColl/terms/shard2 
to Terms{values={core_node6=0, core_node5=0}, version=1} for registerTerm
  2> 79873 INFO  (qtp71276034-1092) [n:127.0.0.1:46371_solr 
c:testSchemaLoadingColl s:shard2 r:core_node6 
x:testSchemaLoadingColl_shard2_replica_n2 t:null-1147] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/testSchemaLoadingColl/leaders/shard2
  2> 80364 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
  2> 80364 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
  2> 80364 INFO  (qtp2066054861-1089) [n:127.0.0.1:33603_solr 
c:testSchemaLoadingColl s:shard1 r:core_node8 
x:testSchemaLoadingColl_shard1_replica_n4 t:null-1147] o.a.s.c.SyncStrategy 
Sync replicas to 
https://127.0.0.1:33603/solr/testSchemaLoadingColl_shard1_replica_n4/
  2> 80365 INFO  (qtp2066054861-1089) [n:127.0.0.

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

upport.parkNanos(LockSupport.java:234)
  2>         at 
[email protected]/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
  2>         at 
[email protected]/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1182)
  2>         at 
[email protected]/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:899)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
  2>         at [email protected]/java.lang.Thread.run(Thread.java:829)
  2>   71) Thread[id=1372, 
name=jetty-launcher-827-thread-3-SendThread(127.0.0.1:38387), 
state=TIMED_WAITING, group=TGRP-TestPackages]
  2>         at [email protected]/java.lang.Thread.sleep(Native Method)
  2>         at 
app//org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1127)
  2>         at 
app//org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1192)
  2>   72) Thread[id=1364, name=h2sc-861-thread-2, state=RUNNABLE, 
group=TGRP-TestPackages]
  2>         at [email protected]/sun.nio.ch.EPoll.wait(Native Method)
  2>         at 
[email protected]/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:120)
  2>         at 
[email protected]/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)
  2>         at 
[email protected]/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:141)
  2>         at 
app//org.eclipse.jetty.io.ManagedSelector.nioSelect(ManagedSelector.java:180)
  2>         at 
app//org.eclipse.jetty.io.ManagedSelector.select(ManagedSelector.java:187)
  2>         at 
app//org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:604)
  2>         at 
app//org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:541)
  2>         at 
app//org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.produceTask(AdaptiveExecutionStrategy.java:455)
  2>         at 
app//org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:248)
  2>         at 
app//org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.produce(AdaptiveExecutionStrategy.java:193)
  2>         at 
app//org.eclipse.jetty.io.ManagedSelector$$Lambda$341/0x00000008404df440.run(Unknown
 Source)
  2>         at 
app//org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:289)
  2>         at 
app//org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$342/0x00000008404dec40.run(Unknown
 Source)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
  2>         at [email protected]/java.lang.Thread.run(Thread.java:829)
  2>   73) Thread[id=1304, name=qtp1329393073-1304, state=TIMED_WAITING, 
group=TGRP-TestPackages]
  2>         at [email protected]/jdk.internal.misc.Unsafe.park(Native Method)
  2>         at 
[email protected]/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
  2>         at 
[email protected]/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
  2>         at 
app//org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:219)
  2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:1124)
  2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1141)
  2>         at [email protected]/java.lang.Thread.run(Thread.java:829)
  2>   74) Thread[id=1378, name=zkConnectionManagerCallback-873-thread-1, 
state=WAITING, group=TGRP-TestPackages]
  2>         at [email protected]/jdk.internal.misc.Unsafe.park(Native Method)
  2>         at 
[email protected]/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
  2>         at 
[email protected]/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
  2>         at 
[email protected]/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
  2>         at 
[email protected]/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
  2>         at [email protected]/java.lang.Thread.run(Thread.java:829)
  2>   75) Thread[id=1317, name=qtp1399711202-1317, state=TIMED_WAITING, 
group=TGRP-TestPackages]
  2>         at [email protected]/jdk.internal.misc.Unsafe.park(Native Method)
  2>         at 
[email protected]/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:234)
  2>         at 
[email protected]/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2123)
  2>         at 
app//org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:219)
  2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:1124)
  2>         at 
app//org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1141)
  2>         at [email protected]/java.lang.Thread.run(Thread.java:829)
   >     java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
   >         at __randomizedtesting.SeedInfo.seed([CF63900ABB0C336E]:0)
  2> NOTE: test params are: codec=Asserting(Lucene95): {}, docValues:{}, 
maxPointsInLeafNode=2022, maxMBSortInHeap=6.052627758194797, 
sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=ar-DZ, 
timezone=America/Barbados
  2> NOTE: Linux 5.4.0-100-generic amd64/Oracle Corporation 11.0.16 
(64-bit)/cpus=1,threads=87,free=175392192,total=357040128
  2> NOTE: All tests run in this JVM: [CommonGramsPhraseQueryTest, 
RecoveryZkTest, LocalFSCloudIncrementalBackupTest, TestConfigReload, 
CustomHighlightComponentTest, TestPackages]
  2> NOTE: reproduce with: gradlew test --tests TestPackages 
-Dtests.seed=CF63900ABB0C336E -Dtests.locale=ar-DZ 
-Dtests.timezone=America/Barbados -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8

:solr:core:test (FAILURE): 4868 test(s), 2 failure(s), 219 skipped

4868 tests completed, 2 failed, 219 skipped

> Task :solr:core:test FAILED
> Task :solr:core:wipeTaskTemp

ERROR: The following test(s) have failed:
  - org.apache.solr.pkg.TestPackages.testCoreReloadingPlugin (:solr:core)
    Test output: 
/tmp/src/solr/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.pkg.TestPackages.txt
    Reproduce with: gradlew :solr:core:test --tests 
"org.apache.solr.pkg.TestPackages.testCoreReloadingPlugin" -Ptests.jvms=96 
"-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=CF63900ABB0C336E -Ptests.file.encoding=ISO-8859-1

  - org.apache.solr.pkg.TestPackages.classMethod (:solr:core)
    Test output: 
/tmp/src/solr/solr/core/build/test-results/test/outputs/OUTPUT-org.apache.solr.pkg.TestPackages.txt
    Reproduce with: gradlew :solr:core:test --tests 
"org.apache.solr.pkg.TestPackages.classMethod" -Ptests.jvms=96 
"-Ptests.jvmargs=-XX:TieredStopAtLevel=1 -XX:+UseParallelGC 
-XX:ActiveProcessorCount=1 -XX:ReservedCodeCacheSize=120m" 
-Ptests.seed=CF63900ABB0C336E -Ptests.file.encoding=ISO-8859-1


FAILURE: Build completed with 2 failures.

1: Task failed with an exception.
-----------
* Where:
Build file '/tmp/src/solr/solr/packaging/build.gradle' line: 285

* What went wrong:
Execution failed for task ':solr:packaging:integrationTests'.
> Process 'command 
> '/tmp/src/solr/.gradle/node/packaging/node_modules/bats/bin/bats'' finished 
> with non-zero exit value 1

* Try:
> Run with --stacktrace option to get the stack trace.
> Run with --info or --debug option to get more log output.
> Run with --scan to get full insights.
==============================================================================

2: Task failed with an exception.
-----------
* What went wrong:
Execution failed for task ':solr:core:test'.
> There were failing tests. See the results at: 
> file:///tmp/src/solr/solr/core/build/test-results/test/

* Try:
> Run with --stacktrace option to get the stack trace.
> Run with --info or --debug option to get more log output.
> Run with --scan to get full insights.
==============================================================================

* Get more help at https://help.gradle.org

BUILD FAILED in 2h 5m 38s
654 actionable tasks: 637 executed, 17 up-to-date
[?12l[?25h
------------------------------------------------------------------------
Build Failed: returned 1

Total time: 2h6m1s
------------------------------------------------------------------------
+ status=1
+ ./crave pull '**/build/**/test/TEST-*.xml' '**/*.events' 'heapdumps/**' 
'**/hs_err_pid*'
Error: rsync: [sender] change_dir "/tmp/src/solr/heapdumps" failed: No such 
file or directory (2)
rsync error: some files/attrs were not transferred (see previous errors) (code 
23) at main.c(1684) [Receiver=3.1.3]
rsync: [Receiver] write error: Broken pipe (32)

+ exit 1
Build step 'Execute shell' marked build as failure
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to