Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/3353/

2 tests failed.
FAILED:  org.apache.solr.cloud.CollectionPropsTest.testWatcher

Error Message:
Test abandoned because suite timeout was reached.

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


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CollectionPropsTest

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

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




Build Log:
[...truncated 16502 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionPropsTest
   [junit4]   2> 725907 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 725907 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/data-dir-62-001
   [junit4]   2> 725907 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 725908 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 725908 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 725908 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 725908 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.CollectionPropsTest Using legacyCloud?: false
   [junit4]   2> 725908 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001
   [junit4]   2> 725909 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 725910 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 725910 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 725911 WARN  (ZkTestServer Run Thread) [     ] 
o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 726010 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.ZkTestServer start zk server on port: 43289
   [junit4]   2> 726010 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:43289
   [junit4]   2> 726010 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:43289
   [junit4]   2> 726010 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 43289
   [junit4]   2> 726035 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726084 INFO  (zkConnectionManagerCallback-5882-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726084 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726136 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726148 INFO  (zkConnectionManagerCallback-5884-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726148 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726168 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726177 INFO  (zkConnectionManagerCallback-5886-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726178 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 
8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 
8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 726289 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 
8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 726294 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 726294 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 726294 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.Server jetty-9.4.44.v20210927; built: 2021-09-27T23:02:44.612Z; git: 
8da83308eeca865e495e53ef315a249d63ba9332; jvm 1.8.0_291-b10
   [junit4]   2> 726372 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 726372 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 726372 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 726379 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@723c95a6{/solr,null,AVAILABLE}
   [junit4]   2> 726396 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 726396 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 726396 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 726400 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6289efdc{/solr,null,AVAILABLE}
   [junit4]   2> 726408 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 726408 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 726408 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@66ed4599{/solr,null,AVAILABLE}
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@7233895{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:40691}
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.s.Server Started @726437ms
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:43289/solr, hostPort=40691}
   [junit4]   2> 726409 ERROR (jetty-launcher-5887-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.11.0
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-15T15:31:54.067Z
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@14fadcb7{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:45697}
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.s.Server Started @726438ms
   [junit4]   2> 726409 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:43289/solr, hostPort=45697}
   [junit4]   2> 726410 ERROR (jetty-launcher-5887-thread-3) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 726410 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 726410 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.11.0
   [junit4]   2> 726410 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 726410 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 726410 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-15T15:31:54.068Z
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@6e35cd20{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:37723}
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.s.Server Started @726441ms
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:43289/solr, hostPort=37723}
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 726413 ERROR (jetty-launcher-5887-thread-4) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.11.0
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 726413 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-15T15:31:54.071Z
   [junit4]   2> 726416 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@ded2c43{/solr,null,AVAILABLE}
   [junit4]   2> 726417 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726417 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726418 INFO  (zkConnectionManagerCallback-5891-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@48e5d07f{HTTP/1.1, (http/1.1, 
h2c)}{127.0.0.1:45561}
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.s.Server Started @726447ms
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
zkHost=127.0.0.1:43289/solr, hostPort=45561}
   [junit4]   2> 726418 INFO  (zkConnectionManagerCallback-5889-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726418 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726418 ERROR (jetty-launcher-5887-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 726419 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 726419 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.11.0
   [junit4]   2> 726419 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 726419 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
   [junit4]   2> 726419 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2021-10-15T15:31:54.077Z
   [junit4]   2> 726419 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 726422 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 726424 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 726426 INFO  (zkConnectionManagerCallback-5893-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726426 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726426 WARN  
(jetty-launcher-5887-thread-1-SendThread(127.0.0.1:43289)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x1083b81e5af0004.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x1083b81e5af0004, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x1083b81e5af0004, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 726426 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 726426 WARN  
(jetty-launcher-5887-thread-3-SendThread(127.0.0.1:43289)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x1083b81e5af0003.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x1083b81e5af0003, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x1083b81e5af0003, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 726427 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726442 INFO  (zkConnectionManagerCallback-5895-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726442 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726442 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 726443 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 726445 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Metrics collection is disabled.
   [junit4]   2> 726445 WARN  
(jetty-launcher-5887-thread-2-SendThread(127.0.0.1:43289)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x1083b81e5af0006.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x1083b81e5af0006, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x1083b81e5af0006, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 726683 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 726684 WARN  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@2b90cb15[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 726684 WARN  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@2b90cb15[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 726692 WARN  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@57599b85[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 726692 WARN  (jetty-launcher-5887-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@57599b85[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 726693 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43289/solr
   [junit4]   2> 726708 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 726716 INFO  (zkConnectionManagerCallback-5912-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726716 INFO  (jetty-launcher-5887-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 726856 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 726864 INFO  (zkConnectionManagerCallback-5917-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 726864 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 727126 WARN  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_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/zookeeper-access-control.html
   [junit4]   2> 727130 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:40691_solr
   [junit4]   2> 727130 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.Overseer Overseer 
(id=74374822941884424-127.0.0.1:40691_solr-n_0000000000) starting
   [junit4]   2> 727143 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:40691_solr
   [junit4]   2> 727160 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40691_solr
   [junit4]   2> 727162 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 727163 WARN  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 727180 INFO  (zkCallback-5916-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 727206 INFO  (jetty-launcher-5887-thread-1) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node1
   [junit4]   2> 728954 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 728955 WARN  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@7b31c08b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 728955 WARN  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@7b31c08b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 728958 WARN  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@639d06d8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 728958 WARN  (jetty-launcher-5887-thread-3) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@639d06d8[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 728959 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43289/solr
   [junit4]   2> 728968 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 728969 INFO  (zkConnectionManagerCallback-5935-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 728969 INFO  (jetty-launcher-5887-thread-3) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 728970 WARN  
(jetty-launcher-5887-thread-3-SendThread(127.0.0.1:43289)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x1083b81e5af0009.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x1083b81e5af0009, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x1083b81e5af0009, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 729216 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 729231 INFO  (zkConnectionManagerCallback-5937-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 729231 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 729234 WARN  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_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/zookeeper-access-control.html
   [junit4]   2> 729237 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 729239 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:45697_solr as DOWN
   [junit4]   2> 729240 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 729240 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45697_solr
   [junit4]   2> 729241 INFO  (zkCallback-5916-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 729242 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 729242 WARN  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 729251 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 729252 INFO  (zkCallback-5936-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 729252 WARN  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@1cdad095[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729252 WARN  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@1cdad095[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729262 WARN  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@19d67e18[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729262 WARN  (jetty-launcher-5887-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@19d67e18[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729263 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43289/solr
   [junit4]   2> 729264 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 729265 INFO  (zkConnectionManagerCallback-5948-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 729265 INFO  (jetty-launcher-5887-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 729281 INFO  (jetty-launcher-5887-thread-3) 
[n:127.0.0.1:45697_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node3
   [junit4]   2> 729372 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 729376 INFO  (zkConnectionManagerCallback-5953-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 729376 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 729380 WARN  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_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/zookeeper-access-control.html
   [junit4]   2> 729380 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 729383 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:45561_solr as DOWN
   [junit4]   2> 729383 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 729383 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45561_solr
   [junit4]   2> 729386 INFO  (zkCallback-5916-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 729387 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 729387 WARN  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 729405 INFO  (zkCallback-5936-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 729405 INFO  (zkCallback-5952-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 729420 INFO  (jetty-launcher-5887-thread-2) 
[n:127.0.0.1:45561_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node2
   [junit4]   2> 729814 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 729815 WARN  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3cb4c3b7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729815 WARN  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3cb4c3b7[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729818 WARN  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@1f220a68[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729818 WARN  (jetty-launcher-5887-thread-4) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@1f220a68[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 729819 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43289/solr
   [junit4]   2> 729819 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 729824 INFO  (zkConnectionManagerCallback-5967-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 729824 INFO  (jetty-launcher-5887-thread-4) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 729825 WARN  
(jetty-launcher-5887-thread-4-SendThread(127.0.0.1:43289)) [     ] 
o.a.z.ClientCnxn An exception was thrown while closing send thread for session 
0x1083b81e5af000d.
   [junit4]   2>           => EndOfStreamException: Unable to read additional 
data from server sessionid 0x1083b81e5af000d, likely server has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable 
to read additional data from server sessionid 0x1083b81e5af000d, likely server 
has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) 
~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
 ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) 
[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 729926 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 729927 INFO  (zkConnectionManagerCallback-5969-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 729927 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 729932 WARN  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_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/zookeeper-access-control.html
   [junit4]   2> 729933 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 729936 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:37723_solr as DOWN
   [junit4]   2> 729937 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient core cache for max 2147483647 cores with initial capacity of 1024
   [junit4]   2> 729937 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37723_solr
   [junit4]   2> 729938 INFO  (zkCallback-5936-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 729938 INFO  (zkCallback-5916-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 729938 INFO  (zkCallback-5952-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 729938 INFO  (zkCallback-5968-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 729939 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.p.PackageLoader /packages.json updated to 
version -1
   [junit4]   2> 729939 WARN  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.CoreContainer Not all security plugins 
configured!  authentication=disabled authorization=disabled.  Solr is only as 
secure as you make it. Consider configuring authentication/authorization before 
exposing Solr to users internal or external.  See 
https://s.apache.org/solrsecurity for more info
   [junit4]   2> 729960 INFO  (jetty-launcher-5887-thread-4) 
[n:127.0.0.1:37723_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node4
   [junit4]   2> 729965 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
   [junit4]   2> 729974 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 729975 INFO  (zkConnectionManagerCallback-5980-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 729975 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 729976 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 729977 INFO  
(SUITE-CollectionPropsTest-seed#[FB4E6BCA039FDD6D]-worker) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:43289/solr ready
   [junit4]   2> 730000 INFO  
(TEST-CollectionPropsTest.testReadWriteCached-seed#[FB4E6BCA039FDD6D]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testReadWriteCached
   [junit4]   2> 730005 INFO  
(OverseerThreadFactory-5924-thread-1-processing-n:127.0.0.1:40691_solr) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
CollectionPropsTest35358111118968345
   [junit4]   2> 730113 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358111118968345_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:45561_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:45561/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358111118968345",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 730115 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358111118968345_shard1_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:40691_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:40691/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358111118968345",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 730117 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358111118968345_shard2_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:45697_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:45697/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358111118968345",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 730119 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358111118968345_shard2_replica_n6",
   [junit4]   2>   "node_name":"127.0.0.1:37723_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:37723/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358111118968345",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 730323 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr    
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard2_replica_n4&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 730324 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr    
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard1_replica_n2&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 730325 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr    
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient core cache for max 
2147483647 cores with initial capacity of 1024
   [junit4]   2> 730327 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr    
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard1_replica_n1&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 730327 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr    
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard2_replica_n6&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 730341 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 730344 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.s.IndexSchema 
Schema name=minimal
   [junit4]   2> 730344 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 730344 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'CollectionPropsTest35358111118968345_shard1_replica_n2' using configuration 
from configset conf, trusted=true
   [junit4]   2> 730345 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.c.SolrCore 
[[CollectionPropsTest35358111118968345_shard1_replica_n2] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node1/CollectionPropsTest35358111118968345_shard1_replica_n2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node1/CollectionPropsTest35358111118968345_shard1_replica_n2/data/]
   [junit4]   2> 730345 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 730347 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.s.IndexSchema 
Schema name=minimal
   [junit4]   2> 730348 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 730348 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'CollectionPropsTest35358111118968345_shard2_replica_n4' using configuration 
from configset conf, trusted=true
   [junit4]   2> 730352 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.c.SolrCore 
[[CollectionPropsTest35358111118968345_shard2_replica_n4] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node3/CollectionPropsTest35358111118968345_shard2_replica_n4],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node3/CollectionPropsTest35358111118968345_shard2_replica_n4/data/]
   [junit4]   2> 730354 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 730355 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 730356 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.s.IndexSchema 
Schema name=minimal
   [junit4]   2> 730356 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 730356 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'CollectionPropsTest35358111118968345_shard1_replica_n1' using configuration 
from configset conf, trusted=true
   [junit4]   2> 730357 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[CollectionPropsTest35358111118968345_shard1_replica_n1] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node2/CollectionPropsTest35358111118968345_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node2/CollectionPropsTest35358111118968345_shard1_replica_n1/data/]
   [junit4]   2> 730358 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.s.IndexSchema 
Schema name=minimal
   [junit4]   2> 730359 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 730359 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.c.CoreContainer Creating SolrCore 
'CollectionPropsTest35358111118968345_shard2_replica_n6' using configuration 
from configset conf, trusted=true
   [junit4]   2> 730359 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.c.SolrCore 
[[CollectionPropsTest35358111118968345_shard2_replica_n6] ] Opening new 
SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node4/CollectionPropsTest35358111118968345_shard2_replica_n6],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J3/temp/solr.cloud.CollectionPropsTest_FB4E6BCA039FDD6D-001/tempDir-001/node4/CollectionPropsTest35358111118968345_shard2_replica_n6/data/]
   [junit4]   2> 730374 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 730374 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 730375 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 730375 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 730376 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 730376 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 730376 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 730376 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1713700253764419584
   [junit4]   2> 730379 INFO  
(searcherExecutor-5982-thread-1-processing-n:127.0.0.1:40691_solr 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5) 
[n:127.0.0.1:40691_solr c:CollectionPropsTest35358111118968345 s:shard1 
r:core_node5 x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.SolrCore [CollectionPropsTest35358111118968345_shard1_replica_n2]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 730387 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 730388 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 730389 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/CollectionPropsTest35358111118968345/terms/shard1 to 
Terms{values={core_node5=0}, version=0}
   [junit4]   2> 730389 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/CollectionPropsTest35358111118968345/leaders/shard1
   [junit4]   2> 730389 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 730390 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 730391 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 730392 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 730392 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 730392 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1713700253781196800
   [junit4]   2> 730393 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard1: total=2 found=1 timeoute in=9999ms
   [junit4]   2> 730400 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 730400 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 730401 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 730401 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 730402 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 730402 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 730402 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 730402 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1713700253791682560
   [junit4]   2> 730404 INFO  
(searcherExecutor-5986-thread-1-processing-n:127.0.0.1:45561_solr 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3) 
[n:127.0.0.1:45561_solr c:CollectionPropsTest35358111118968345 s:shard1 
r:core_node3 x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.c.SolrCore [CollectionPropsTest35358111118968345_shard1_replica_n1]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 730403 INFO  
(searcherExecutor-5984-thread-1-processing-n:127.0.0.1:45697_solr 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7) 
[n:127.0.0.1:45697_solr c:CollectionPropsTest35358111118968345 s:shard2 
r:core_node7 x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.SolrCore [CollectionPropsTest35358111118968345_shard2_replica_n4]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 730407 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/CollectionPropsTest35358111118968345/terms/shard2 to 
Terms{values={core_node7=0}, version=0}
   [junit4]   2> 730407 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/CollectionPropsTest35358111118968345/leaders/shard2
   [junit4]   2> 730409 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 730409 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 730409 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/CollectionPropsTest35358111118968345/terms/shard1 to 
Terms{values={core_node3=0, core_node5=0}, version=1}
   [junit4]   2> 730409 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/CollectionPropsTest35358111118968345/leaders/shard1
   [junit4]   2> 730410 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 730410 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 730411 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 730412 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 730412 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 730412 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1713700253802168320
   [junit4]   2> 730414 INFO  
(searcherExecutor-5988-thread-1-processing-n:127.0.0.1:37723_solr 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8) 
[n:127.0.0.1:37723_solr c:CollectionPropsTest35358111118968345 s:shard2 
r:core_node8 x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.c.SolrCore [CollectionPropsTest35358111118968345_shard2_replica_n6]  
Registered new searcher autowarm time: 0 ms
   [junit4]   2> 730416 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for 
shard shard2: total=2 found=1 timeoute in=9998ms
   [junit4]   2> 730419 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/CollectionPropsTest35358111118968345/terms/shard2 to 
Terms{values={core_node7=0, core_node8=0}, version=1}
   [junit4]   2> 730419 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/CollectionPropsTest35358111118968345/leaders/shard2
   [junit4]   2> 730894 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 730894 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 730894 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.c.SyncStrategy 
Sync replicas to 
http://127.0.0.1:40691/solr/CollectionPropsTest35358111118968345_shard1_replica_n2/
   [junit4]   2> 730895 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.u.PeerSync 
PeerSync: core=CollectionPropsTest35358111118968345_shard1_replica_n2 
url=http://127.0.0.1:40691/solr  START 
replicas=[http://127.0.0.1:45561/solr/CollectionPropsTest35358111118968345_shard1_replica_n1/]
 nUpdates=100
   [junit4]   2> 730895 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.u.PeerSync 
PeerSync: core=CollectionPropsTest35358111118968345_shard1_replica_n2 
url=http://127.0.0.1:40691/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 730897 INFO  (qtp1176643275-8666) [n:127.0.0.1:45561_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node3 
x:CollectionPropsTest35358111118968345_shard1_replica_n1 ] o.a.s.c.S.Request 
[CollectionPropsTest35358111118968345_shard1_replica_n1]  webapp=/solr 
path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 730897 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 730897 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 730898 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/CollectionPropsTest35358111118968345/leaders/shard1/leader after 
winning as 
/collections/CollectionPropsTest35358111118968345/leader_elect/shard1/election/74374822941884424-core_node5-n_0000000000
   [junit4]   2> 730900 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:40691/solr/CollectionPropsTest35358111118968345_shard1_replica_n2/
 shard1
   [junit4]   2> 730917 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 730917 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 730917 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.c.SyncStrategy 
Sync replicas to 
http://127.0.0.1:45697/solr/CollectionPropsTest35358111118968345_shard2_replica_n4/
   [junit4]   2> 730918 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.u.PeerSync 
PeerSync: core=CollectionPropsTest35358111118968345_shard2_replica_n4 
url=http://127.0.0.1:45697/solr  START 
replicas=[http://127.0.0.1:37723/solr/CollectionPropsTest35358111118968345_shard2_replica_n6/]
 nUpdates=100
   [junit4]   2> 730920 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.u.PeerSync 
PeerSync: core=CollectionPropsTest35358111118968345_shard2_replica_n4 
url=http://127.0.0.1:45697/solr  DONE. We have no versions. sync failed.
   [junit4]   2> 730921 INFO  (qtp1626488654-8661) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node8 
x:CollectionPropsTest35358111118968345_shard2_replica_n6 ] o.a.s.c.S.Request 
[CollectionPropsTest35358111118968345_shard2_replica_n6]  webapp=/solr 
path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 730921 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 730921 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 730921 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/CollectionPropsTest35358111118968345/leaders/shard2/leader after 
winning as 
/collections/CollectionPropsTest35358111118968345/leader_elect/shard2/election/74374822941884426-core_node7-n_0000000000
   [junit4]   2> 730923 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:45697/solr/CollectionPropsTest35358111118968345_shard2_replica_n4/
 shard2
   [junit4]   2> 731025 INFO  (zkCallback-5936-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731025 INFO  (zkCallback-5916-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731026 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358111118968345 s:shard2 r:core_node7 
x:CollectionPropsTest35358111118968345_shard2_replica_n4 ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 731026 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr 
c:CollectionPropsTest35358111118968345 s:shard1 r:core_node5 
x:CollectionPropsTest35358111118968345_shard1_replica_n2 ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 731030 INFO  (qtp440213888-8651) [n:127.0.0.1:45697_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard2_replica_n4&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=707
   [junit4]   2> 731030 INFO  (qtp165988313-8640) [n:127.0.0.1:40691_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard1_replica_n2&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=706
   [junit4]   2> 731131 INFO  (zkCallback-5936-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731131 INFO  (zkCallback-5916-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731131 INFO  (zkCallback-5916-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731131 INFO  (zkCallback-5936-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731417 INFO  (qtp1176643275-8664) [n:127.0.0.1:45561_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard1_replica_n1&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1090
   [junit4]   2> 731428 INFO  (qtp1626488654-8659) [n:127.0.0.1:37723_solr     
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358111118968345_shard2_replica_n6&action=CREATE&numShards=2&collection=CollectionPropsTest35358111118968345&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1100
   [junit4]   2> 731430 INFO  (qtp440213888-8649) [n:127.0.0.1:45697_solr     ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
45 seconds. Check all shard replicas
   [junit4]   2> 731528 INFO  (zkCallback-5936-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5952-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5936-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5968-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5968-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5952-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5916-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731528 INFO  (zkCallback-5916-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/state.json] for 
collection [CollectionPropsTest35358111118968345] has occurred - updating... 
(live nodes size: [4])
   [junit4]   2> 731538 INFO  (qtp440213888-8649) [n:127.0.0.1:45697_solr     ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf&name=CollectionPropsTest35358111118968345&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=1535
   [junit4]   2> 731542 INFO  (zkCallback-5979-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A collection property change: [WatchedEvent 
state:SyncConnected type:NodeCreated 
path:/collections/CollectionPropsTest35358111118968345/collectionprops.json] 
for collection [CollectionPropsTest35358111118968345] has occurred - updating...
   [junit4]   2> 731546 INFO  (collectionPropsNotifications-5978-thread-1) [    
 ] o.a.s.c.CollectionPropsTest collection properties changed. Now: 
{property1=value1}
   [junit4]   2> 731546 INFO  (zkCallback-5979-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A collection property change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/collectionprops.json] 
for collection [CollectionPropsTest35358111118968345] has occurred - updating...
   [junit4]   2> 731548 INFO  (collectionPropsNotifications-5978-thread-1) [    
 ] o.a.s.c.CollectionPropsTest collection properties changed. Now: 
{property1=value1, property2=value2}
   [junit4]   2> 731549 INFO  (zkCallback-5979-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A collection property change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/collectionprops.json] 
for collection [CollectionPropsTest35358111118968345] has occurred - updating...
   [junit4]   2> 731549 INFO  (collectionPropsNotifications-5978-thread-1) [    
 ] o.a.s.c.CollectionPropsTest collection properties changed. Now: 
{property2=value2}
   [junit4]   2> 731550 INFO  (zkCallback-5979-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A collection property change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/collectionprops.json] 
for collection [CollectionPropsTest35358111118968345] has occurred - updating...
   [junit4]   2> 731553 INFO  (collectionPropsNotifications-5978-thread-1) [    
 ] o.a.s.c.CollectionPropsTest collection properties changed. Now: 
{property2=newValue}
   [junit4]   2> 731554 INFO  (zkCallback-5979-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A collection property change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/CollectionPropsTest35358111118968345/collectionprops.json] 
for collection [CollectionPropsTest35358111118968345] has occurred - updating...
   [junit4]   2> 731555 INFO  (collectionPropsNotifications-5978-thread-1) [    
 ] o.a.s.c.CollectionPropsTest collection properties changed. Now: {}
   [junit4]   2> 731555 INFO  (collectionPropsNotifications-5978-thread-1) [    
 ] o.a.s.c.CollectionPropsTest ...new props match expected
   [junit4]   2> 731557 INFO  
(TEST-CollectionPropsTest.testReadWriteCached-seed#[FB4E6BCA039FDD6D]) [     ] 
o.a.s.SolrTestCaseJ4 ###Ending testReadWriteCached
   [junit4]   2> 731583 INFO  
(TEST-CollectionPropsTest.testMultipleWatchers-seed#[FB4E6BCA039FDD6D]) [     ] 
o.a.s.SolrTestCaseJ4 ###Starting testMultipleWatchers
   [junit4]   2> 731586 INFO  
(OverseerCollectionConfigSetProcessor-74374822941884424-127.0.0.1:40691_solr-n_0000000000)
 [n:127.0.0.1:40691_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 731586 INFO  
(OverseerThreadFactory-5924-thread-2-processing-n:127.0.0.1:40691_solr) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
CollectionPropsTest35358112701407044
   [junit4]   2> 731798 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358112701407044_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:37723_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:37723/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358112701407044",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 731801 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358112701407044_shard1_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:40691_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:40691/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358112701407044",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 731803 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358112701407044_shard2_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:45697_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:45697/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358112701407044",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 731805 INFO  
(OverseerStateUpdate-74374822941884424-127.0.0.1:40691_solr-n_0000000000) 
[n:127.0.0.1:40691_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   
"core":"CollectionPropsTest35358112701407044_shard2_replica_n6",
   [junit4]   2>   "node_name":"127.0.0.1:45561_solr",
   [junit4]   2>   "base_url":"http://127.0.0.1:45561/solr";,
   [junit4]   2>   "collection":"CollectionPropsTest35358112701407044",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 732007 INFO  (qtp440213888-8648) [n:127.0.0.1:45697_solr    
x:CollectionPropsTest35358112701407044_shard2_replica_n4 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358112701407044_shard2_replica_n4&action=CREATE&numShards=2&collection=CollectionPropsTest35358112701407044&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 732007 INFO  (qtp1626488654-8662) [n:127.0.0.1:37723_solr    
x:CollectionPropsTest35358112701407044_shard1_replica_n1 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358112701407044_shard1_replica_n1&action=CREATE&numShards=2&collection=CollectionPropsTest35358112701407044&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 732007 INFO  (qtp165988313-8641) [n:127.0.0.1:40691_solr    
x:CollectionPropsTest35358112701407044_shard1_replica_n2 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358112701407044_shard1_replica_n2&action=CREATE&numShards=2&collection=CollectionPropsTest35358112701407044&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 732008 INFO  (qtp1176643275-8667) [n:127.0.0.1:45561_solr    
x:CollectionPropsTest35358112701407044_shard2_replica_n6 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf&newCollection=true&name=CollectionPropsTest35358112701407044_shard2_replica_n6&action=CREATE&numShards=2&collection=CollectionPropsTest35358112701407044&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 732021 INFO  (qtp440213888-8648) [n:127.0.0.1:45697_solr 
c:CollectionPropsTest35358112701407044 s:shard2 r:core_node7 
x:CollectionPropsTest35358112701407044_shard2_replica_n4 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 732021 INFO  (qtp1626488654-8662) [n:127.0.0.1:37723_solr 
c:CollectionPropsTest35358112701407044 s:shard1 r:core_node3 
x:CollectionPropsTest35358112701407044_shard1_replica_n1 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.11.0
   [junit4]   2> 732021 INFO  (qtp165

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

k(ThreadPoolExecutor.java:1074)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2>   85) Thread[id=8644, name=Session-HouseKeeper-309d1fc6-1, 
state=TIMED_WAITING, group=TGRP-CollectionPropsTest]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
   [junit4]   2>         at 
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
   [junit4]   2>         at 
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2>   86) Thread[id=8658, name=qtp1626488654-8658, 
state=TIMED_WAITING, group=TGRP-CollectionPropsTest]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
   [junit4]   2>         at 
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:974)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1018)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2>   87) Thread[id=8725, name=Thread-1202, state=WAITING, 
group=TGRP-CollectionPropsTest]
   [junit4]   2>         at java.lang.Object.wait(Native Method)
   [junit4]   2>         at java.lang.Object.wait(Object.java:502)
   [junit4]   2>         at 
org.apache.solr.core.CloserThread.run(CoreContainer.java:2291)
   [junit4]   2>   88) Thread[id=8654, name=qtp1176643275-8654, state=RUNNABLE, 
group=TGRP-CollectionPropsTest]
   [junit4]   2>         at sun.nio.ch.EPollArrayWrapper.epollWait(Native 
Method)
   [junit4]   2>         at 
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
   [junit4]   2>         at 
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
   [junit4]   2>         at 
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
   [junit4]   2>         at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
   [junit4]   2>         at 
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector.nioSelect(ManagedSelector.java:183)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector.select(ManagedSelector.java:190)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:606)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:543)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:362)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:186)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:173)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:137)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$$Lambda$353/1722995543.run(Unknown Source)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:883)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1034)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2>   89) Thread[id=8665, name=qtp1176643275-8665, 
state=TIMED_WAITING, group=TGRP-CollectionPropsTest]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
   [junit4]   2>         at 
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:382)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.idleJobPoll(QueuedThreadPool.java:974)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1018)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2>   90) Thread[id=8730, name=h2sc-5964-thread-1, state=RUNNABLE, 
group=TGRP-CollectionPropsTest]
   [junit4]   2>         at sun.nio.ch.EPollArrayWrapper.epollWait(Native 
Method)
   [junit4]   2>         at 
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
   [junit4]   2>         at 
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
   [junit4]   2>         at 
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
   [junit4]   2>         at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
   [junit4]   2>         at 
sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector.nioSelect(ManagedSelector.java:183)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector.select(ManagedSelector.java:190)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:606)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:543)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produceTask(EatWhatYouKill.java:362)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:186)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:173)
   [junit4]   2>         at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:137)
   [junit4]   2>         at 
org.eclipse.jetty.io.ManagedSelector$$Lambda$353/1722995543.run(Unknown Source)
   [junit4]   2>         at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:218)
   [junit4]   2>         at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$116/1659405809.run(Unknown
 Source)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=he-IL, 
timezone=Antarctica/Troll
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 
1.8.0_291 (64-bit)/cpus=4,threads=116,free=204931832,total=503840768
   [junit4]   2> NOTE: All tests run in this JVM: [TestSimPolicyCloud, 
TestStressThreadBackup, LegacyCloudClusterPropTest, TestSolrConfigHandler, 
DirectoryFactoryTest, TestFileDictionaryLookup, 
BigEndianAscendingWordDeserializerTest, TestLegacyField, 
TestExactSharedStatsCache, RangeFacetCloudTest, 
TestDeleteCollectionOnDownNodes, TestSearcherReuse, SoftAutoCommitTest, 
FullHLLTest, TestSizeLimitedDistributedMap, TestInPlaceUpdateWithRouteField, 
TestLeaderElectionZkExpiry, ResponseHeaderTest, ShardsWhitelistTest, 
LeaderFailoverAfterPartitionTest, FieldAnalysisRequestHandlerTest, 
TestGraphTermsQParserPlugin, TestMaxTokenLenTokenizer, 
TestSchemaDesignerSettingsDAO, TestCloudRecovery2, DistanceUnitsTest, TestTrie, 
DistributedQueueTest, CdcrWithNodesRestartsTest, XmlUpdateRequestHandlerTest, 
TestCoreContainer, TestCloudPhrasesIdentificationComponent, TestConfigOverlay, 
CloudExitableDirectoryReaderTest, TestManagedSynonymGraphFilterFactory, 
TriggerIntegrationTest, MetricTriggerTest, TestCloudNestedDocsSort, 
TestSolrXml, TestSnapshotCloudManager, TestBadConfig, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, ComputePlanActionTest, 
TestMacros, SolrGraphiteReporterTest, RankFieldTest, SystemLogListenerTest, 
TestEmbeddedSolrServerSchemaAPI, TestSubQueryTransformerDistrib, AuthToolTest, 
SolrTestCaseJ4DeleteCoreTest, SpellCheckCollatorWithCollapseTest, 
TestDistribPackageStore, TestDocSet, TestStreamBody, TestConfigsApi, 
DistributedSpellCheckComponentTest, PeerSyncWithIndexFingerprintCachingTest, 
TestSimGenericDistributedQueue, TestUtils, CollectionPropsTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CollectionPropsTest 
-Dtests.seed=FB4E6BCA039FDD6D -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=he-IL -Dtests.timezone=Antarctica/Troll -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J3 | CollectionPropsTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 
7200000 msec).
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([FB4E6BCA039FDD6D]:0)
   [junit4] Completed [892/947 (1!)] on J3 in 7213.38s, 4 tests, 2 errors <<< 
FAILURES!

[...truncated 54425 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to