Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.5/333/

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.HttpPartitionTest

Error Message:
ObjectTracker found 2 object(s) that were not released!!! [ZkCollectionTerms, 
ZkCollectionTerms] 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
  at org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)  
at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)  
at org.apache.solr.cloud.ZkController.unregister(ZkController.java:1633)  at 
org.apache.solr.cloud.ZkController.unregister(ZkController.java:1627)  at 
org.apache.solr.core.CoreContainer.unload(CoreContainer.java:1716)  at 
org.apache.solr.cloud.ZkController$UnloadCoreOnDeletedWatcher.onStateChanged(ZkController.java:2563)
  at 
org.apache.solr.common.cloud.ZkStateReader$Notification.run(ZkStateReader.java:2047)
  at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)  
at java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
 at java.lang.Thread.run(Thread.java:748)  
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
  at org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)  
at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)  
at org.apache.solr.cloud.ZkController.register(ZkController.java:1197)  at 
org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:269)
  at java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
 at java.lang.Thread.run(Thread.java:748)   expected null, but 
was:<ObjectTracker found 2 object(s) that were not released!!! 
[ZkCollectionTerms, ZkCollectionTerms] 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
  at org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)  
at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)  
at org.apache.solr.cloud.ZkController.unregister(ZkController.java:1633)  at 
org.apache.solr.cloud.ZkController.unregister(ZkController.java:1627)  at 
org.apache.solr.core.CoreContainer.unload(CoreContainer.java:1716)  at 
org.apache.solr.cloud.ZkController$UnloadCoreOnDeletedWatcher.onStateChanged(ZkController.java:2563)
  at 
org.apache.solr.common.cloud.ZkStateReader$Notification.run(ZkStateReader.java:2047)
  at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)  
at java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
 at java.lang.Thread.run(Thread.java:748)  
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
  at org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)  
at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)  
at org.apache.solr.cloud.ZkController.register(ZkController.java:1197)  at 
org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:269)
  at java.util.concurrent.FutureTask.run(FutureTask.java:266)  at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
  at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 
 at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 
 at java.lang.Thread.run(Thread.java:748)  >

Stack Trace:
java.lang.AssertionError: ObjectTracker found 2 object(s) that were not 
released!!! [ZkCollectionTerms, ZkCollectionTerms]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
        at org.apache.solr.cloud.ZkController.unregister(ZkController.java:1633)
        at org.apache.solr.cloud.ZkController.unregister(ZkController.java:1627)
        at org.apache.solr.core.CoreContainer.unload(CoreContainer.java:1716)
        at 
org.apache.solr.cloud.ZkController$UnloadCoreOnDeletedWatcher.onStateChanged(ZkController.java:2563)
        at 
org.apache.solr.common.cloud.ZkStateReader$Notification.run(ZkStateReader.java:2047)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)

org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
        at org.apache.solr.cloud.ZkController.register(ZkController.java:1197)
        at 
org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:269)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)

 expected null, but was:<ObjectTracker found 2 object(s) that were not 
released!!! [ZkCollectionTerms, ZkCollectionTerms]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
        at org.apache.solr.cloud.ZkController.unregister(ZkController.java:1633)
        at org.apache.solr.cloud.ZkController.unregister(ZkController.java:1627)
        at org.apache.solr.core.CoreContainer.unload(CoreContainer.java:1716)
        at 
org.apache.solr.cloud.ZkController$UnloadCoreOnDeletedWatcher.onStateChanged(ZkController.java:2563)
        at 
org.apache.solr.common.cloud.ZkStateReader$Notification.run(ZkStateReader.java:2047)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)

org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
        at org.apache.solr.cloud.ZkController.register(ZkController.java:1197)
        at 
org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:269)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)

>
        at __randomizedtesting.SeedInfo.seed([60A00E4F0B827F9C]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.junit.Assert.failNotNull(Assert.java:755)
        at org.junit.Assert.assertNull(Assert.java:737)
        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:334)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:901)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13388 lines...]
   [junit4] Suite: org.apache.solr.cloud.HttpPartitionTest
   [junit4]   2> 325118 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to 
test-framework derived value of 
'/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 325118 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 325118 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/data-dir-14-001
   [junit4]   2> 325118 WARN  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
   [junit4]   2> 325118 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 325120 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
   [junit4]   2> 325120 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: 
/w_bmt/b
   [junit4]   2> 325127 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 325128 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 325128 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 325228 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer start zk server on port:45534
   [junit4]   2> 325228 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:45534
   [junit4]   2> 325228 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:45534
   [junit4]   2> 325228 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1 45534
   [junit4]   2> 325230 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 325232 INFO  (zkConnectionManagerCallback-1093-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 325232 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 325234 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 325244 INFO  (zkConnectionManagerCallback-1095-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 325244 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 325247 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 325248 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 325250 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 325251 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 325252 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 325253 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 325254 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 325255 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 325264 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 325265 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 325267 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 325268 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 325535 WARN  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 325535 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 325535 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 325535 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] o.e.j.s.Server 
jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 325536 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] o.e.j.s.session 
DefaultSessionIdManager workerName=node0
   [junit4]   2> 325536 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] o.e.j.s.session 
No SessionScavenger set, using defaults
   [junit4]   2> 325536 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] o.e.j.s.session 
node0 Scavenging every 660000ms
   [junit4]   2> 325537 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6e42b40b{/w_bmt/b,null,AVAILABLE}
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@38fba607{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:33990}
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] o.e.j.s.Server 
Started @325572ms
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/tempDir-001/control/data,
 replicaType=NRT, hostContext=/w_bmt/b, hostPort=45662, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/control-001/cores}
   [junit4]   2> 325538 ERROR 
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.5.3
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 325538 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-06-18T13:46:51.890Z
   [junit4]   2> 325539 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 325549 INFO  (zkConnectionManagerCallback-1097-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 325549 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 325650 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 325650 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/control-001/solr.xml
   [junit4]   2> 325654 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 325654 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 325656 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 329271 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 329272 WARN  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@c4a5dcd[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329272 WARN  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@c4a5dcd[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329284 WARN  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@4205b8cc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329284 WARN  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@4205b8cc[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 329285 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45534/solr
   [junit4]   2> 329286 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 329287 INFO  (zkConnectionManagerCallback-1104-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 329287 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 329391 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 329392 INFO  (zkConnectionManagerCallback-1106-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 329392 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 329518 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.OverseerElectionContext I am going 
to be the leader 127.0.0.1:45662_w_bmt%2Fb
   [junit4]   2> 329519 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.Overseer Overseer 
(id=72992369858445316-127.0.0.1:45662_w_bmt%2Fb-n_0000000000) starting
   [junit4]   2> 329525 INFO  
(OverseerStateUpdate-72992369858445316-127.0.0.1:45662_w_bmt%2Fb-n_0000000000) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.Overseer Starting to work on the 
main queue : 127.0.0.1:45662_w_bmt%2Fb
   [junit4]   2> 329525 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.ZkController Register node as live 
in ZooKeeper:/live_nodes/127.0.0.1:45662_w_bmt%2Fb
   [junit4]   2> 329538 INFO  
(OverseerStateUpdate-72992369858445316-127.0.0.1:45662_w_bmt%2Fb-n_0000000000) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 329550 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.p.PackageLoader /packages.json updated 
to version -1
   [junit4]   2> 329588 WARN  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] 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> 329660 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 329725 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 329777 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 329777 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 329779 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/control-001/cores
   [junit4]   2> 329887 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 329887 INFO  (zkConnectionManagerCallback-1115-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 329887 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 329889 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 329890 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45534/solr ready
   [junit4]   2> 329891 INFO  (SocketProxy-Acceptor-45662) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=48826,localport=45662], receiveBufferSize:531000
   [junit4]   2> 329895 INFO  (SocketProxy-Acceptor-45662) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=33990,localport=41996], receiveBufferSize=530904
   [junit4]   2> 329905 INFO  (qtp1585652396-3045) [n:127.0.0.1:45662_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with 
params 
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:45662_w_bmt%252Fb&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 329909 INFO  
(OverseerThreadFactory-1642-thread-1-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.a.c.CreateCollectionCmd Create 
collection control_collection
   [junit4]   2> 330024 INFO  (SocketProxy-Acceptor-45662) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=48834,localport=45662], receiveBufferSize:531000
   [junit4]   2> 330050 INFO  (SocketProxy-Acceptor-45662) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=33990,localport=42004], receiveBufferSize=530904
   [junit4]   2> 330051 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
   x:control_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core 
create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 330051 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
   x:control_collection_shard1_replica_n1 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 331081 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.3
   [junit4]   2> 331143 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 331384 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 331404 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1' 
using configuration from configset conf1, trusted=true
   [junit4]   2> 331405 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 331405 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore 
at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 331408 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=95.88671875, 
floorSegmentMB=0.3310546875, forceMergeDeletesPctAllowed=16.38473096386915, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=34.34110177855355
   [junit4]   2> 331410 WARN  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 331470 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 331470 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 331472 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 331472 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 331473 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=88.2666015625, 
floorSegmentMB=0.2333984375, forceMergeDeletesPctAllowed=5.951726848324932, 
segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=38.88450365974299
   [junit4]   2> 331473 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@72da6f5e[control_collection_shard1_replica_n1] main]
   [junit4]   2> 331476 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 331476 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 331477 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 331477 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1669844715783061504
   [junit4]   2> 331481 INFO  
(searcherExecutor-1647-thread-1-processing-n:127.0.0.1:45662_w_bmt%2Fb 
x:control_collection_shard1_replica_n1 c:control_collection s:shard1) 
[n:127.0.0.1:45662_w_bmt%2Fb c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore 
[control_collection_shard1_replica_n1] Registered new searcher 
Searcher@72da6f5e[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 331483 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/control_collection/terms/shard1 to Terms{values={core_node2=0}, 
version=0}
   [junit4]   2> 331483 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created 
/collections/control_collection/leaders/shard1
   [junit4]   2> 331487 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 331487 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 331487 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:45662/w_bmt/b/control_collection_shard1_replica_n1/
   [junit4]   2> 331488 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 331488 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.SyncStrategy 
http://127.0.0.1:45662/w_bmt/b/control_collection_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 331488 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node 
/collections/control_collection/leaders/shard1/leader after winning as 
/collections/control_collection/leader_elect/shard1/election/72992369858445316-core_node2-n_0000000000
   [junit4]   2> 331490 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:45662/w_bmt/b/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 331592 INFO  (zkCallback-1105-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 331593 INFO  (zkCallback-1105-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 331593 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 331594 ERROR (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.c.c.ZkStateReader Collection control_collection is not lazy or watched!
   [junit4]   2> 331596 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
c:control_collection s:shard1  x:control_collection_shard1_replica_n1 ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1545
   [junit4]   2> 331599 INFO  (qtp1585652396-3045) [n:127.0.0.1:45662_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 331709 INFO  (zkCallback-1105-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 331716 INFO  (zkCallback-1105-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 331729 INFO  (qtp1585652396-3045) [n:127.0.0.1:45662_w_bmt%2Fb 
    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:45662_w_bmt%252Fb&wt=javabin&version=2}
 status=0 QTime=1824
   [junit4]   2> 331730 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in 
collection: control_collection
   [junit4]   2> 331733 INFO  (zkCallback-1105-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 331870 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 331871 INFO  (zkConnectionManagerCallback-1121-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 331872 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 331873 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 331875 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:45534/solr ready
   [junit4]   2> 331878 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 331907 INFO  (SocketProxy-Acceptor-45662) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=48858,localport=45662], receiveBufferSize:531000
   [junit4]   2> 331908 INFO  (SocketProxy-Acceptor-45662) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=33990,localport=42028], receiveBufferSize=530904
   [junit4]   2> 331909 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with 
params 
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 331913 INFO  
(OverseerThreadFactory-1642-thread-2-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.a.c.CreateCollectionCmd Create 
collection collection1
   [junit4]   2> 331913 INFO  
(OverseerCollectionConfigSetProcessor-72992369858445316-127.0.0.1:45662_w_bmt%2Fb-n_0000000000)
 [n:127.0.0.1:45662_w_bmt%2Fb     ] 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> 332117 WARN  
(OverseerThreadFactory-1642-thread-2-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.a.c.CreateCollectionCmd It is 
unusual to create a collection (collection1) without cores.
   [junit4]   2> 332118 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at 
most 45 seconds. Check all shard replicas
   [junit4]   2> 332119 INFO  (qtp1585652396-3044) [n:127.0.0.1:45662_w_bmt%2Fb 
    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2}
 status=0 QTime=209
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
   [junit4]   2> 332121 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances 
pullReplicaCount=0 numOtherReplicas=3
   [junit4]   2> 332277 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-1-001
 of type NRT for shard2
   [junit4]   2> 332280 WARN  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 332280 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 332280 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 332280 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 332281 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 332281 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 332281 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 332281 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@780dd517{/w_bmt/b,null,AVAILABLE}
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@503fba93{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:40513}
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.s.Server Started @332317ms
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/tempDir-001/jetty1,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/w_bmt/b, 
hostPort=36355, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-1-001/cores}
   [junit4]   2> 332282 ERROR (closeThreadPool-1122-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.5.3
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 332282 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-06-18T13:46:58.634Z
   [junit4]   2> 332283 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 332293 INFO  (zkConnectionManagerCallback-1124-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 332293 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 332411 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 332411 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-1-001/solr.xml
   [junit4]   2> 332491 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 332491 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 332493 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 333661 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-2-001
 of type NRT for shard1
   [junit4]   2> 333662 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 333662 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 333662 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 333662 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 333663 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 333663 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 333663 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 333664 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@16cb752c{/w_bmt/b,null,AVAILABLE}
   [junit4]   2> 333664 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@78e22f37{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:33554}
   [junit4]   2> 333664 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.Server Started @333699ms
   [junit4]   2> 333664 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/tempDir-001/jetty2,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/w_bmt/b, 
hostPort=38354, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-2-001/cores}
   [junit4]   2> 333665 ERROR (closeThreadPool-1122-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 333665 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 333665 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.5.3
   [junit4]   2> 333665 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 333665 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 333665 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-06-18T13:47:00.017Z
   [junit4]   2> 333666 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 333668 INFO  (zkConnectionManagerCallback-1127-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 333668 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 333769 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 333769 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-2-001/solr.xml
   [junit4]   2> 333784 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 333784 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 333810 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 333915 INFO  
(OverseerCollectionConfigSetProcessor-72992369858445316-127.0.0.1:45662_w_bmt%2Fb-n_0000000000)
 [n:127.0.0.1:45662_w_bmt%2Fb     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 337080 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 337139 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@26f56530[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 337139 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@26f56530[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 337143 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@21f932e0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 337143 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@21f932e0[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 337144 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45534/solr
   [junit4]   2> 337145 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 337146 INFO  (zkConnectionManagerCallback-1134-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 337146 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 337269 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 337350 INFO  (zkConnectionManagerCallback-1136-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 337350 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 337356 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 337360 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:38354_w_bmt%2Fb as DOWN
   [junit4]   2> 337361 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 4 transient cores
   [junit4]   2> 337361 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.ZkController Register node as live 
in ZooKeeper:/live_nodes/127.0.0.1:38354_w_bmt%2Fb
   [junit4]   2> 337375 INFO  (zkCallback-1105-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 337375 INFO  (zkCallback-1120-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 337377 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.p.PackageLoader /packages.json updated 
to version -1
   [junit4]   2> 337379 WARN  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] 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> 337407 INFO  (zkCallback-1135-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 337566 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 337673 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 337756 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 337756 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 337764 INFO  (closeThreadPool-1122-thread-2) 
[n:127.0.0.1:38354_w_bmt%2Fb     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-2-001/cores
   [junit4]   2> 337939 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:38354_w_bmt%2Fb
   [junit4]   2> 338229 INFO  
(TEST-HttpPartitionTest.test-seed#[60A00E4F0B827F9C]) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-3-001
 of type NRT for shard2
   [junit4]   2> 338230 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, 
break even is size 23
   [junit4]   2> 338230 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 338230 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 338230 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
   [junit4]   2> 338231 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 338231 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 338231 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 338232 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2f0bb1b2{/w_bmt/b,null,AVAILABLE}
   [junit4]   2> 338232 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@8d9acb3{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:40415}
   [junit4]   2> 338232 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.s.Server Started @338267ms
   [junit4]   2> 338232 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/tempDir-001/jetty3,
 replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/w_bmt/b, 
hostPort=40008, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-3-001/cores}
   [junit4]   2> 338233 ERROR (closeThreadPool-1122-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 338233 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 338233 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.5.3
   [junit4]   2> 338233 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 338233 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr
   [junit4]   2> 338233 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2020-06-18T13:47:04.585Z
   [junit4]   2> 338234 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 338235 INFO  (zkConnectionManagerCallback-1142-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 338247 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 338349 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 338349 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-3-001/solr.xml
   [junit4]   2> 338362 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 338362 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 338480 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 338861 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 338862 WARN  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@313d221b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 338862 WARN  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@313d221b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 338877 WARN  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@33c56a00[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 338877 WARN  (closeThreadPool-1122-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@33c56a00[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 338879 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45534/solr
   [junit4]   2> 338879 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 338881 INFO  (zkConnectionManagerCallback-1149-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 338881 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 338983 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 339000 INFO  (zkConnectionManagerCallback-1151-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 339000 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 339005 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (2)
   [junit4]   2> 339010 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:36355_w_bmt%2Fb as DOWN
   [junit4]   2> 339011 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 4 transient cores
   [junit4]   2> 339011 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.ZkController Register node as live 
in ZooKeeper:/live_nodes/127.0.0.1:36355_w_bmt%2Fb
   [junit4]   2> 339012 INFO  (zkCallback-1105-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 339012 INFO  (zkCallback-1135-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 339012 INFO  (zkCallback-1120-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 339012 INFO  (zkCallback-1150-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 339014 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.p.PackageLoader /packages.json updated 
to version -1
   [junit4]   2> 339015 WARN  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] 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> 339082 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 339212 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 339254 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 339254 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 339268 INFO  (closeThreadPool-1122-thread-1) 
[n:127.0.0.1:36355_w_bmt%2Fb     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-1-001/cores
   [junit4]   2> 339524 INFO  (closeThreadPool-1122-thread-1) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:36355_w_bmt%2Fb
   [junit4]   2> 341368 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 341369 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@60442949[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 341369 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@60442949[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 341393 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@25390730[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 341393 WARN  (closeThreadPool-1122-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@25390730[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 341395 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:45534/solr
   [junit4]   2> 341412 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 341412 INFO  (zkConnectionManagerCallback-1161-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 341412 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 341535 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 341537 INFO  (zkConnectionManagerCallback-1163-thread-1) [     
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 341537 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 341554 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 341560 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.ZkController Publish node=127.0.0.1:40008_w_bmt%2Fb as DOWN
   [junit4]   2> 341561 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 341561 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:40008_w_bmt%2Fb
   [junit4]   2> 341562 INFO  (zkCallback-1135-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 341563 INFO  (zkCallback-1105-thread-2) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 341574 INFO  (zkCallback-1150-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 341575 INFO  (zkCallback-1120-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 341575 INFO  (zkCallback-1162-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 341577 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 341578 WARN  (closeThreadPool-1122-thread-2) [     ] 
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> 341686 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history 
in memory.
   [junit4]   2> 341851 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 341946 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 341946 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 341948 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-3-001/cores
   [junit4]   2> 342253 INFO  (closeThreadPool-1122-thread-2) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:40008_w_bmt%2Fb
   [junit4]   2> 342257 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36118,localport=36355], receiveBufferSize:531000
   [junit4]   2> 342257 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=40513,localport=47124], receiveBufferSize=530904
   [junit4]   2> 342258 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36120,localport=36355], receiveBufferSize:531000
   [junit4]   2> 342260 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=40513,localport=47126], receiveBufferSize=530904
   [junit4]   2> 342261 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36122,localport=36355], receiveBufferSize:531000
   [junit4]   2> 342262 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=40513,localport=47128], receiveBufferSize=530904
   [junit4]   2> 342262 INFO  (qtp1409295563-3109) [n:127.0.0.1:36355_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with 
params 
node=127.0.0.1:36355_w_bmt%252Fb&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 342262 INFO  (qtp1409295563-3110) [n:127.0.0.1:36355_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with 
params 
node=127.0.0.1:38354_w_bmt%252Fb&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 342263 INFO  (qtp1409295563-3111) [n:127.0.0.1:36355_w_bmt%2Fb 
    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with 
params 
node=127.0.0.1:40008_w_bmt%252Fb&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 342281 INFO  
(OverseerThreadFactory-1642-thread-3-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb c:collection1 s:shard2   ] 
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:36355_w_bmt%2Fb for 
creating new replica of shard shard2 for collection collection1
   [junit4]   2> 342281 INFO  
(OverseerThreadFactory-1642-thread-4-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb c:collection1 s:shard1   ] 
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:38354_w_bmt%2Fb for 
creating new replica of shard shard1 for collection collection1
   [junit4]   2> 342283 INFO  
(OverseerThreadFactory-1642-thread-4-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb c:collection1 s:shard1   ] 
o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
   [junit4]   2> 342284 INFO  
(OverseerThreadFactory-1642-thread-3-processing-n:127.0.0.1:45662_w_bmt%2Fb) 
[n:127.0.0.1:45662_w_bmt%2Fb c:collection1 s:shard2   ] 
o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
   [junit4]   2> 342285 INFO  (SocketProxy-Acceptor-38354) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=32972,localport=38354], receiveBufferSize:531000
   [junit4]   2> 342285 INFO  (SocketProxy-Acceptor-38354) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=33554,localport=54570], receiveBufferSize=530904
   [junit4]   2> 342374 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36134,localport=36355], receiveBufferSize:531000
   [junit4]   2> 342397 INFO  (SocketProxy-Acceptor-36355) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=40513,localport=47136], receiveBufferSize=530904
   [junit4]   2> 342456 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
   x:collection1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 342460 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
   x:collection1_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create 
command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n2&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 343472 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.5.3
   [junit4]   2> 343483 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.5.3
   [junit4]   2> 343540 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n2] Schema name=test
   [junit4]   2> 343548 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 344366 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 344411 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 344423 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard1_replica_n1' using configuration from 
configset conf1, trusted=true
   [junit4]   2> 344424 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard1.replica_n1' (registry 
'solr.core.collection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 344424 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-2-001/cores/collection1_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-2-001/cores/collection1_shard1_replica_n1/data/]
   [junit4]   2> 344427 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=95.88671875, 
floorSegmentMB=0.3310546875, forceMergeDeletesPctAllowed=16.38473096386915, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=34.34110177855355
   [junit4]   2> 344429 WARN  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 344490 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n2' using configuration from 
configset conf1, trusted=true
   [junit4]   2> 344490 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n2' (registry 
'solr.core.collection1.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7141c05c
   [junit4]   2> 344490 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-1-001/cores/collection1_shard2_replica_n2],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.5/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_60A00E4F0B827F9C-001/shard-1-001/cores/collection1_shard2_replica_n2/data/]
   [junit4]   2> 344493 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=39, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=95.88671875, 
floorSegmentMB=0.3310546875, forceMergeDeletesPctAllowed=16.38473096386915, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=34.34110177855355
   [junit4]   2> 344516 WARN  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, class=DumpRequestHandler},args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 344735 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 344735 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 344737 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 344737 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 344738 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=88.2666015625, 
floorSegmentMB=0.2333984375, forceMergeDeletesPctAllowed=5.951726848324932, 
segmentsPerTier=41.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=38.88450365974299
   [junit4]   2> 344738 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@36f946b8[collection1_shard1_replica_n1] main]
   [junit4]   2> 344757 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 344757 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 344758 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 344758 INFO  (qtp2094900340-3124) [n:127.0.0.1:38354_w_bmt%2Fb 
c:collection1 s:shard1  x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1669844729709199360
   [junit4]   2> 344785 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 344785 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 344787 INFO  (qtp1409295563-3218) [n:127.0.0.1:36355_w_bmt%2Fb 
c:collection1 s:shard2  x:collection1_shard2_replica_n2 ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit

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

4]   2>     java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]:
   [junit4]   2>     java.lang.Thread.sleep(Native Method)
   [junit4]   2>     [...com.carrotsearch.randomizedtesting.*]
   [junit4]   2> 
   [junit4]   2> Log4j2-TF-1-AsyncLoggerConfig-1:
   [junit4]   2>     [...sun.*]
   [junit4]   2>     
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
   [junit4]   2>     
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
   [junit4]   2>     
com.lmax.disruptor.TimeoutBlockingWaitStrategy.waitFor(TimeoutBlockingWaitStrategy.java:38)
   [junit4]   2>     
com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
   [junit4]   2>     
com.lmax.disruptor.BatchEventProcessor.processEvents(BatchEventProcessor.java:159)
   [junit4]   2>     
com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:125)
   [junit4]   2>     java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> main:
   [junit4]   2>     java.lang.Object.wait(Native Method)
   [junit4]   2>     java.lang.Thread.join(Thread.java:1252)
   [junit4]   2>     java.lang.Thread.join(Thread.java:1326)
   [junit4]   2>     [...com.carrotsearch.randomizedtesting.*]
   [junit4]   2>     
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:269)
   [junit4]   2>     
com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:394)
   [junit4]   2>     
com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:13)
   [junit4]   2> 
   [junit4]   2> Finalizer:
   [junit4]   2>     java.lang.Object.wait(Native Method)
   [junit4]   2>     
java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
   [junit4]   2>     
java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
   [junit4]   2>     
java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:216)
   [junit4]   2> 
   [junit4]   2> org.apache.hadoop.hdfs.PeerCache@2f8ed8c1:
   [junit4]   2>     java.lang.Thread.sleep(Native Method)
   [junit4]   2>     org.apache.hadoop.hdfs.PeerCache.run(PeerCache.java:253)
   [junit4]   2>     
org.apache.hadoop.hdfs.PeerCache.access$000(PeerCache.java:46)
   [junit4]   2>     org.apache.hadoop.hdfs.PeerCache$1.run(PeerCache.java:124)
   [junit4]   2>     java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> Signal Dispatcher:
   [junit4]   2> 
   [junit4]   2> Reference Handler:
   [junit4]   2>     java.lang.Object.wait(Native Method)
   [junit4]   2>     java.lang.Object.wait(Object.java:502)
   [junit4]   2>     
java.lang.ref.Reference.tryHandlePending(Reference.java:191)
   [junit4]   2>     
java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)
   [junit4]   2> 
   [junit4]   2> 463214 INFO  
(SUITE-HttpPartitionTest-seed#[60A00E4F0B827F9C]-worker) [     ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@70756fd9),
 locale=hr, timezone=US/Arizona
   [junit4]   2> NOTE: Linux 4.4.0-170-generic amd64/Oracle Corporation 
1.8.0_191 (64-bit)/cpus=8,threads=1,free=179361448,total=520617984
   [junit4]   2> NOTE: All tests run in this JVM: [CdcrUpdateLogTest, 
SystemInfoHandlerTest, DocValuesMissingTest, MultiThreadedOCPTest, 
BitVectorTest, FileUtilsTest, TriggerCooldownIntegrationTest, 
SearchRateTriggerTest, TestHdfsUpdateLog, HdfsLockFactoryTest, TestFieldCache, 
TestLazyCores, TestCloudDeleteByQuery, TestScoreJoinQPScore, UpdateLogTest, 
InfixSuggestersTest, TestLuceneIndexBackCompat, PingRequestHandlerTest, 
DistanceFunctionTest, TestComponentsName, HttpPartitionTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=HttpPartitionTest 
-Dtests.seed=60A00E4F0B827F9C -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=hr -Dtests.timezone=US/Arizona -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J0 | HttpPartitionTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: ObjectTracker found 2 
object(s) that were not released!!! [ZkCollectionTerms, ZkCollectionTerms]
   [junit4]    > 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
   [junit4]    >        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    >        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.unregister(ZkController.java:1633)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.unregister(ZkController.java:1627)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer.unload(CoreContainer.java:1716)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController$UnloadCoreOnDeletedWatcher.onStateChanged(ZkController.java:2563)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader$Notification.run(ZkStateReader.java:2047)
   [junit4]    >        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
   [junit4]    >        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    >        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.register(ZkController.java:1197)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:269)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    >  expected null, but was:<ObjectTracker found 2 object(s) that 
were not released!!! [ZkCollectionTerms, ZkCollectionTerms]
   [junit4]    > 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
   [junit4]    >        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    >        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.unregister(ZkController.java:1633)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.unregister(ZkController.java:1627)
   [junit4]    >        at 
org.apache.solr.core.CoreContainer.unload(CoreContainer.java:1716)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController$UnloadCoreOnDeletedWatcher.onStateChanged(ZkController.java:2563)
   [junit4]    >        at 
org.apache.solr.common.cloud.ZkStateReader$Notification.run(ZkStateReader.java:2047)
   [junit4]    >        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException: 
org.apache.solr.cloud.ZkCollectionTerms
   [junit4]    >        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
   [junit4]    >        at 
org.apache.solr.cloud.ZkCollectionTerms.<init>(ZkCollectionTerms.java:39)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.getCollectionTerms(ZkController.java:1614)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController.register(ZkController.java:1197)
   [junit4]    >        at 
org.apache.solr.cloud.ZkController$RegisterCoreAsync.call(ZkController.java:269)
   [junit4]    >        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]    >        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:210)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]    >        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > >
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([60A00E4F0B827F9C]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:334)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4] Completed [102/901 (1!)] on J0 in 138.52s, 1 test, 1 failure <<< 
FAILURES!

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

Reply via email to