Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1400/
Java: 64bit/jdk1.8.0_162 -XX:-UseCompressedOops -XX:+UseParallelGC

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

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

Stack Trace:
java.lang.AssertionError: expected:<5> but was:<0>
        at 
__randomizedtesting.SeedInfo.seed([4068533799FEB33:69FA21CEC3D71434]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest.testHistory(AutoscalingHistoryHandlerTest.java:310)
        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 12633 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
   [junit4]   2> 579943 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/init-core-data-001
   [junit4]   2> 579944 WARN  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
   [junit4]   2> 579944 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 579946 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-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> 579947 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001
   [junit4]   2> 579947 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 579947 INFO  (Thread-1187) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 579947 INFO  (Thread-1187) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 579948 ERROR (Thread-1187) [    ] 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> 580047 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:34687
   [junit4]   2> 580049 INFO  (zkConnectionManagerCallback-1241-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580053 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T03:27:37+06:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 580053 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T03:27:37+06:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 580053 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T03:27:37+06:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 580054 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T03:27:37+06:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 580069 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 580069 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 580069 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 580073 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@40f02cd0{/solr,null,AVAILABLE}
   [junit4]   2> 580077 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 580077 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 580077 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 580077 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@30010431{SSL,[ssl, 
http/1.1]}{127.0.0.1:35753}
   [junit4]   2> 580077 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.e.j.s.Server Started @581836ms
   [junit4]   2> 580077 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=35753}
   [junit4]   2> 580078 ERROR (jetty-launcher-1238-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 580078 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 580078 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 580078 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 580078 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-21T10:40:05.015Z
   [junit4]   2> 580080 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 580080 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 580080 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6bba53dc{/solr,null,AVAILABLE}
   [junit4]   2> 580080 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1c570e61{SSL,[ssl, 
http/1.1]}{127.0.0.1:38481}
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.e.j.s.Server Started @581840ms
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38481}
   [junit4]   2> 580081 INFO  (zkConnectionManagerCallback-1243-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1f401068{/solr,null,AVAILABLE}
   [junit4]   2> 580081 ERROR (jetty-launcher-1238-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 580081 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 580082 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 580082 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 580082 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 580082 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-21T10:40:05.019Z
   [junit4]   2> 580082 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7e04b826{/solr,null,AVAILABLE}
   [junit4]   2> 580082 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@68883186{SSL,[ssl, 
http/1.1]}{127.0.0.1:33729}
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.e.j.s.Server Started @581841ms
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=33729}
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1d47e155{SSL,[ssl, 
http/1.1]}{127.0.0.1:43091}
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.e.j.s.Server Started @581841ms
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43091}
   [junit4]   2> 580083 ERROR (jetty-launcher-1238-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 580083 ERROR (jetty-launcher-1238-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 580083 INFO  (zkConnectionManagerCallback-1245-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.3.0
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-21T10:40:05.020Z
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-02-21T10:40:05.020Z
   [junit4]   2> 580083 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 580093 INFO  (zkConnectionManagerCallback-1248-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580094 INFO  (zkConnectionManagerCallback-1249-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580094 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 580094 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 580095 INFO  (jetty-launcher-1238-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34687/solr
   [junit4]   2> 580095 INFO  (jetty-launcher-1238-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34687/solr
   [junit4]   2> 580105 INFO  (zkConnectionManagerCallback-1257-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580105 INFO  (zkConnectionManagerCallback-1255-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580106 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1007596028a0005, likely client has closed socket
   [junit4]   2> 580107 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1007596028a0004, likely client has closed socket
   [junit4]   2> 580110 INFO  
(zkConnectionManagerCallback-1261-thread-1-processing-n:127.0.0.1:38481_solr) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580110 INFO  
(zkConnectionManagerCallback-1260-thread-1-processing-n:127.0.0.1:35753_solr) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580111 INFO  (jetty-launcher-1238-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34687/solr
   [junit4]   2> 580113 INFO  (jetty-launcher-1238-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34687/solr
   [junit4]   2> 580114 INFO  (zkConnectionManagerCallback-1266-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580115 INFO  (zkConnectionManagerCallback-1271-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580115 INFO  
(zkConnectionManagerCallback-1273-thread-1-processing-n:127.0.0.1:33729_solr) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580116 INFO  
(zkConnectionManagerCallback-1275-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580121 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 580121 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:43091_solr
   [junit4]   2> 580122 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer Overseer 
(id=72186881186070540-127.0.0.1:43091_solr-n_0000000000) starting
   [junit4]   2> 580125 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 580125 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43091_solr
   [junit4]   2> 580126 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.OverseerTriggerThread Adding 
.autoAddReplicas trigger
   [junit4]   2> 580126 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.OverseerTriggerThread Refreshing 
/autoscaling.json with znode version 1
   [junit4]   2> 580127 INFO  
(zkCallback-1274-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 580127 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.NodeLostTrigger Initial livenodes: 
[127.0.0.1:43091_solr]
   [junit4]   2> 580127 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion -1
   [junit4]   2> 580127 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.OverseerTriggerThread Processed trigger 
updates upto znodeVersion 1
   [junit4]   2> 580129 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.OverseerTriggerThread -- clean old 
nodeAdded markers
   [junit4]   2> 580129 DEBUG 
(OverseerAutoScalingTriggerThread-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_solr    ] o.a.s.c.a.OverseerTriggerThread Current 
znodeVersion 1, lastZnodeVersion 1
   [junit4]   2> 580129 DEBUG (ScheduledTrigger-2064-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 1
   [junit4]   2> 580146 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 580147 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 580147 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 580148 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 580148 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 580148 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 580148 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33729_solr
   [junit4]   2> 580149 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38481_solr
   [junit4]   2> 580149 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:33729_solr"} current state version: 0
   [junit4]   2> 580149 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:33729_solr
   [junit4]   2> 580149 INFO  
(zkCallback-1274-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 580149 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer processMessage: queueSize: 2, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:38481_solr"} current state version: 0
   [junit4]   2> 580149 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:38481_solr
   [junit4]   2> 580154 INFO  
(zkCallback-1258-thread-1-processing-n:127.0.0.1:38481_solr) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 580154 INFO  
(zkCallback-1259-thread-1-processing-n:127.0.0.1:35753_solr) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 580155 INFO  
(zkCallback-1272-thread-1-processing-n:127.0.0.1:33729_solr) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 580155 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:35753_solr
   [junit4]   2> 580155 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:35753_solr"} current state version: 0
   [junit4]   2> 580156 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:35753_solr
   [junit4]   2> 580156 INFO  
(zkCallback-1274-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 580157 INFO  
(zkCallback-1258-thread-1-processing-n:127.0.0.1:38481_solr) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 580157 INFO  
(zkCallback-1272-thread-1-processing-n:127.0.0.1:33729_solr) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 580157 INFO  
(zkCallback-1259-thread-1-processing-n:127.0.0.1:35753_solr) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 580172 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43091.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580189 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43091.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580189 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43091.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580190 INFO  (jetty-launcher-1238-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001/node1/.
   [junit4]   2> 580192 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38481.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580193 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33729.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580196 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35753.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580197 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38481.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580197 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38481.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580198 INFO  (jetty-launcher-1238-thread-2) 
[n:127.0.0.1:38481_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001/node2/.
   [junit4]   2> 580200 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33729.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580201 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_33729.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580201 INFO  (jetty-launcher-1238-thread-4) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001/node4/.
   [junit4]   2> 580203 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35753.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580203 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_35753.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 580203 INFO  (jetty-launcher-1238-thread-3) 
[n:127.0.0.1:35753_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001/node3/.
   [junit4]   2> 580303 INFO  (zkConnectionManagerCallback-1283-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580305 INFO  (zkConnectionManagerCallback-1287-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 580306 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 580307 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34687/solr ready
   [junit4]   2> 580322 INFO  (qtp482477522-5411) [n:127.0.0.1:33729_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:43091_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 580325 INFO  
(OverseerThreadFactory-2066-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
.system
   [junit4]   2> 580328 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091_solr",
   [junit4]   2>   "nrtReplicas":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 580328 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: .system
   [junit4]   2> 580328 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/.system/state.json
   [junit4]   2> 580430 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 580430 INFO  
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 580430 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 580431 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 580531 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 0
   [junit4]   2> 580657 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 580657 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 580659 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43091_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> 580659 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43091_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> 580659 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr","node_name":"127.0.0.1:43091_solr","state":"down","type":"NRT"}
   [junit4]   2> 580659 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:43091_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 580760 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 1
   [junit4]   2> 580760 INFO  
(zkCallback-1274-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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: [4])
   [junit4]   2> 580760 INFO  
(zkCallback-1274-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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: [4])
   [junit4]   2> 581130 DEBUG (ScheduledTrigger-2064-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 4
   [junit4]   2> 581682 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581685 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581687 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581691 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581692 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581692 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581693 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581693 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43091.solr.core..system.shard1.replica_n1' (registry 
'solr.core..system.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1fd03da6
   [junit4]   2> 581693 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 581693 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001/node1/.system_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J1/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001/tempDir-001/node1/./.system_shard1_replica_n1/data/]
   [junit4]   2> 581770 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581770 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581771 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581771 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 581773 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6510b074[.system_shard1_replica_n1] 
main]
   [junit4]   2> 581773 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581773 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581774 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581774 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581774 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581775 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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 
1593006732567642112
   [junit4]   2> 581777 INFO  
(searcherExecutor-2075-thread-1-processing-n:127.0.0.1:43091_solr 
x:.system_shard1_replica_n1 s:shard1 c:.system r:core_node2) 
[n:127.0.0.1:43091_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@6510b074[.system_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 581780 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581780 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581781 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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:43091/solr/.system_shard1_replica_n1/
   [junit4]   2> 581781 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581781 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_solr 
c:.system s:shard1 r:core_node2 x:.system_shard1_replica_n1] 
o.a.s.c.SyncStrategy https://127.0.0.1:43091/solr/.system_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 581781 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581782 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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:43091/solr/.system_shard1_replica_n1/ shard1
   [junit4]   2> 581782 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "core":".system_shard1_replica_n1",
   [junit4]   2>   "state":"active"} current state version: 0
   [junit4]   2> 581883 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 2
   [junit4]   2> 581885 INFO  
(zkCallback-1274-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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: [4])
   [junit4]   2> 581885 INFO  
(zkCallback-1274-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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: [4])
   [junit4]   2> 581933 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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> 581934 INFO  (qtp683236386-5416) [n:127.0.0.1:43091_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=1277
   [junit4]   2> 581937 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43091_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> 581937 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:43091_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> 581937 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr","node_name":"127.0.0.1:43091_solr","state":"active","type":"NRT","leader":"true"}
   [junit4]   2> 581937 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:43091/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:43091_solr",
   [junit4]   2>           "state":"active",
   [junit4]   2>           "type":"NRT",
   [junit4]   2>           "leader":"true"}}}}}
   [junit4]   2> 581939 INFO  (qtp482477522-5411) [n:127.0.0.1:33729_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> 582038 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/.system/state.json version: 3
   [junit4]   2> 582038 INFO  
(zkCallback-1274-thread-1-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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: [4])
   [junit4]   2> 582038 INFO  
(zkCallback-1274-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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: [4])
   [junit4]   2> 582131 DEBUG (ScheduledTrigger-2064-thread-2) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 4
   [junit4]   2> 582329 INFO  
(OverseerCollectionConfigSetProcessor-72186881186070540-127.0.0.1:43091_solr-n_0000000000)
 [n:127.0.0.1:43091_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> 582940 INFO  (qtp482477522-5411) [n:127.0.0.1:33729_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:43091_solr&wt=javabin&version=2}
 status=0 QTime=2618
   [junit4]   2> 582941 INFO  (qtp482477522-5414) [n:127.0.0.1:33729_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=3&name=AutoscalingHistoryHandlerTest_collection&nrtReplicas=3&action=CREATE&numShards=1&createNodeSet=127.0.0.1:33729_solr,127.0.0.1:35753_solr,127.0.0.1:38481_solr&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 582942 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 582943 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/protwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/protwords.txt
   [junit4]   2> 582943 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/managed-schema to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2> 582944 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/solrconfig.xml to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/solrconfig.xml
   [junit4]   2> 582945 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/synonyms.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/synonyms.txt
   [junit4]   2> 582945 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/stopwords.txt to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/stopwords.txt
   [junit4]   2> 582946 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582947 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582947 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582948 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582948 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582949 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582949 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582950 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582950 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582951 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582951 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582952 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582952 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582953 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582953 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582963 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582964 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582965 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582965 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582966 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582966 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582967 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582967 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582968 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582968 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582969 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582970 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582970 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582971 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582971 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582972 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582972 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582973 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582974 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582974 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582975 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582976 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582976 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_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> 582977 INFO  
(OverseerThreadFactory-2066-thread-2-processing-n:127.0.0.1:43091_solr) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.c.ZkConfigManager Copying zk node 
/configs/_default/params.json to 
/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/params.json
   [junit4]   2> 582980 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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>   
"createNodeSet":"127.0.0.1:33729_solr,127.0.0.1:35753_solr,127.0.0.1:38481_solr",
   [junit4]   2>   "nrtReplicas":"3",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 582980 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: AutoscalingHistoryHandlerTest_collection
   [junit4]   2> 583080 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2> 583131 DEBUG (ScheduledTrigger-2064-thread-1) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: 
.auto_add_replicas with currently live nodes: 4
   [junit4]   2> 583187 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:38481/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 583187 INFO  
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:38481/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 583190 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{}}
   [junit4]   2> 583190 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.SliceMutator New Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:38481/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 583191 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:35753/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 583191 INFO  
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:35753/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 583192 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.SliceMutator Old Slice: shard1:{
   [junit4]   2>   "range":"80000000-7fffffff",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "replicas":{"core_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:38481/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 583192 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:38481/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:35753/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 583193 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_n3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} current state version: 0
   [junit4]   2> 583193 INFO  
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_n3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 583193 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:38481/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:35753/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 583194 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_node4":{
   [junit4]   2>       
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>       "base_url":"https://127.0.0.1:38481/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:35753/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_n3",
   [junit4]   2>       "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>       "state":"down",
   [junit4]   2>       "node_name":null,
   [junit4]   2>       "type":"NRT"}}}
   [junit4]   2> 583294 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 0
   [junit4]   2> 583396 INFO  (qtp482477522-5400) [n:127.0.0.1:33729_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_n3&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 583397 INFO  (qtp482477522-5400) [n:127.0.0.1:33729_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 583407 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:33729_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> 583407 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
   [junit4]   2>   "core_node_name":"core_node6",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:33729_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> 583407 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node6:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3","base_url":"https://127.0.0.1:33729/solr","node_name":"127.0.0.1:33729_solr","state":"down","type":"NRT"}
   [junit4]   2> 583407 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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":"1",
   [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_node4":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:38481/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:35753/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_n3",
   [junit4]   2>           "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:33729_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 583422 INFO  (qtp150796232-5408) [n:127.0.0.1:38481_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=AutoscalingHistoryHandlerTest_collection.AUTOCREATED&newCollection=true&name=AutoscalingHistoryHandlerTest_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=AutoscalingHistoryHandlerTest_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 583422 INFO  (qtp2067541297-5401) [n:127.0.0.1:35753_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> 583423 INFO  (qtp2067541297-5401) [n:127.0.0.1:35753_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 583423 INFO  (qtp150796232-5408) [n:127.0.0.1:38481_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 583426 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:35753/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:35753_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> 583426 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:35753/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:35753_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> 583426 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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:35753/solr","node_name":"127.0.0.1:35753_solr","state":"down","type":"NRT"}
   [junit4]   2> 583426 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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":"1",
   [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_node4":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:38481/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:35753/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:35753_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
   [junit4]   2>           "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:33729_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 583429 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.Overseer processMessage: queueSize: 3, 
message = {
   [junit4]   2>   
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>   "core_node_name":"core_node4",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:38481/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38481_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> 583429 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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_node4",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:38481/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:38481_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> 583429 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ReplicaMutator Will update state for 
replica: 
core_node4:{"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1","base_url":"https://127.0.0.1:38481/solr","node_name":"127.0.0.1:38481_solr","state":"down","type":"NRT"}
   [junit4]   2> 583429 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_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":"1",
   [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_node4":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n1",
   [junit4]   2>           "base_url":"https://127.0.0.1:38481/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:38481_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:35753/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:35753_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"},
   [junit4]   2>         "core_node6":{
   [junit4]   2>           
"core":"AutoscalingHistoryHandlerTest_collection_shard1_replica_n3",
   [junit4]   2>           "base_url":"https://127.0.0.1:33729/solr";,
   [junit4]   2>           "node_name":"127.0.0.1:33729_solr",
   [junit4]   2>           "state":"down",
   [junit4]   2>           "type":"NRT"}}}}}
   [junit4]   2> 583529 DEBUG 
(OverseerStateUpdate-72186881186070540-127.0.0.1:43091_solr-n_0000000000) 
[n:127.0.0.1:43091_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/AutoscalingHistoryHandlerTest_collection/state.json version: 1
   [junit4]   2> 583530 INFO  
(zkCallback-1258-thread-1-processing-n:127.0.0.1:38481_solr) 
[n:127.0.0.1:38481_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: [4])
   [junit4]   2> 583530 INFO  
(zkCallback-1259-thread-1-processing-n:127.0.0.1:35753_solr) 
[n:127.0.0.1:35753_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: [4])
   [junit4]   2> 583530 INFO  
(zkCallback-1272-thread-1-processing-n:127.0.0.1:33729_solr) 
[n:127.0.0.1:33729_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: [4])
   [junit4]   2> 583530 INFO  
(zkCallback-1272-thread-2-processing-n:127.0.0.1:33729_solr) 
[n:127.0.0.1:33729_solr    ] o.a.s.c.c.ZkStateReader A cluster state

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

s.c.Overseer Overseer Loop exiting : 127.0.0.1:45297_solr
   [junit4]   2> 31029 WARN  
(OverseerAutoScalingTriggerThread-72187068831694860-127.0.0.1:45297_solr-n_0000000000)
 [n:127.0.0.1:45297_solr    ] o.a.s.c.a.OverseerTriggerThread 
OverseerTriggerThread woken up but we are closed, exiting.
   [junit4]   2> 31029 INFO  (coreCloseExecutor-65-thread-1) 
[n:127.0.0.1:37521_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 
r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.c.SolrCore [AutoscalingHistoryHandlerTest_collection_shard1_replica_n1]  
CLOSING SolrCore org.apache.solr.core.SolrCore@2523a456
   [junit4]   2> 31030 INFO  (coreCloseExecutor-65-thread-1) 
[n:127.0.0.1:37521_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 
r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n1, 
tag=623092822
   [junit4]   2> 31030 INFO  (coreCloseExecutor-64-thread-1) 
[n:127.0.0.1:40851_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n3] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2012c8ec: rootName = 
solr_40851, domain = solr.core..system.shard1.replica_n3, service url = null, 
agent id = null] for registry solr.core..system.shard1.replica_n3 / 
com.codahale.metrics.MetricRegistry@b143117
   [junit4]   2> 31030 INFO  (coreCloseExecutor-65-thread-1) 
[n:127.0.0.1:37521_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 
r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@658f68c: rootName = 
solr_37521, domain = 
solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n1, service 
url = null, agent id = null] for registry 
solr.core.AutoscalingHistoryHandlerTest_collection.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@23fd13d4
   [junit4]   2> 31030 DEBUG (jetty-closer-2-thread-1) [    ] 
o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly
   [junit4]   2> 31031 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x10075c1b317000c, likely client has closed socket
   [junit4]   2> 31032 INFO  
(zkCallback-29-thread-1-processing-n:127.0.0.1:37521_solr) 
[n:127.0.0.1:37521_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:37521_solr
   [junit4]   2> 31034 INFO  (jetty-closer-2-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1925b928{/solr,null,UNAVAILABLE}
   [junit4]   2> 31034 INFO  (jetty-closer-2-thread-1) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 31045 INFO  (coreCloseExecutor-64-thread-1) 
[n:127.0.0.1:40851_solr c:.system s:shard1 r:core_node4 
x:.system_shard1_replica_n3] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection..system.shard1.leader, tag=1203015930
   [junit4]   2> 31045 INFO  (coreCloseExecutor-62-thread-1) 
[n:127.0.0.1:34687_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 
r:core_node5 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n2] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader,
 tag=489774989
   [junit4]   2> 31046 INFO  (coreCloseExecutor-65-thread-1) 
[n:127.0.0.1:37521_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 
r:core_node3 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader,
 tag=623092822
   [junit4]   2> 31047 INFO  (coreCloseExecutor-63-thread-1) 
[n:127.0.0.1:37153_solr c:AutoscalingHistoryHandlerTest_collection s:shard1 
r:core_node6 x:AutoscalingHistoryHandlerTest_collection_shard1_replica_n4] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.AutoscalingHistoryHandlerTest_collection.shard1.leader,
 tag=1496806561
   [junit4]   2> 31056 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x10075c1b3170011, likely client has closed socket
   [junit4]   2> 31056 INFO  (jetty-closer-2-thread-5) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2edd2bb2{/solr,null,UNAVAILABLE}
   [junit4]   2> 31056 INFO  (jetty-closer-2-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4bc71c7c{/solr,null,UNAVAILABLE}
   [junit4]   2> 31056 INFO  (jetty-closer-2-thread-5) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 31056 INFO  (jetty-closer-2-thread-4) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 32558 INFO  (jetty-closer-2-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@32821cdb{/solr,null,UNAVAILABLE}
   [junit4]   2> 32558 INFO  (jetty-closer-2-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@2e35b84{/solr,null,UNAVAILABLE}
   [junit4]   2> 32558 INFO  (jetty-closer-2-thread-2) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 32558 INFO  (jetty-closer-2-thread-3) [    ] o.e.j.s.session 
Stopped scavenging
   [junit4]   2> 32558 ERROR 
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-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> 32559 INFO  
(SUITE-AutoscalingHistoryHandlerTest-seed#[4068533799FEB33]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34289 34289
   [junit4]   2> 37661 INFO  (Thread-1) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:34289 34289
   [junit4]   2> 37662 WARN  (Thread-1) [    ] o.a.s.c.ZkTestServer Watch limit 
violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        13      /solr/aliases.json
   [junit4]   2>        9       
/solr/collections/AutoscalingHistoryHandlerTest_collection/terms/shard1
   [junit4]   2>        6       /solr/collections/.system/terms/shard1
   [junit4]   2>        5       /solr/security.json
   [junit4]   2>        3       
/solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED/managed-schema
   [junit4]   2>        3       
/solr/configs/AutoscalingHistoryHandlerTest_collection.AUTOCREATED
   [junit4]   2>        2       /solr/configs/.system
   [junit4]   2>        2       /solr/configs/.system/managed-schema
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        22      
/solr/collections/AutoscalingHistoryHandlerTest_collection/state.json
   [junit4]   2>        15      /solr/collections/.system/state.json
   [junit4]   2>        13      /solr/clusterprops.json
   [junit4]   2>        13      /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        13      /solr/live_nodes
   [junit4]   2>        13      /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/J2/temp/solr.handler.admin.AutoscalingHistoryHandlerTest_4068533799FEB33-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{action_s=FSTOrd50, event.source_s=PostingsFormat(name=Asserting), 
type=FSTOrd50, before.actions_ss=PostingsFormat(name=Asserting), 
event.property._enqueue_time__ss=FSTOrd50, 
after.actions_ss=BlockTreeOrds(blocksize=128), stage_s=FSTOrd50, 
event.id_s=Lucene50(blocksize=128), event.property.eventTimes_ss=FSTOrd50, 
source_s=Lucene50(blocksize=128), event.type_s=FSTOrd50, 
responses_ts=BlockTreeOrds(blocksize=128), id=Lucene50(blocksize=128), 
collections_ss=FSTOrd50, operations.params_ts=FSTOrd50, 
event.property.nodeNames_ss=FSTOrd50}, 
docValues:{_version_=DocValuesFormat(name=Memory), 
event.time_l=DocValuesFormat(name=Memory), 
timestamp=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=357, 
maxMBSortInHeap=6.815142484009092, sim=RandomSimilarity(queryNorm=true): {}, 
locale=es-MX, timezone=Europe/Gibraltar
   [junit4]   2> NOTE: Linux 4.13.0-32-generic amd64/Oracle Corporation 
1.8.0_162 (64-bit)/cpus=8,threads=1,free=378170616,total=513277952
   [junit4]   2> NOTE: All tests run in this JVM: 
[AutoscalingHistoryHandlerTest]
   [junit4] Completed [2/5 (2!)] on J2 in 38.55s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 25 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1560: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1085: 
There were test failures: 5 suites, 5 tests, 2 failures [seed: 4068533799FEB33]

Total time: 1 minute 24 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   2/5 failed: 
org.apache.solr.handler.admin.AutoscalingHistoryHandlerTest
[repro] git checkout a42e4b36f106f6e0e609127b7956e02bb8aa4cfa
HEAD is now at a42e4b3... SOLR-12006: Add a '*_t' and '*_t_sort' dynamic field 
for single valued text fields
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
+ rm -f /tmp/tmp.DNYSAuhZXo
Archiving artifacts
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=a42e4b36f106f6e0e609127b7956e02bb8aa4cfa, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #1399
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to