Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/21528/
Java: 64bit/jdk-10-ea+43 -XX:+UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollections

Error Message:
The operations computed by ComputePlanAction should not be 
nullSolrClientNodeStateProvider.DEBUG{AFTER_ACTION=[compute_plan, null], 
BEFORE_ACTION=[compute_plan, null]}

Stack Trace:
java.lang.AssertionError: The operations computed by ComputePlanAction should 
not be nullSolrClientNodeStateProvider.DEBUG{AFTER_ACTION=[compute_plan, null], 
BEFORE_ACTION=[compute_plan, null]}
        at 
__randomizedtesting.SeedInfo.seed([1EF8D84E948F36AE:24563D97AAEBEFC0]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testSelectedCollections(ComputePlanActionTest.java:469)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        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 
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.base/java.lang.Thread.run(Thread.java:844)


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([1EF8D84E948F36AE:73047CB32EC7C9A9]: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:313)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        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 
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.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 12274 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/init-core-data-001
   [junit4]   2> 171612 WARN  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 171612 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 171612 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 171613 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 171613 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001
   [junit4]   2> 171614 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 171628 INFO  (Thread-429) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 171628 INFO  (Thread-429) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 171639 ERROR (Thread-429) [    ] 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> 171728 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:41551
   [junit4]   2> 171730 INFO  (zkConnectionManagerCallback-237-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171745 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T15:27:37-06:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 171746 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T15:27:37-06:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 171780 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 171780 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 171780 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 171780 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@664cd542{/solr,null,AVAILABLE}
   [junit4]   2> 171786 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 171786 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 171786 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 171788 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@72132ffa{/solr,null,AVAILABLE}
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@2ec13039{SSL,[ssl, 
http/1.1]}{127.0.0.1:43961}
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@71847c61{SSL,[ssl, 
http/1.1]}{127.0.0.1:41415}
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.e.j.s.Server Started @174012ms
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.e.j.s.Server Started @174012ms
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43961}
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41415}
   [junit4]   2> 171796 ERROR (jetty-launcher-234-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 171796 ERROR (jetty-launcher-234-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-25T00:00:38.232558Z
   [junit4]   2> 171796 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-25T00:00:38.232568Z
   [junit4]   2> 171814 INFO  (zkConnectionManagerCallback-240-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171814 INFO  (zkConnectionManagerCallback-241-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171815 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 171815 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 171839 INFO  (jetty-launcher-234-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41551/solr
   [junit4]   2> 171847 INFO  (jetty-launcher-234-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41551/solr
   [junit4]   2> 171863 INFO  (zkConnectionManagerCallback-245-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171865 INFO  (zkConnectionManagerCallback-249-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171869 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x10087e604270004, likely client has closed socket
   [junit4]   2> 171878 INFO  
(zkConnectionManagerCallback-253-thread-1-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171897 INFO  
(zkConnectionManagerCallback-252-thread-1-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 171975 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 171975 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:41415_solr
   [junit4]   2> 171976 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer Overseer 
(id=72207016019820550-127.0.0.1:41415_solr-n_0000000000) starting
   [junit4]   2> 171981 INFO  (jetty-launcher-234-thread-2) 
[n:127.0.0.1:43961_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 171982 INFO  (jetty-launcher-234-thread-2) 
[n:127.0.0.1:43961_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43961_solr
   [junit4]   2> 171999 INFO  
(zkCallback-251-thread-1-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 172003 INFO  
(zkCallback-250-thread-1-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 172003 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 172003 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 172004 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 172004 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:43961_solr]
   [junit4]   2> 172004 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 172004 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41415_solr
   [junit4]   2> 172004 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 172007 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:41415_solr"} current state version: 0
   [junit4]   2> 172007 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:41415_solr
   [junit4]   2> 172007 INFO  
(zkCallback-250-thread-1-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 172007 INFO  
(zkCallback-251-thread-1-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 172034 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 172034 DEBUG 
(OverseerAutoScalingTriggerThread-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 172035 DEBUG (ScheduledTrigger-449-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 172037 INFO  (jetty-launcher-234-thread-2) 
[n:127.0.0.1:43961_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43961.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 172045 INFO  (jetty-launcher-234-thread-2) 
[n:127.0.0.1:43961_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43961.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 172046 INFO  (jetty-launcher-234-thread-2) 
[n:127.0.0.1:43961_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43961.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 172047 INFO  (jetty-launcher-234-thread-2) 
[n:127.0.0.1:43961_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node2/.
   [junit4]   2> 172074 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41415.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 172082 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41415.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 172082 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41415.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 172084 INFO  (jetty-launcher-234-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/.
   [junit4]   2> 172128 INFO  (zkConnectionManagerCallback-259-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 172145 INFO  (zkConnectionManagerCallback-263-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 172146 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 172146 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41551/solr ready
   [junit4]   2> 172212 INFO  (qtp475191908-1356) [n:127.0.0.1:41415_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:43961_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 172218 INFO  
(OverseerThreadFactory-451-thread-1-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 172221 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 172221 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: .system
   [junit4]   2> 172221 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/.system/state.json
   [junit4]   2> 172325 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 172325 INFO  
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 172326 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 172326 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 172427 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 0
   [junit4]   2> 172583 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 172584 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 172608 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43961_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> 172608 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43961_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> 172608 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr","node_name":"127.0.0.1:43961_solr","state":"down","type":"NRT"}
   [junit4]   2> 172608 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:43961_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 172709 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 1
   [junit4]   2> 172709 INFO  
(zkCallback-250-thread-1-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_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> 172711 INFO  
(zkCallback-250-thread-2-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_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> 173038 DEBUG (ScheduledTrigger-449-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 173615 WARN  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.Config You 
should not use LATEST as luceneMatchVersion property: if you use this setting, 
and then Solr upgrades to a newer release of Lucene, sizable changes may 
happen. If precise back compatibility is important then you should instead 
explicitly specify an actual Lucene version.
   [junit4]   2> 173618 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 173622 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173626 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173630 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173655 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173657 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173657 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173658 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43961.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@37e7bb82
   [junit4]   2> 173670 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 173671 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
[[.system_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node2/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node2/./.system_shard1_replica_n1/data/]
   [junit4]   2> 173771 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173771 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173773 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173773 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 173775 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1cdf82f6[.system_shard1_replica_n1] 
main]
   [junit4]   2> 173777 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173788 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173788 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173789 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173790 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173791 INFO  
(searcherExecutor-456-thread-1-processing-n:127.0.0.1:43961_solr 
x:.system_shard1_replica_n1 s:shard1 c:.system r:core_node2) 
[n:127.0.0.1:43961_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@1cdf82f6[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 173791 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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 
1593328890257866752
   [junit4]   2> 173799 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173799 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173799 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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:43961/solr/.system_shard1_replica_n1/
   [junit4]   2> 173799 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173799 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy https://127.0.0.1:43961/solr/.system_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 173799 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173807 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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:43961/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 173807 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 173908 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 2
   [junit4]   2> 173908 INFO  
(zkCallback-250-thread-2-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_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> 173908 INFO  
(zkCallback-250-thread-1-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_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> 173958 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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> 173959 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43961_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> 173959 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43961_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> 173959 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr","node_name":"127.0.0.1:43961_solr","state":"active","type":"NRT","leader":"true"}
   [junit4]   2> 173959 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:43961/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:43961_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 174005 INFO  (qtp1404859822-1357) [n:127.0.0.1:43961_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=1421
   [junit4]   2> 174011 INFO  (qtp475191908-1356) [n:127.0.0.1:41415_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> 174039 DEBUG (ScheduledTrigger-449-thread-2) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 174060 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 3
   [junit4]   2> 174060 INFO  
(zkCallback-250-thread-2-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_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> 174060 INFO  
(zkCallback-250-thread-1-processing-n:127.0.0.1:43961_solr) 
[n:127.0.0.1:43961_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> 174219 INFO  
(OverseerCollectionConfigSetProcessor-72207016019820550-127.0.0.1:41415_solr-n_0000000000)
 [n:127.0.0.1:41415_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> 175013 INFO  (qtp475191908-1356) [n:127.0.0.1:41415_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:43961_solr&wt=javabin&version=2}
 status=0 QTime=2801
   [junit4]   2> 175017 INFO  (qtp475191908-1360) [n:127.0.0.1:41415_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:41415_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 175021 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 175022 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 175023 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 175025 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
   [junit4]   2> 175029 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 175031 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 175032 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175035 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175036 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175037 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175039 DEBUG (ScheduledTrigger-449-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 175042 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175044 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175045 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175047 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175048 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175049 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175050 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175051 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175068 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175069 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175070 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175071 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175072 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175073 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175074 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175086 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175087 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175090 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175091 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175092 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175093 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175094 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175095 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175102 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175143 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175144 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175145 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175146 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175147 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175148 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175149 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175149 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175150 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175151 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175153 INFO  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
   [junit4]   2> 175159 WARN  
(OverseerThreadFactory-451-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175162 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 175162 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 175262 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 175370 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 175370 INFO  
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 175371 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 175371 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 175381 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 175381 INFO  
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 175381 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 175381 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 175397 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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_n5",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 175397 INFO  
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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_n5",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 175398 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 175398 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:41415/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_n5",
   [junit4]   2>       "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 175498 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 175618 INFO  (qtp475191908-1358) [n:127.0.0.1:41415_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&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> 175619 INFO  (qtp475191908-1358) [n:127.0.0.1:41415_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 175623 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node4",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41415_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> 175623 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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_node4",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41415_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> 175623 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node4:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2","base_url":"https://127.0.0.1:41415/solr","node_name":"127.0.0.1:41415_solr","state":"down","type":"NRT"}
   [junit4]   2> 175623 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node4":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:41415_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
   [junit4]   2>           "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 175632 INFO  (qtp475191908-1350) [n:127.0.0.1:41415_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> 175634 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
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:41415/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41415_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> 175634 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41415_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> 175634 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr","node_name":"127.0.0.1:41415_solr","state":"down","type":"NRT"}
   [junit4]   2> 175634 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:41415_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node4":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:41415_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
   [junit4]   2>           "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 175640 INFO  (qtp475191908-1346) [n:127.0.0.1:41415_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_n5&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 175641 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41415_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> 175641 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:41415_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> 175641 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node6:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5","base_url":"https://127.0.0.1:41415/solr","node_name":"127.0.0.1:41415_solr","state":"down","type":"NRT"}
   [junit4]   2> 175641 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_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:41415/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:41415_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node4":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:41415_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n5",
   [junit4]   2>           "base_url":"https://127.0.0.1:41415/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:41415_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 175742 DEBUG 
(OverseerStateUpdate-72207016019820550-127.0.0.1:41415_solr-n_0000000000) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 1
   [junit4]   2> 175742 INFO  
(zkCallback-251-thread-1-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 175746 INFO  
(zkCallback-251-thread-2-processing-n:127.0.0.1:41415_solr) 
[n:127.0.0.1:41415_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> 176039 DEBUG (ScheduledTrigger-449-thread-1) 
[n:127.0.0.1:41415_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 176633 INFO  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.RequestParams conf resource params.json loaded . version : 0 
   [junit4]   2> 176633 INFO  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.RequestParams request params refreshed to version 0
   [junit4]   2> 176635 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/extraction/lib
   [junit4]   2> 176635 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
   [junit4]   2> 176635 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/clustering/lib
   [junit4]   2> 176636 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
   [junit4]   2> 176636 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/langid/lib
   [junit4]   2> 176636 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../dist
   [junit4]   2> 176636 WARN  (qtp475191908-1358) [n:127.0.0.1:41415_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node4 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.c.SolrConfig Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHandlerTest_collection_shard1_replica_n2/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_1EF8D84E948F36AE-001/tempDir-001/node1/AutoscalingHistoryHan

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


   [junit4]   2> 132295 INFO  (jetty-closer-195-thread-2) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 132295 INFO  (coreCloseExecutor-445-thread-1) 
[n:127.0.0.1:40485_solr c:testSelected1 s:shard1 r:core_node5 
x:testSelected1_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSelected1.shard1.leader, 
tag=306554510
   [junit4]   2> 132295 INFO  (coreCloseExecutor-445-thread-2) 
[n:127.0.0.1:40485_solr c:testSelected2 s:shard1 r:core_node5 
x:testSelected2_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSelected2.shard1.leader, 
tag=1899067719
   [junit4]   2> 132295 INFO  (coreCloseExecutor-445-thread-3) 
[n:127.0.0.1:40485_solr c:testSelected3 s:shard2 r:core_node8 
x:testSelected3_shard2_replica_n6] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSelected3.shard2.leader, 
tag=1446778424
   [junit4]   2> 132297 INFO  (jetty-closer-195-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72207270799605790-127.0.0.1:40485_solr-n_0000000007) closing
   [junit4]   2> 132297 INFO  
(OverseerStateUpdate-72207270799605790-127.0.0.1:40485_solr-n_0000000007) 
[n:127.0.0.1:40485_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:40485_solr
   [junit4]   2> 132297 WARN  
(OverseerAutoScalingTriggerThread-72207270799605790-127.0.0.1:40485_solr-n_0000000007)
 [n:127.0.0.1:40485_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 132298 DEBUG (jetty-closer-195-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 132299 INFO  (jetty-closer-195-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@23ca5f53{/solr,null,UNAVAILABLE}
   [junit4]   2> 132299 INFO  (jetty-closer-195-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 134732 WARN  
(zkCallback-312-thread-1-processing-n:127.0.0.1:33207_solr) 
[n:127.0.0.1:33207_solr c:testSelected1 s:shard2 r:core_node8 
x:testSelected1_shard2_replica_n6] o.a.s.c.SyncStrategy Closed, skipping sync 
up.
   [junit4]   2> 134732 INFO  
(zkCallback-312-thread-1-processing-n:127.0.0.1:33207_solr) 
[n:127.0.0.1:33207_solr c:testSelected1 s:shard2 r:core_node8 
x:testSelected1_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext We failed 
sync, but we have no versions - we can't sync in that case - we were active 
before, so become leader anyway
   [junit4]   2> 134732 INFO  
(zkCallback-312-thread-1-processing-n:127.0.0.1:33207_solr) 
[n:127.0.0.1:33207_solr c:testSelected1 s:shard2 r:core_node8 
x:testSelected1_shard2_replica_n6] o.a.s.c.SolrCore 
[testSelected1_shard2_replica_n6]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4819ec65
   [junit4]   2> 134732 INFO  
(zkCallback-312-thread-1-processing-n:127.0.0.1:33207_solr) 
[n:127.0.0.1:33207_solr c:testSelected1 s:shard2 r:core_node8 
x:testSelected1_shard2_replica_n6] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.testSelected1.shard2.replica_n6, tag=1209658469
   [junit4]   2> 134732 INFO  
(zkCallback-312-thread-1-processing-n:127.0.0.1:33207_solr) 
[n:127.0.0.1:33207_solr c:testSelected1 s:shard2 r:core_node8 
x:testSelected1_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@53221f45: rootName = 
solr_33207, domain = solr.core.testSelected1.shard2.replica_n6, service url = 
null, agent id = null] for registry solr.core.testSelected1.shard2.replica_n6 / 
com.codahale.metrics.MetricRegistry@45a33fa9
   [junit4]   2> 134738 INFO  
(zkCallback-312-thread-1-processing-n:127.0.0.1:33207_solr) 
[n:127.0.0.1:33207_solr c:testSelected1 s:shard2 r:core_node8 
x:testSelected1_shard2_replica_n6] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.testSelected1.shard2.leader, 
tag=1209658469
   [junit4]   2> 134739 INFO  (jetty-closer-195-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@6ad26006{/solr,null,UNAVAILABLE}
   [junit4]   2> 134740 INFO  (jetty-closer-195-thread-3) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 134740 ERROR 
(SUITE-ComputePlanActionTest-seed#[1EF8D84E948F36AE]-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> 134740 INFO  
(SUITE-ComputePlanActionTest-seed#[1EF8D84E948F36AE]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34767 34767
   [junit4]   2> 140268 INFO  (Thread-158) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34767 34767
   [junit4]   2> 140269 WARN  (Thread-158) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/aliases.json
   [junit4]   2>        11      /solr/configs/conf
   [junit4]   2>        10      /solr/security.json
   [junit4]   2>        9       
/solr/collections/testNodeWithMultipleReplicasLost/terms/shard2
   [junit4]   2>        9       
/solr/collections/testNodeWithMultipleReplicasLost/terms/shard1
   [junit4]   2>        6       /solr/collections/testNodeLost/terms/shard1
   [junit4]   2>        5       /solr/collections/testNodeAdded/terms/shard1
   [junit4]   2>        5       /solr/collections/testSelected1/terms/shard2
   [junit4]   2>        5       /solr/collections/testSelected2/terms/shard1
   [junit4]   2>        5       /solr/collections/testSelected1/terms/shard1
   [junit4]   2>        5       /solr/collections/testSelected2/terms/shard2
   [junit4]   2>        5       /solr/collections/testSelected3/terms/shard2
   [junit4]   2>        5       /solr/collections/testSelected3/terms/shard1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        31      /solr/collections/testSelected3/state.json
   [junit4]   2>        27      /solr/collections/testSelected1/state.json
   [junit4]   2>        27      /solr/collections/testSelected2/state.json
   [junit4]   2>        19      
/solr/collections/testNodeWithMultipleReplicasLost/state.json
   [junit4]   2>        16      /solr/collections/testNodeLost/state.json
   [junit4]   2>        15      /solr/clusterprops.json
   [junit4]   2>        15      /solr/clusterstate.json
   [junit4]   2>        5       
/solr/overseer_elect/election/72207270799605763-127.0.0.1:39017_solr-n_0000000000
   [junit4]   2>        3       /solr/autoscaling.json
   [junit4]   2>        2       /solr/collections/testNodeAdded/state.json
   [junit4]   2>        2       
/solr/overseer_elect/election/72207270799605782-127.0.0.1:34027_solr-n_0000000005
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        59      /solr/live_nodes
   [junit4]   2>        42      /solr/collections
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        3       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        3       /solr/overseer/collection-queue-work
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.autoscaling.ComputePlanActionTest_1EF8D84E948F36AE-002
   [junit4]   2> NOTE: test params are: 
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=8, maxDocsPerChunk=10, blockSize=7), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=8, blockSize=7)), 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@ff433de),
 locale=bm-ML, timezone=Africa/Mogadishu
   [junit4]   2> NOTE: Linux 4.13.0-32-generic amd64/Oracle Corporation 10 
(64-bit)/cpus=8,threads=1,free=167036680,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [ComputePlanActionTest, 
AutoscalingHistoryHandlerTest, ComputePlanActionTest]
   [junit4] Completed [9/10 (8!)] on J0 in 47.40s, 4 tests, 1 failure <<< 
FAILURES!

[...truncated 22 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1560: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1085: 
There were test failures: 10 suites, 25 tests, 8 failures [seed: 
1EF8D84E948F36AE]

Total time: 3 minutes 0 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   3/5 failed: 
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[repro]   5/5 failed: org.apache.solr.cloud.autoscaling.ComputePlanActionTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=29e5b8abcee8a566cc057b862ab99c5ffef13a76, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #21527
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to