You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/06/01 09:37:07 UTC

[JENKINS] Lucene » Lucene-Solr-BadApples-Tests-8.x - Build # 295 - Still Unstable!

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

3 tests failed.
FAILED:  org.apache.solr.cloud.LeaderTragicEventTest.testLeaderFailsOver

Error Message:
Error from server at https://127.0.0.1:40127/solr: Underlying core creation failed while creating collection: testLeaderFailsOver

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:40127/solr: Underlying core creation failed while creating collection: testLeaderFailsOver
	at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:681)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:266)
	at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248)
	at org.apache.solr.client.solrj.impl.LBSolrClient.doRequest(LBSolrClient.java:369)
	at org.apache.solr.client.solrj.impl.LBSolrClient.request(LBSolrClient.java:297)
	at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.sendRequest(BaseCloudSolrClient.java:1171)
	at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.requestWithRetryOnStaleState(BaseCloudSolrClient.java:934)
	at org.apache.solr.client.solrj.impl.BaseCloudSolrClient.request(BaseCloudSolrClient.java:866)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:214)
	at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:231)
	at org.apache.solr.cloud.LeaderTragicEventTest.testLeaderFailsOver(LeaderTragicEventTest.java:80)
	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$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
	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)


FAILED:  org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory

Error Message:
action did not execute

Stack Trace:
java.lang.AssertionError: action did not execute
	at __randomizedtesting.SeedInfo.seed([A4B6924471DBAD19:C94A36B9CB93521E]:0)
	at org.junit.Assert.fail(Assert.java:89)
	at org.junit.Assert.assertTrue(Assert.java:42)
	at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:285)
	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$8.evaluate(RandomizedRunner.java:938)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.junit.rules.RunRules.evaluate(RunRules.java:20)
	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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
	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)


FAILED:  org.apache.solr.metrics.reporters.SolrJmxReporterTest.testClosedCore

Error Message:
Captured an uncaught exception in thread: Thread[id=36497, name=Thread-5054, state=RUNNABLE, group=TGRP-SolrJmxReporterTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=36497, name=Thread-5054, state=RUNNABLE, group=TGRP-SolrJmxReporterTest]
	at __randomizedtesting.SeedInfo.seed([A4B6924471DBAD19:D3CB44645142CFE9]:0)
Caused by: java.lang.AssertionError
	at __randomizedtesting.SeedInfo.seed([A4B6924471DBAD19]:0)
	at org.junit.Assert.fail(Assert.java:87)
	at org.junit.Assert.assertTrue(Assert.java:42)
	at org.junit.Assert.assertNotNull(Assert.java:713)
	at org.junit.Assert.assertNotNull(Assert.java:723)
	at org.apache.solr.metrics.reporters.SolrJmxReporterTest$1.run(SolrJmxReporterTest.java:213)




Build Log:
[...truncated 13600 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> 147201 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/server/solr/configsets/_default/conf'
   [junit4]   2> 147201 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 147202 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_A4B6924471DBAD19-001/data-dir-15-001
   [junit4]   2> 147202 WARN  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=36 numCloses=36
   [junit4]   2> 147202 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 147204 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
   [junit4]   2> 147204 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.SolrCloudTestCase Using per-replica state
   [junit4]   2> 147205 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_A4B6924471DBAD19-001/tempDir-001
   [junit4]   2> 147205 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 147205 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
   [junit4]   2> 147206 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 147206 WARN  (ZkTestServer Run Thread) [     ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
   [junit4]   2> 147306 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.ZkTestServer start zk server on port: 37425
   [junit4]   2> 147306 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:37425
   [junit4]   2> 147306 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37425
   [junit4]   2> 147306 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 37425
   [junit4]   2> 147307 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 147310 INFO  (zkConnectionManagerCallback-810-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 147310 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 147312 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 147317 INFO  (zkConnectionManagerCallback-812-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 147317 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 147318 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 147319 INFO  (zkConnectionManagerCallback-814-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 147319 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 147423 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 147423 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 147423 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
   [junit4]   2> 147424 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 147424 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
   [junit4]   2> 147424 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_281-b09
   [junit4]   2> 147436 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 147436 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 147436 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 147437 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6d070e02{/solr,null,AVAILABLE}
   [junit4]   2> 147438 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 147438 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 147438 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 147440 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3888dd00{/solr,null,AVAILABLE}
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.AbstractConnector Started ServerConnector@32008b16{SSL, (ssl, http/1.1)}{127.0.0.1:39363}
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.e.j.s.Server Started @147479ms
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:37425/solr, hostPort=39363}
   [junit4]   2> 147441 ERROR (jetty-launcher-815-thread-1) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.9.0
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 147441 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-06-01T08:38:26.863Z
   [junit4]   2> 147443 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.AbstractConnector Started ServerConnector@24362f8c{SSL, (ssl, http/1.1)}{127.0.0.1:42331}
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.e.j.s.Server Started @147483ms
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, zkHost=127.0.0.1:37425/solr, hostPort=42331}
   [junit4]   2> 147445 INFO  (zkConnectionManagerCallback-817-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 147445 ERROR (jetty-launcher-815-thread-2) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 8.9.0
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr
   [junit4]   2> 147445 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2021-06-01T08:38:26.867Z
   [junit4]   2> 147446 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 147446 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 147448 INFO  (zkConnectionManagerCallback-819-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 147448 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 147449 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 147451 WARN  (jetty-launcher-815-thread-1-SendThread(127.0.0.1:37425)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1057da67f7a0003.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x1057da67f7a0003, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1057da67f7a0003, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 148095 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 148096 WARN  (jetty-launcher-815-thread-2) [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 148097 WARN  (jetty-launcher-815-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@77d2c9aa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148097 WARN  (jetty-launcher-815-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@77d2c9aa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148099 WARN  (jetty-launcher-815-thread-2) [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 148100 WARN  (jetty-launcher-815-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5f1c7e69[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148100 WARN  (jetty-launcher-815-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5f1c7e69[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148102 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37425/solr
   [junit4]   2> 148102 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 148128 INFO  (zkConnectionManagerCallback-833-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 148129 INFO  (jetty-launcher-815-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 148250 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 148276 INFO  (zkConnectionManagerCallback-835-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 148276 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 148276 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 148280 WARN  (jetty-launcher-815-thread-1) [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 148317 WARN  (jetty-launcher-815-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4398b154[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148317 WARN  (jetty-launcher-815-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4398b154[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148340 WARN  (jetty-launcher-815-thread-1) [     ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
   [junit4]   2> 148348 WARN  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 148361 WARN  (jetty-launcher-815-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@561f3aaa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148361 WARN  (jetty-launcher-815-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@561f3aaa[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 148362 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37425/solr
   [junit4]   2> 148366 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:42331_solr
   [junit4]   2> 148366 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer Overseer (id=73603122978226182-127.0.0.1:42331_solr-n_0000000000) starting
   [junit4]   2> 148392 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 148405 INFO  (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:42331_solr
   [junit4]   2> 148427 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:42331_solr
   [junit4]   2> 148428 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers
   [junit4]   2> 148429 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 148429 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 148430 WARN  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 148437 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 0
   [junit4]   2> 148437 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 148438 INFO  (zkConnectionManagerCallback-845-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 148438 INFO  (jetty-launcher-815-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 148446 INFO  (zkCallback-834-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 148457 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:42331_solr]
   [junit4]   2> 148484 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 148512 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread -- deactivating old nodeLost / nodeAdded markers
   [junit4]   2> 148513 DEBUG (OverseerAutoScalingTriggerThread-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [     ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 148520 DEBUG (ScheduledTrigger-848-thread-3) [     ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 and last live nodes: 1
   [junit4]   2> 148521 WARN  (jetty-launcher-815-thread-1-SendThread(127.0.0.1:37425)) [     ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x1057da67f7a0007.
   [junit4]   2>           => EndOfStreamException: Unable to read additional data from server sessionid 0x1057da67f7a0007, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
   [junit4]   2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x1057da67f7a0007, likely server has closed socket
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
   [junit4]   2> 148529 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42331.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 148557 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42331.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 148557 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42331.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 148558 INFO  (jetty-launcher-815-thread-2) [n:127.0.0.1:42331_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_A4B6924471DBAD19-001/tempDir-001/node1
   [junit4]   2> 148656 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 148668 INFO  (zkConnectionManagerCallback-857-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 148668 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 148671 WARN  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.ZkController Contents of zookeeper /security.json are world-readable; consider setting up ACLs as described in https://solr.apache.org/guide/zookeeper-access-control.html
   [junit4]   2> 148673 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 148675 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:39363_solr as DOWN
   [junit4]   2> 148684 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 148684 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39363_solr
   [junit4]   2> 148685 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "operation":"downnode"} current state version: 0
   [junit4]   2> 148685 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:39363_solr
   [junit4]   2> 148685 INFO  (zkCallback-834-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 148686 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.p.PackageLoader /packages.json updated to version -1
   [junit4]   2> 148687 WARN  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.CoreContainer Not all security plugins configured!  authentication=disabled authorization=disabled.  Solr is only as secure as you make it. Consider configuring authentication/authorization before exposing Solr to users internal or external.  See https://s.apache.org/solrsecurity for more info
   [junit4]   2> 148692 INFO  (zkCallback-856-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 148700 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 148727 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39363.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 148758 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39363.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 148758 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39363.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 148776 INFO  (jetty-launcher-815-thread-1) [n:127.0.0.1:39363_solr     ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_A4B6924471DBAD19-001/tempDir-001/node2
   [junit4]   2> 148872 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=2
   [junit4]   2> 148878 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 148880 INFO  (zkConnectionManagerCallback-870-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 148880 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 148894 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 148895 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37425/solr ready
   [junit4]   2> 148955 INFO  (OverseerThreadFactory-850-thread-1-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
   [junit4]   2> 148962 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "name":".system",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "numShards":1,
   [junit4]   2>   "createNodeSet":"127.0.0.1:42331_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 148962 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
   [junit4]   2> 148962 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
   [junit4]   2> 149066 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 149066 INFO  (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 149067 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 149067 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node2":{
   [junit4]   2>       "core":".system_shard1_replica_n1",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:42331/solr"}}}
   [junit4]   2> 149168 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
   [junit4]   2> 149286 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr    x:.system_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 149286 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr    x:.system_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 149292 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 149292 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 149293 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 149293 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/1 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           "core":".system_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"}}}}}
   [junit4]   2> 149301 WARN  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig You should not use LATEST as luceneMatchVersion property: if you use this setting, and then Solr upgrades to a newer release of Lucene, sizable changes may happen. If precise back compatibility is important then you should instead explicitly specify an actual Lucene version.
   [junit4]   2> 149301 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.9.0
   [junit4]   2> 149302 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
   [junit4]   2> 149304 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=_system collection or core
   [junit4]   2> 149304 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema _system collection or core/1.1 with uniqueid field id
   [junit4]   2> 149306 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/.system/managed-schema
   [junit4]   2> 149308 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/.system/schema.xml to /configs/.system/schema.xml.bak
   [junit4]   2> 149308 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore '.system_shard1_replica_n1' using configuration from configset .system, trusted=true
   [junit4]   2> 149309 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42331.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e1cdbb3
   [junit4]   2> 149309 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [[.system_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_A4B6924471DBAD19-001/tempDir-001/node1/.system_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_A4B6924471DBAD19-001/tempDir-001/node1/.system_shard1_replica_n1/data/]
   [junit4]   2> 149378 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 149378 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 149379 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommitted docs; 
   [junit4]   2> 149379 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 149392 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/.system
   [junit4]   2> 149392 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/.system
   [junit4]   2> 149394 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/.system/managed-schema
   [junit4]   2> 149396 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
   [junit4]   2> 149397 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 149397 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
   [junit4]   2> 149398 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1701353051987640320
   [junit4]   2> 149405 INFO  (searcherExecutor-872-thread-1-processing-n:127.0.0.1:42331_solr x:.system_shard1_replica_n1 c:.system s:shard1 r:core_node2) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SolrCore [.system_shard1_replica_n1]  Registered new searcher autowarm time: 0 ms
   [junit4]   2> 149420 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/.system/terms/shard1 to Terms{values={core_node2=0}, version=0}
   [junit4]   2> 149420 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/.system/leaders/shard1
   [junit4]   2> 149424 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 149424 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 149424 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:42331/solr/.system_shard1_replica_n1/
   [junit4]   2> 149425 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 149425 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:42331/solr/.system_shard1_replica_n1/ has no replicas
   [junit4]   2> 149425 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/.system/leaders/shard1/leader after winning as /collections/.system/leader_elect/shard1/election/73603122978226182-core_node2-n_0000000000
   [junit4]   2> 149427 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:42331/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 149428 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "operation":"leader"} current state version: 0
   [junit4]   2> 149521 DEBUG (ScheduledTrigger-848-thread-1) [     ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2 and last live nodes: 1
   [junit4]   2> 149529 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
   [junit4]   2> 149530 INFO  (zkCallback-834-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 149533 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 149555 INFO  (qtp785270012-1280) [n:127.0.0.1:42331_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=.system&newCollection=true&name=.system_shard1_replica_n1&action=CREATE&numShards=1&collection=.system&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=270
   [junit4]   2> 149560 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 149560 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 149560 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "leader":"true"}
   [junit4]   2> 149560 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(.system//collections/.system/state.json/3 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"1",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{"core_node2":{
   [junit4]   2>           "core":".system_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:42331_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:42331/solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 149560 INFO  (qtp785270012-1273) [n:127.0.0.1:42331_solr     ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
   [junit4]   2> 149565 INFO  (zkCallback-834-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 149661 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
   [junit4]   2> 149661 INFO  (zkCallback-834-thread-2) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 149661 INFO  (zkCallback-834-thread-1) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 149663 INFO  (qtp785270012-1273) [n:127.0.0.1:42331_solr     ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:42331_solr&wt=javabin&version=2} status=0 QTime=730
   [junit4]   2> 149667 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.c.MiniSolrCloudCluster waitForActiveCollection: .system
   [junit4]   2> 149674 INFO  (zkCallback-834-thread-3) [     ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/.system/state.json] for collection [.system] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 149693 INFO  (OverseerCollectionConfigSetProcessor-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
   [junit4]   2> 149708 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 149709 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
   [junit4]   2> 149711 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 149713 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 149714 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
   [junit4]   2> 149721 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_it.txt
   [junit4]   2> 149722 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ca.txt
   [junit4]   2> 149724 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_no.txt
   [junit4]   2> 149725 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stemdict_nl.txt
   [junit4]   2> 149726 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hy.txt
   [junit4]   2> 149727 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_id.txt
   [junit4]   2> 149728 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_et.txt
   [junit4]   2> 149730 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hi.txt
   [junit4]   2> 149731 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_da.txt
   [junit4]   2> 149732 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ga.txt
   [junit4]   2> 149733 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ja.txt
   [junit4]   2> 149735 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_pt.txt
   [junit4]   2> 149736 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_hu.txt
   [junit4]   2> 149737 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_el.txt
   [junit4]   2> 149740 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ru.txt
   [junit4]   2> 149742 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_tr.txt
   [junit4]   2> 149748 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ar.txt
   [junit4]   2> 149749 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/userdict_ja.txt
   [junit4]   2> 149750 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_it.txt
   [junit4]   2> 149752 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_eu.txt
   [junit4]   2> 149753 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_cz.txt
   [junit4]   2> 149757 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stoptags_ja.txt
   [junit4]   2> 149759 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_fr.txt
   [junit4]   2> 149761 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fa.txt
   [junit4]   2> 149764 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_de.txt
   [junit4]   2> 149765 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/contractions_ga.txt
   [junit4]   2> 149767 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ca.txt
   [junit4]   2> 149768 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_nl.txt
   [junit4]   2> 149769 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_bg.txt
   [junit4]   2> 149770 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_es.txt
   [junit4]   2> 149772 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_en.txt
   [junit4]   2> 149773 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_lv.txt
   [junit4]   2> 149774 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_th.txt
   [junit4]   2> 149776 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_ro.txt
   [junit4]   2> 149777 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fr.txt
   [junit4]   2> 149778 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_sv.txt
   [junit4]   2> 149780 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_fi.txt
   [junit4]   2> 149781 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/hyphenations_ga.txt
   [junit4]   2> 149782 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/lang/stopwords_gl.txt
   [junit4]   2> 149783 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 149784 INFO  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 149788 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "name":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "createNodeSet":"127.0.0.1:39363_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 149788 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 149889 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 149990 WARN  (OverseerThreadFactory-850-thread-2-processing-n:127.0.0.1:42331_solr) [n:127.0.0.1:42331_solr     ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 3 on collection AutoscalingHistoryHandlerTest_collection is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
   [junit4]   2> 149994 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 149994 INFO  (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 149996 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 149996 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"}}}
   [junit4]   2> 149996 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 149996 INFO  (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 149998 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node3":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"}}}
   [junit4]   2> 149998 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"}}}
   [junit4]   2> 149999 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 149999 INFO  (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 150000 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"}}}
   [junit4]   2> 150000 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{
   [junit4]   2>     "core_node3":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"},
   [junit4]   2>     "core_node6":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>       "type":"NRT",
   [junit4]   2>       "base_url":"https://127.0.0.1:39363/solr"}}}
   [junit4]   2> 150100 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 150247 INFO  (qtp955834470-1279) [n:127.0.0.1:39363_solr    x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node6&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n4&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 150258 INFO  (qtp955834470-1284) [n:127.0.0.1:39363_solr    x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 150262 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 150262 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 150262 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "force_set_state":"false"}
   [junit4]   2> 150262 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.o.ReplicaMutator Collection is now: DocCollection(AutoscalingHistoryHandlerTest_collection//collections/AutoscalingHistoryHandlerTest_collection/state.json/1 )={
   [junit4]   2>   "pullReplicas":"0",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "router":{"name":"compositeId"},
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "autoAddReplicas":"false",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "tlogReplicas":"0",
   [junit4]   2>   "shards":{"shard1":{
   [junit4]   2>       "range":"80000000-7fffffff",
   [junit4]   2>       "state":"active",
   [junit4]   2>       "replicas":{
   [junit4]   2>         "core_node3":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>           "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "force_set_state":"false"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "base_url":"https://127.0.0.1:39363/solr"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "base_url":"https://127.0.0.1:39363/solr"}}}}}
   [junit4]   2> 150273 DEBUG (OverseerStateUpdate-73603122978226182-127.0.0.1:42331_solr-n_0000000000) [n:127.0.0.1:42331_solr     ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "node_name":"127.0.0.1:39363_solr",
   [junit4]   2>   "base_url":"https://127.0.0.1:39363/solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
  

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

lrJmxReporterTest-xhbwqipvn, domain = solr.core.collection1, service url = null, agent id = localhost_1622538644098] for registry solr.core.collection1/com.codahale.metrics.MetricRegistry@58a58869
   [junit4]   2> 2088115 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@111e4836
   [junit4]   2> 2088115 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@111e4836
   [junit4]   2> 2088115 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter.close()  ... SKIPPED (unnecessary).
   [junit4]   2> giu 01, 2021 11:10:47 AM com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler uncaughtException
   [junit4]   2> AVVERTENZA: Uncaught exception in thread: Thread[Thread-5054,5,TGRP-SolrJmxReporterTest]
   [junit4]   2> java.lang.AssertionError
   [junit4]   2> 	at __randomizedtesting.SeedInfo.seed([A4B6924471DBAD19]:0)
   [junit4]   2> 	at org.junit.Assert.fail(Assert.java:87)
   [junit4]   2> 	at org.junit.Assert.assertTrue(Assert.java:42)
   [junit4]   2> 	at org.junit.Assert.assertNotNull(Assert.java:713)
   [junit4]   2> 	at org.junit.Assert.assertNotNull(Assert.java:723)
   [junit4]   2> 	at org.apache.solr.metrics.reporters.SolrJmxReporterTest$1.run(SolrJmxReporterTest.java:213)
   [junit4]   2> 
   [junit4]   2> 2090119 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=null
   [junit4]   2> 2090119 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1 tag=SolrCore@111e4836
   [junit4]   2> 2090119 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 2090119 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=41446197
   [junit4]   2> 2090119 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
   [junit4]   2> 2090119 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2a3363db: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@e4cebc2
   [junit4]   2> 2090125 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
   [junit4]   2> 2090125 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4647ca7c: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@f31119a
   [junit4]   2> 2090128 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
   [junit4]   2> 2090128 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2e79270b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@11750701
   [junit4]   2> 2090130 INFO  (TEST-SolrJmxReporterTest.testClosedCore-seed#[A4B6924471DBAD19]) [     ] o.a.s.SolrTestCaseJ4 ###Ending testClosedCore
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SolrJmxReporterTest -Dtests.method=testClosedCore -Dtests.seed=A4B6924471DBAD19 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=it -Dtests.timezone=Africa/Harare -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
   [junit4] ERROR   3.21s J1 | SolrJmxReporterTest.testClosedCore <<<
   [junit4]    > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=36497, name=Thread-5054, state=RUNNABLE, group=TGRP-SolrJmxReporterTest]
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A4B6924471DBAD19:D3CB44645142CFE9]:0)
   [junit4]    > Caused by: java.lang.AssertionError
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A4B6924471DBAD19]:0)
   [junit4]    > 	at org.apache.solr.metrics.reporters.SolrJmxReporterTest$1.run(SolrJmxReporterTest.java:213)
   [junit4]   2> 2090131 INFO  (SUITE-SolrJmxReporterTest-seed#[A4B6924471DBAD19]-worker) [     ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene87): {}, docValues:{}, maxPointsInLeafNode=1219, maxMBSortInHeap=6.758850279323291, sim=Asserting(RandomSimilarity(queryNorm=false): {}), locale=it, timezone=Africa/Harare
   [junit4]   2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_281 (64-bit)/cpus=4,threads=1,free=191512080,total=526385152
   [junit4]   2> NOTE: All tests run in this JVM: [SuggesterFSTTest, JvmMetricsTest, BitVectorTest, TestFaceting, HdfsNNFailoverTest, TestFieldCacheReopen, RestoreTriggerStateTest, TestQueryUtils, CloneFieldUpdateProcessorFactoryTest, TestSimNodeAddedTrigger, TestSimpleQParserPlugin, FileBasedSpellCheckerTest, TestSchemaResource, TriggerCooldownIntegrationTest, TestCrossCoreJoin, CdcrRequestHandlerTest, TestLocalFSCloudBackupRestore, AutoscalingHistoryHandlerTest, TestUninvertingReader, TestSegmentSorting, TestReversedWildcardFilterFactory, TestSystemIdResolver, TestConfigSetProperties, ZkStateReaderTest, TestExactStatsCache, SolrIndexSearcherTest, TestLegacyFieldReuse, BasicAuthIntegrationTest, ShardRoutingTest, TestNumericRangeQuery32, SpatialHeatmapFacetsTest, PackageManagerCLITest, TestSimClusterStateProvider, TestFieldResource, NotRequiredUniqueKeyTest, MaxScoreCollectorTest, TestDynamicURP, TestHalfAndHalfDocValues, BlockJoinFacetSimpleTest, TestJoin, MoreLikeThisHandlerTest, SearchRateTriggerIntegrationTest, TestSolrCoreProperties, DataDrivenBlockJoinTest, TestBlockCollapse, TestUseDocValuesAsStored2, ZkFailoverTest, SolrCoreTest, CreateRoutedAliasTest, TestSimExecutePlanAction, TestHdfsBackupRestoreCore, TestNestedDocsSort, TestReRankQParserPlugin, TestIBSimilarityFactory, TestExceedMaxTermLength, DebugComponentTest, TestDistributedStatsComponentCardinality, TestSchemalessBufferedUpdates, TestStressInPlaceUpdates, TestReload, TestCopyFieldCollectionResource, TestSQLHandlerNonCloud, ClusterStateTest, TestBlobHandler, TestUnifiedSolrHighlighterWithoutStoredId, V2CollectionBackupsAPIMappingTest, TestAnalyzeInfixSuggestions, CollectionsAPISolrJTest, CSVRequestHandlerTest, TestMissingGroups, JWTAuthPluginTest, TestCollectionAPIs, ConcurrentDeleteAndCreateCollectionTest, TestPullReplicaErrorHandling, TestStressIncrementalBackup, DistributedFacetPivotWhiteBoxTest, TestComplexPhraseQParserPlugin, BadCopyFieldTest, TestLRUCache, TestXmlQParser, ReplicationFactorTest, RulesTest, SuggestComponentTest, TestRTimerTree, TestManagedResource, SolrIndexConfigTest, TestJsonRequest, TestPKIAuthenticationPlugin, TestTrackingShardHandlerFactory, SpellPossibilityIteratorTest, RankQParserPluginTest, TestUnInvertedFieldException, TestHashPartitioner, VersionInfoTest, IndexSizeEstimatorTest, HLLUtilTest, TestDocBasedVersionConstraints, MBeansHandlerTest, UnloadDistributedZkTest, ShardsWhitelistTest, TestCustomDocTransformer, TestInPlaceUpdatesRequiredField, TestDistributedTracing, AssignBackwardCompatibilityTest, HighlighterTest, QueryElevationComponentTest, TestFilteredDocIdSet, TestCloudDeleteByQuery, ReindexCollectionTest, DistributedIntervalFacetingTest, DOMUtilTest, TestShardHandlerFactory, DirectSolrConnectionTest, TestSimTriggerIntegration, ProtectedTermFilterFactoryTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, CloudExitableDirectoryReaderTest, CollectionPropsTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest, HttpPartitionWithTlogReplicasTest, LeaderFailoverAfterPartitionTest, LegacyCloudClusterPropTest, MetricsHistoryWithAuthIntegrationTest, MoveReplicaHDFSFailoverTest, MoveReplicaHDFSTest, MoveReplicaTest, OverseerCollectionConfigSetProcessorTest, OverseerSolrResponseTest, OverseerSolrResponseUnsafeSerializationTest, OverseerStatusTest, RecoveryAfterSoftCommitTest, SystemCollectionCompatTest, TestCloudPivotFacet, TestClusterProperties, TestConfigSetsAPI, TestCryptoKeys, TestDownShardTolerantSearch, TestLockTree, TestMiniSolrCloudClusterSSL, TestSolrCloudWithDelegationTokens, TestTolerantUpdateProcessorCloud, TestWithCollection, PurgeGraphTest, SimpleCollectionCreateDeleteTest, TestCollectionAPI, ExecutePlanActionTest, IndexSizeTriggerTest, ConfigureRecoveryStrategyTest, CoreSorterTest, DirectoryFactoriesTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, RAMDirectoryFactoryTest, TestBadConfig, TestInitParams, TestJmxIntegration, TestLazyCores, TestSolrIndexConfig, BackupIdTest, HdfsBackupRepositoryIntegrationTest, FieldAnalysisRequestHandlerTest, RequestLoggingTest, TestReplicationHandlerDiskOverFlow, TestSolrConfigHandlerCloud, DistributedQueryComponentOptimizationTest, DistributedSpellCheckComponentTest, TaggerTest, XmlInterpolationTest, TestPostingsSolrHighlighter, SolrCoreMetricManagerTest, SolrJmxReporterTest]
   [junit4] Completed [732/939 (3!)] on J1 in 5.63s, 4 tests, 1 error <<< FAILURES!

[...truncated 53278 lines...]