Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1430/
Java: 32bit/jdk1.8.0_162 -client -XX:+UseParallelGC

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

Error Message:
Timed out wait for collection be active null Live Nodes: [127.0.0.1:35557_solr, 
127.0.0.1:37895_solr] Last available state: null

Stack Trace:
java.lang.AssertionError: Timed out wait for collection be active
null
Live Nodes: [127.0.0.1:35557_solr, 127.0.0.1:37895_solr]
Last available state: null
        at 
__randomizedtesting.SeedInfo.seed([14DFB14221230D81:792315BF9B6BF286]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:269)
        at 
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:233)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 14360 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001/init-core-data-001
   [junit4]   2> 3216110 WARN  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 3216111 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 3216115 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 3216117 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 3216118 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001/tempDir-001
   [junit4]   2> 3216118 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 3216118 INFO  (Thread-6032) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 3216118 INFO  (Thread-6032) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 3216138 ERROR (Thread-6032) [    ] 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> 3216218 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:35945
   [junit4]   2> 3216234 INFO  (zkConnectionManagerCallback-5137-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216284 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 3216285 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-21T16:27:37-05:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 3216328 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3216328 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3216329 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 3216329 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@dd094f{/solr,null,AVAILABLE}
   [junit4]   2> 3216330 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@552801{SSL,[ssl, 
http/1.1]}{127.0.0.1:35557}
   [junit4]   2> 3216330 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.e.j.s.Server Started @3217526ms
   [junit4]   2> 3216331 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=35557}
   [junit4]   2> 3216331 ERROR (jetty-launcher-5134-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 3216331 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 3216331 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3216331 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3216331 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-26T03:17:06.230Z
   [junit4]   2> 3216357 INFO  (zkConnectionManagerCallback-5139-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216357 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3216357 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3216357 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 3216357 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3216357 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@ddf60{/solr,null,AVAILABLE}
   [junit4]   2> 3216358 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1ccf25f{SSL,[ssl, 
http/1.1]}{127.0.0.1:37895}
   [junit4]   2> 3216358 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.e.j.s.Server Started @3217554ms
   [junit4]   2> 3216358 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37895}
   [junit4]   2> 3216359 ERROR (jetty-launcher-5134-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 3216359 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.3.0
   [junit4]   2> 3216359 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3216359 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3216359 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-26T03:17:06.258Z
   [junit4]   2> 3216370 INFO  (zkConnectionManagerCallback-5141-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216370 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3216380 INFO  (jetty-launcher-5134-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35945/solr
   [junit4]   2> 3216381 INFO  (jetty-launcher-5134-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35945/solr
   [junit4]   2> 3216402 INFO  (zkConnectionManagerCallback-5145-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216414 INFO  (zkConnectionManagerCallback-5149-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216428 INFO  
(zkConnectionManagerCallback-5151-thread-1-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216433 INFO  
(zkConnectionManagerCallback-5153-thread-1-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3216512 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3216513 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:37895_solr
   [junit4]   2> 3216513 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer Overseer 
(id=72213450865836038-127.0.0.1:37895_solr-n_0000000000) starting
   [junit4]   2> 3216541 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 3216544 INFO  (jetty-launcher-5134-thread-1) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 3216545 INFO  (jetty-launcher-5134-thread-1) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35557_solr
   [junit4]   2> 3216559 INFO  
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 3216559 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37895_solr
   [junit4]   2> 3216565 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 3216571 INFO  
(zkCallback-5150-thread-1-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 3216571 INFO  
(zkCallback-5152-thread-1-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 3216576 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 3216577 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:37895_solr"} current state version: 0
   [junit4]   2> 3216577 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:37895_solr
   [junit4]   2> 3216577 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:37895_solr, 127.0.0.1:35557_solr]
   [junit4]   2> 3216577 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 3216577 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 3216614 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 3216615 DEBUG 
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 3216618 DEBUG (ScheduledTrigger-6030-thread-1) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 3216732 INFO  (jetty-launcher-5134-thread-1) 
[n:127.0.0.1:35557_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35557.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3216749 INFO  (jetty-launcher-5134-thread-1) 
[n:127.0.0.1:35557_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35557.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3216749 INFO  (jetty-launcher-5134-thread-1) 
[n:127.0.0.1:35557_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35557.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3216751 INFO  (jetty-launcher-5134-thread-1) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001/tempDir-001/node1/.
   [junit4]   2> 3216882 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37895.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3216906 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37895.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3216906 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37895.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3216908 INFO  (jetty-launcher-5134-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001/tempDir-001/node2/.
   [junit4]   2> 3217013 INFO  (zkConnectionManagerCallback-5159-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3217020 INFO  (zkConnectionManagerCallback-5163-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3217021 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3217022 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:35945/solr ready
   [junit4]   2> 3217111 INFO  (qtp13779907-26080) [n:127.0.0.1:37895_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:35557_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 3217159 INFO  
(OverseerThreadFactory-6032-thread-1-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 3217202 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 3217202 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: .system
   [junit4]   2> 3217202 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/.system/state.json
   [junit4]   2> 3217292 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 3217292 INFO  
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 3217292 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 3217293 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 3217399 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 0
   [junit4]   2> 3217618 DEBUG (ScheduledTrigger-6030-thread-1) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 3217645 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3217645 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 3217672 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:35557_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> 3217672 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:35557_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> 3217672 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr","node_name":"127.0.0.1:35557_solr","state":"down","type":"NRT"}
   [junit4]   2> 3217672 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:35557_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 3217784 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 1
   [junit4]   2> 3217792 INFO  
(zkCallback-5150-thread-1-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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> 3217792 INFO  
(zkCallback-5150-thread-2-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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> 3218622 DEBUG (ScheduledTrigger-6030-thread-2) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 3218693 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.3.0
   [junit4]   2> 3218705 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218715 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218726 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218735 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218737 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218737 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218738 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35557.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@4b7e69
   [junit4]   2> 3218739 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 3218739 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001/tempDir-001/node1/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001/tempDir-001/node1/./.system_shard1_replica_n1/data/]
   [junit4]   2> 3218836 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218836 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218838 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218839 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 3218842 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@8c6ab2[.system_shard1_replica_n1] 
main]
   [junit4]   2> 3218843 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218844 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218844 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218845 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218846 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218849 INFO  
(searcherExecutor-6037-thread-1-processing-n:127.0.0.1:35557_solr 
x:.system_shard1_replica_n1 s:shard1 c:.system r:core_node2) 
[n:127.0.0.1:35557_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@8c6ab2[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3218849 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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 
1593431848384462848
   [junit4]   2> 3218856 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218856 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218856 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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:35557/solr/.system_shard1_replica_n1/
   [junit4]   2> 3218856 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218856 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy https://127.0.0.1:35557/solr/.system_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 3218857 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3218860 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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:35557/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 3218861 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 3218961 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 2
   [junit4]   2> 3218962 INFO  
(zkCallback-5150-thread-2-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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> 3218962 INFO  
(zkCallback-5150-thread-1-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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> 3219011 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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> 3219016 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:35557_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> 3219016 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:35557_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> 3219016 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr","node_name":"127.0.0.1:35557_solr","state":"active","type":"NRT","leader":"true"}
   [junit4]   2> 3219017 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:35557/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:35557_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 3219111 INFO  (qtp24407333-26070) [n:127.0.0.1:35557_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=1466
   [junit4]   2> 3219116 INFO  (qtp13779907-26080) [n:127.0.0.1:37895_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> 3219118 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 3
   [junit4]   2> 3219119 INFO  
(zkCallback-5150-thread-1-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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> 3219119 INFO  
(zkCallback-5150-thread-2-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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> 3219119 INFO  (qtp13779907-26080) [n:127.0.0.1:37895_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:35557_solr&wt=javabin&version=2}
 status=0 QTime=2007
   [junit4]   2> 3219122 INFO  (qtp13779907-26075) [n:127.0.0.1:37895_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:37895_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 3219126 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 3219126 INFO  
(OverseerCollectionConfigSetProcessor-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_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> 3219127 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 3219128 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 3219130 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219131 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219132 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219133 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219134 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219135 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219136 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219137 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219138 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219139 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219140 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219141 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219142 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219143 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219144 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219168 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219172 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219173 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219174 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219176 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219177 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219178 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219179 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219184 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219186 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219188 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219190 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219191 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219193 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219194 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219195 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219197 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219198 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219200 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219202 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219203 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219205 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219209 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219211 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
   [junit4]   2> 3219213 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 3219215 INFO  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 3219217 WARN  
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219220 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 3219220 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 3219320 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 3219424 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 3219424 INFO  
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 3219425 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 3219425 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 3219425 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 3219425 INFO  
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 3219426 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 3219426 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 3219427 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 3219427 INFO  
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"AutoscalingHistoryHandlerTest_collection",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 3219427 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 3219427 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node5":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>       "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"},
   [junit4]   2>     "core_node6":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>       "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 3219528 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 3219622 DEBUG (ScheduledTrigger-6030-thread-1) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 3219636 INFO  (qtp13779907-26067) [n:127.0.0.1:37895_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> 3219637 INFO  (qtp13779907-26067) [n:127.0.0.1:37895_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 3219685 INFO  (qtp13779907-26065) [n:127.0.0.1:37895_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node5&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n2&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 3219686 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node3",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:37895_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> 3219686 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:37895_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> 3219686 INFO  (qtp13779907-26137) [n:127.0.0.1:37895_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n4&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 3219686 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr","node_name":"127.0.0.1:37895_solr","state":"down","type":"NRT"}
   [junit4]   2> 3219686 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:37895_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 3219687 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:37895_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> 3219688 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>   "core_node_name":"core_node5",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:37895_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> 3219688 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node5:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2","base_url":"https://127.0.0.1:37895/solr","node_name":"127.0.0.1:37895_solr","state":"down","type":"NRT"}
   [junit4]   2> 3219688 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:37895_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:37895_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>           "state":"down",
   [junit4]   2>           "node_name":null,
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 3219689 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:37895_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> 3219689 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:37895_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> 3219689 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node6:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4","base_url":"https://127.0.0.1:37895/solr","node_name":"127.0.0.1:37895_solr","state":"down","type":"NRT"}
   [junit4]   2> 3219689 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_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:37895/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:37895_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node5":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n2",
   [junit4]   2>           "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:37895_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n4",
   [junit4]   2>           "base_url":"https://127.0.0.1:37895/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:37895_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 3219790 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 1
   [junit4]   2> 3219791 INFO  
(zkCallback-5152-thread-1-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3219791 INFO  
(zkCallback-5152-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_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> 3220623 DEBUG (ScheduledTrigger-6030-thread-1) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 2
   [junit4]   2> 3220691 ERROR (qtp13779907-26067) [n:127.0.0.1:37895_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Error 
CREATEing SolrCore 
'AutoscalingHistoryHandlerTest_collection_shard1_replica_n1': Unable to create 
core [AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] Caused by: 
Can't find resource 'solrconfig.xml' in classpath or 
'/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED', 
cwd=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.create(CoreContainer.java:989)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:195)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:736)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:717)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:498)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:380)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1637)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1637)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:533)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1253)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:168)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:166)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1155)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:455)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:530)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:347)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:256)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:279)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:289)
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:149)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102)
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:124)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:247)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:140)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:382)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Unable to 
create core [AutoscalingHistoryHandlerTest_collection_shard1_replica_n1]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1055)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.create(CoreContainer.java:950)
   [junit4]   2>        ... 42 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Could not 
load conf for core AutoscalingHistoryHandlerTest_collection_shard1_replica_n1: 
Error loading solr config from solrconfig.xml
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:97)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.getConfigSet(CoreContainer.java:1083)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.createFromDescriptor(CoreContainer.java:1035)
   [junit4]   2>        ... 43 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Error loading 
solr config from solrconfig.xml
   [junit4]   2>        at 
org.apache.solr.core.SolrConfig.readFromResourceLoader(SolrConfig.java:189)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.createSolrConfig(ConfigSetService.java:109)
   [junit4]   2>        at 
org.apache.solr.core.ConfigSetService.getConfig(ConfigSetService.java:91)
   [junit4]   2>        ... 45 more
   [junit4]   2> Caused by: org.apache.solr.core.SolrResourceNotFoundException: 
Can't find resource 'solrconfig.xml' in classpath or 
'/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED', 
cwd=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0
   [junit4]   2>        at 
org.apache.solr.cloud.ZkSolrResourceLoader.openResource(ZkSolrResourceLoader.java:130)
   [junit4]   2>        at 
org.apache.solr.core.SolrResourceLoader.openConfig(SolrResourceLoader.java:362)
   [junit4]   2>        at org.apache.solr.core.Config.<init>(Config.java:120)
   [junit4]   2>        at org.apache.solr.core.Config.<init>(Config.java:90)
   [junit4]   2>        at 
org.apache.solr.core.SolrConfig.<init>(SolrConfig.java:204)
   [junit4]   2>        at 
org.apache.solr.core.SolrConfig.readFromResourceLoader(SolrConfig.java:181)
   [junit4]   2>        ... 47 more
   [junit4]   2> 
   [junit4]   2> 3220692 INFO  (qtp13779907-26067) [n:127.0.0.1:37895_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node3 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={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}
 status=400 QTime=1055
   [junit4]   2> 3220692 ERROR 
(OverseerThreadFactory-6032-thread-2-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler Error 
from shard: https://127.0.0.1:37895/solr
   [junit4]   2> 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:37895/solr: Error CREATEing SolrCore 
'AutoscalingHistoryHandlerTest_collection_shard1_replica_n1': Unable to create 
core [AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] Caused by: 
Can't find resource 'solrconfig.xml' in classpath or 
'/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED', 
cwd=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
   [junit4]   2>        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
   [junit4]   2>        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:172)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 3220693 ERROR (qtp13779907-26065) [n:127.0.0.1:37895_solr 
c:AutoscalingHistoryHandlerTest_collection s:shard1 r:core_node5 
x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Error 
CREATEing SolrCore 
'AutoscalingHistoryHandlerTest_collection_shard1_replica_n2': Unable to create 
core [AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] Caused by: 
Can't find resource 'solrconfig.xml' in classpath or 
'/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED', 
cwd=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.create(CoreContainer.java:989)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:91)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:195)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:736)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:717)
   [junit4]   2>        at org.apache.solr.servlet.HttpSolrCall.ca

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

_solr"} current state version: 0
   [junit4]   2> 3341668 DEBUG 
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:37895_solr
   [junit4]   2> 3341668 INFO  
(zkCallback-5152-thread-5-processing-n:127.0.0.1:37895_solr) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 3341669 INFO  (jetty-closer-5135-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=72213450865836038-127.0.0.1:37895_solr-n_0000000000) closing
   [junit4]   2> 3341670 INFO  
(OverseerStateUpdate-72213450865836038-127.0.0.1:37895_solr-n_0000000000) 
[n:127.0.0.1:37895_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:37895_solr
   [junit4]   2> 3341670 INFO  
(zkCallback-5150-thread-5-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_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: [0])
   [junit4]   2> 3341670 INFO  
(zkCallback-5150-thread-4-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (0)
   [junit4]   2> 3341670 WARN  
(OverseerAutoScalingTriggerThread-72213450865836038-127.0.0.1:37895_solr-n_0000000000)
 [n:127.0.0.1:37895_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 3341672 DEBUG (jetty-closer-5135-thread-2) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 3341673 INFO  
(zkCallback-5150-thread-4-processing-n:127.0.0.1:35557_solr) 
[n:127.0.0.1:35557_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:35557_solr
   [junit4]   2> 3341674 INFO  (jetty-closer-5135-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@ddf60{/solr,null,UNAVAILABLE}
   [junit4]   2> 3341675 INFO  (jetty-closer-5135-thread-2) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 3341685 INFO  (coreCloseExecutor-6042-thread-1) 
[n:127.0.0.1:35557_solr c:.system s:shard1 r:core_node2 
x:.system_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection..system.shard1.leader, tag=9397101
   [junit4]   2> 3341690 INFO  (jetty-closer-5135-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@dd094f{/solr,null,UNAVAILABLE}
   [junit4]   2> 3341691 INFO  (jetty-closer-5135-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 3341692 ERROR 
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-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> 3341692 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[14DFB14221230D81]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:35945 35945
   [junit4]   2> 3346729 INFO  (Thread-6032) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:35945 35945
   [junit4]   2> 3346732 WARN  (Thread-6032) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        2       /solr/collections/.system/terms/shard1
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       
/solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/collections/.system/state.json
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2>        3       
/solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_14DFB14221230D81-001
   [junit4]   2> NOTE: test params are: codec=Lucene70, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ar-SY, 
timezone=America/Lower_Princes
   [junit4]   2> NOTE: Linux 4.13.0-32-generic i386/Oracle Corporation 
1.8.0_162 (32-bit)/cpus=8,threads=1,free=38971824,total=515899392
   [junit4]   2> NOTE: All tests run in this JVM: [SpellingQueryConverterTest, 
TestSolrQueryResponse, TestCrossCoreJoin, DocValuesMissingTest, 
HdfsSyncSliceTest, ChaosMonkeySafeLeaderWithPullReplicasTest, 
OverseerModifyCollectionTest, TestCustomSort, SolrJmxReporterCloudTest, 
SubstringBytesRefFilterTest, BadIndexSchemaTest, TestNumericTerms64, 
TestExtendedDismaxParser, TestGroupingSearch, 
ClassificationUpdateProcessorFactoryTest, TestSortByMinMaxFunction, 
TestBlendedInfixSuggestions, TestLegacyNumericRangeQueryBuilder, 
TestHttpShardHandlerFactory, DocumentAnalysisRequestHandlerTest, 
TestPseudoReturnFields, TestImplicitCoreProperties, TestCloudRecovery, 
ChaosMonkeyNothingIsSafeTest, TestManagedSynonymGraphFilterFactory, 
JavabinLoaderTest, IndexBasedSpellCheckerTest, TestCollectionAPIs, 
SolrCLIZkUtilsTest, TestRTimerTree, TestPrepRecovery, TestCryptoKeys, 
TestInPlaceUpdatesStandalone, TestEmbeddedSolrServerSchemaAPI, 
TestConfigReload, XmlUpdateRequestHandlerTest, TestSlowCompositeReaderWrapper, 
TestBackupRepositoryFactory, CloudExitableDirectoryReaderTest, 
CdcrBidirectionalTest, AssignTest, TestIndexSearcher, TestConfigSetProperties, 
AutoScalingHandlerTest, TestStreamBody, TestConfigSetsAPI, TestExactStatsCache, 
SpellCheckCollatorTest, TestRandomFlRTGCloud, 
DistributedQueryComponentCustomSortTest, TestHighlightDedupGrouping, 
HdfsRecoverLeaseTest, SystemLogListenerTest, TestSQLHandler, 
TestHashPartitioner, DeleteShardTest, TestAuthenticationFramework, 
TestRawResponseWriter, TestBinaryField, 
LeaderInitiatedRecoveryOnShardRestartTest, ExitableDirectoryReaderTest, 
SolrRequestParserTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
ImplicitSnitchTest, DirectUpdateHandlerTest, TestLuceneIndexBackCompat, 
TestExecutePlanAction, CollectionsAPIAsyncDistributedZkTest, 
TestScoreJoinQPScore, SegmentsInfoRequestHandlerTest, 
FieldAnalysisRequestHandlerTest, TestCustomDocTransformer, TestOmitPositions, 
SolrCloudReportersTest, NumberUtilsTest, TestClusterStateMutator, 
TestSolrCoreParser, FullHLLTest, PluginInfoTest, 
PeerSyncWithIndexFingerprintCachingTest, V2StandaloneTest, 
AssignBackwardCompatibilityTest, TestSubQueryTransformerCrossCore, 
DistribDocExpirationUpdateProcessorTest, BinaryUpdateRequestHandlerTest, 
TestNRTOpen, ShufflingReplicaListTransformerTest, ChangedSchemaMergeTest, 
BasicAuthStandaloneTest, TestMergePolicyConfig, TestWordDelimiterFilterFactory, 
SimpleCollectionCreateDeleteTest, TestRecoveryHdfs, 
LeaderElectionContextKeyTest, TestQuerySenderNoQuery, JSONWriterTest, 
ShardRoutingTest, TestSolrCloudWithDelegationTokens, UUIDFieldTest, 
DistributedTermsComponentTest, TestClusterStateProvider, 
TestLuceneMatchVersion, SolrPluginUtilsTest, TestSimpleTextCodec, 
CursorMarkTest, SolrCoreCheckLockOnStartupTest, TestUniqueKeyFieldResource, 
PreAnalyzedFieldManagedSchemaCloudTest, TestFastOutputStream, 
TestCloudJSONFacetJoinDomain, BufferStoreTest, CreateCollectionCleanupTest, 
TestNodeAddedTrigger, TestXmlQParserPlugin, TestDelegationWithHadoopAuth, 
SolrIndexConfigTest, SynonymTokenizerTest, ZkSolrClientTest, 
TestDocumentBuilder, UpdateParamsTest, DebugComponentTest, SimpleFacetsTest, 
ParsingFieldUpdateProcessorsTest, OverseerTaskQueueTest, 
TestCloudNestedDocsSort, TestDistributedMap, 
BigEndianAscendingWordSerializerTest, FacetPivotSmallTest, 
BasicDistributedZkTest, TestStressCloudBlindAtomicUpdates, 
TestTolerantUpdateProcessorRandomCloud, TestUtilizeNode, 
TriLevelCompositeIdRoutingTest, CollectionTooManyReplicasTest, 
HdfsCollectionsAPIDistributedZkTest, ShardSplitTest, V2ApiIntegrationTest, 
AutoscalingHistoryHandlerTest]
   [junit4] Completed [657/777 (1!)] on J0 in 130.80s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 401 lines...]
   [junit4] JVM J2: stdout was not empty, see: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/temp/junit4-J2-20180226_022328_6767463739860068491329.sysout
   [junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
   [junit4] java.lang.OutOfMemoryError: Java heap space
   [junit4] Dumping heap to 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/heapdumps/java_pid20423.hprof ...
   [junit4] Heap dump file created [531620873 bytes in 0.941 secs]
   [junit4] <<< JVM J2: EOF ----

[...truncated 8719 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:618: The following 
error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/build.xml:570: Some of the tests 
produced a heap dump, but did not fail. Maybe a suppressed OutOfMemoryError? 
Dumps created:
* java_pid20423.hprof

Total time: 87 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to