You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2018/02/24 13:31:46 UTC

[JENKINS] Lucene-Solr-Tests-7.x - Build # 447 - Still Unstable

Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/447/

1 tests failed.
FAILED:  org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory

Error Message:
expected:<5> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<5> but was:<0>
	at __randomizedtesting.SeedInfo.seed([B82DF0D7630977DB:D5D1542AD94188DC]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:311)
	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:1737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 12423 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/init-core-data-001
   [junit4]   2> 329722 WARN  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=612 numCloses=612
   [junit4]   2> 329726 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 329727 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 329728 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 329728 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001
   [junit4]   2> 329728 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 329731 INFO  (Thread-578) [    ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 329731 INFO  (Thread-578) [    ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 329733 ERROR (Thread-578) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 329831 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.c.ZkTestServer start zk server on port:46419
   [junit4]   2> 329872 INFO  (zkConnectionManagerCallback-692-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 329900 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 329907 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 329995 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 329995 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 329995 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 329996 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6bf494ea{/solr,null,AVAILABLE}
   [junit4]   2> 329996 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 329996 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 329996 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 329997 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@13704b06{/solr,null,AVAILABLE}
   [junit4]   2> 329998 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.AbstractConnector Started ServerConnector@44b055cd{SSL,[ssl, http/1.1]}{127.0.0.1:34988}
   [junit4]   2> 329998 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.AbstractConnector Started ServerConnector@26c7ada{SSL,[ssl, http/1.1]}{127.0.0.1:44173}
   [junit4]   2> 329998 INFO  (jetty-launcher-689-thread-1) [    ] o.e.j.s.Server Started @332481ms
   [junit4]   2> 329998 INFO  (jetty-launcher-689-thread-2) [    ] o.e.j.s.Server Started @332481ms
   [junit4]   2> 329998 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44173}
   [junit4]   2> 329998 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34988}
   [junit4]   2> 329998 ERROR (jetty-launcher-689-thread-2) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 329998 ERROR (jetty-launcher-689-thread-1) [    ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.3.0
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.3.0
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-02-24T12:30:42.189Z
   [junit4]   2> 329999 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2018-02-24T12:30:42.189Z
   [junit4]   2> 330021 INFO  (zkConnectionManagerCallback-694-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330022 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 330053 INFO  (zkConnectionManagerCallback-696-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330054 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 330059 INFO  (jetty-launcher-689-thread-2) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46419/solr
   [junit4]   2> 330068 INFO  (jetty-launcher-689-thread-1) [    ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:46419/solr
   [junit4]   2> 330073 INFO  (zkConnectionManagerCallback-700-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330081 INFO  (zkConnectionManagerCallback-704-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330082 INFO  (zkConnectionManagerCallback-706-thread-1-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330084 INFO  (zkConnectionManagerCallback-708-thread-1-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330173 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 330174 INFO  (jetty-launcher-689-thread-2) [n:127.0.0.1:44173_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 330174 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34988_solr
   [junit4]   2> 330175 INFO  (jetty-launcher-689-thread-2) [n:127.0.0.1:44173_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44173_solr
   [junit4]   2> 330175 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer Overseer (id=73350445591298054-127.0.0.1:34988_solr-n_0000000000) starting
   [junit4]   2> 330182 INFO  (zkCallback-705-thread-1-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 330186 INFO  (zkCallback-707-thread-1-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 330210 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 330213 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34988_solr
   [junit4]   2> 330226 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 0, message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr"} current state version: 0
   [junit4]   2> 330226 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:34988_solr
   [junit4]   2> 330226 INFO  (zkCallback-707-thread-1-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 330227 INFO  (zkCallback-705-thread-1-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 330227 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread Adding .autoAddReplicas trigger
   [junit4]   2> 330227 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1
   [junit4]   2> 330228 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: [127.0.0.1:44173_solr, 127.0.0.1:34988_solr]
   [junit4]   2> 330228 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 330228 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1
   [junit4]   2> 330248 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers
   [junit4]   2> 330248 DEBUG (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 330250 DEBUG (ScheduledTrigger-1529-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 330314 INFO  (jetty-launcher-689-thread-2) [n:127.0.0.1:44173_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44173.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 330322 INFO  (jetty-launcher-689-thread-2) [n:127.0.0.1:44173_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44173.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 330322 INFO  (jetty-launcher-689-thread-2) [n:127.0.0.1:44173_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44173.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 330323 INFO  (jetty-launcher-689-thread-2) [n:127.0.0.1:44173_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node2/.
   [junit4]   2> 330356 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34988.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 330366 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34988.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 330366 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34988.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 330367 INFO  (jetty-launcher-689-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/.
   [junit4]   2> 330416 INFO  (zkConnectionManagerCallback-714-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330460 INFO  (zkConnectionManagerCallback-718-thread-1) [    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 330461 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 330462 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:46419/solr ready
   [junit4]   2> 330502 INFO  (qtp2009309746-3200) [n:127.0.0.1:44173_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:44173_solr&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 330516 INFO  (OverseerThreadFactory-1531-thread-1-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection .system
   [junit4]   2> 330538 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "name":".system",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"1",
   [junit4]   2>   "numShards":1,
   [junit4]   2>   "createNodeSet":"127.0.0.1:44173_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 330538 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ClusterStateMutator building a new cName: .system
   [junit4]   2> 330539 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/.system/state.json
   [junit4]   2> 330626 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 330626 INFO  (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 330627 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 330627 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>       "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 330727 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 0
   [junit4]   2> 330830 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr    ] 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> 330831 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 330833 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "node_name":"127.0.0.1:44173_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 330833 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "node_name":"127.0.0.1:44173_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 330833 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{"core":".system_shard1_replica_n1","base_url":"https://127.0.0.1:44173/solr","node_name":"127.0.0.1:44173_solr","state":"down","type":"NRT"}
   [junit4]   2> 330834 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>           "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>           "node_name":"127.0.0.1:44173_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 330934 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 1
   [junit4]   2> 330935 INFO  (zkCallback-705-thread-1-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] 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> 330935 INFO  (zkCallback-705-thread-2-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] 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> 331251 DEBUG (ScheduledTrigger-1529-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 331844 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 331848 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331851 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.IndexSchema [.system_shard1_replica_n1] Schema name=_system collection or core
   [junit4]   2> 331855 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331855 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331857 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331857 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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 collection .system, trusted=true
   [junit4]   2> 331858 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44173.solr.core..system.shard1.replica_n1' (registry 'solr.core..system.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3ada72d1
   [junit4]   2> 331858 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 331858 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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 [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node2/.system_shard1_replica_n1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node2/./.system_shard1_replica_n1/data/]
   [junit4]   2> 331901 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331901 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331902 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: if 1 uncommited docs 
   [junit4]   2> 331903 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 331904 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@79b79e08[.system_shard1_replica_n1] main]
   [junit4]   2> 331905 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331906 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331906 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331906 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331907 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 331907 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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 1593285483269455872
   [junit4]   2> 331909 INFO  (searcherExecutor-1536-thread-1-processing-n:127.0.0.1:44173_solr x:.system_shard1_replica_n1 s:shard1 c:.system r:core_node2) [n:127.0.0.1:44173_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 Searcher@79b79e08[.system_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 331914 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331914 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331914 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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:44173/solr/.system_shard1_replica_n1/
   [junit4]   2> 331914 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 331914 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SyncStrategy https://127.0.0.1:44173/solr/.system_shard1_replica_n1/ has no replicas
   [junit4]   2> 331914 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
   [junit4]   2> 331916 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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:44173/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 331917 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 332017 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 2
   [junit4]   2> 332018 INFO  (zkCallback-705-thread-1-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] 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> 332018 INFO  (zkCallback-705-thread-2-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] 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> 332067 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_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> 332068 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "node_name":"127.0.0.1:44173_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 332068 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>   "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>   "node_name":"127.0.0.1:44173_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":".system",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 332068 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node2:{"core":".system_shard1_replica_n1","base_url":"https://127.0.0.1:44173/solr","node_name":"127.0.0.1:44173_solr","state":"active","type":"NRT","leader":"true"}
   [junit4]   2> 332068 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>           "base_url":"https://127.0.0.1:44173/solr",
   [junit4]   2>           "node_name":"127.0.0.1:44173_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 332069 INFO  (qtp2009309746-3204) [n:127.0.0.1:44173_solr c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 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=1238
   [junit4]   2> 332071 INFO  (qtp2009309746-3200) [n:127.0.0.1:44173_solr    ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
   [junit4]   2> 332169 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 3
   [junit4]   2> 332170 INFO  (zkCallback-705-thread-2-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] 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> 332170 INFO  (zkCallback-705-thread-1-processing-n:127.0.0.1:44173_solr) [n:127.0.0.1:44173_solr    ] 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> 332252 DEBUG (ScheduledTrigger-1529-thread-2) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 332517 INFO  (OverseerCollectionConfigSetProcessor-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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> 333072 INFO  (qtp2009309746-3200) [n:127.0.0.1:44173_solr    ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&name=.system&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:44173_solr&wt=javabin&version=2} status=0 QTime=2569
   [junit4]   2> 333073 INFO  (qtp2009309746-3203) [n:127.0.0.1:44173_solr    ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=3&maxShardsPerNode=3&name=AutoscalingHistoryHandlerTest_collection&nrtReplicas=3&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34988_solr&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 333075 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 333076 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 333078 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 333079 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
   [junit4]   2> 333080 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 333082 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 333083 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333084 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333086 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333087 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333089 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333090 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333092 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333093 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333094 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333096 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333097 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333098 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333099 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333101 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333102 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333104 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333105 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333106 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333107 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333109 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333110 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333112 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333113 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333115 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333116 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333117 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333118 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333120 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333121 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333122 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333123 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333125 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333126 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333127 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333129 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333130 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333131 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333132 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333133 INFO  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
   [junit4]   2> 333135 WARN  (OverseerThreadFactory-1531-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_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> 333138 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "name":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"3",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "maxShardsPerNode":"3",
   [junit4]   2>   "createNodeSet":"127.0.0.1:34988_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 333138 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ClusterStateMutator building a new cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 333239 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 333252 DEBUG (ScheduledTrigger-1529-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 333342 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 333342 INFO  (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 333344 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 333344 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 333345 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 333345 INFO  (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 333347 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 333347 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 333349 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 333349 INFO  (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 333349 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 333350 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node6":{
   [junit4]   2>       "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>       "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 333450 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 333594 INFO  (qtp1687402272-3213) [n:127.0.0.1:34988_solr    ] 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> 333595 INFO  (qtp1687402272-3213) [n:127.0.0.1:34988_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 333597 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 333597 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 333597 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node3:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1","base_url":"https://127.0.0.1:34988/solr","node_name":"127.0.0.1:34988_solr","state":"down","type":"NRT"}
   [junit4]   2> 333597 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 333607 INFO  (qtp1687402272-3211) [n:127.0.0.1:34988_solr    ] 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> 333609 INFO  (qtp1687402272-3210) [n:127.0.0.1:34988_solr    ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 333611 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 333611 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 333611 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node6:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4","base_url":"https://127.0.0.1:34988/solr","node_name":"127.0.0.1:34988_solr","state":"down","type":"NRT"}
   [junit4]   2> 333611 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 333611 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, message = {
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 333612 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
   [junit4]   2>   "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>   "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 333612 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ReplicaMutator Will update state for replica: core_node5:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2","base_url":"https://127.0.0.1:34988/solr","node_name":"127.0.0.1:34988_solr","state":"down","type":"NRT"}
   [junit4]   2> 333612 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_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>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           "core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:34988/solr",
   [junit4]   2>           "node_name":"127.0.0.1:34988_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 333713 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/AutoscalingHistoryHandlerTest_collection/state.json version: 1
   [junit4]   2> 333713 INFO  (zkCallback-707-thread-1-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/AutoscalingHistoryHandlerTest_collection/state.json] for collection [AutoscalingHistoryHandlerTest_collection] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 333713 INFO  (zkCallback-707-thread-2-processing-n:127.0.0.1:34988_solr) [n:127.0.0.1:34988_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/AutoscalingHistoryHandlerTest_collection/state.json] for collection [AutoscalingHistoryHandlerTest_collection] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 334252 DEBUG (ScheduledTrigger-1529-thread-1) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 2
   [junit4]   2> 334606 INFO  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 334606 INFO  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 334607 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/extraction/lib
   [junit4]   2> 334608 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist
   [junit4]   2> 334609 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/clustering/lib
   [junit4]   2> 334609 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist
   [junit4]   2> 334609 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/langid/lib
   [junit4]   2> 334609 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist
   [junit4]   2> 334610 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../contrib/velocity/lib
   [junit4]   2> 334610 WARN  (qtp1687402272-3213) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n1/../../../../dist
   [junit4]   2> 334622 INFO  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 334622 INFO  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 334634 WARN  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/extraction/lib
   [junit4]   2> 334634 WARN  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
   [junit4]   2> 334635 WARN  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/clustering/lib
   [junit4]   2> 334635 WARN  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
   [junit4]   2> 334635 WARN  (qtp1687402272-3210) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.c.SolrConfig Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/

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

Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@48474564: rootName = solr_34988, domain = solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n2, service url = null, agent id = null] for registry solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n2 / com.codahale.metrics.MetricRegistry@333d3531
   [junit4]   2> 353834 INFO  (coreCloseExecutor-1569-thread-2) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.c.SolrCore [AutoscalingHistoryHandlerTest_collection_shard1_replica_n1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1ee470a0
   [junit4]   2> 353844 INFO  (coreCloseExecutor-1569-thread-3) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4] o.a.s.c.SolrCore [AutoscalingHistoryHandlerTest_collection_shard1_replica_n4]  CLOSING SolrCore org.apache.solr.core.SolrCore@28588ec6
   [junit4]   2> 353844 INFO  (coreCloseExecutor-1569-thread-3) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n4, tag=676892358
   [junit4]   2> 353844 INFO  (coreCloseExecutor-1569-thread-3) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@a16e5fc: rootName = solr_34988, domain = solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n4, service url = null, agent id = null] for registry solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n4 / com.codahale.metrics.MetricRegistry@1737104f
   [junit4]   2> 353855 INFO  (coreCloseExecutor-1569-thread-2) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n1, tag=518287520
   [junit4]   2> 353856 INFO  (coreCloseExecutor-1569-thread-2) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2aa8c504: rootName = solr_34988, domain = solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@33d125a0
   [junit4]   2> 353855 INFO  (jetty-closer-690-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@13704b06{/solr,null,UNAVAILABLE}
   [junit4]   2> 353862 INFO  (jetty-closer-690-thread-1) [    ] o.e.j.s.session Stopped scavenging
   [junit4]   2> 353869 INFO  (coreCloseExecutor-1568-thread-1) [n:127.0.0.1:40922_solr c:.system s:shard1 r:core_node4 x:.system_shard1_replica_n3] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection..system.shard1.leader, tag=476072173
   [junit4]   2> 353873 INFO  (coreCloseExecutor-1569-thread-2) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader, tag=518287520
   [junit4]   2> 353873 INFO  (coreCloseExecutor-1569-thread-1) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader, tag=798074763
   [junit4]   2> 353873 INFO  (coreCloseExecutor-1569-thread-3) [n:127.0.0.1:34988_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader, tag=676892358
   [junit4]   2> 353897 INFO  (jetty-closer-690-thread-3) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2c9e327a{/solr,null,UNAVAILABLE}
   [junit4]   2> 353898 INFO  (jetty-closer-690-thread-3) [    ] o.e.j.s.session Stopped scavenging
   [junit4]   2> 353906 DEBUG (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/.system/state.json version: 10
   [junit4]   2> 353937 INFO  (jetty-closer-690-thread-2) [    ] o.a.s.c.Overseer Overseer (id=73350445591298054-127.0.0.1:34988_solr-n_0000000000) closing
   [junit4]   2> 353937 INFO  (OverseerStateUpdate-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:34988_solr
   [junit4]   2> 353939 DEBUG (jetty-closer-690-thread-2) [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 353946 WARN  (OverseerAutoScalingTriggerThread-73350445591298054-127.0.0.1:34988_solr-n_0000000000) [n:127.0.0.1:34988_solr    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 353953 INFO  (jetty-closer-690-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6bf494ea{/solr,null,UNAVAILABLE}
   [junit4]   2> 353953 INFO  (jetty-closer-690-thread-2) [    ] o.e.j.s.session Stopped scavenging
   [junit4]   2> 353954 ERROR (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 353955 INFO  (SUITE-AutoscalingHistoryHandlerTest-seed#[B82DF0D7630977DB]-worker) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46419 46419
   [junit4]   2> 354053 INFO  (Thread-578) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46419 46419
   [junit4]   2> 354054 WARN  (Thread-578) [    ] o.a.s.c.ZkTestServer Watch limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2> 	11	/solr/aliases.json
   [junit4]   2> 	7	/solr/collections/.system/terms/shard1
   [junit4]   2> 	4	/solr/collections/AutoscalingHistoryHandlerTest_collection/terms/shard1
   [junit4]   2> 	3	/solr/security.json
   [junit4]   2> 	3	/solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 	2	/solr/configs/.system
   [junit4]   2> 	2	/solr/configs/.system/managed-schema
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2> 	15	/solr/collections/.system/state.json
   [junit4]   2> 	11	/solr/clusterstate.json
   [junit4]   2> 	11	/solr/clusterprops.json
   [junit4]   2> 	8	/solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 	2	/solr/overseer_elect/election/73350445591298054-127.0.0.1:34988_solr-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2> 	11	/solr/live_nodes
   [junit4]   2> 	11	/solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_B82DF0D7630977DB-001
   [junit4]   2> Feb 24, 2018 12:31:06 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
   [junit4]   2> NOTE: test params are: codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=3, maxDocsPerChunk=6, blockSize=8), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=3, blockSize=8)), sim=RandomSimilarity(queryNorm=false): {}, locale=th, timezone=Asia/Novokuznetsk
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=4,threads=1,free=169586488,total=490209280
   [junit4]   2> NOTE: All tests run in this JVM: [SortByFunctionTest, DeleteStatusTest, TestCollectionAPI, AutoAddReplicasIntegrationTest, BasicZkTest, TestFieldResource, LoggingHandlerTest, TestSmileRequest, RestartWhileUpdatingTest, UpdateRequestProcessorFactoryTest, TestReload, CoreMergeIndexesAdminHandlerTest, TestSolrCoreSnapshots, TestTrieFacet, ConfigSetsAPITest, CollectionReloadTest, TestSolrFieldCacheBean, SaslZkACLProviderTest, QueryElevationComponentTest, FastVectorHighlighterTest, TestTriggerIntegration, UninvertDocValuesMergePolicyTest, SchemaApiFailureTest, SolrShardReporterTest, AddReplicaTest, SystemInfoHandlerTest, TestLeaderElectionZkExpiry, DirectUpdateHandlerOptimizeTest, TestDistributedGrouping, TestChildDocTransformer, HdfsWriteToMultipleCollectionsTest, DistributedFacetPivotLargeTest, SuggesterFSTTest, TestReqParamsAPI, AtomicUpdateProcessorFactoryTest, SolrJmxReporterTest, SOLR749Test, CSVRequestHandlerTest, PathHierarchyTokenizerFactoryTest, TestInfoStreamLogging, TestSystemCollAutoCreate, TestTolerantUpdateProcessorCloud, AutoscalingHistoryHandlerTest]
   [junit4] Completed [112/777 (1!)] on J1 in 24.99s, 1 test, 1 failure <<< FAILURES!

[...truncated 50763 lines...]